[Search for users] [Overall Top Noters] [List of all Conferences] [Download this site]

Conference irnbru::ims_api

Title:
Moderator:IRNBRU::MACKENZIE
Created:Wed Jul 10 1991
Last Modified:Tue May 06 1997
Last Successful Update:Fri Jun 06 1997
Number of topics:289
Total number of notes:1527

283.0. "Not all Pending Messages Processed" by FUTURS::BURRELL (Live long/prosper-live short/enjoy) Mon Feb 03 1997 14:03

    
    I'm trying to solve a problem I have sending messages to a MRQ with
    full recovery.
    
    If no process is attached to the queue then the messages sent to it are
    correctly held as "pending".
    
    If I then start the server, it processes from the pending excluding the
    first message written there.
    
    For example 
    
    - Stop the server.
    - Send three messages. 
    - Check the queue - 0 sent, 0 received, 3 pending
    - Start the server
    - Messages 2 and 3 are processed - Queue shows 0 send, 2 received, 1
      pending
    - Stop server
    - Start server - server loops ate the wait_for_request.
    
    Reply 1 is the log of the sending process - reply 2 is the log of the
    server. The only thing I can see in the logs is that the server
    reported a 
    
    DmQ T 35:03.4 *** Rcvd msg is larger than users msg area ***
    DmQ T 35:03.4 %PAMS-E-AREATOSMALL, Received message is larger than the
    user's mssage area
    
    Is that the reason?
    
    Thanks for any help.
    
    Paul. (7-830 3536)
    
T.RTitleUserPersonal
Name
DateLines
283.1Client Log (sorry, no DMQ log)FUTURS::BURRELLLive long/prosper-live short/enjoyMon Feb 03 1997 14:06220
    
    Messages send were:
    
    Message 1 = Dec Number 960184445 Line Item 1
    		Transactions D30, C30, D50
    Message 2 = Dec Number 960184446 Line Item 1
    		Transactions D30, C30, D50
    Message 3 = Dec Number 960184444 Line Item 2
    		Transaction E69
    
$ !	Startup file for detached process
$ !
$ !	First let's sense where we are
$ !
$ 	appenv$me = f$environment("PROCEDURE")
$ 	appenv$disk = f$parse(appenv$me,,, "DEVICE", "SYNTAX_ONLY")
$	appenv$dir = f$parse(appenv$me,,, "DIRECTORY", "SYNTAX_ONLY")           
$	appenv$topdir = f$extract( 1, f$locate(".", appenv$dir) - 1, appenv$dir )
$	appenv$uscore = f$locate("_", appenv$topdir)
$	appenv$variant = f$extract(appenv$uscore, f$len(appenv$topdir), appenv$topdir)
$	appenv$name = f$extract(0, appenv$uscore - 3, appenv$topdir)
$	appenv$version = f$extract(appenv$uscore - 3, 3, appenv$topdir)
$ !
$ !	Set up a command to point to the SET_LOGICALS process
$ !
$	set_logicals :== $DISK$DATA9:[COMAND070.EXE]SET_LOGICALS
$
$ !	Set the lnm$file_dev in lnm$process_directory for comand logicals
$ !
$ !	Format to build from LNM$SYSTEM_DIRECTORY LNM$FILE_DEV
$ !         set_logicals SYSTEM COMAND$LOGICAL_NAMES[,<table_name>]
$ !      
$ !	Format to build from LNM$PROCESS_DIRECTORY LNM$FILE_DEV
$ !         set_logicals PROCES COMAND$LOGICAL_NAMES[,<table_name>]
$ !
$	set_logicals SYSTEM COMAND$LOGICAL_NAMES
$ !
$ !	Finally run the detached process we want
$ !
$ !
$ ON ERROR THEN $EXIT
$ define sl_api_debug Y
$ define dmq$debug Y
$ @COMAND$$D_COM:COMAND$ASSIGN_TO_DMQ
$ WRITE SYS$OUTPUT "Attaching to the correct DMQ Queue. Please wait..."
Attaching to the correct DMQ Queue. Please wait...
$ !
$ COMAND_DMQ_Bus = "0"
$ COMAND_DMQ_Bus_Int = 0
$ COMAND_DMQ_Bus = F$TRNLNM ("COMAND$DMQ_BUS_NUMBER","COMAND$LOGICAL_NAMES")
$ COMAND_DMQ_Bus_Int = F$INTEGER (COMAND_DMQ_Bus)
$ IF (COMAND_DMQ_Bus_Int .EQ. 0)
$ ENDIF
$ !
$ !	Get the DMQ group for COMAND on the current node.
$ !
$ This_node = F$GETSYI ("NODENAME")
$ COMAND_DMQ_Group = "0"
$ COMAND_DMQ_Group = F$TRNLNM ("COMAND$DMQ_GROUP_CHEST","COMAND$LOGICAL_NAMES")
$ COMAND_DMQ_Group_Int = F$INTEGER (COMAND_DMQ_Group)
$ IF (COMAND_DMQ_Group .EQ. 0)
$ ENDIF
$ !
$ !	Get bus and group in the correct format (bbbb & ggggg).
$ !
$ Bus_Id_Long = "0000" + COMAND_DMQ_Bus
$ Bus_Id = F$EXTRACT (F$LENGTH (Bus_Id_Long)-4, 4, Bus_Id_Long)
$ Group_Id_Long = "00000" + COMAND_DMQ_Group
$ Group_Id = F$EXTRACT (F$LENGTH (Group_Id_Long)-5, 5, Group_Id_Long)
$ !
$ !	Check that the DMQ tables is available and determine the
$ !	disk & root directory for DMQ.
$ !
$ Dmq_Disk = F$TRNLNM ("DMQ$DISK", "DMQ$LNM_0140_01999")
$ Dmq_Root = F$TRNLNM ("DMQ$ROOT", "DMQ$LNM_0140_01999")
$ IF (Dmq_Disk .EQS. "") .OR. (Dmq_Root .EQS. "")
$ ENDIF
$ !
$ !	Assign to DMQ.
$ !
$ @SYS$SYSDEVICE:[DMQ$V21.EXE]DMQ$SET_LNM_TABLE 0140 01999
$!	===============================================================
$!			DMQ$SET_LNM_TABLE.COM
$!
$!	  This procedure is used to insert a named DECmessageQ LNM
$!	table into the default search list.  In addition it will
$!	create the table if required.  It is a shell arround the
$!	DMQ$SET_LNM_TABLEVnn.EXE image.
$!
$!	Arguments:
$!		P1 ==> DECmessageQ bus ID
$!		P2 ==> DECmessageQ group ID
$!		P3 ==> flag to control LNM table creation
$!	===============================================================
$!
$	wl           := write sys$output
$ 	ss$_abort     =  44
$ 	ss$_nolognam  = 444
$	on control_y then exit 44
$!
$	com_dir       = f$parse(f$environment("PROCEDURE"),,,"DEVICE","SYNTAX_ONLY") +-
	                f$parse(f$environment("PROCEDURE"),,,"DIRECTORY","SYNTAX_ONLY") 
