Output from a SYSJES trace

Example: merged output from four SYSJES sublevel traces with FULL parameter is an example of merged output from the four SYSJES sublevel traces with the FULL parameter specified.

Example: merged output from four SYSJES sublevel traces with FULL parameter

_______________________________________________________________________________
********** MERGED TRACES ***********
01. CTRACE comp(sysjes) sub((flow)) full
02. CTRACE comp(sysjes) sub((usrxit)) full
03. CTRACE comp(sysjes) sub((msgtrc)) full
04. CTRACE comp(sysjes) sub((xcfevt)) full

_______________________________________________________________________________
 COMPONENT TRACE FULL FORMAT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((FLOW))

_______________________________________________________________________________
 COMPONENT TRACE FULL FORMAT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((USRXIT))

_______________________________________________________________________________
 COMPONENT TRACE FULL FORMAT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((MSGTRC))

_______________________________________________________________________________
 COMPONENT TRACE FULL FORMAT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((XCFEVT))

 **** 10/25/93
      MNEMONIC  ENTRY ID    TIME STAMP     DESCRIPTION
      --------  --------  ---------------  -----------
 04.  XCFEVT    00000030  16:53:54.876999  XCF event message buffer
    HOMEASID 0013     JOBNAME. JESXCF   HOMETCB@ 007EA6F8
    CPUID... FF170945 30900000          CTCR@... 03062460 MEMBER.. SY1
                      SYSNAME. SY1
    MSGBUF@. 20000014 ALET.... 0101001B REQTOKEN 00000001 20000014
    MSGTOKEN 00000001 20000014
    +0000  E8C9E7C5 D5400100 00000001 00000001 | YIXEN .......... |
    +0010  E2E8E2E9 D1C5E2F3 E2E8E2C5 E5C5D5E3 | SYSZJES3SYSEVENT |
    +0020  40404040 40404040 E2E8E2C5 E5C5D5E3 |         SYSEVENT |
    +0030  40404040 40404040 E2E8E2E9 D1C5E2F3 |         SYSZJES3 |
    +0040  E2E8E2C5 E5C5D5E3 40404040 40404040 | SYSEVENT         |
    +0050  E2E8E2C5 E5C5D5E3 40404040 40404040 | SYSEVENT         |
    +0060  10001000 80000108 01140000 00000000 | ................ |
    +0070  00000000 A849C5A7 AE08EC01 00000000 | ....y.Ex........ |
    +0080  00000000 00000000 00000000 00000000 | ................ |
                            .
                            .
                            .
