The most important events in the program units of the applications are contained in the TRACE2 evaluation list in sequence. Since the evaluation is not broken down into columns for the UTM tasks as in the TRACE list, the TRACE2 list can show any number of tasks. In addition to the entries of the TRACE evaluation, TRACE2 also contains important data for performance analysis.
The entries in the evaluation are sorted in chronological order. The TIME STAMP column contains the time stamp of the event (accuracy: milliseconds).
The TRACE2 evaluation list records the following events and data:
Start of a program unit as an entry
strt >>>tac withTransaction code of the program unit
TAC class
Current I/O and CPU stamp
Wait time of job in the TAC class
All UTM function calls with operation code and modification, plus the information:
KCMF for KCMF-relevant calls
KCRN for KCRN-relevant calls
KCLT for PADM and DADM calls
For PEND calls with KCOM = ER/FR/RS, the transaction ID (SC,VC,TC, and VN) for the assignment to the aborted service.
If KCRCCC
!=0, the return codes KCRCDC and KCRRCC and the transaction ID (SC,VC,TC and VN).
End of the program unit as an entry
WAIT end<<<<withCPU utilization in the program unit in microseconds in the “CPU” column
I/O utilization in the program unit in column “I/0”
At the end of column "TRACE" the first two bytes of the last bourse announcement are rendered as four characters representing the sedecimal value of the announcement.
This information allows the system service a better analysis and diagnosis of possible performance problems.
The structure elements <<<<<< in the list make it easier to read the entries.
Example
TIME STAMP | TRACE | PID | SC VC TC VN|KCRN CPU |KCMF I/O |TACCLASS Q.TIME | 16:39:38.339+ INIT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.339| MGET -------------| " | | | | | 16:39:38.339| ADMI -------------| " | | | | | 16:39:38.339| ADMI -------------| " | | | | | 16:39:38.339+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.339| MPUT NT -------------| " | | | | | 16:39:38.339| MPUT NT -------------| " | | | | | 16:39:38.339| MPUT NT -------------| " | | | | | 16:39:38.339+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.339| MPUT NT -------------| " | | | | | 16:39:38.339| MPUT NT -------------| " | | | | | 16:39:38.339| MPUT NT -------------| " | | | | | 16:39:38.339+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.339| MPUT NT -------------| " | | | | | 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340| MPUT NT -------------| " | | | | | 16:39:38.340| | " | | | | | 16:39:38.341+ PEND FI -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:38.342| WAIT -------------| " | | | | | 16:39:38.342| WAIT end<<<<< 4545| " |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| +1071 | +2 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:44.194| CONT -------------| " | | | | | 16:39:44.194+ strt >>>palget + " + 2 13 1 6+ 102 + 15 + 0 * 0 + 0 16:39:44.194| | " | | | | | 16:39:44.198| INIT -------------| " | | | | | 16:39:44.198| MGET -------------| 7645 | 2 13 1 6| | | | 16:39:44.198| ADMI -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198| MPUT NT -------------| " | | | | | 16:39:44.198+ MPUT NT -------------+ " +----------------------------+-------------+-------------+------------------+----------- 16:39:44.198| | " | | | | | 16:39:44.206| PEND FI -------------| " | | | | | 16:39:44.207| WAIT -------------| " | | | | | 16:39:44.207+ WAIT end<<<<< 4545+ " |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| +867 | +2 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:44.891| WAIT end<<<<< F602| " |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| +17 | +0 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:44.891| WAIT end<<<<< F0F7| 7628 |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| +17 | +0 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:54.878| WAIT end<<<<< F602| 7640 |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| 91 | 6 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:54.879+ WAIT end<<<<< 00F7+ 7644 |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| 81 | 6 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:54.901| WAIT end<<<<< F602| " |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| +17 | +0 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:54.901| WAIT end<<<<< F0F7| 7640 |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| +9473 | +0 |<<<<<<<<<<<<<<< |<<<<<<<<<<< 16:39:57.154| CONT -------------| " | | | | | 16:39:57.154+ strt >>>CSELEMP + " + 2 14 1 6+ 100 + 6 + 0 * 0 + 016:39:57.154| | " | | | | |
16:39:57.155| INIT -------------| " | | | | |
16:39:57.155| MGET -------------| " | | | | |
16:39:57.161+ MPUT NE -------------+ " +----------------------------+-------------+-------------+------------------+-----------
16:39:57.161| | " | | | | | 16:39:57.162| PEND FI -------------| " | | | | |