Oracle 11g新SQL Trace 10046方法(一)

2014-11-24 17:46:40 · 作者: · 浏览: 0

进入11g之后,Oracle提供了10046的替代Trace方法,原有event方法依然支持。本篇就着重介绍一下新的SQL Trace手段。


1、环境和背景介绍


我们依然选择Oracle 11gR2作为实验对象,同时创建实验数据表T


SQL> select * from v$version;



BANNER


--------------------------------------------------------------------------------


Oracle Database 11g Enterprise Edition Release 11.2.0.1.0 - Production


PL/SQL Release 11.2.0.1.0 - Production


CORE 11.2.0.1.0 Production



TNS for Linux: Version 11.2.0.1.0 - Production


NLSRTL Version 11.2.0.1.0 – Production




创建数据表,并且清理shared pool和buffer cache信息。




SQL> create table t as select * from dba_objects;


Table created



SQL> create index idx_t_id on t(object_id);


Index created



SQL> exec dbms_stats.gather_table_stats(user,'T',cascade => true);


PL/SQL procedure successfully completed



SQL> alter system flush shared_pool;


System altered



SQL> alter system flush buffer_cache;


System altered




2、SQL_TRACE方法



首先我们查看新接口方法的默认手段。在之前的Oracle版本中,我们有大致上下面几种手段。



ü Alter session set events;


ü Dbms_跟踪包;


ü Oradebug设置跟踪事件;


ü 初始化参数sql_trace;



应该说,这几种方法对于Oracle的跟踪非常彻底。在事件10046作用的范围内,所有的SQL,除了目标SQL还有recursive SQL,都会被记录下来到跟踪文件。所以,我们明明发出了一条SQL语句,但是跟踪文件里面包括了很多对数据字典的检索。由此,我们经常需要使用tkprof进行raw文件处理。



我们先看下新接口方法使用。先定位到Trace文件位置。




SQL> select value from v$diag_info where name='Default Trace File';


VALUE


-------------------------------------------------------------------------


/u01/diag/rdbms/wilson/wilson/trace/wilson_ora_3663.trc




开启跟踪。



--标记


SQL> alter session set tracefile_identifier='10046';


会话已更改。



SQL> alter session set timed_statistics = true;


会话已更改。



SQL> alter session set statistics_level=all;


会话已更改。



SQL> alter session set max_dump_file_size = unlimited;


会话已更改。



--跟踪接口


SQL> alter session set events 'sql_trace level 12';



会话已更改。



SQL> select /*+demo*/count(*) from t where object_id=1000;



COUNT(*)


----------


1



SQL> alter session set events 'sql_trace off';


会话已更改。


10046有若干的跟踪level,其中level 12包括了所有信息,一般我们作为初学者,把尽可能多的信息获取到比较方便。在sql_trace跟踪接口中,我们可以设置level取值。


目标SQL在其中执行。在我们看SQL Trace文件之前,我们先从shared pool中找到这个缓存SQL的sql_id。这个id做什么用,我们先留一个话头。


SQL> select sql_id, executions from v$sqlarea where sql_text like 'select /*+demo*/count(*)%';


SQL_ID EXECUTIONS


------------- ----------


94wk1cqs4g2f5 1


我们可以在目录中找到Trace File了。


[root@bspdev ~]# su - oracle


[oracle@bspdev ~]$ cd /u01/diag/rdbms/wilson/wilson/trace/


[oracle@bspdev trace]$ ls -l | grep 3663


-rw-r----- 1 oracle oinstall 16783 Aug 22 05:55 wilson_ora_3663_10046.trc


-rw-r----- 1 oracle oinstall 158 Aug 22 05:55 wilson_ora_3663_10046.trm


打开Trace文件,可以发现与目标SQL相关的Recursive SQL都在其中。


*** 2013-08-22 05:54:47.257


WAIT #1: nam='SQL*Net message from client' ela= 66502048 driver id=1413697536 #bytes=1 p3=0 obj#=-1 tim=1377122087257296


CLOSE #1:c=0,e=10,dep=0,type=1,tim=1377122087257461


=====================


PARSING IN CURSOR #2 len=202 dep=1 uid=0 ct=3 lid=0 tim=1377122087259383 hv=3819099649 ad='525e44f4' sqlid='3nkd3g3ju5ph1'


select obj#,type#,ctime,mtime,stime, status, dataobj#, flags, oid$, spare1, spare2 from obj$ where owner#=:1 and name=:2 and namespace=:3 and remoteowner is null and linkname is null and subname is null


END OF STMT


(省略……)


CLOSE #2:c=0,e=14391,dep=1,type=3,tim=1377122087295194


=====================


PARSING IN CURSOR #1 len=52 dep=0 uid=0 ct=3 lid=0 tim=1377122087365631 hv=2957478341 ad='525a33fc' sqlid='94wk1cqs4g2f5'


select /*+demo*/count(*) from t where object