HHC00398I 02:07:32.759894 0:0148> file[0] l2[10,29] trk[2589] read_l2ent 0x4d08
HHC00398I 02:07:32.759898 0:0148> file[0] read_l2 10 active 0 10 2
HHC00398I 02:07:32.759901 0:0148> file[0] l2[10,29] trk[2589] read_l2ent 0x14c1f2f 6290 6290
HHC00398I 02:07:32.759904 0:0148> file[0] fd[16] read, off 0x14c1f2f len 6290
HHC00398I 02:07:32.759918 0:0148> 0 rdtrk[208] 2589 complete buf 0000000007F67CD0:0100560009
HHC00398I 02:07:32.759922 0:0148> uncompress comp 1 len 6290 maxlen 19456 trk 2589
HHC00398I 02:07:32.760082 0:0148> uncompress zlib newlen 13065 rc 0
HHC00398I 02:07:32.760085 0:0148> validating trk 2589 len 13065 0000560009 0056000900000008
HHC00398I 02:07:32.760091 0:0148> read trk 2589 uncompressed len 13065
HHC00398I 02:07:32.760096 0:0148> end i/o bufcur 2589 cache[208] waiters 0
HHC00398I 02:07:32.760104 0:0148> start i/o file[0] bufcur 2589 cache[208]
HHC00398I 02:07:32.760112 0:0148> end i/o bufcur 2589 cache[208] waiters 0
HHC00398I 02:07:32.760118 0:0148> start i/o file[0] bufcur 2589 cache[208]
HHC00398I 02:07:32.760124 0:0148> end i/o bufcur 2589 cache[208] waiters 0
.
several lines not displayed
.
HHC00398I 02:07:32.760712 0:0148> end i/o bufcur 2589 cache[208] waiters 0
HHC00398I 02:07:32.760718 0:0148> start i/o file[0] bufcur 2589 cache[208]
HHC00398I 02:07:32.760722 0:0148> end i/o bufcur 2589 cache[208] waiters 0
HHC00398I 02:07:32.760728 0:0148> start i/o file[0] bufcur 2589 cache[208]
HHC00398I 02:07:32.760732 0:0148> read trk 2590 (synchronous)
HHC00398I 02:07:32.760734 0:0148> 0 rdtrk 2590
HHC00398I 02:07:32.760737 0:0148> 0 rdtrk[209] 2590 syncio cache miss
HHC00398I 02:07:32.760748 0:0148> read trk 2590 (asynchronous)
HHC00398I 02:07:32.760751 0:0148> 0 rdtrk 2590
HHC00398I 02:07:32.760754 0:0148> 0 rdtrk[209] 2590 cache miss
HHC00398I 02:07:32.760769 0:0148> 0 rdtrk[209] 2590 buf 0000000007F6C8E0 len 19456
HHC00398I 02:07:32.760773 0:0148> trk[2590] read_trkimg
HHC00398I 02:07:32.760775 0:0148> file[0] l2[10,30] trk[2590] read_l2ent 0x4d08
HHC00398I 02:07:32.760779 0:0148> file[0] read_l2 10 active 0 10 2
HHC00398I 02:07:32.760782 0:0148> file[0] l2[10,30] trk[2590] read_l2ent 0x14c37c1 4716 4716
HHC00398I 02:07:32.760785 0:0148> file[0] fd[16] read, off 0x14c37c1 len 4716
HHC00398I 02:07:32.760798 0:0148> 0 rdtrk[209] 2590 complete buf 0000000007F6C8E0:010056000a
HHC00398I 02:07:32.760803 0:0148> uncompress comp 1 len 4716 maxlen 19456 trk 2590
HHC00398I 02:07:32.760927 0:0148> uncompress zlib newlen 9813 rc 0
HHC00398I 02:07:32.760929 0:0148> validating trk 2590 len 9813 000056000a 0056000a00000008
HHC00398I 02:07:32.760935 0:0148> read trk 2590 uncompressed len 9813
HHC00398I 02:07:32.760940 0:0148> end i/o bufcur 2590 cache[209] waiters 0
HHC00398I 02:07:32.760947 0:0148> start i/o file[0] bufcur 2590 cache[209]
HHC00398I 02:07:32.760954 0:0148> end i/o bufcur 2590 cache[209] waiters 0
HHC00398I 02:07:32.760960 0:0148> start i/o file[0] bufcur 2590 cache[209]
HHC00398I 02:07:32.760966 0:0148> end i/o bufcur 2590 cache[209] waiters 0
.
.
.
Figure 164: K command