$	dir_name      = f$parse(f$environment("PROCEDURE"),,,"DIRECTORY","SYNTAX_ONLY") 
$
$	vmsinstal_symbol := 
$	if vmsinstal_symbol .eqs. "" 
$	  then 
$	    vers      = f$extract(5,3,dir_name)
$	  else
$	endif
$	if vers .eqs. "" then goto BAD_ROOT
$!
$	dset          = "$SYS$SYSDEVICE:[DMQ$V21.EXE]dmq$set_lnm_tableV21"
$
$	dset "0140" "01999" "" 

%DMQ-S-SETLNM, Set to DECmessageQ LNM table DMQ$LNM_0140_01999
$
$	goto FINISHED
$ FINISHED:
$	exit
$ EXIT
$ RUN COMAND$$D_EXE:COMAND_SYNCH
 Process COMAND_SYNCH started by user COMANDRCVE   on node CHEST 
IMS-I-GETENV:-unable to translate DMQ$DNS_DIRECTORY logical
SL-I-IPTOLERANCE:   = 32000000
SL-I-OPTOLERANCE:   = 32000000
SL-I-RESENDTIME:    = 1
SL-I-RESENDTRIES:   = 10
SL-I-RECOVERYSTYLE: = 2
SL-I-TAGTRANSLATION = 0
SL-I-TIMESTAMPREQD  = 1
SL-I-MSGCPOMPRESS   = 0
SL-I-RESENDTIME:    = 1
SL-I-RESENDTRIES:   = 10
SL-I-AUDITSTATUS:   = 0
SL-I-PRIORITYSTYLE: = 0
SL-I-ACKSTYLE:      = 1
SL-I-TYPE:          = 0
SL-I-WAITSTYLE:     = 2
SL-I-AUTOPURGE:     = N
SL-I-EXITHNDLR: submitting exit handler
SL-I-LOCNOTFND:- Local translation file not found
SL-I-CONNECT: connected as temporary Q 1999.233
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: message found handle = 1
SL-I-POSTORGANIC: submitting organic request handler
sl_wait_reqA called sort context = -458702
SL-I-SAVERTSADR: Create request use SOURCE = 0.0 for RTS
SL-I-USEREQID: USE requests last_requestid=0 as RESPONSEID
SL_SEND_REQ called looking for addressee in request
SL_SEND_REQ put addressee name=2001.50 into message
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
SL-I-USEMSGID: USE requests last_messageid=0 as RESPONSEID
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
IMS-I-ENCODESVCNAME:put service name in Body=[COMAND_SYNCH_SERVICESERVICE_NAME]
SL-I-SENDMSG: address name length = 0
SL-I-SENDTOADDRESS = [2001.50]
SL-I-DELIVERYMODE  = 26

****************************************
*SL-I-MSGSENT: message sent STAT1 = 1 *
*SL-I-MSGSENT: psb_status = 139756331         *
****************************************

SL-I-SAVERTSADR: Create request use SOURCE = 0.0 for RTS
SL-I-USEREQID: USE requests last_requestid=0 as RESPONSEID
SL_SEND_REQ called looking for addressee in request
SL_SEND_REQ put addressee name=2001.50 into message
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
SL-I-USEMSGID: USE requests last_messageid=0 as RESPONSEID
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
IMS-I-ENCODESVCNAME:put service name in Body=[COMAND_SYNCH_SERVICESERVICE_NAME]
SL-I-SENDMSG: address name length = 0
SL-I-SENDTOADDRESS = [2001.50]
SL-I-DELIVERYMODE  = 26

****************************************
*SL-I-MSGSENT: message sent STAT1 = 1 *
*SL-I-MSGSENT: psb_status = 139756331         *
****************************************

SL-I-SAVERTSADR: Create request use SOURCE = 0.0 for RTS
SL-I-USEREQID: USE requests last_requestid=0 as RESPONSEID
SL_SEND_REQ called looking for addressee in request
SL_SEND_REQ put addressee name=2001.50 into message
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
SL-I-USEMSGID: USE requests last_messageid=0 as RESPONSEID
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: look for message handle = 1
IMS-I-ENCODESVCNAME:put service name in Body=[COMAND_SYNCH_SERVICESERVICE_NAME]
SL-I-SENDMSG: address name length = 0
SL-I-SENDTOADDRESS = [2001.50]
SL-I-DELIVERYMODE  = 26

****************************************
*SL-I-MSGSENT: message sent STAT1 = 1 *
*SL-I-MSGSENT: psb_status = 139756331         *
****************************************

COMAND_SYNCH stopped on node CHEST  by user COMANDRCVE  

SL-I-EXITHNDLR: exit handler called
$ !
$ EXIT
  COMANDRCVE   job terminated at  3-FEB-1997 10:31:50.65

  Accounting information:
  Buffered I/O count:             147         Peak working set size:    3032
  Direct I/O count:                81         Peak page file size:     12214
  Page faults:                   2468         Mounted volumes:             0
  Charged CPU time:           0 00:00:00.94   Elapsed time:     0 00:00:13.34
    
