TKPROF: Release 11.1.0.6.0 - Production on Tue Dec 30 03:14:40 2008 Copyright (c) 1982, 2007, Oracle. All rights reserved. Trace file: e:\oracle\app\diag\rdbms\orcl899\orcl899\trace\orcl899_ora_3600.trc Sort options: prsela exeela fchela ******************************************************************************** count = number of times OCI procedure was executed cpu = cpu time in seconds executing elapsed = elapsed time in seconds executing disk = number of physical reads of buffers from disk query = number of buffers gotten for consistent read current = number of buffers gotten in current mode (usually for update) rows = number of rows processed by the fetch or execute call ******************************************************************************** SELECT o.owner, o.object_type, COUNT(*) FROM all_my_objects o GROUP BY o.object_type, o.owner UNION ALL SELECT NULL, o.object_type, COUNT(*) FROM all_my_objects o GROUP BY o.object_type UNION ALL SELECT o.owner, NULL, COUNT(*) FROM all_my_objects o GROUP BY o.owner UNION ALL SELECT NULL, NULL, COUNT(*) FROM all_my_objects o call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 1 0.03 0.01 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 23 1.57 55.26 24100 24116 0 327 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 25 1.60 55.27 24100 24116 0 327 Misses in library cache during parse: 1 Optimizer mode: ALL_ROWS Parsing user id: 5 Rows Row Source Operation ------- --------------------------------------------------- 327 UNION-ALL (cr=24116 pr=24100 pw=24100 time=34 us) 258 HASH GROUP BY (cr=6029 pr=6025 pw=6025 time=10 us cost=1657 size=12105 card=807) 411120 TABLE ACCESS FULL ALL_MY_OBJECTS (cr=6029 pr=6025 pw=6025 time=374929 us cost=1641 size=6166800 card=411120) 38 HASH GROUP BY (cr=6029 pr=6025 pw=6025 time=4 us cost=1657 size=342 card=38) 411120 TABLE ACCESS FULL ALL_MY_OBJECTS (cr=6029 pr=6025 pw=6025 time=309144 us cost=1641 size=3700080 card=411120) 30 HASH GROUP BY (cr=6029 pr=6025 pw=6025 time=218 us cost=1655 size=180 card=30) 411120 TABLE ACCESS FULL ALL_MY_OBJECTS (cr=6029 pr=6025 pw=6025 time=1212530 us cost=1639 size=2466720 card=411120) 1 SORT AGGREGATE (cr=6029 pr=6025 pw=6025 time=0 us) 411120 TABLE ACCESS FULL ALL_MY_OBJECTS (cr=6029 pr=6025 pw=6025 time=392674 us cost=1639 size=0 card=411120) Elapsed times include waiting on following events: Event waited on Times Max. Wait Total Waited ---------------------------------------- Waited ---------- ------------ SQL*Net message to client 24 0.00 0.00 SQL*Net message from client 24 0.00 0.10 reliable message 4 0.00 0.00 enq: KO - fast object checkpoint 4 0.00 0.00 direct path read 388 1.19 53.02 ******************************************************************************** BEGIN DBMS_OUTPUT.GET_LINES(:LINES, :NUMLINES); END; call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 3 0.00 0.00 0 0 0 0 Execute 3 0.00 0.02 0 0 0 3 Fetch 0 0.00 0.00 0 0 0 0 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 6 0.00 0.02 0 0 0 3 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 5 Elapsed times include waiting on following events: Event waited on Times Max. Wait Total Waited ---------------------------------------- Waited ---------- ------------ SQL*Net message to client 3 0.00 0.00 SQL*Net message from client 3 187.53 225.59 ******************************************************************************** alter session set events '10046 trace name context off' call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 2 0.00 0.00 0 0 0 0 Execute 2 0.00 0.00 0 0 0 0 Fetch 0 0.00 0.00 0 0 0 0 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 4 0.00 0.00 0 0 0 0 Misses in library cache during parse: 0 Parsing user id: 5 ******************************************************************************** OVERALL TOTALS FOR ALL NON-RECURSIVE STATEMENTS call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 6 0.03 0.01 0 0 0 0 Execute 6 0.00 0.02 0 0 0 3 Fetch 23 1.57 55.26 24100 24116 0 327 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 35 1.60 55.30 24100 24116 0 330 Misses in library cache during parse: 1 Elapsed times include waiting on following events: Event waited on Times Max. Wait Total Waited ---------------------------------------- Waited ---------- ------------ SQL*Net message to client 28 0.00 0.00 SQL*Net message from client 28 187.53 225.70 reliable message 4 0.00 0.00 enq: KO - fast object checkpoint 4 0.00 0.00 direct path read 388 1.19 53.02 OVERALL TOTALS FOR ALL RECURSIVE STATEMENTS call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 0 0.00 0.00 0 0 0 0 Fetch 0 0.00 0.00 0 0 0 0 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 0 0.00 0.00 0 0 0 0 Misses in library cache during parse: 0 5 user SQL statements in session. 0 internal SQL statements in session. 5 SQL statements in session. ******************************************************************************** Trace file: e:\oracle\app\diag\rdbms\orcl899\orcl899\trace\orcl899_ora_3600.trc Trace file compatibility: 10.01.00 Sort options: prsela exeela fchela 1 session in tracefile. 5 user SQL statements in trace file. 0 internal SQL statements in trace file. 5 SQL statements in trace file. 3 unique SQL statements in trace file. 722 lines in trace file. 452 elapsed seconds in trace file.