獲得執行計劃方法三-sql_trace

1 追蹤這個sesion

SQL> alter session set sql_trace=true ;
Session altered.

2 執行想要跟蹤的語句

SQL> select * from scott.emp ;
     EMPNO ENAME      JOB              MGR HIREDATE         SAL       COMM
---------- ---------- --------- ---------- --------- ---------- ----------
    DEPTNO
----------
      7369 SMITH      CLERK           7902 17-DEC-80        800
        20
      7499 ALLEN      SALESMAN        7698 20-FEB-81       1600        300
        30
      7521 WARD       SALESMAN        7698 22-FEB-81       1250        500
        30
     EMPNO ENAME      JOB              MGR HIREDATE         SAL       COMM
---------- ---------- --------- ---------- --------- ---------- ----------
    DEPTNO
----------
      7566 JONES      MANAGER         7839 02-APR-81       2975
        20
      7654 MARTIN     SALESMAN        7698 28-SEP-81       1250       1400
        30
      7698 BLAKE      MANAGER         7839 01-MAY-81       2850
        30
     EMPNO ENAME      JOB              MGR HIREDATE         SAL       COMM
---------- ---------- --------- ---------- --------- ---------- ----------
    DEPTNO
----------
      7782 CLARK      MANAGER         7839 09-JUN-81       2450
        10
      7788 SCOTT      ANALYST         7566 19-APR-87       3000
        20
      7839 KING       PRESIDENT            17-NOV-81       5000
        10
     EMPNO ENAME      JOB              MGR HIREDATE         SAL       COMM
---------- ---------- --------- ---------- --------- ---------- ----------
    DEPTNO
----------
      7844 TURNER     SALESMAN        7698 08-SEP-81       1500          0
        30
      7876 ADAMS      CLERK           7788 23-MAY-87       1100
        20
      7900 JAMES      CLERK           7698 03-DEC-81        950
        30
     EMPNO ENAME      JOB              MGR HIREDATE         SAL       COMM
---------- ---------- --------- ---------- --------- ---------- ----------
    DEPTNO
----------
      7902 FORD       ANALYST         7566 03-DEC-81       3000
        20
      7934 MILLER     CLERK           7782 23-JAN-82       1300
        10
14 rows selected.

3 關閉sql trace

SQL>  alter session set sql_trace=false;
Session altered.

4 查看trace文件所在位置，摘自eygle.com

