TKPROF: Release 11.2.0.1.0 - Development on Mon Dec 17 16:16:16 2012 Copyright (c) 1982, 2009, Oracle and/or its affiliates. All rights reserved. Trace file: orcl2_ora_21296.trc Sort options: default ******************************************************************************** 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 -------------------------------------------------------------------------------- *** SESSION ID:(139.1991) 2012-12-17 15:14:43.991 ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 2.76 2.76 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 2.76 2.76 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=2767018 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10424779 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3716288 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 2.78 2.79 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 2.78 2.79 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=2791879 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10705955 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3781658 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 2.62 2.63 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 2.62 2.63 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=0 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=0 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=0 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 2.69 2.69 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 2.69 2.69 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=2698650 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10283050 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3631007 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 3.32 3.32 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 3.32 3.32 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=3329490 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10356842 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3707583 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 4.31 4.30 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 4.31 4.30 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=4309814 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10778480 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3916724 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 5.28 5.28 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 5.28 5.28 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=5281233 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10242843 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3678870 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 7.92 7.94 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 7.92 7.94 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=7942264 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10327076 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3729447 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** select --+ index(test) count(pad) from test call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 1 0.00 0.00 0 0 0 0 Fetch 2 13.06 13.07 0 41401 0 1 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 3 13.06 13.07 0 41401 0 1 Misses in library cache during parse: 0 Optimizer mode: ALL_ROWS Parsing user id: 90 Rows Row Source Operation ------- --------------------------------------------------- 1 SORT AGGREGATE (cr=41401 pr=0 pw=0 time=13077285 us) 10000000 TABLE ACCESS BY INDEX ROWID TEST (cr=41401 pr=0 pw=0 time=10224430 us cost=41718 size=20000000 card=10000000) 10000000 INDEX FULL SCAN IDX (cr=23555 pr=0 pw=0 time=3668132 us cost=23671 size=0 card=10000000)(object id 77898) ******************************************************************************** OVERALL TOTALS FOR ALL NON-RECURSIVE STATEMENTS call count cpu elapsed disk query current rows ------- ------ -------- ---------- ---------- ---------- ---------- ---------- Parse 0 0.00 0.00 0 0 0 0 Execute 9 0.00 0.00 0 0 0 0 Fetch 18 44.74 44.83 0 372609 0 9 ------- ------ -------- ---------- ---------- ---------- ---------- ---------- total 27 44.74 44.83 0 372609 0 9 Misses in library cache during parse: 0 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 9 user SQL statements in session. 0 internal SQL statements in session. 9 SQL statements in session. ******************************************************************************** Trace file: orcl2_ora_21296.trc Trace file compatibility: 11.1.0.7 Sort options: default 1 session in tracefile. 9 user SQL statements in trace file. 0 internal SQL statements in trace file. 9 SQL statements in trace file. 1 unique SQL statements in trace file. 157 lines in trace file. 45 elapsed seconds in trace file.