**** 10/25/93
      MNEMONIC  ENTRY ID    TIME STAMP     DESCRIPTION
      --------  --------  ---------------  -----------
 02.  PREXIT3   00000007  16:53:55.303610  SPELL prior to Exit 3 processing
    HOMEASID 0017     JOBNAME. JES3     HOMETCB@ 007FD2B8
    CPUID... FF170945 30900000          CTCR@... 03062460 MEMBER.. SY1
                      SYSNAME. SY1
    XPLBUF@. 03368000
    +0000  E95BE7D7 D3400101 C9E7E9E7 C9E3F0F3 | Z$XPL ..IXZXIT03 |
    +0010  40404040 40404040 40000000 80000000 |          ....... |
    +0020  00000000 00000000 00000000 00000000 | ................ |
    +0030  00000054 00000038 E2E8E2E9 D1C5E2F3 | ........SYSZJES3 |
    +0040  E2E8F140 40404040 40404040 40404040 | SY1              |
    +0050  00000000                            | ....             |
 02.  POSTXIT3  00000008  16:53:55.306462  SPELL after Exit 3 processing
    HOMEASID 0017     JOBNAME. JES3     HOMETCB@ 007FD2B8
    CPUID... FF170945 30900000          CTCR@... 03062460 MEMBER.. SY1
                      SYSNAME. SY1
    XPLBUF@. 03368000
    +0000  E95BE7D7 D3400101 C9E7E9E7 C9E3F0F3 | Z$XPL ..IXZXIT03 |
    +0010  40404040 40404040 40000000 80000000 |          ....... |
    +0020  00000000 00000000 00000000 00000000 | ................ |
    +0030  00000054 00000038 E2E8E2E9 D1C5E2F3 | ........SYSZJES3 |
    +0040  E2E8F140 40404040 40404040 40404040 | SY1              |
    +0050  00000000                            | ....             |
 **** 10/25/93
      MNEMONIC  ENTRY ID    TIME STAMP     DESCRIPTION
      --------  --------  ---------------  -----------
 03.  INDATA    00000011  16:55:17.318441  input message data
    HOMEASID 0017     JOBNAME. JES3     HOMETCB@ 007FD2B8
    CPUID... FF170945 30900000          CTCR@... 03062460 MEMBER.. SY1
                      SYSNAME. SY1
    MSGBUF@. 1FFFF814 ALET.... 0102001B REQTOKEN 00000001 1FFFF814
    MSGTOKEN 00000001 1FFFF814
    +0000  E8C9E7C5 D5400100 00000001 00000001 | YIXEN .......... |
    +0010  E2E8E2E9 D1C5E2F3 E2E8F240 40404040 | SYSZJES3SY2      |
    +0020  40404040 40404040 E2E8E2D1 C5E24040 |         SYSJES   |
    +0030  C3D6D5E2 C5D9E540 E2E8E2E9 D1C5E2F3 | CONSERV SYSZJES3 |
    +0040  E2E8F140 40404040 40404040 40404040 | SY1              |
    +0050  E2E8E2D1 C5E24040 C3D6D5E2 C5D9E540 | SYSJES  CONSERV  |
    +0060  20001000 20000100 01148000 00000000 | ................ |
    +0070  00000000 A849C5F6 19827F03 00000000 | ....y.E6.b"..... |
    +0080  00000000 007FD2B8 00FC1D00 00000000 | ....."K......... |
    +0090  00000214 00000000 00000000 00000001 | ................ |
    +00A0  1FFFF814 00000000 00000000 00000000 | ..8............. |
                            .
                            .
                            .
 02.  EXIT1ERR  00000003  16:55:17.474658  SPELL error Exit 1 processing
    HOMEASID 0017     JOBNAME. JES3     HOMETCB@ 007FD2B8
    CPUID... FF170945 30900000          CTCR@... 03062460 MEMBER.. SY1
                      SYSNAME. SY1
    XPLBUF@. 1FFFF414
    MSGBUF@. 1FFFF814 ALET.... 0102001B REQTOKEN 00000001 1FFFF814
    MSGTOKEN 00000001 1FFFF814
    +0000  E95BE7D7 D3400100 C9E7E9E7 C9E3F0F1 | Z$XPL ..IXZXIT01 |
    +0010  40404040 40404040 40000000 20000000 |          ....... |
    +0020  00000000 00000000 00000000 00000000 | ................ |
    +0030  000001A0 00000038 E2E8E2E9 D1C5E2F3 | ........SYSZJES3 |
    +0040  E2E8F240 40404040 40404040 40404040 | SY2              |
    +0050  E2E8E2D1 C5E24040 C3D6D5E2 C5D9E540 | SYSJES  CONSERV  |
    +0060  E2E8E2E9 D1C5E2F3 E2E8F140 40404040 | SYSZJES3SY1      |
    +0070  40404040 40404040 E2E8E2D1 C5E24040 |         SYSJES   |
    +0080  C3D6D5E2 C5D9E540 00000100 1FFFF4B4 | CONSERV ......4. |
    +0090  00000000 00000000 0000E300 00000000 | ..........T..... |
    +00A0  E3C8C9E2 40C9E240 C1D540C1 E2E8D5C3 | THIS IS AN ASYNC |
    +00B0  C8C1C3D2 40D4C5E2 E2C1C7C5 40404040 | HACK MESSAGE     |
    +00C0  40404040 40404040 40404040 40404040 |                  |
    +00D0  40404040 40404040 40404040 40404040 |                  |
    +00E0  40404040 40404040 40404040 40404040 |                  |
    +00F0  40404040 40404040 40404040 40404040 |                  |
    +0100  40404040 40404040 40404040 40404040 |                  |
    +0110  40404040 40404040 40404040 40404040 |                  |
    +0120  40404040 40404040 40404040 40404040 |                  |
    +0130  40404040 40404040 40404040 40404040 |                  |
    +0140  40404040 40404040 40404040 40404040 |                  |
    +0150  40404040 40404040 40404040 40404040 |                  |
    +0160  40404040 40404040 40404040 40404040 |                  |
    +0170  40404040 40404040 40404040 40404040 |                  |
    +0180  40404040 40404040 40404040 40404040 |                  |
    +0190  40404040 40404040 40404040 40404040 |                  |
 03.  SEND      00000010  16:55:17.568558  message queued to be sent
    HOMEASID 0013     JOBNAME. JESXCF   HOMETCB@ 007EA6F8
    CPUID... FF170945 30900000          CTCR@... 03062460 MEMBER.. SY1
                      SYSNAME. SY1
    MSGBUF@. 1FFFF814 ALET.... 0102001B REQTOKEN 00000001 1FFFF814
    MSGTOKEN 00000001 1FFFF814
    +0000  E8C9E7C5 D5400100 00000001 00000001 | YIXEN .......... |
    +0010  E2E8E2E9 D1C5E2F3 E2E8F240 40404040 | SYSZJES3SY2      |
    +0020  40404040 40404040 E2E8E2D1 C5E24040 |         SYSJES   |
    +0030  C3D6D5E2 C5D9E540 E2E8E2E9 D1C5E2F3 | CONSERV SYSZJES3 |
    +0040  E2E8F140 40404040 40404040 40404040 | SY1              |
    +0050  E2E8E2D1 C5E24040 C3D6D5E2 C5D9E540 | SYSJES  CONSERV  |
                            .
                            .
                            .

