------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------ SID @INST, USERNAME , TYPE, STATISTIC , DELTA, HDELTA/SEC, %TIME, GRAPH , NUM_WAITS, WAITS/SEC, AVERAGES ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------ 1864 @2, GGS , STAT, Requests to/from client , 347, 53.68, , , , , .69 per execution 1864 @2, GGS , STAT, opened cursors cumulative , 170, 26.3, , , , , .34 per execution 1864 @2, GGS , STAT, user commits , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, user calls , 354, 54.77, , , , , .71 per execution 1864 @2, GGS , STAT, recursive calls , 227, 35.12, , , , , 88.11us recursive CPU per recursive call 1864 @2, GGS , STAT, recursive cpu usage , 2, .31, , , , , 20ms total recursive CPU usage 1864 @2, GGS , STAT, session logical reads , 8347, 1.29k, , , , , 8.39k total buffer visits 1864 @2, GGS , STAT, CPU used when call started , 11, 1.7, , , , , 110ms total CPU used when call started 1864 @2, GGS , STAT, CPU used by this session , 11, 1.7, , , , , 110ms total CPU used by this session 1864 @2, GGS , STAT, DB time , 642, 99.32, , , , , 1.28 per execution 1864 @2, GGS , STAT, cluster wait time , 5, .77, , , , , .01 per execution 1864 @2, GGS , STAT, concurrency wait time , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, user I/O wait time , 614, 94.99, , , , , 1.22 per execution 1864 @2, GGS , STAT, non-idle wait time , 620, 95.92, , , , , 1.24 per execution 1864 @2, GGS , STAT, non-idle wait count , 1347, 208.39, , , , , 2.68 per execution 1864 @2, GGS , STAT, messages sent , 31, 4.8, , , , , .06 per execution 1864 @2, GGS , STAT, session pga memory , 131072, 20.28k, , , , , 131.07k actual value in end of snapshot 1864 @2, GGS , STAT, enqueue waits , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, enqueue requests , 45, 6.96, , , , , .09 per execution 1864 @2, GGS , STAT, enqueue releases , 43, 6.65, , , , , .09 per execution 1864 @2, GGS , STAT, global enqueue gets sync , 33, 5.11, , , , , .07 per execution 1864 @2, GGS , STAT, global enqueue releases , 31, 4.8, , , , , .06 per execution 1864 @2, GGS , STAT, physical read total IO requests , 348, 53.84, , , , , .69 per execution 1864 @2, GGS , STAT, physical read total bytes , 2850816, 441.04k, , , , , 5.68k per execution 1864 @2, GGS , STAT, cell physical IO interconnect bytes , 2850816, 441.04k, , , , , 5.68k per execution 1864 @2, GGS , STAT, gcs messages sent , 290, 44.87, , , , , .58 per execution 1864 @2, GGS , STAT, ges messages sent , 6, .93, , , , , .01 per execution 1864 @2, GGS , STAT, db block gets , 7431, 1.15k, , , , , 14.8 per execution 1864 @2, GGS , STAT, db block gets from cache , 7431, 1.15k, , , , , 14.8 per execution 1864 @2, GGS , STAT, db block gets from cache (fastpath) , 1925, 297.81, , , , , 3.83 per execution 1864 @2, GGS , STAT, consistent gets , 916, 141.71, , , , , 1.82 per execution 1864 @2, GGS , STAT, consistent gets from cache , 916, 141.71, , , , , 1.82 per execution 1864 @2, GGS , STAT, consistent gets from cache (fastpath) , 419, 64.82, , , , , .83 per execution 1864 @2, GGS , STAT, consistent gets - examination , 446, 69, , , , , .89 per execution 1864 @2, GGS , STAT, logical read bytes from cache , 68386816, 10.58M, , , , , 136.23k per execution 1864 @2, GGS , STAT, physical reads , 348, 53.84, , , , , .69 per execution 1864 @2, GGS , STAT, physical reads cache , 348, 53.84, , , , , .69 per execution 1864 @2, GGS , STAT, physical read IO requests , 348, 53.84, , , , , 8.19k bytes per request 1864 @2, GGS , STAT, physical read bytes , 2850816, 441.04k, , , , , 5.68k per execution 1864 @2, GGS , STAT, db block changes , 4444, 687.52, , , , , 8.85 per execution 1864 @2, GGS , STAT, consistent changes , 8, 1.24, , , , , .02 per execution 1864 @2, GGS , STAT, free buffer requested , 475, 73.49, , , , , .95 per execution 1864 @2, GGS , STAT, hot buffers moved to head of LRU , 925, 143.1, , , , , 1.84 per execution 1864 @2, GGS , STAT, free buffer inspected , 694, 107.37, , , , , 1.38 per execution 1864 @2, GGS , STAT, commit cleanout failures: block lost , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, commit cleanout failures: callback failure , 44, 6.81, , , , , .09 per execution 1864 @2, GGS , STAT, commit cleanouts , 900, 139.24, , , , , 1.79 per execution 1864 @2, GGS , STAT, commit cleanouts successfully completed , 855, 132.27, , , , , 1.7 per execution 1864 @2, GGS , STAT, switch current to new buffer , 34, 5.26, , , , , .07 per execution 1864 @2, GGS , STAT, shared hash latch upgrades - no wait , 10, 1.55, , , , , .02 per execution 1864 @2, GGS , STAT, calls to kcmgcs , 98, 15.16, , , , , .2 per execution 1864 @2, GGS , STAT, calls to kcmgas , 125, 19.34, , , , , .25 per execution 1864 @2, GGS , STAT, calls to get snapshot scn: kcmgss , 346, 53.53, , , , , .69 per execution 1864 @2, GGS , STAT, redo entries , 2566, 396.98, , , , , 5.11 per execution 1864 @2, GGS , STAT, redo size , 1261700, 195.19k, , , , , 1.26M bytes per user commit 1864 @2, GGS , STAT, redo ordering marks , 73, 11.29, , , , , .15 per execution 1864 @2, GGS , STAT, redo subscn max counts , 3, .46, , , , , .01 per execution 1864 @2, GGS , STAT, file io wait time , 6006037, 929.18k, , , , , 17.26ms bad guess of IO wait time per IO request 1864 @2, GGS , STAT, gc cr blocks received , 3, .46, , , , , .01 per execution 1864 @2, GGS , STAT, gc current blocks received , 14, 2.17, , , , , .03 per execution 1864 @2, GGS , STAT, gc local grants , 214, 33.11, , , , , .43 per execution 1864 @2, GGS , STAT, gc remote grants , 273, 42.24, , , , , .54 per execution 1864 @2, GGS , STAT, undo change vector size , 422032, 65.29k, , , , , 840.7 per execution 1864 @2, GGS , STAT, no work - consistent read gets , 417, 64.51, , , , , .83 per execution 1864 @2, GGS , STAT, cleanouts only - consistent read gets , 2, .31, , , , , 0 per execution 1864 @2, GGS , STAT, RowCR attempts , 3, .46, , , , , .01 per execution 1864 @2, GGS , STAT, RowCR hits , 2, .31, , , , , 0 per execution 1864 @2, GGS , STAT, RowCR - row contention , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, immediate (CURRENT) block cleanout applications , 69, 10.67, , , , , .14 per execution 1864 @2, GGS , STAT, immediate (CR) block cleanout applications , 2, .31, , , , , 0 per execution 1864 @2, GGS , STAT, deferred (CURRENT) block cleanout applications , 198, 30.63, , , , , .39 per execution 1864 @2, GGS , STAT, commit txn count during cleanout , 48, 7.43, , , , , .1 per execution 1864 @2, GGS , STAT, active txn count during cleanout , 31, 4.8, , , , , .06 per execution 1864 @2, GGS , STAT, cleanout - number of ktugct calls , 43, 6.65, , , , , .09 per execution 1864 @2, GGS , STAT, Commit SCN cached , 7, 1.08, , , , , .01 per execution 1864 @2, GGS , STAT, Block Cleanout Optim referenced , 61, 9.44, , , , , .12 per execution 1864 @2, GGS , STAT, min active SCN optimization applied on CR , 2, .31, , , , , 0 per execution 1864 @2, GGS , STAT, commit wait/nowait requested , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, commit nowait requested , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, commit wait/nowait performed , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, commit nowait performed , 1, .15, , , , , 0 per execution 1864 @2, GGS , STAT, table fetch by rowid , 88, 13.61, , , , , .18 per execution 1864 @2, GGS , STAT, table fetch continued row , 11, 1.7, , , , , .02 per execution 1864 @2, GGS , STAT, cluster key scans , 113, 17.48, , , , , .23 per execution 1864 @2, GGS , STAT, cluster key scan block gets , 244, 37.75, , , , , .49 per execution 1864 @2, GGS , STAT, index crx upgrade (positioned) , 4, .62, , , , , .01 per execution 1864 @2, GGS , STAT, leaf node splits , 20, 3.09, , , , , .04 per execution 1864 @2, GGS , STAT, lob writes , 56, 8.66, , , , , .11 per execution 1864 @2, GGS , STAT, lob writes unaligned , 56, 8.66, , , , , .11 per execution 1864 @2, GGS , STAT, index fetch by key , 149, 23.05, , , , , .3 per execution 1864 @2, GGS , STAT, index scans kdiixs1 , 89, 13.77, , , , , .18 per execution 1864 @2, GGS , STAT, HSC Heap Segment Block Changes , 340, 52.6, , , , , .68 per execution 1864 @2, GGS , STAT, sql area evicted , 3, .46, , , , , .01 per execution 1864 @2, GGS , STAT, session cursor cache hits , 164, 25.37, , , , , 155 softparses avoided thanks to cursor cache 1864 @2, GGS , STAT, session cursor cache count , -1, -.15, , , , , 0 per execution 1864 @2, GGS , STAT, buffer is pinned count , 40, 6.19, , , , , .48 % buffer gets avoided thanks to buffer pin caching 1864 @2, GGS , STAT, buffer is not pinned count , 648, 100.25, , , , , 1.29 per execution 1864 @2, GGS , STAT, workarea executions - optimal , 22, 3.4, , , , , .04 per execution 1864 @2, GGS , STAT, parse count (total) , 9, 1.39, , , , , 4.5 softparses per hardparse 1864 @2, GGS , STAT, parse count (hard) , 2, .31, , , , , 0 per execution 1864 @2, GGS , STAT, execute count , 502, 77.66, , , , , 55.78 executions per parse 1864 @2, GGS , STAT, bytes sent via SQL*Net to client , 59813, 9.25k, , , , , 172.87 bytes per roundtrip 1864 @2, GGS , STAT, bytes received via SQL*Net from client , 365977, 56.62k, , , , , 1.06k bytes per roundtrip 1864 @2, GGS , STAT, SQL*Net roundtrips to/from client , 346, 53.53, , , , , .69 per execution 1864 @2, GGS , STAT, sorts (memory) , 113, 17.48, , , , , .23 per execution 1864 @2, GGS , STAT, sorts (rows) , 1956, 302.61, , , , , 3.9 per execution 1864 @2, GGS , TIME, hard parse elapsed time , 415861, 64.34ms, 6.4%, [# ], , , 1864 @2, GGS , TIME, repeated bind elapsed time , 729, 112.78us, .0%, [ ], , , 1864 @2, GGS , TIME, parse time elapsed , 416409, 64.42ms, 6.4%, [# ], , , 1864 @2, GGS , TIME, DB CPU , 242964, 37.59ms, 3.8%, [@ ], , , 1864 @2, GGS , TIME, sql execute elapsed time , 6125962, 947.73ms, 94.8%, [##########], , , 1864 @2, GGS , TIME, DB time , 6141266, 950.1ms, 95.0%, [##########], , , 3.45 % unaccounted time 1864 @2, GGS , WAIT, db file sequential read , 5901443, 913ms, 91.3%, [WWWWWWWWWW], 362, 56, 16.3ms average wait 1864 @2, GGS , WAIT, gc cr block 2-way , 192, 29.7us, .0%, [ ], 1, .15, 192us average wait 1864 @2, GGS , WAIT, gc current block 2-way , 959, 148.36us, .0%, [ ], 6, .93, 159.83us average wait 1864 @2, GGS , WAIT, gc current block busy , 805, 124.54us, .0%, [ ], 2, .31, 402.5us average wait 1864 @2, GGS , WAIT, gc cr grant 2-way , 2469, 381.97us, .0%, [ ], 23, 3.56, 107.35us average wait 1864 @2, GGS , WAIT, gc cr grant congested , 461, 71.32us, .0%, [ ], 1, .15, 461us average wait 1864 @2, GGS , WAIT, gc current grant 2-way , 16348, 2.53ms, .3%, [ ], 129, 19.96, 126.73us average wait 1864 @2, GGS , WAIT, gc current grant busy , 35577, 5.5ms, .6%, [W ], 125, 19.34, 284.62us average wait 1864 @2, GGS , WAIT, gc current grant congested , 128, 19.8us, .0%, [ ], 1, .15, 128us average wait 1864 @2, GGS , WAIT, row cache lock , 5612, 868.22us, .1%, [ ], 28, 4.33, 200.43us average wait 1864 @2, GGS , WAIT, library cache pin , 479, 74.1us, .0%, [ ], 3, .46, 159.67us average wait 1864 @2, GGS , WAIT, library cache lock , 321, 49.66us, .0%, [ ], 2, .31, 160.5us average wait 1864 @2, GGS , WAIT, SQL*Net message to client , 595, 92.05us, .0%, [ ], 366, 56.62, 1.63us average wait 1864 @2, GGS , WAIT, SQL*Net message from client , 99311, 15.36ms, 1.5%, [W ], 365, 56.47, 272.08us average wait -- End of Stats snap 1, end=2018-12-20 10:47:19, seconds=6.5 --------------------------------------------------------------------------------------------------------------- ActSes %Thread | INST | SQL_ID | SQL_CHILD | EVENT | WAIT_CLASS --------------------------------------------------------------------------------------------------------------- .54 (54%) | 2 | g4cf65js6kjf0 | 0 | db file sequential read | User I/O .18 (18%) | 2 | 43dvz166uqtkq | 0 | db file sequential read | User I/O .13 (13%) | 2 | gabtdu60mta41 | 1 | db file sequential read | User I/O .05 (5%) | 2 | 0s6zmhwfkuxwf | 0 | db file sequential read | User I/O .03 (3%) | 2 | 7a5tppp6fph0s | 1 | db file sequential read | User I/O .03 (3%) | 2 | 9v9vx2tqfy8rq | 0 | db file sequential read | User I/O .03 (3%) | 2 | gabtdu60mta41 | 1 | gc current request | Cluster .03 (3%) | 2 | 5wc19gh3h1cuc | 0 | db file sequential read | User I/O -- End of ASH snap 1, end=2018-12-20 10:47:19, seconds=5, samples_taken=39, AAS=1