Die Auswertungsliste TRACE2 listet die wichtigsten Ereignisse in den Teilprogrammen der Anwendung sequenziell auf. Da die Auswertung nicht wie in der Liste TRACE in Spalten für die UTM-Prozesse erfolgt, kann die Liste TRACE2 beliebig viele Prozesse anzeigen. TRACE2 enthält zusätzlich zu den Einträgen der Auswertung TRACE wichtige Daten zur Performanceanalyse.
Die Einträge in der Auswertung sind in zeitlicher Reihenfolge sortiert. Die Spalte TIME STAMP enthält den Zeitstempel des Ereignisses (in Mikrosekunden).
Die Auswertungsliste TRACE2 erfasst folgende Ereignisse und Daten:
Start eines Teilprogramms als Eintrag
strt >>> tac
mitTransaktionscode des Teilprogramms
TAC-Klasse
aktueller I/O- und CPU-Stempel (in Millisekunden)
Wartezeit der Nachricht in BCAM
Wartezeit des Auftrags in der TAC-Klasse
Alle UTM-Funktionsaufrufe mit Operationscode und -modifikation und zusätzlich folgende Informationen:
KCMF bei Aufrufen, bei denen KCMF relevant ist
KCRN bei Aufrufen, bei denen KCRN relevant ist
KCLT bei den Aufrufen PADM und DADM
Bei PEND-Aufrufen mit KCOM = ER/FR/RS und bei den Datenbankaufrufen FITA und CATA die Transaction-ID (SC,VC,TC und VN) für die Zuordnung zum abgebrochenen Vorgang.
Wenn KCRCCC ungleich 0, die Returncodes KCRCCC und KCRCDC und die Transaction-ID (SC,VC,TC und VN).
Alle Datenbankaufrufe, wenn die UTM-Anwendung koordiniert mit dem DB-System zusammenarbeitet. Die Aufrufe an das Datenbanksystem werden protokolliert mit einem Eintrag DBCL opcode db-time.
opcode und db-time haben die gleiche Bedeutung wie bei der Liste TRACE.
Wenn auf der Seite des DBH der SESCOS eingeschaltet ist, wird bei Aufrufen an das Datenbanksystem SESAM zusätzlich eine Information
SESCOS-INFO -->
xyttttnnnmmmmmmmm protokolliert. Die Werte ermöglichen die Zuordnung von TRACE2-Listen und SESCOS-Auswertung. Sehen Sie dazu auch die Beschreibung der Felder für die TRACE-Liste in Abschnitt "TRACE: TASK SPECIFIC TRACES".Ende des Teilprogramms als Eintrag
WAIT end<<<<
mitCPU-Verbrauch im Teilprogramm in Mikrosekunden in Spalte „CPU“
Anzahl I/Os im Teilprogramm in Spalte „I/0“
Am Ende der Spalte "TRACE" werden in vier Zeichen die Sedezimal-Werte der beiden ersten Bytes des Börsen-Announcements protokolliert, das diesen Börsen-Zyklus gestartet hat.
Diese Information dient dem Software Service zur besseren Analyse.
Eine logische Prozessornummer, die KDCMON liefert.
Jede Nummer identifiziert dabei jeweils eine CPU. Die Nummer wird in der Auswertung in der Spalte „ID“ angezeigt. Auf Multiprozessoranlagen kann damit festgestellt werden, welche UTM-Prozesse parallel laufen.
Die Strukturelemente <<<<<<
in der Liste erleichtern die Lesbarkeit der Einträge.
Die Auswertungsliste TRACE2 hat das folgende Format.
TIME STAMP | TRACE | ID TSN | SC VC TC VN|KCRN CPU |KCMF I/O |TACCLASS Q.TIME |BCAM W.TIME
10:48:08.353714| DBCL USRC 205| 1 8E8R | | | | |
10:48:08.353761| CONT 31 -------------| 1 8E85 | 1 192108 1 31| | | |
10:48:08.353900| WAIT -------------| 1 " | | | | |
10:48:08.353905+ WAIT end <<<<< 45C5+ 1 " |<<<<<<<<<<<<<<<<<<<<<<<<<<<<| +621 | +2 |<<<<<<<<<<<<<<< |<<<<<<<<<<<
10:48:08.353925| DBCL USRC 2065| 1 8E8R | | | | |
10:48:08.356002| DBCL USRC 205| 1 " | | | | |
10:48:08.356213| DBCL USRC 3| 1 " | | | | |
10:48:08.356219+ DBCL USRC 3370+ 1 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.357268| strt >>>RDUDS | 1 8E85 | 1 192110 1 32| 40758 | 98786 | 0 * 0 | 0
10:48:08.357321| INIT -------------| 1 " | | | | |
10:48:08.357335| MGET -------------| 1 " | | | | |
10:48:08.357355+ DBCL USRC 8+ 1 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.357370| DBCL USRC 307| 1 " | | | | |
10:48:08.357685| DBCL USRC 2| 1 " | | | | |
10:48:08.357690| DBCL USRC 121| 1 " | | | | |
10:48:08.357818+ DBCL USRC 1+ 1 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.357822| DBCL USRC 2| 1 " | | | | |
10:48:08.357835| MPUT NT -------------| 1 " | | | | |
10:48:08.357850| MPUT NT -------------| 1 " | | | | |
10:48:08.357859+ MPUT NT -------------+ 1 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.357868| PEND FI -------------| 1 " | | | | |
10:48:08.358905| strt >>>WRUDS | 1 8E83 | 1 192111 1 33| 41722 | 100624 | 0 * 0 | 0
10:48:08.358975| INIT -------------| 1 " | | | | |
10:48:08.358986+ MGET -------------+ 1 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.359007| DBCL USRC 7| 1 " | | | | |
10:48:08.359018| DBCL USRC 707| 1 " | | | | |
10:48:08.359214| strt >>>WRUDS | 2 8E86 | 1 192112 1 30| 40893 | 98246 | 0 * 0 | 0
10:48:08.359274+ INIT -------------+ 2 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.359286| MGET -------------| 2 " | | | | |
10:48:08.359304| DBCL USRC 6| 2 " | | | | |
10:48:08.359317| DBCL USRC 173| 2 " | | | | |
10:48:08.359496+ DBCL USRC 1+ 2 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.359500| DBCL USRC 41| 2 " | | | | |
10:48:08.359544| DBCL USRC 1188| 2 " | | | | |
10:48:08.359614| RSET -------------| 1 8E8R | 1 192109 1 34| | | |
10:48:08.359653+ DBCL CATA 192+ 1 " + 1 192109 1 34+ ----------- +-------------+------------------+-----------
10:48:08.359734| DBCL USRC 1| 1 8E83 | | | | |
10:48:08.359738| DBCL USRC 129| 1 " | | | | |
10:48:08.359850| DBCL EDVG 87| 1 8E8R | | | | |
10:48:08.359872+ DBCL USRC 2389+ 1 8E83 +----------------------------+-------------+-------------+------------------+-----------
10:48:08.359945| CONT 4C -------------| 1 8E8R | 1 192109 1 34| | | |
10:48:08.359992| DBCL USRC 5| 1 " | | | | |
10:48:08.360002| DBCL USRC 251| 1 " | | | | |
10:48:08.360262+ DBCL USRC 111+ 1 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.360378| DBCL USRC 34| 1 " | | | | |
10:48:08.360417| DBCL USRC 2| 1 " | | | | |
10:48:08.360423| DBCL USRC 4689| 1 " | | | | |
10:48:08.360740+ DBCL USRC 2+ 2 8E86 +----------------------------+-------------+-------------+------------------+-----------
10:48:08.360745| DBCL USRC 2| 2 " | | | | |
10:48:08.360757| MPUT NT -------------| 2 " | | | | |
10:48:08.360777| MPUT NT -------------| 2 " | | | | |
10:48:08.360785+ MPUT NT -------------+ 2 " +----------------------------+-------------+-------------+------------------+-----------
10:48:08.360795| PEND FI -------------| 2 " | | | | |
10:48:08.361494| DBCL FITA 574| 1 8E85 | 1 192110 1 32| | | |
10:48:08.362080| CONT 31 -------------| 1 " | | | | |