283.2Server LogFUTURS::BURRELLLive long/prosper-live short/enjoyMon Feb 03 1997 14:08659
$ !
$ !	Startup file for detached process
$ !
$ !	First let's sense where we are
$ !
$ 	appenv$me = f$environment("PROCEDURE")
$ 	appenv$disk = f$parse(appenv$me,,, "DEVICE", "SYNTAX_ONLY")
$	appenv$dir = f$parse(appenv$me,,, "DIRECTORY", "SYNTAX_ONLY")           
$	appenv$topdir = f$extract( 1, f$locate(".", appenv$dir) - 1, appenv$dir )
$	appenv$uscore = f$locate("_", appenv$topdir)
$	appenv$variant = f$extract(appenv$uscore, f$len(appenv$topdir), appenv$topdir)
$	appenv$name = f$extract(0, appenv$uscore - 3, appenv$topdir)
$	appenv$version = f$extract(appenv$uscore - 3, 3, appenv$topdir)
$ !
$ !	Set up a command to point to the SET_LOGICALS process
$ !
$	set_logicals :== $DISK$APPL_13:[COMAND070.EXE]SET_LOGICALS
$
$ !	Set the lnm$file_dev in lnm$process_directory for comand logicals
$ !
$ !	Format to build from LNM$SYSTEM_DIRECTORY LNM$FILE_DEV
$ !         set_logicals SYSTEM COMAND$LOGICAL_NAMES[,<table_name>]
$ !      
$ !	Format to build from LNM$PROCESS_DIRECTORY LNM$FILE_DEV
$ !         set_logicals PROCES COMAND$LOGICAL_NAMES[,<table_name>]
$ !
$	set_logicals SYSTEM COMAND$LOGICAL_NAMES
$ !
$ !	Finally run the detached process we want
$ !
$ !
$ ON ERROR THEN $EXIT
$ define sl_api_debug Y
$ define dmq$debug ALL
$ @COMAND$$D_COM:COMAND$ASSIGN_TO_DMQ
$ WRITE SYS$OUTPUT "Attaching to the correct DMQ Queue. Please wait..."
Attaching to the correct DMQ Queue. Please wait...
$ !
$ COMAND_DMQ_Bus = "0"
$ COMAND_DMQ_Bus_Int = 0
$ COMAND_DMQ_Bus = F$TRNLNM ("COMAND$DMQ_BUS_NUMBER","COMAND$LOGICAL_NAMES")
$ COMAND_DMQ_Bus_Int = F$INTEGER (COMAND_DMQ_Bus)
$ IF (COMAND_DMQ_Bus_Int .EQ. 0)
$ ENDIF
$ !
$ !	Get the DMQ group for COMAND on the current node.
$ !
$ This_node = F$GETSYI ("NODENAME")
$ COMAND_DMQ_Group = "0"
$ COMAND_DMQ_Group = F$TRNLNM ("COMAND$DMQ_GROUP_RDGE33","COMAND$LOGICAL_NAMES")
$ COMAND_DMQ_Group_Int = F$INTEGER (COMAND_DMQ_Group)
$ IF (COMAND_DMQ_Group .EQ. 0)
$ ENDIF
$ !
$ !	Get bus and group in the correct format (bbbb & ggggg).
$ !
$ Bus_Id_Long = "0000" + COMAND_DMQ_Bus
$ Bus_Id = F$EXTRACT (F$LENGTH (Bus_Id_Long)-4, 4, Bus_Id_Long)
$ Group_Id_Long = "00000" + COMAND_DMQ_Group
$ Group_Id = F$EXTRACT (F$LENGTH (Group_Id_Long)-5, 5, Group_Id_Long)
$ !
$ !	Check that the DMQ tables is available and determine the
$ !	disk & root directory for DMQ.
$ !
$ Dmq_Disk = F$TRNLNM ("DMQ$DISK", "DMQ$LNM_0140_02001")
$ Dmq_Root = F$TRNLNM ("DMQ$ROOT", "DMQ$LNM_0140_02001")
$ IF (Dmq_Disk .EQS. "") .OR. (Dmq_Root .EQS. "")
$ ENDIF
$ !
$ !	Assign to DMQ.
$ !
$ @SYS$SYSDEVICE:[DMQ$V32.EXE]DMQ$SET_LNM_TABLE 0140 02001
$!*++
$!*       Copyright Digital Equipment Corporation 1995.        *
$!*                  All rights reserved.                      *
$!*                                                            *
$!*                                                            *
$!* Restricted Rights: Use, duplication, or disclosure by the  *
$!* U.S. Government is subject to restrictions as set forth in *
$!* subparagraph (c)(1)(ii) of DFARS 252.227-7013, or in FAR   *
$!* 52.227-19, or in FAR 52.227-14 Alt. III, as applicable.    *
$!*                                                            *
$!* This software is proprietary to and embodies the           *
$!* confidential technology of Digital Equipment Corporation.  *
$!* Possession, use, or copying of this software and media is  *
$!* authorized only pursuant to a valid written license from   *
$!* Digital or an authorized sublicensor.                      *
$!*--
$!	===============================================================
$!			DMQ$SET_LNM_TABLE.COM
$!
$!	  This procedure is used to insert a named DECmessageQ LNM
$!	table into the default search list.  In addition it will
$!	create the table if required.  It is a shell arround the
$!	DMQ$SET_LNM_TABLEVnn.EXE image.
$!
$!	Arguments:
$!		P1 ==> DECmessageQ bus ID
$!		P2 ==> DECmessageQ group ID
$!		P3 ==> One of three flags to control LNM table
$!		       	CREATE - Creates the LNM table (if it does not exist)
$!			UNSET  - Reverses the SET process
$!			NOEXEC - Assigns the LNMs to only super mode
$!	===============================================================
$!
$	wl           := write sys$output
$ 	ss$_abort     =  44
$ 	ss$_nolognam  = 444
$	on control_y then exit 44
$
$	dev_name      = f$parse(f$environment("PROCEDURE"),,,"DEVICE","SYNTAX_ONLY")
$	dir_name      = f$parse(f$environment("PROCEDURE"),,,"DIRECTORY","SYNTAX_ONLY") 
$
$	dev_name      = f$getdvi("SYS$SYSDEVICE:","LOGVOLNAM") + ":"
$
$	vmsinstal_symbol := 
$	if vmsinstal_symbol .eqs. "" 
$	  then 
$	    vers      = f$extract(5,3,dir_name)
$	  else
$	endif
$	if vers .eqs. "" then goto BAD_ROOT
$
$	dset          = "$DISK$BTATST_SYS:[DMQ$V32.EXE]dmq$set_lnm_tableV32"
$
$	dset "0140" "02001" "" 

%DMQ-S-SETLNM, Set to DECmessageQ LNM table DMQ$LNM_0140_02001
$
$	goto FINISHED
$ FINISHED:
$	exit
$ EXIT
$ CMD_SERVER :== $COMAND$$D_EXE:COMAND$SERVER.EXE;
$ CMD_SERVER CMD$SERVER_1
 Process CMD$SERVER_1 started by user COMANDRCVE   on node RDGE33
IMS-I-GETENV:-unable to translate DMQ$DNS_DIRECTORY logical
SL-I-IPTOLERANCE:   = 32000000
SL-I-OPTOLERANCE:   = 32000000
SL-I-RESENDTIME:    = 1
SL-I-RESENDTRIES:   = 10
SL-I-RECOVERYSTYLE: = 2
SL-I-TAGTRANSLATION = 0
SL-I-TIMESTAMPREQD  = 1
SL-I-MSGCPOMPRESS   = 0
SL-I-RESENDTIME:    = 1
SL-I-RESENDTRIES:   = 10
SL-I-AUDITSTATUS:   = 0
SL-I-PRIORITYSTYLE: = 0
SL-I-ACKSTYLE:      = 1
SL-I-TYPE:          = 0
SL-I-WAITSTYLE:     = 2
SL-I-AUTOPURGE:     = Y
SL-I-EXITHNDLR: submitting exit handler
SL-I-LOCNOTFND:- Local translation file not found