Figure 1 is an example of merged output from the four SYSJES sublevel traces with the TALLY parameter specified. Use the TALLY report to look at event identifiers in the trace output.

Figure 1. Example: merged output from the four SYSJES sublevel traces with the TALLY parameter
_______________________________________________________________________________
 COMPONENT TRACE TALLY REPORT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((FLOW))
     TRACE ENTRY COUNTS AND AVERAGE INTERVALS (IN MICROSECONDS)
 FMTID     COUNT     INTERVAL      MNEMONIC  DESCRIBE
 --------  --------  ------------  --------  --------------------------------
 00000020        29     6,902,004  MSGFLOW   module flow for this message
 00000021       114     1,755,686  MODFLOW   module flow
 0000002E         3     2,631,973  MSGERR    module error flow
 0000002F         7    27,207,632  MODERR    module error flow
Total trace entries:      153
_______________________________________________________________________________
 COMPONENT TRACE TALLY REPORT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((MSGTRC))
     TRACE ENTRY COUNTS AND AVERAGE INTERVALS (IN MICROSECONDS)
 FMTID     COUNT     INTERVAL      MNEMONIC  DESCRIBE
 --------  --------  ------------  --------  --------------------------------
 00000010        13    17,076,718  SEND      message queued to be sent
 00000011        17    12,821,783  INDATA    input message data
 00000012         0                SENDBUF   buffer sent by XCF
 00000013         0                SENDQERR  Sendq queueing error
 00000014         0                SBUFERR   Send error from XCF
 00000018        13    17,061,037  RECEIVE   msg dequeued from receive
 00000019        10    30,944,882  OUTDATA   output message data
 0000001A        26     8,192,076  RECVBUF   buffer received from XCF
 0000001B         0                RBUFERR   Receive error from XCF
 0000001C         0                RECVQERR  Receiveq queueing error
Total trace entries:       79
_______________________________________________________________________________
 COMPONENT TRACE TALLY REPORT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((XCFEVT))
     TRACE ENTRY COUNTS AND AVERAGE INTERVALS (IN MICROSECONDS)
 FMTID     COUNT     INTERVAL      MNEMONIC  DESCRIBE
 --------  --------  ------------  --------  --------------------------------
 00000030        27    35,794,857  XCFEVT    XCF event message buffer
 00000031         0                XCFERR    XCF event message error
Total trace entries:       27
_______________________________________________________________________________
 COMPONENT TRACE TALLY REPORT
 SYSNAME(SY1)
 COMP(SYSJES)  SUBNAME((USRXIT))
     TRACE ENTRY COUNTS AND AVERAGE INTERVALS (IN MICROSECONDS)
 FMTID     COUNT     INTERVAL      MNEMONIC  DESCRIBE
 --------  --------  ------------  --------  --------------------------------
 00000001         1                PREXIT1   SPELL prior to Exit 1 processing
 00000002         0                POSTXIT1  SPELL after Exit 1 processing
 00000003         1                EXIT1ERR  SPELL error Exit 1 processing
 00000004         1                PREXIT2   SPELL prior to Exit 2 processing
 00000005         0                POSTXIT2  SPELL after Exit 2 processing
 00000006         1                EXIT2ERR  SPELL error Exit 2 processing
 00000007        14    60,329,405  PREXIT3   SPELL prior to Exit 3 processing
 00000008        14    60,374,425  POSTXIT3  SPELL after Exit 3 processing
 00000009         0                EXIT3ERR  SPELL error Exit 3 processing
Total trace entries:       32