Backup and restore statistics
Each successful backup and restore operation generates a single record in the db2diag.log file, which provides information on the performance of that operation. The log record is informational and is dumped at diagnostic error capture level (diaglevel) 3 (the default) and 4.
Examples
The log records for backup and restore statistics consist of a row for each backup and restore buffer manipulator (db2bm) EDU and a row for each backup and restore media controller (db2med) EDU:
2024-06-04-09.55.13.829999-420 E241344E2439 LEVEL: Info
PID : 34402 TID : 139624752080448 PROC : db2sysc
INSTANCE: aprilico NODE : 000 DB : SAMPLE
APPHDL : 0-63 APPID: *LOCAL.aprilico.240604165604
UOWID : 2 LAST_ACTID: 0
AUTHID : APRILICO HOSTNAME: aprillico1-846ir-x86
EDUID : 141 EDUNAME: db2agent (SAMPLE)
FUNCTION: DB2 UDB, database utilities, sqluxLogDataStats, probe:2051
MESSAGE : Performance statistics
DATA #1 : String, 1862 bytes
Parallelism = 10
Number of buffers = 20
Buffer size = 1576960 (385 4kB pages)
Log
BM# Total I/O MsgQ WaitQ Throttle LogPhase Buffers kBytes kBytes
--- -------- -------- -------- -------- -------- -------- -------- -------- --------
000 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 19 24672 0
001 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 6 8960 0
002 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 17 24576 0
003 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 17 24576 0
004 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 17 24576 0
005 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 14 21088 0
006 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 17 24576 0
007 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 4 4864 0
008 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0 0 0
009 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0 0 0
--- -------- -------- -------- -------- -------- -------- -------- -------- --------
TOT - - - - - - 111 157888 0
MC# Total I/O MsgQ WaitQ Buffers kBytes
--- -------- -------- -------- -------- -------- --------
000 0:00:00 0:00:00 0:00:00 0:00:00 112 169432
--- -------- -------- -------- -------- -------- --------
TOT - - - - 112 169432- BM
- The db2bm engine dispatchable unit (EDU) ID.
- Total
- The length of time that each EDU existed.
- I/O
- The time spent running read or write input/output (I/O) operations, to or from stable storage.
- MsgQ
- The time spent waiting for an I/O buffer.
- WaitQ
- The time spent waiting for a state machine control message.
- Throttle
- The amount of time this EDU was paused due to utility throttling.
- LogPhase
- The amount of time that this EDU spent processing recovery logs.
- Buffers
- The number of processed I/O buffers.
- KBytes
- The quantity of processed data.
- Log kBytes
- The quantity of recovery log data processed by this EDU.
- MC
- The db2med EDU ID.
Examples
For compressed backups, the log record contains two extra columns for performance information about the compression operation:
2024-06-04-09.58.09.256872-420 E37662814E2208 LEVEL: Info
PID : 35329 TID : 139953824589376 PROC : db2sysc
INSTANCE: aprilico NODE : 000 DB : ITPDB
APPHDL : 0-124 APPID: *LOCAL.aprilico.240604165859
UOWID : 3 LAST_ACTID: 0
AUTHID : APRILICO HOSTNAME: aprillico1-846ir-x86
EDUID : 274 EDUNAME: db2agent (ITPDB)
FUNCTION: DB2 UDB, database utilities, sqluxLogDataStats, probe:2051
MESSAGE : Performance statistics
DATA #1 : String, 1633 bytes
Parallelism = 5
Number of buffers = 10
Buffer size = 16781312 (4097 4kB pages)
Compr Log
BM# Total I/O Compr MsgQ WaitQ Throttle LogPhase Buffers kBytes kBytes kBytes
--- -------- -------- -------- -------- -------- -------- -------- -------- -------- -------- --------
000 0:00:03 0:00:00 0:00:00 0:00:00 0:00:03 0:00:00 0:00:00 9 115085 115487 0
001 0:00:03 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 2 768 780 12
002 0:00:03 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 2 17152 17152 0
003 0:00:03 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 7 108032 108032 0
004 0:00:03 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 0:00:00 1 10496 10496 0
--- -------- -------- -------- -------- -------- -------- -------- -------- -------- -------- --------
TOT - - - - - - - 21 251533 251947 12
MC# Total I/O MsgQ WaitQ Buffers kBytes
--- -------- -------- -------- -------- -------- --------
000 0:00:03 0:00:00 0:00:00 0:00:03 22 327792
--- -------- -------- -------- -------- -------- --------
TOT - - - - 22 327792- Compr
- The time spent running the compression operation.
- Compr Bytes
- The quantity of uncompressed data that was compressed.