DmQ T 35:01.8 Time Stamp -  3-FEB-1997 10:35:01.80
DmQ T 35:01.8 Tracing/logging event flag number = 63 
DmQ T 35:01.8  Entering PAMS_ATTACH_Q
DmQ T 35:01.8 Entering PAMS_COMMON_ATTACH
DmQ T 35:01.8 Entering INIT_PARAMS
DmQ T 35:01.8   (req_q_num:0, &q_num:0X1E17F8, q_type:-200, q_name:""
DmQ T 35:01.8    q_name_len:0, adver_scope:-202, mode:-212)
DmQ T 35:01.8 Entering MAP_AND_CHECK_QUEUE
DmQ T 35:01.8 Entering PAMS_DCL_PREP
DmQ T 35:01.8 Process name: "+CMD$SERVER_1"   PID: 00428518
DmQ T 35:01.8 Using event flag 62
DmQ T 35:01.8 Using event flag 61
DmQ T 35:01.8 DMQ$BLOCKING_CONFIRM == YES
DmQ T 35:01.8 Wakeup Mode = EXEC_MODE_AST
DmQ T 35:01.8 Connecting to message bus #0140  group #02001
DmQ T 35:01.9 Entering PAMS_CREATE_OBJECT_CACHE module.
DmQ T 35:01.9 Created PAMS Object Cache containing 128 elements
DmQ T 35:01.9 Locking resource "DMQ$PID_00428518"
DmQ T 35:01.9 Granted resource lock
DmQ T 35:01.9 Entering PAMS_GBL_SEC (version 0003020A)
DmQ T 35:01.9 System page size is 512
DmQ T 35:01.9 Mapped to section  "_DMQ$MCS_C_0140_02001"  protected
DmQ T 35:01.9 Mapped to section  "_DMQ$LLS_S_0140_02001"  protected
DmQ T 35:01.9 Mapped to section  "_DMQ$LLS_M_0140_02001"  protected
DmQ T 35:01.9 Mapped to section  "_DMQ$LLS_L_0140_02001"  protected
DmQ T 35:01.9 Mapped to section  "_DMQ$MRQ_C_0140_02001"  protected
DmQ T 35:01.9 Mapped to section  "_DMQ$GNT_C_0140_02001" 
DmQ T 35:02.0 Entering DMQCS_MAP_GSECT
DmQ T 35:02.0 Mapped to section  "_DMQ$GRP_C_0140_02001" protected
DmQ T 35:02.0 Entering PAMS_GET_VM_PAGE (size=1)
DmQ T 35:02.0 pams_get_vm_page(req_pages=1,ret_pages=1,ptr=20a800:20a9ff) sizeof(ENV)=324
DmQ T 35:02.0 exec_mapgblsc(in_addr=20a800:20a9ff, flags=8008, name="_DMQ$GRP_C_0140_02001")
DmQ T 35:02.0 Remapped section "_DMQ$GRP_C_0140_02001" (EXEC protected)
DmQ T 35:02.0 DMQ MCS & LLS mapped contigously.
DmQ T 35:02.0 Entering SET_MCS_QUEUE_NUM
DmQ T 35:02.0 Entering PAMS_GET_VM_PAGE (size=1)
DmQ T 35:02.0 Entering PAMS_GET_VM_PAGE (size=1)
DmQ T 35:02.0 Entering BIND_QUEUE_TO_PROCESS
DmQ T 35:02.0 Entering PAMS_ALLOC_MSG(*size:58)
DmQ T 35:02.0 Entering PAMS_GET_VM_PAGE (size=3)
DmQ T 35:02.0 PAMS_ALLOC_MSG: ctxt_ID:1, addr:20ae00, hdr:20aea0, data:20af18
DmQ T 35:02.0 Sending Process name of :+CMD$SERVER_1 to Com Server
DmQ T 35:02.0 Waiting for the COM Server to attach us
DmQ T 35:02.1 Queue Number returned from the COM server = 210
DmQ T 35:02.3 Entering PAMS_DCL_FINISH_UP
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_A (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_B (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_C (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_D (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_E (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_F (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_G (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_H (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_I (stub)
DmQ T 35:02.3 Entering PAMS_USER_CALLBACK_DCL_J (stub)
DmQ T 35:02.3 Called PSS_INIT_LOCATE
DmQ T 35:02.3 Declared process as 2001.210 (+CMD$SERVER_1_210)
DmQ T 35:02.3 Updating log streams (P:0001, G:000C, T:0001) & capabilities (0003)
SL-I-CONNECT: connected as temporary Q 2001.210
SL-I-CONNECT: checking group cache for name
DmQ T 35:02.4 Entering PAMS_LOCATE_Q
DmQ T 35:02.4 Attempting to locate "COMAND$ECSC_SERVER"
DmQ T 35:02.4 Searching group table
DmQ T 35:02.4 Adding object "COMAND$ECSC_SERVER" ID:0X7D10032 (2001.50) to local object cache [0]
DmQ T 35:02.4 Entering PAMS_GET_MSG module.
DmQ T 35:02.4 Entering PAMS_GET_VM_PAGE (size=65)
DmQ T 35:02.4 Entering PAMS_COMMON_RCV
DmQ T 35:02.5 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:02.5 Available msg Types: 
DmQ T 35:02.5 Rcv Priority=1  Sel_addr=-3.50
DmQ T 35:02.5 msg_area_len:50 show_buflen:0 
DmQ T 35:02.5 Entering PAMS_INIT_UNCONF_DB
DmQ T 35:02.5 Entering PAMS_ADD_TO_UNCONF_FREELIST
DmQ T 35:02.5 Entering PAMS_ATTACH_TO_MRQS for selidx:10
DmQ T 35:02.5 Entering PAMS_ATTACH_MRQ. Attaching to mrq:50 
DmQ T 35:02.5 Getting mrq registration for mrq:50 
DmQ T 35:02.5 Registration entry added for mrq:50
DmQ T 35:02.5 Entering PAMS_PUT_MSG
DmQ T 35:02.5 Entering PAMS_COMMON_SEND
DmQ T 35:02.5 Target=2001.100 send=OK class=29 type=-968 length=12
DmQ T 35:02.5 Priority=1 delivery=39 UMA=6 timeout=300 buffer=BUF_SEND  
DmQ T 35:02.6 Setting up selective rcv index for mrq:50, type:-968 
DmQ T 35:02.6 Entering PAMS_SET_SELECT module 
DmQ T 35:02.6 --- Selection index created = 110 --- 
DmQ T 35:02.6 Entering PAMS_GET_VM_PAGE (size=65)
DmQ T 35:02.6 Entering PAMS_COMMON_RCV
DmQ T 35:02.6 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:02.6 Available msg Types:  P1_RCV
DmQ T 35:02.6 Rcv Priority=0  Timeout=0  Sel_addr=-1.11
DmQ T 35:02.6 Entering PAMS_SCAN_QUEUES, context addr:39f800 
DmQ T 35:02.6 Entering PAMS_SCAN_LLS
DmQ T 35:02.6 Canceling timer for context at 39f800 with id:dec10003
DmQ T 35:02.6 Received msg: Source=2001.100 class=29 type=-968 length=12 priority=1 
DmQ T 35:02.6 Return from PAMS_COMMON_RCV
DmQ T 35:02.6 Entering PAMS_SCAN_QUEUES, context addr:20b400 
DmQ T 35:02.7 Entering PAMS_SCAN_LLS
DmQ T 35:02.7 Message (00E907CF:00000002) is recoverable
DmQ T 35:02.7 Entering PAMS_ADD_UNCONF_MSG(msg_ctxt=0020B400, MSN:00E907CF,00000002)
DmQ T 35:02.7 Message (00E907CF:00000002) is from a MRQ
DmQ T 35:02.7 Received msg: Source=1999.233 class=0 type=0 length=689 priority=0 
DmQ T 35:02.7 Return from PAMS_COMMON_RCV
DmQ T 35:03.4 *** Rcvd msg is larger than users msg area ***
DmQ T 35:03.4 %PAMS-E-AREATOSMALL, Received message is larger than the user's message area
SL-I-CONNECT: connected as temporary MRQ Q 2001.210
SL-I-CONNECT: located MRQ 2001.50
SL-I-CONNECT: add MRQ address to sel filter
SL-I-CREATEMSG: SET sender to be MRQ address = 2001.50
SL-I-FINDMSG: look for message handle = 1
SL-I-FINDMSG: message found handle = 1
SL-I-POSTORGANIC: submitting organic request handler
sl_wait_reqA called sort context = -458702
DmQ T 35:03.4 Entering PAMS_GET_MSGA module.
DmQ T 35:03.4 GETA: Pri=0 Area_len=32000 Sel_filter=-7.50 Actrtn:001B0894 Actparm=0 Flag_id:none
DmQ T 35:03.4 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:03.4 Available msg Types: 
DmQ T 35:03.4 Rcv Priority=0  Sel_addr=-7.50
DmQ T 35:03.4 msg_area_len:32000 show_buflen:64 
DmQ T 35:03.4 Entering PAMS_ADD_TO_UNCONF_FREELIST
DmQ T 35:03.4 Entering PAMS_SCAN_QUEUES, context addr:39f800 
DmQ T 35:03.4 Entering PAMS_SCAN_LLS
DmQ T 35:03.4 Entering PAMS_SCAN_ASTQ
DmQ T 35:03.5 Entering PAMS_SCAN_LLS
SL-I-MEMUSE: memory use = 
 78 calls to LIB$GET_VM, 9 calls to LIB$FREE_VM, 159152 bytes still allocated

***********************
*Wait for next Message*
***********************
SL-I-ADDMRQ: adding mrq_sel_filter = 1902692 to sort_context
DmQ T 35:03.5 Entering PAMS_GET_MSGW module.
DmQ T 35:03.5 Entering PAMS_COMMON_RCV
DmQ T 35:03.5 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:03.5 Available msg Types: 
DmQ T 35:03.5 Rcv Priority=0  Timeout=0  Sel_addr=-5.50
DmQ T 35:03.5 msg_area_len:32000 show_buflen:64 
DmQ T 35:03.5 Entering PAMS_ATTACH_TO_MRQS for selidx:11
DmQ T 35:03.5 Entering PAMS_ATTACH_MRQ. Attaching to mrq:50 
DmQ T 35:03.5 MRQ:50 is already attached 
DmQ T 35:03.5 Entering PAMS_SCAN_QUEUES, context addr:20b400 
DmQ T 35:03.5 Entering PAMS_SET_MRQ_INTEREST for msg context at 20b400
DmQ T 35:03.5 Entering PAMS_SCAN_LLS
DmQ T 35:03.5 Message (00E907CF:00000102) is recoverable
DmQ T 35:03.6 Entering PAMS_ADD_UNCONF_MSG(msg_ctxt=0020B400, MSN:00E907CF,00000102)
DmQ T 35:03.6 Message (00E907CF:00000102) is from a MRQ
DmQ T 35:03.6 Canceling timer for context at 20b400 with id:dec10002
DmQ T 35:03.6 Received msg: Source=1999.233 class=0 type=0 length=689 priority=0 
DmQ T 35:03.6 Return from PAMS_COMMON_RCV
SL-I-MEMUSE: memory use = 
 78 calls to LIB$GET_VM, 9 calls to LIB$FREE_VM, 159152 bytes still allocated
IMS-DECODE_MESSAGE: decode_msg
IMS-DECODE_MESSAGE: decode incoming v11 message
SL-I-ENDOFMSG: successfull end of envelope reached
IMS-READ_HEADER_INFO: read message header information
IMS-READ_HEADER_INFO: End of header reached
IMS-READ_BODY_INFO: start of Body init Body linked list
new request
read msg info, cont req = false
IMS-I-DECODE:SERVICE_NAME found in Body=[COMAND_SYNCH_SERVICE]
linkflag = 0
End of body Item reached
IMS-READ_BODY_INFO: End of body reached
IMS-I-REQCONTFLG:request cont flag=[0]
IMS-I-MSGCONTFLG: message cont flag = [0]
IMS-I-ENDOFMSG: successfull end of message reached
IMS-READ_MESSAGE_INFO: End of message reached
SL-I-MSGHANDLE: message_handle = 3
MESSAGE
	ENVELOPE
		ORIGINATOR = ,,1999.233
		SENDER     = ,COMANDRCVE,0.0
		ADDRESSEE  = ,,2001.50
		PRIORITYSTYLE = 0
		ACKSTYLE      = 1
		RECOVERYSTYLE = 2
		AUTHSTYLE     = 0
		DEFERREDTIME  = 0
	END of ENVELOPE
	HEADER
		DAYANDTIME          = 1997020310314036
		CLASS               = 0
		TYPE                = 0
		WAITSTYLE           = 2
		TRANSACTIONID       = 0
		RESPONSEID          = 0
		MESSAGEID           = 2
		REQUESTCONTINUATIONFLAG    = 0
		MESSAGECONTINUATIONFLAG    = 0
		PRECEEDINGMESSAGEID = 0
		NODEPLUSACCOUNT     = CHEST::COMANDRCVE
	END of HEADER
	BODY
		BODYITEM  - TYPE = 0,LINKFLAG = 0,SERVICE_NAME = COMAND_SYNCH_SERVICE
			ELEMENT  = [DEC_NUMBER,960184446]
			ELEMENT  = [DEC_BUSINESS_ENTITY,AE0004]
			ELEMENT  = [ADMINISTRATOR,181181]
			ELEMENT  = [SYNCH_DATA,   1D309702050000001+]
			ELEMENT  = [SYNCH_DATA,   1C30970130]
			ELEMENT  = [SYNCH_DATA,   1D50970207           N]
	END of BODY
	TRAILER
		TRAILER = ,COMANDRCVE,1999.233,1997020310314036
	END of TRAILER
END of MESSAGE
SL-I-SAVERTSADR: SL_WAIT_REQ: use ORIGINATOR = 1999.233 for RTS
SL_READ_REQ: rcv_msg_ptr->seen = 0
SL_READ_REQ: found request seen,type = [0,0]
sl_get_req_elt_internal service_name_LENGTH=[20]
sl_get_req_elt_internal service_name=[COMAND_SYNCH_SERVICE]
 Processing :- DEC Nr: 960184446 L/I:    1 Transaction: D30
 Processing :- DEC Nr: 960184446 L/I:    1 Transaction: C30
 Processing :- DEC Nr: 960184446 L/I:    1 Transaction: D50

TOLERANCE INFORMATION
*********************
sl_get_req_elt:continuing request,unseen count=[0,0]
Unselective read return first elt from next message
*********************
SL_FINISH_REQ:-No more requests in message, free space
SL_FINISH_REQ:- current_msg_ptr->del_psb_status=139756323
SL_FINISH_REQ:- recoverable message, remove from DQF
DmQ T 35:05.0 Entering PAMS_CONFIRM_MSG
DmQ T 35:05.0 (Msg_seq_num=00E907CF,00000102, Status=00000000, Force_j=0)
DmQ T 35:05.0 Entering PAMS_FIND_UNCONF_MSG (MSN:00E907CF,00000102)
DmQ T 35:05.0 Entering PAMS_ALLOC_MSG(*size:24)
DmQ T 35:05.0 PAMS_ALLOC_MSG: ctxt_ID:1, addr:20ae00, hdr:20aea0, data:20af18
DmQ T 35:05.0 Sending Confirmation request for (e907cf,102)
DmQ T 35:05.0 Entering PAMS_SEND_MSG
DmQ T 35:05.0 Entering PAMS_COMMON_SEND
DmQ T 35:05.0 Target=2001.98 send=OK class=28 type=-840 length=24
DmQ T 35:05.1 Priority=1 delivery=20 UMA=5 timeout=0 buffer=BUF_SEND  
DmQ T 35:05.1 Buffer will be freed by PAMS_SEND_MSG
DmQ T 35:05.1 Entering PAMS_COMMON_RCV
DmQ T 35:05.1 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:05.1 Available msg Types: 
DmQ T 35:05.1 Rcv Priority=0  Timeout=200  Sel_addr=-1.11
DmQ T 35:05.1 msg_area_len:32000 show_buflen:0 
DmQ T 35:05.1 Entering PAMS_ADD_TO_UNCONF_FREELIST
DmQ T 35:05.1 Entering PAMS_SCAN_QUEUES, context addr:20b400 
DmQ T 35:05.1 Entering PAMS_SCAN_LLS
DmQ T 35:05.1 Entering PAMS_BLOCK_FOR_EVENT
DmQ T 35:05.2 Entering PAMS_SCAN_ASTQ
DmQ T 35:05.2 Entering PAMS_SCAN_LLS
DmQ T 35:05.3 Entering PAMS_SCAN_LLS
DmQ T 35:05.3 Canceling timer for context at 20b400 with id:dec10002
DmQ T 35:05.4 Received msg: Source=2001.98 class=28 type=-841 length=0 priority=1 
DmQ T 35:05.4 Return from PAMS_COMMON_RCV
DmQ T 35:05.4 --- Msg (00E907CF,00000102) confirmed with 0X0 ---
DmQ T 35:05.4 PAMS_FREE_UNCONF (uc=0039A050, MSN:00E907CF,00000102)
SL-I-MEMUSE: memory use = 
 129 calls to LIB$GET_VM, 35 calls to LIB$FREE_VM, 171448 bytes still allocated

***********************
*Wait for next Message*
***********************
SL-I-ADDMRQ: adding mrq_sel_filter = 1902692 to sort_context
DmQ T 35:05.4 Entering PAMS_GET_MSGW module.
DmQ T 35:05.4 Entering PAMS_COMMON_RCV
DmQ T 35:05.4 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:05.4 Available msg Types: 
DmQ T 35:05.4 Rcv Priority=0  Timeout=0  Sel_addr=-5.50
DmQ T 35:05.4 msg_area_len:32000 show_buflen:64 
DmQ T 35:05.4 Entering PAMS_ATTACH_TO_MRQS for selidx:11
DmQ T 35:05.4 Entering PAMS_ATTACH_MRQ. Attaching to mrq:50 
DmQ T 35:05.5 MRQ:50 is already attached 
DmQ T 35:05.5 Entering PAMS_SCAN_QUEUES, context addr:20b400 
DmQ T 35:05.5 Entering PAMS_SET_MRQ_INTEREST for msg context at 20b400
DmQ T 35:05.5 Entering PAMS_SCAN_LLS
DmQ T 35:05.5 Message (00E907CF:00000202) is recoverable
DmQ T 35:05.6 Entering PAMS_ADD_UNCONF_MSG(msg_ctxt=0020B400, MSN:00E907CF,00000202)
DmQ T 35:05.6 Message (00E907CF:00000202) is from a MRQ
DmQ T 35:05.6 Canceling timer for context at 20b400 with id:dec10002
DmQ T 35:05.6 Received msg: Source=1999.233 class=0 type=0 length=633 priority=0 
DmQ T 35:05.6 Return from PAMS_COMMON_RCV
SL-I-MEMUSE: memory use = 
 129 calls to LIB$GET_VM, 35 calls to LIB$FREE_VM, 171448 bytes still allocated
IMS-DECODE_MESSAGE: decode_msg
IMS-DECODE_MESSAGE: decode incoming v11 message
SL-I-ENDOFMSG: successfull end of envelope reached
IMS-READ_HEADER_INFO: read message header information
IMS-READ_HEADER_INFO: End of header reached
IMS-READ_BODY_INFO: start of Body init Body linked list
new request
read msg info, cont req = false
IMS-I-DECODE:SERVICE_NAME found in Body=[COMAND_SYNCH_SERVICE]
linkflag = 0
End of body Item reached
IMS-READ_BODY_INFO: End of body reached
IMS-I-REQCONTFLG:request cont flag=[0]
IMS-I-MSGCONTFLG: message cont flag = [0]
IMS-I-ENDOFMSG: successfull end of message reached
IMS-READ_MESSAGE_INFO: End of message reached
SL-I-MSGHANDLE: message_handle = 4
MESSAGE
	ENVELOPE
		ORIGINATOR = ,,1999.233
		SENDER     = ,COMANDRCVE,0.0
		ADDRESSEE  = ,,2001.50
		PRIORITYSTYLE = 0
		ACKSTYLE      = 1
		RECOVERYSTYLE = 2
		AUTHSTYLE     = 0
		DEFERREDTIME  = 0
	END of ENVELOPE
	HEADER
		DAYANDTIME          = 1997020310314071
		CLASS               = 0
		TYPE                = 0
		WAITSTYLE           = 2
		TRANSACTIONID       = 0
		RESPONSEID          = 0
		MESSAGEID           = 3
		REQUESTCONTINUATIONFLAG    = 0
		MESSAGECONTINUATIONFLAG    = 0
		PRECEEDINGMESSAGEID = 0
		NODEPLUSACCOUNT     = CHEST::COMANDRCVE
	END of HEADER
	BODY
		BODYITEM  - TYPE = 0,LINKFLAG = 0,SERVICE_NAME = COMAND_SYNCH_SERVICE
			ELEMENT  = [DEC_NUMBER,960184444]
			ELEMENT  = [DEC_BUSINESS_ENTITY,AE0004]
			ELEMENT  = [ADMINISTRATOR,181181]
			ELEMENT  = [SYNCH_DATA,   2E69970203IMAINTAINED]
	END of BODY
	TRAILER
		TRAILER = ,COMANDRCVE,1999.233,1997020310314071
	END of TRAILER
END of MESSAGE
SL-I-SAVERTSADR: SL_WAIT_REQ: use ORIGINATOR = 1999.233 for RTS
SL_READ_REQ: rcv_msg_ptr->seen = 0
SL_READ_REQ: found request seen,type = [0,0]
sl_get_req_elt_internal service_name_LENGTH=[20]
sl_get_req_elt_internal service_name=[COMAND_SYNCH_SERVICE]
 Processing :- DEC Nr: 960184444 L/I:    2 Transaction: E69

TOLERANCE INFORMATION
*********************
sl_get_req_elt:continuing request,unseen count=[0,0]
Unselective read return first elt from next message
*********************
SL_FINISH_REQ:-No more requests in message, free space
SL_FINISH_REQ:- current_msg_ptr->del_psb_status=139756323
SL_FINISH_REQ:- recoverable message, remove from DQF
DmQ T 35:06.4 Entering PAMS_CONFIRM_MSG
DmQ T 35:06.4 (Msg_seq_num=00E907CF,00000202, Status=00000000, Force_j=0)
DmQ T 35:06.4 Entering PAMS_FIND_UNCONF_MSG (MSN:00E907CF,00000202)
DmQ T 35:06.4 Entering PAMS_ALLOC_MSG(*size:24)
DmQ T 35:06.4 PAMS_ALLOC_MSG: ctxt_ID:1, addr:20ae00, hdr:20aea0, data:20af18
DmQ T 35:06.4 Sending Confirmation request for (e907cf,202)
DmQ T 35:06.4 Entering PAMS_SEND_MSG
DmQ T 35:06.4 Entering PAMS_COMMON_SEND
DmQ T 35:06.4 Target=2001.98 send=OK class=28 type=-840 length=24
DmQ T 35:06.4 Priority=1 delivery=20 UMA=5 timeout=0 buffer=BUF_SEND  
DmQ T 35:06.5 Buffer will be freed by PAMS_SEND_MSG
DmQ T 35:06.5 Entering PAMS_COMMON_RCV
DmQ T 35:06.5 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:06.5 Available msg Types: 
DmQ T 35:06.5 Rcv Priority=0  Timeout=200  Sel_addr=-1.11
DmQ T 35:06.5 msg_area_len:32000 show_buflen:0 
DmQ T 35:06.5 Entering PAMS_SCAN_QUEUES, context addr:20b400 
DmQ T 35:06.5 Entering PAMS_SCAN_LLS
DmQ T 35:06.5 Canceling timer for context at 20b400 with id:dec10002
DmQ T 35:06.5 Received msg: Source=2001.98 class=28 type=-841 length=0 priority=1 
DmQ T 35:06.6 Return from PAMS_COMMON_RCV
DmQ T 35:06.6 --- Msg (00E907CF,00000202) confirmed with 0X0 ---
DmQ T 35:06.6 PAMS_FREE_UNCONF (uc=0039A350, MSN:00E907CF,00000202)
DmQ T 35:06.6 Entering PAMS_SCAN_ASTQ
DmQ T 35:06.6 Entering PAMS_SCAN_LLS
SL-I-MEMUSE: memory use = 
 170 calls to LIB$GET_VM, 60 calls to LIB$FREE_VM, 168120 bytes still allocated

***********************
*Wait for next Message*
***********************
SL-I-ADDMRQ: adding mrq_sel_filter = 1902692 to sort_context
DmQ T 35:06.6 Entering PAMS_GET_MSGW module.
DmQ T 35:06.6 Entering PAMS_COMMON_RCV
DmQ T 35:06.6 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:06.6 Available msg Types: 
DmQ T 35:06.6 Rcv Priority=0  Timeout=0  Sel_addr=-5.50
DmQ T 35:06.6 msg_area_len:32000 show_buflen:64 
DmQ T 35:06.6 Entering PAMS_ATTACH_TO_MRQS for selidx:11
DmQ T 35:06.6 Entering PAMS_ATTACH_MRQ. Attaching to mrq:50 
DmQ T 35:06.6 MRQ:50 is already attached 
DmQ T 35:06.6 Entering PAMS_SCAN_QUEUES, context addr:20b400 
DmQ T 35:06.6 Entering PAMS_SET_MRQ_INTEREST for msg context at 20b400
DmQ T 35:06.7 Entering PAMS_SCAN_LLS
DmQ T 35:06.7 Entering PAMS_BLOCK_FOR_EVENT
DmQ T 35:53.0 Entering PAMS_SCAN_ASTQ
DmQ T 35:53.0 Entering PAMS_SCAN_LLS
DmQ T 35:53.0 Entering PAMS_SET_MRQ_INTEREST for msg context at 20b400
DmQ T 35:53.0 Entering PAMS_SCAN_LLS
DmQ T 35:53.0 Message (00D407D1:00000006) is recoverable
DmQ T 35:53.0 Entering PAMS_ADD_UNCONF_MSG(msg_ctxt=0020B400, MSN:00D407D1,00000006)
DmQ T 35:53.0 Message (00D407D1:00000006) is from a MRQ
DmQ T 35:53.0 Canceling timer for context at 20b400 with id:dec10002
DmQ T 35:53.0 Received msg: Source=2001.212 class=0 type=0 length=405 priority=0 
DmQ T 35:53.0 Return from PAMS_COMMON_RCV
SL-I-MEMUSE: memory use = 
 170 calls to LIB$GET_VM, 60 calls to LIB$FREE_VM, 168120 bytes still allocated
IMS-DECODE_MESSAGE: decode_msg
IMS-DECODE_MESSAGE: decode incoming v11 message
SL-I-ENDOFMSG: successfull end of envelope reached
IMS-READ_HEADER_INFO: read message header information
IMS-READ_HEADER_INFO: End of header reached
IMS-READ_BODY_INFO: start of Body init Body linked list
new request
read msg info, cont req = false
IMS-I-DECODE:SERVICE_NAME found in Body=[EXIT]
linkflag = 0
End of body Item reached
IMS-READ_BODY_INFO: End of body reached
IMS-I-REQCONTFLG:request cont flag=[0]
IMS-I-MSGCONTFLG: message cont flag = [0]
IMS-I-ENDOFMSG: successfull end of message reached
IMS-READ_MESSAGE_INFO: End of message reached
SL-I-MSGHANDLE: message_handle = 5
MESSAGE
	ENVELOPE
		ORIGINATOR = ,,2001.212
		SENDER     = ,TESTINSTALL,0.0
		ADDRESSEE  = ,,2001.50
		PRIORITYSTYLE = 0
		ACKSTYLE      = 1
		RECOVERYSTYLE = 2
		AUTHSTYLE     = 0
		DEFERREDTIME  = 0
	END of ENVELOPE
	HEADER
		DAYANDTIME          = 1997020310355287
		CLASS               = 0
		TYPE                = 0
		WAITSTYLE           = 2
		TRANSACTIONID       = 0
		RESPONSEID          = 0
		MESSAGEID           = 1
		REQUESTCONTINUATIONFLAG    = 0
		MESSAGECONTINUATIONFLAG    = 0
		PRECEEDINGMESSAGEID = 0
		NODEPLUSACCOUNT     = RDGE33::TESTINSTALL
	END of HEADER
	BODY
		BODYITEM  - TYPE = 0,LINKFLAG = 0,SERVICE_NAME = EXIT
	END of BODY
	TRAILER
		TRAILER = ,TESTINSTALL,2001.212,1997020310355287
	END of TRAILER
END of MESSAGE
SL-I-SAVERTSADR: SL_WAIT_REQ: use ORIGINATOR = 2001.212 for RTS
SL_READ_REQ: rcv_msg_ptr->seen = 0
SL_READ_REQ: found request seen,type = [0,0]
sl_get_req_elt_internal service_name_LENGTH=[4]
sl_get_req_elt_internal service_name=[EXIT]
SL_FINISH_REQ:-No more requests in message, free space
SL_FINISH_REQ:- current_msg_ptr->del_psb_status=139756323
SL_FINISH_REQ:- recoverable message, remove from DQF
DmQ T 35:53.4 Entering PAMS_CONFIRM_MSG
DmQ T 35:53.4 (Msg_seq_num=00D407D1,00000006, Status=00000000, Force_j=0)
DmQ T 35:53.4 Entering PAMS_FIND_UNCONF_MSG (MSN:00D407D1,00000006)
DmQ T 35:53.4 Entering PAMS_ALLOC_MSG(*size:24)
DmQ T 35:53.4 PAMS_ALLOC_MSG: ctxt_ID:1, addr:20ae00, hdr:20aea0, data:20af18
DmQ T 35:53.4 Sending Confirmation request for (d407d1,6)
DmQ T 35:53.4 Entering PAMS_SEND_MSG
DmQ T 35:53.4 Entering PAMS_COMMON_SEND
DmQ T 35:53.4 Target=2001.98 send=OK class=28 type=-840 length=24
DmQ T 35:53.4 Priority=1 delivery=20 UMA=5 timeout=0 buffer=BUF_SEND  
DmQ T 35:53.4 Buffer will be freed by PAMS_SEND_MSG
DmQ T 35:53.4 Entering PAMS_COMMON_RCV
DmQ T 35:53.4 Entering PAMS_SETUP_COMMON_RCV
DmQ T 35:53.4 Available msg Types: 
DmQ T 35:53.4 Rcv Priority=0  Timeout=200  Sel_addr=-1.11
DmQ T 35:53.5 msg_area_len:32000 show_buflen:0 
DmQ T 35:53.5 Entering PAMS_SCAN_QUEUES, context addr:20b400 
DmQ T 35:53.5 Entering PAMS_SCAN_LLS
DmQ T 35:53.5 Canceling timer for context at 20b400 with id:dec10002
DmQ T 35:53.5 Received msg: Source=2001.98 class=28 type=-841 length=0 priority=1 
DmQ T 35:53.5 Return from PAMS_COMMON_RCV
DmQ T 35:53.5 --- Msg (00D407D1,00000006) confirmed with 0X0 ---
DmQ T 35:53.5 PAMS_FREE_UNCONF (uc=0039A050, MSN:00D407D1,00000006)
DmQ T 35:53.5 Entering PAMS_SCAN_ASTQ
DmQ T 35:53.5 Entering PAMS_SCAN_LLS
DmQ T 35:53.7 Entering PAMS_EXIT routine
DmQ T 35:53.7 Entering PAMS_DETACH_Q
DmQ T 35:53.7 Detaching queue (0.210)
DmQ T 35:53.7 Entering PAMS_EXIT_HANDLER
DmQ T 35:53.7 Exit switches: DISABLE_FORCEX:0, DISABLE_DELTVA:0, ALLOW_PURGE:1 
DmQ T 35:53.7 PAMS_FREE_UNCONF (uc=0038E910, MSN:00E907CF,00000002)
DmQ T 35:53.7 Entering PAMS_EXIT_DNS routine
DmQ T 35:53.9 Entering PAMS_FREE_OBJECT_CACHE module.
DmQ T 35:54.0 Entering PAMS_CALL_USERS_AST module (sel_filter=-7.50)
DmQ T 35:54.0 Setting users EF (-1) and/or calling AST rtn (addr:001B0894,Actparm:0)
 
 
COMAND$SERVER has been requested to stop

SL-I-EXITHNDLR: exit handler called
$ !
$ EXIT
  COMANDRCVE   job terminated at  3-FEB-1997 10:35:55.16

  Accounting information:
  Buffered I/O count:             160         Peak working set size:    3296
  Direct I/O count:               132         Peak page file size:     13043
  Page faults:                   3322         Mounted volumes:             0
  Charged CPU time:           0 00:00:05.46   Elapsed time:     0 00:01:00.59
    
283.3FUTURS::BURRELLLive long/prosper-live short/enjoyTue Feb 04 1997 12:313
    
    After installing the correct versions of IMS and DMQ on both sending
    and receiving systems the problems has disappeared.