SQL> select  d.value || '/' || lower(rtrim(i.instance, chr(0))) || '_ora_' || p.spid || '.trc' trace_file_name
  2    from (select p.spid
  3            from sys.v$mystat m, sys.v$session s, sys.v$process p
  4           where m.statistic# = 1
  5             and s.sid = m.sid
  6             and p.addr = s.paddr) p,
  7         (select t.instance
  8            from sys.v$thread t, sys.v$parameter v
  9           where v.name = 'thread'
 10             and (v.value = 0 or t.thread# = to_number(v.value))) i,
 11         (select value from sys.v$parameter where name = 'user_dump_dest') d
 12  /
TRACE_FILE_NAME
--------------------------------------------------------------------------------
/u01/oracle/admin/orcl/udump/orcl_ora_5331.trc

SQL> !
5 查看trace文件
[oracle@sunblaze ~]$ cat /u01/oracle/admin/orcl/udump/orcl_ora_5331.trc
/u01/oracle/admin/orcl/udump/orcl_ora_5331.trc
Oracle Database 10g Enterprise Edition Release 10.2.0.1.0 - Production
With the Partitioning, OLAP and Data Mining options
ORACLE_HOME = /u01/oracle/product/OraHome
System name:    Linux
Node name:      sunblaze.com
Release:        2.6.9-42.ELsmp
Version:        #1 SMP Wed Jul 12 23:27:17 EDT 2006
Machine:        i686
Instance name: orcl
Redo thread mounted by this instance: 1
Oracle process number: 22
Unix process pid: 5331, p_w_picpath: oracle@sunblaze.com (TNS V1-V3)
*** 2013-04-04 22:22:10.753
*** SERVICE NAME:(SYS$USERS) 2013-04-04 22:22:10.752
*** SESSION ID:(139.15) 2013-04-04 22:22:10.752
=====================
PARSING IN CURSOR #1 len=33 dep=0 uid=0 oct=42 lid=0 tim=1333091143313155 hv=1217565140 ad='2afac650'
alter session set sql_trace=true 
END OF STMT
EXEC #1:c=1000,e=1621,p=0,cr=0,cu=0,mis=1,r=0,dep=0,og=1,tim=1333091143313136
*** 2013-04-04 22:22:20.769
=====================
PARSING IN CURSOR #3 len=789 dep=1 uid=0 oct=3 lid=0 tim=1333091153095142 hv=3159716790 ad='30f17f14'
select i.obj#,i.ts#,i.file#,i.block#,i.intcols,i.type#,i.flags,i.property,i.pctfree$,i.initrans,i.maxtrans,i.blevel,i.leafcnt,i.distkey,i.lblkkey,i.dblkkey,i.clufac,i.cols,i.analyzetime,i.samplesize,i.dataobj#,nvl(i.degree,1),nvl(i.instances,1),i.rowcnt,mod(i.pctthres$,256),i.indmethod#,i.trunccnt,nvl(c.unicols,0),nvl(c.deferrable#+c.valid#,0),nvl(i.spare1,i.intcols),i.spare4,i.spare2,i.spare6,decode(i.pctthres$,null,null,mod(trunc(i.pctthres$/256),256)),ist.cachedblk,ist.cachehit,ist.logicalread from ind$ i, ind_stats$ ist, (select enabled, min(cols) unicols,min(to_number(bitand(defer,1))) deferrable#,min(to_number(bitand(defer,4))) valid# from cdef$ where obj#=:1 and enabled > 1 group by enabled) c where i.obj#=c.enabled(+) and i.obj# = ist.obj#(+) and i.bo#=:1 order by i.obj#
END OF STMT
PARSE #3:c=4000,e=2967,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153095128
=====================
PARSING IN CURSOR #1 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153102422 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
PARSE #1:c=2000,e=1983,p=0,cr=0,cu=0,mis=1,r=0,dep=2,og=3,tim=1333091153102409
EXEC #1:c=2999,e=2657,p=0,cr=0,cu=0,mis=1,r=0,dep=2,og=3,tim=1333091153105361
FETCH #1:c=1000,e=571,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153106136
STAT #1 id=1 cnt=1 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=3 pr=0 pw=0 time=565 us)'
STAT #1 id=2 cnt=1 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=2 pr=0 pw=0 time=489 us)'
=====================
PARSING IN CURSOR #1 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153106734 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #1:c=0,e=100,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153106720
FETCH #1:c=999,e=350,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153107239
STAT #1 id=1 cnt=2 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=6 pr=0 pw=0 time=916 us)'
STAT #1 id=2 cnt=2 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=4 pr=0 pw=0 time=784 us)'
=====================
PARSING IN CURSOR #1 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153107851 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #1:c=1000,e=145,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153107787
FETCH #1:c=0,e=89,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153108104
STAT #1 id=1 cnt=3 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=9 pr=0 pw=0 time=1008 us)'
STAT #1 id=2 cnt=3 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=6 pr=0 pw=0 time=826 us)'
EXEC #3:c=15997,e=16031,p=0,cr=9,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153112259
FETCH #3:c=3000,e=3066,p=1,cr=8,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153115465
=====================
PARSING IN CURSOR #1 len=67 dep=1 uid=0 oct=3 lid=0 tim=1333091153116757 hv=2280069326 ad='30f2a8c4'
select pos#,intcol#,col#,spare1,bo#,spare2 from icol$ where obj#=:1
END OF STMT
PARSE #1:c=1999,e=1050,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153116683
=====================
PARSING IN CURSOR #4 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153118587 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #4:c=1000,e=178,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153118572
FETCH #4:c=0,e=157,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153118920
STAT #4 id=1 cnt=4 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=12 pr=0 pw=0 time=1167 us)'
STAT #4 id=2 cnt=4 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=8 pr=0 pw=0 time=911 us)'
=====================
PARSING IN CURSOR #4 len=121 dep=2 uid=0 oct=3 lid=0 tim=1333091153120304 hv=3150898423 ad='30e94228'
select /*+ rule */ bucket, endpoint, col#, epvalue from histgrm$ where obj#=:1 and intcol#=:2 and row#=:3 order by bucket
END OF STMT
PARSE #4:c=999,e=1126,p=0,cr=0,cu=0,mis=1,r=0,dep=2,og=3,tim=1333091153120292
EXEC #4:c=2000,e=1327,p=0,cr=0,cu=0,mis=1,r=0,dep=2,og=3,tim=1333091153121864
FETCH #4:c=0,e=291,p=1,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153122205
STAT #4 id=1 cnt=1 pid=0 pos=1 obj=0 op='SORT ORDER BY (cr=3 pr=1 pw=0 time=304 us)'
STAT #4 id=2 cnt=1 pid=1 pos=1 obj=253 op='TABLE ACCESS CLUSTER HISTGRM$ (cr=3 pr=1 pw=0 time=247 us)'
STAT #4 id=3 cnt=1 pid=2 pos=1 obj=252 op='INDEX UNIQUE SCAN I_OBJ#_INTCOL# (cr=2 pr=0 pw=0 time=55 us)'
=====================
PARSING IN CURSOR #4 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153122475 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #4:c=1000,e=43,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153122468
FETCH #4:c=0,e=71,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153122605
STAT #4 id=1 cnt=5 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=15 pr=0 pw=0 time=1237 us)'
STAT #4 id=2 cnt=5 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=10 pr=0 pw=0 time=935 us)'
EXEC #1:c=6999,e=6550,p=1,cr=9,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153123508
FETCH #1:c=0,e=80,p=0,cr=3,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153123667
FETCH #1:c=0,e=14,p=0,cr=1,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153123722
STAT #1 id=1 cnt=1 pid=0 pos=1 obj=20 op='TABLE ACCESS BY INDEX ROWID ICOL$ (cr=4 pr=0 pw=0 time=154 us)'
STAT #1 id=2 cnt=1 pid=1 pos=1 obj=40 op='INDEX RANGE SCAN I_ICOL1 (cr=3 pr=0 pw=0 time=65 us)'
FETCH #3:c=0,e=13,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153123833
STAT #3 id=1 cnt=1 pid=0 pos=1 obj=0 op='SORT ORDER BY (cr=8 pr=1 pw=0 time=3131 us)'
STAT #3 id=2 cnt=1 pid=1 pos=1 obj=0 op='HASH JOIN OUTER (cr=8 pr=1 pw=0 time=2950 us)'
STAT #3 id=3 cnt=1 pid=2 pos=1 obj=0 op='NESTED LOOPS OUTER (cr=5 pr=0 pw=0 time=380 us)'
STAT #3 id=4 cnt=1 pid=3 pos=1 obj=19 op='TABLE ACCESS CLUSTER IND$ (cr=4 pr=0 pw=0 time=229 us)'
STAT #3 id=5 cnt=1 pid=4 pos=1 obj=3 op='INDEX UNIQUE SCAN I_OBJ# (cr=2 pr=0 pw=0 time=94 us)'
STAT #3 id=6 cnt=0 pid=3 pos=2 obj=710 op='TABLE ACCESS BY INDEX ROWID IND_STATS$ (cr=1 pr=0 pw=0 time=70 us)'
STAT #3 id=7 cnt=0 pid=6 pos=1 obj=711 op='INDEX UNIQUE SCAN I_IND_STATS$_OBJ# (cr=1 pr=0 pw=0 time=43 us)'
STAT #3 id=8 cnt=1 pid=2 pos=2 obj=0 op='VIEW  (cr=3 pr=1 pw=0 time=1309 us)'
STAT #3 id=9 cnt=1 pid=8 pos=1 obj=0 op='SORT GROUP BY (cr=3 pr=1 pw=0 time=1273 us)'
STAT #3 id=10 cnt=1 pid=9 pos=1 obj=31 op='TABLE ACCESS BY INDEX ROWID CDEF$ (cr=3 pr=1 pw=0 time=1023 us)'
STAT #3 id=11 cnt=2 pid=10 pos=1 obj=51 op='INDEX RANGE SCAN I_CDEF2 (cr=2 pr=0 pw=0 time=97 us)'
=====================
PARSING IN CURSOR #4 len=348 dep=1 uid=0 oct=3 lid=0 tim=1333091153124705 hv=2512561537 ad='30f2a1a4'
select name,intcol#,segcol#,type#,length,nvl(precision#,0),decode(type#,2,nvl(scale,-127/*MAXSB1MINAL*/),178,scale,179,scale,180,scale,181,scale,182,scale,183,scale,231,scale,0),null$,fixedstorage,nvl(deflength,0),default$,rowid,col#,property, nvl(charsetid,0),nvl(charsetform,0),spare1,spare2,nvl(spare3,0) from col$ where obj#=:1 order by intcol#
END OF STMT
PARSE #4:c=1000,e=583,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153124699
=====================
PARSING IN CURSOR #1 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153125910 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #1:c=0,e=53,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153125902
FETCH #1:c=0,e=90,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153126062
STAT #1 id=1 cnt=6 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=18 pr=0 pw=0 time=1329 us)'
STAT #1 id=2 cnt=6 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=12 pr=0 pw=0 time=984 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153126263 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=37,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153126257
FETCH #3:c=1000,e=45,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153126381
STAT #3 id=1 cnt=7 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=21 pr=0 pw=0 time=1371 us)'
STAT #3 id=2 cnt=7 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=14 pr=0 pw=0 time=1004 us)'
=====================
PARSING IN CURSOR #1 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153126694 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #1:c=0,e=47,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153126686
FETCH #1:c=0,e=46,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153126802
STAT #1 id=1 cnt=8 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=24 pr=0 pw=0 time=1420 us)'
STAT #1 id=2 cnt=8 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=16 pr=0 pw=0 time=1028 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153127017 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=37,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153127012
FETCH #3:c=0,e=25,p=0,cr=2,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153127096
STAT #3 id=1 cnt=8 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=26 pr=0 pw=0 time=1451 us)'
STAT #3 id=2 cnt=8 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=18 pr=0 pw=0 time=1045 us)'
=====================
PARSING IN CURSOR #1 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153127257 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #1:c=0,e=31,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153127252
FETCH #1:c=999,e=41,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153127371
STAT #1 id=1 cnt=9 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=29 pr=0 pw=0 time=1493 us)'
STAT #1 id=2 cnt=9 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=20 pr=0 pw=0 time=1064 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153127574 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=34,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153127568
FETCH #3:c=0,e=40,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153127665
STAT #3 id=1 cnt=10 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=32 pr=0 pw=0 time=1534 us)'
STAT #3 id=2 cnt=10 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=22 pr=0 pw=0 time=1082 us)'
=====================
PARSING IN CURSOR #1 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153127820 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #1:c=0,e=32,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153127815
FETCH #1:c=0,e=37,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153127908
STAT #1 id=1 cnt=11 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=35 pr=0 pw=0 time=1573 us)'
STAT #1 id=2 cnt=11 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=24 pr=0 pw=0 time=1098 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153128095 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=33,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153128089
FETCH #3:c=0,e=39,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153128186
STAT #3 id=1 cnt=12 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=38 pr=0 pw=0 time=1612 us)'
STAT #3 id=2 cnt=12 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=26 pr=0 pw=0 time=1116 us)'
EXEC #4:c=3999,e=4123,p=0,cr=23,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153128943
FETCH #4:c=0,e=110,p=0,cr=3,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129110
FETCH #4:c=0,e=9,p=0,cr=0,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129168
FETCH #4:c=0,e=8,p=0,cr=0,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129209
FETCH #4:c=0,e=9,p=0,cr=0,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129281
FETCH #4:c=0,e=7,p=0,cr=0,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129319
FETCH #4:c=0,e=7,p=0,cr=0,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129356
FETCH #4:c=0,e=8,p=0,cr=0,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129393
FETCH #4:c=0,e=9,p=0,cr=0,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153129461
FETCH #4:c=0,e=10,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153129502
STAT #4 id=1 cnt=8 pid=0 pos=1 obj=0 op='SORT ORDER BY (cr=3 pr=0 pw=0 time=147 us)'
STAT #4 id=2 cnt=8 pid=1 pos=1 obj=21 op='TABLE ACCESS CLUSTER COL$ (cr=3 pr=0 pw=0 time=89 us)'
STAT #4 id=3 cnt=1 pid=2 pos=1 obj=3 op='INDEX UNIQUE SCAN I_OBJ# (cr=2 pr=0 pw=0 time=27 us)'
=====================
PARSING IN CURSOR #3 len=116 dep=2 uid=0 oct=3 lid=0 tim=1333091153130629 hv=854877822 ad='30f29bc8'
select o.owner#,o.name,o.namespace,o.remoteowner,o.linkname,o.subname,o.dataobj#,o.flags from obj$ o where o.obj#=:1
END OF STMT
PARSE #3:c=1000,e=387,p=0,cr=0,cu=0,mis=1,r=0,dep=2,og=4,tim=1333091153130624
EXEC #3:c=1000,e=1046,p=0,cr=0,cu=0,mis=1,r=0,dep=2,og=4,tim=1333091153131772
FETCH #3:c=0,e=91,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=4,tim=1333091153131910
STAT #3 id=1 cnt=1 pid=0 pos=1 obj=18 op='TABLE ACCESS BY INDEX ROWID OBJ$ (cr=3 pr=0 pw=0 time=93 us)'
STAT #3 id=2 cnt=1 pid=1 pos=1 obj=36 op='INDEX UNIQUE SCAN I_OBJ1 (cr=2 pr=0 pw=0 time=60 us)'
=====================
PARSING IN CURSOR #1 len=169 dep=1 uid=0 oct=3 lid=0 tim=1333091153132153 hv=1173719687 ad='30f1df48'
select col#, grantee#, privilege#,max(mod(nvl(option$,0),2)) from objauth$ where obj#=:1 and col# is not null group by privilege#, col#, grantee# order by col#, grantee#
END OF STMT
PARSE #1:c=2000,e=2278,p=0,cr=3,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153132147
=====================
PARSING IN CURSOR #4 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153132819 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #4:c=0,e=44,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153132813
FETCH #4:c=0,e=112,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153133014
STAT #4 id=1 cnt=13 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=41 pr=0 pw=0 time=1725 us)'
STAT #4 id=2 cnt=13 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=28 pr=0 pw=0 time=1141 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153133218 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=1000,e=37,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153133212
FETCH #3:c=0,e=65,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153133339
STAT #3 id=1 cnt=14 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=44 pr=0 pw=0 time=1790 us)'
STAT #3 id=2 cnt=14 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=30 pr=0 pw=0 time=1161 us)'
=====================
PARSING IN CURSOR #4 len=121 dep=2 uid=0 oct=3 lid=0 tim=1333091153133507 hv=3150898423 ad='30e94228'
select /*+ rule */ bucket, endpoint, col#, epvalue from histgrm$ where obj#=:1 and intcol#=:2 and row#=:3 order by bucket
END OF STMT
EXEC #4:c=0,e=45,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153133502
FETCH #4:c=0,e=128,p=0,cr=3,cu=0,mis=0,r=17,dep=2,og=3,tim=1333091153133688
STAT #4 id=1 cnt=18 pid=0 pos=1 obj=0 op='SORT ORDER BY (cr=6 pr=1 pw=0 time=501 us)'
STAT #4 id=2 cnt=18 pid=1 pos=1 obj=253 op='TABLE ACCESS CLUSTER HISTGRM$ (cr=6 pr=1 pw=0 time=369 us)'
STAT #4 id=3 cnt=2 pid=2 pos=1 obj=252 op='INDEX UNIQUE SCAN I_OBJ#_INTCOL# (cr=4 pr=0 pw=0 time=79 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153133935 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=37,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153133929
FETCH #3:c=0,e=41,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153134032
STAT #3 id=1 cnt=15 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=47 pr=0 pw=0 time=1833 us)'
STAT #3 id=2 cnt=15 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=32 pr=0 pw=0 time=1180 us)'
=====================
PARSING IN CURSOR #4 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153134275 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #4:c=1000,e=36,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153134268
FETCH #4:c=0,e=44,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153134402
STAT #4 id=1 cnt=16 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=50 pr=0 pw=0 time=1877 us)'
STAT #4 id=2 cnt=16 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=34 pr=0 pw=0 time=1199 us)'
EXEC #1:c=2999,e=2933,p=0,cr=15,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153135211
FETCH #1:c=0,e=196,p=0,cr=2,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153135454
STAT #1 id=1 cnt=0 pid=0 pos=1 obj=0 op='SORT GROUP BY (cr=2 pr=0 pw=0 time=232 us)'
STAT #1 id=2 cnt=0 pid=1 pos=1 obj=57 op='TABLE ACCESS BY INDEX ROWID OBJAUTH$ (cr=2 pr=0 pw=0 time=190 us)'
STAT #1 id=3 cnt=0 pid=2 pos=1 obj=103 op='INDEX RANGE SCAN I_OBJAUTH1 (cr=2 pr=0 pw=0 time=175 us)'
=====================
PARSING IN CURSOR #3 len=151 dep=1 uid=0 oct=3 lid=0 tim=1333091153136041 hv=4139184264 ad='30f1d620'
select grantee#,privilege#,nvl(col#,0),max(mod(nvl(option$,0),2))from objauth$ where obj#=:1 group by grantee#,privilege#,nvl(col#,0) order by grantee#
END OF STMT
PARSE #3:c=0,e=426,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153136035
EXEC #3:c=1000,e=1203,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153137358
FETCH #3:c=0,e=51,p=0,cr=2,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153137461
STAT #3 id=1 cnt=0 pid=0 pos=1 obj=0 op='SORT GROUP BY (cr=2 pr=0 pw=0 time=75 us)'
STAT #3 id=2 cnt=0 pid=1 pos=1 obj=57 op='TABLE ACCESS BY INDEX ROWID OBJAUTH$ (cr=2 pr=0 pw=0 time=47 us)'
STAT #3 id=3 cnt=0 pid=2 pos=1 obj=103 op='INDEX RANGE SCAN I_OBJAUTH1 (cr=2 pr=0 pw=0 time=33 us)'
=====================
PARSING IN CURSOR #4 len=69 dep=1 uid=0 oct=3 lid=0 tim=1333091153138013 hv=1471956217 ad='30f1ea58'
select con#,obj#,rcon#,enabled,nvl(defer,0) from cdef$ where robj#=:1
END OF STMT
PARSE #4:c=0,e=411,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153138007
EXEC #4:c=1000,e=1034,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153139161
FETCH #4:c=0,e=40,p=0,cr=1,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153139373
STAT #4 id=1 cnt=0 pid=0 pos=1 obj=31 op='TABLE ACCESS BY INDEX ROWID CDEF$ (cr=1 pr=0 pw=0 time=50 us)'
STAT #4 id=2 cnt=0 pid=1 pos=1 obj=52 op='INDEX RANGE SCAN I_CDEF3 (cr=1 pr=0 pw=0 time=36 us)'
=====================
PARSING IN CURSOR #1 len=146 dep=1 uid=0 oct=3 lid=0 tim=1333091153140006 hv=2107929772 ad='30f204f4'
select con#,type#,condlength,intcols,robj#,rcon#,match#,refact,nvl(enabled,0),rowid,cols,nvl(defer,0),mtime,nvl(spare1,0) from cdef$ where obj#=:1
END OF STMT
PARSE #1:c=1000,e=514,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153140000
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153140739 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=68,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153140732
FETCH #3:c=0,e=71,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153140872
STAT #3 id=1 cnt=17 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=53 pr=0 pw=0 time=1945 us)'
STAT #3 id=2 cnt=17 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=36 pr=0 pw=0 time=1226 us)'
=====================
PARSING IN CURSOR #4 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153141090 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #4:c=1000,e=36,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153141084
FETCH #4:c=0,e=89,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153141235
STAT #4 id=1 cnt=18 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=56 pr=0 pw=0 time=2035 us)'
STAT #4 id=2 cnt=18 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=38 pr=0 pw=0 time=1290 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153141409 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=36,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153141403
FETCH #3:c=0,e=40,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153141502
STAT #3 id=1 cnt=19 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=59 pr=0 pw=0 time=2077 us)'
STAT #3 id=2 cnt=19 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=40 pr=0 pw=0 time=1308 us)'
=====================
PARSING IN CURSOR #4 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153141734 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #4:c=0,e=37,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153141728
FETCH #4:c=0,e=40,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153141830
STAT #4 id=1 cnt=20 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=62 pr=0 pw=0 time=2119 us)'
STAT #4 id=2 cnt=20 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=42 pr=0 pw=0 time=1327 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153142008 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=999,e=34,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153142002
FETCH #3:c=0,e=39,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153142102
STAT #3 id=1 cnt=21 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=65 pr=0 pw=0 time=2158 us)'
STAT #3 id=2 cnt=21 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=44 pr=0 pw=0 time=1345 us)'
EXEC #1:c=1999,e=2637,p=0,cr=15,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153142749
FETCH #1:c=0,e=54,p=0,cr=3,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153142849
=====================
PARSING IN CURSOR #4 len=70 dep=1 uid=0 oct=3 lid=0 tim=1333091153143357 hv=3849548163 ad='30f1e568'
select intcol#,nvl(pos#,0),col#,nvl(spare1,0) from ccol$ where con#=:1
END OF STMT
PARSE #4:c=1000,e=448,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153143351
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153144027 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=1000,e=55,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153144021
FETCH #3:c=0,e=109,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153144283
STAT #3 id=1 cnt=22 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=68 pr=0 pw=0 time=2268 us)'
STAT #3 id=2 cnt=22 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=46 pr=0 pw=0 time=1372 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153144526 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=39,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153144520
FETCH #3:c=0,e=43,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153144683
STAT #3 id=1 cnt=23 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=71 pr=0 pw=0 time=2312 us)'
STAT #3 id=2 cnt=23 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=48 pr=0 pw=0 time=1393 us)'
=====================
PARSING IN CURSOR #3 len=210 dep=2 uid=0 oct=3 lid=0 tim=1333091153144882 hv=864012087 ad='30e966e8'
select /*+ rule */ bucket_cnt, row_cnt, cache_cnt, null_cnt, timestamp#, sample_size, minimum, maximum, distcnt, lowval, hival, density, col#, spare1, spare2, avgcln from hist_head$ where obj#=:1 and intcol#=:2
END OF STMT
EXEC #3:c=0,e=35,p=0,cr=0,cu=0,mis=0,r=0,dep=2,og=3,tim=1333091153144853
FETCH #3:c=0,e=39,p=0,cr=3,cu=0,mis=0,r=1,dep=2,og=3,tim=1333091153144977
STAT #3 id=1 cnt=24 pid=0 pos=1 obj=255 op='TABLE ACCESS BY INDEX ROWID HIST_HEAD$ (cr=74 pr=0 pw=0 time=2352 us)'
STAT #3 id=2 cnt=24 pid=1 pos=1 obj=257 op='INDEX RANGE SCAN I_HH_OBJ#_INTCOL# (cr=50 pr=0 pw=0 time=1411 us)'
EXEC #4:c=2000,e=1997,p=0,cr=9,cu=0,mis=1,r=0,dep=1,og=4,tim=1333091153145453
FETCH #4:c=1000,e=18392,p=2,cr=3,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153163887
FETCH #4:c=0,e=18,p=0,cr=1,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153163986
STAT #4 id=1 cnt=1 pid=0 pos=1 obj=32 op='TABLE ACCESS BY INDEX ROWID CCOL$ (cr=4 pr=2 pw=0 time=18387 us)'
STAT #4 id=2 cnt=1 pid=1 pos=1 obj=54 op='INDEX RANGE SCAN I_CCOL1 (cr=3 pr=2 pw=0 time=18366 us)'
FETCH #1:c=0,e=35,p=0,cr=2,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153164509
=====================
PARSING IN CURSOR #3 len=70 dep=1 uid=0 oct=3 lid=0 tim=1333091153164759 hv=3849548163 ad='30f1e568'
select intcol#,nvl(pos#,0),col#,nvl(spare1,0) from ccol$ where con#=:1
END OF STMT
EXEC #3:c=0,e=126,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153164751
FETCH #3:c=0,e=47,p=0,cr=3,cu=0,mis=0,r=1,dep=1,og=4,tim=1333091153164934
FETCH #3:c=0,e=14,p=0,cr=1,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153164983
FETCH #1:c=0,e=32,p=0,cr=1,cu=0,mis=0,r=0,dep=1,og=4,tim=1333091153165065
STAT #1 id=1 cnt=2 pid=0 pos=1 obj=31 op='TABLE ACCESS BY INDEX ROWID CDEF$ (cr=6 pr=0 pw=0 time=53 us)'
STAT #1 id=2 cnt=2 pid=1 pos=1 obj=51 op='INDEX RANGE SCAN I_CDEF2 (cr=4 pr=0 pw=0 time=40 us)'
=====================
PARSING IN CURSOR #2 len=24 dep=0 uid=0 oct=3 lid=0 tim=1333091153166475 hv=435537109 ad='30f3b458'
select * from scott.emp 
END OF STMT
PARSE #2:c=58991,e=75116,p=4,cr=117,cu=0,mis=1,r=0,dep=0,og=1,tim=1333091153166466
EXEC #2:c=0,e=42,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=1,tim=1333091153166754
FETCH #2:c=999,e=947,p=6,cr=7,cu=0,mis=0,r=1,dep=0,og=1,tim=1333091153167769
FETCH #2:c=0,e=49,p=0,cr=1,cu=0,mis=0,r=13,dep=0,og=1,tim=1333091153168670
STAT #2 id=1 cnt=14 pid=0 pos=1 obj=51148 op='TABLE ACCESS FULL EMP (cr=8 pr=6 pw=0 time=933 us)'
*** 2013-04-04 22:22:45.861
=====================
PARSE ERROR #4:len=37 dep=0 uid=0 oct=42 lid=0 tim=1333091177598788 err=911
alter session set sql_trace=false 
*** 2013-04-04 22:23:14.012
=====================
PARSING IN CURSOR #3 len=34 dep=0 uid=0 oct=42 lid=0 tim=1333091205089913 hv=3317026814 ad='2afbcc64'
 alter session set sql_trace=false
END OF STMT
PARSE #3:c=1000,e=1359,p=0,cr=0,cu=0,mis=1,r=0,dep=0,og=1,tim=1333091205089897
EXEC #3:c=0,e=741,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=1,tim=1333091205090949
[oracle@sunblaze ~]$