首页 > 代码库 > sql_trace基本用法

sql_trace基本用法

 sql_trace是oracle提供的一个非常好的跟踪工具,主要用来检查数据库的异常情况,通过跟踪数据库的活动,找到有问题的语句。

一、概述:
    SQL_TRACE是Oracle的一个非常强大的工具。打开SQL_TRACE就可以逐步捕获任何一个会话的数据库活动,或者捕获整个数据库的活动,并将数据库活动记录成跟踪文件。每次使用完之后需要关闭跟踪,否则会降低系统的性能。
    SQL_TRACE可以帮助诊断许多问题,其中包括:

二、用法:
   1、文件跟踪的分类:
      跟踪DBA可以采用两种方式进行跟踪:
    . 跟踪整个数据库实例。只需要简单的修改参数文件(pfile/spfile)参数 SQL_TRACE = TRUE ,然后重新启动数据库即可。在全局启用SQL_TRACE会导致所有进程的活动被跟踪,包括后台进程及所有用户进程,这样也会数据库导致性能下降比较明显。
    . 会话级跟踪。SQL_TRACE的通常使用方式是仅跟踪一个会话。被跟踪的会话可以是您自己的,也可以是其它用户的会话。如果是自己的会话,只需要在SQL*PLUS中运行一下命令即可:
      SQL> alter session set sql_trace = true;
      类似的如果取消对会话的跟踪,运行一下命令:
      SQL> alter session set sql_trace = false;
     
      如果需要跟踪一个特定的会话,首先需要获取会话的SID和Serial#,这些信息可以在视图V$SESSION中获得,一旦知道了这两个参数,就可以运行一下命令:
      SQL> execute SYS.dbms_system.set_sql_trace_in_session(13,9,true);
      同样也可以使用这个过程关闭会话跟踪:
    SQL> execute SYS.dbms_system.set_sql_trace_in_session(13,9,false);
 
  2、跟踪文件的位置:
     一旦为会话激活了SQL_TRACE,ORACLE就会在udump管理区创建跟踪文件,文件的目标位置由参数user_dump_dest来确定。每个操作都不会覆盖原来的文件,新的跟踪记录将会被追加到文件末尾。通常情况下,可以根据文件的修改时间判断目录下哪个文件是最新的文件。
   SQL> show parameter user_dump_dest;
  
   NAME                                 TYPE        VALUE
   ------------------------------------ ----------- ------------------------------
   user_dump_dest                       string      d:oracleadminora9iudump
  
   也可以通过以下SQL来确定文件名:
    
     select d.value||‘‘||lower(rtrim(i.instance, chr(0)))||‘_ora_‘||p.spid||‘.trc‘ trace_file_name 
   from 
   (
    select p.spid     
      from sys.v$mystat m,sys.v$session s,sys.v$process p
     where m.statistic# = 1
       and s.sid = m.sid
       and p.addr = s.paddr
   ) p,
   (
   select t.instance
     from sys.v$thread  t,sys.v$parameter  v 
    where v.name = ‘thread‘
      and ( v.value = http://www.mamicode.com/0 or t.thread# = to_number(v.value) )
   ) i, 
   (
   select value from sys.v$parameter where name = ‘user_dump_dest‘
   ) d ;

   TRACE_FILE_NAME
   --------------------------------------------------------------------------------
  
   d:oracleadminora9iudumpora9i_ora_2060.trc  
 
 3、计时信息:
    为了最大限度的利用跟踪文件,应该打开计时标志,通过参数TIMED_STATISTICTS=TRUE进行设置,这样可以对每个SQL语句的执行时间等进行记录,这个功能对系统性能的负担很小。
    打开会话的计时信息:
    SQL> alter session set timed_statistics = true ;
    打开数据库系统的计时信息
    SQL> alter system set timed_statistics = true ;
 
 4、TKPROF:
    通过前三步的设置已经知道如何生成SQL跟踪文件了,ORACLE生成的跟踪文件阅读起来很困难(也就是易读性很差),可以看跟踪文件的一部分,执行以下SQL语句:
   SQL> select count(*) from sys_dept;
  
    COUNT(*)
   ----------
          16   
   执行完后,查看跟踪文件中这个语句的内容如下:
   
    PARSING IN CURSOR #1 len=31 dep=0 uid=62 oct=3 lid=62 tim=14727407741 hv=2200985491 ad=‘128e3820‘
   select count(*) from sys_dept
   END OF STMT
   PARSE #1:c=0,e=16348,p=1,cr=31,cu=0,mis=1,r=0,dep=0,og=4,tim=14727407735
   EXEC #1:c=0,e=24,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=14727407814
   FETCH #1:c=0,e=15641,p=5,cr=7,cu=0,mis=0,r=1,dep=0,og=4,tim=14727423807
   =====================
   PARSING IN CURSOR #2 len=61 dep=0 uid=62 oct=47 lid=62 tim=14727508742 hv=3517412409 ad=‘12bbcff4‘
   begin :id := sys.dbms_transaction.local_transaction_id; end;
   END OF STMT
   PARSE #2:c=0,e=122,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=14727508735
   EXEC #2:c=0,e=144,p=0,cr=0,cu=0,mis=0,r=1,dep=0,og=4,tim=14727508945
   =====================
   PARSING IN CURSOR #2 len=61 dep=0 uid=62 oct=47 lid=62 tim=14727587562 hv=3517412409 ad=‘12bbcff4‘
   begin :id := sys.dbms_transaction.local_transaction_id; end;
   END OF STMT
   PARSE #2:c=0,e=121,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=14727587556
   EXEC #2:c=0,e=97,p=0,cr=0,cu=0,mis=0,r=1,dep=0,og=4,tim=14727587721
  
   这样不仅阅读麻烦,并且也有很多内容难以理解。ORACLE提供了一个格式化跟踪文件的工具 - TKPROF( Transient Kernel Profiler ),通过这个工具能将SQL文件转化为分析人员容易理解的格式。
   
    一般TKPROF工具的使用的简单方法,只用到了两个关键字:跟踪文件名和输出文件名 (TKPROF的具体请参阅其他资料):
    TKPROF <trace file> <output file>
   
    在命令行模式下运行(数据库在window2000下安装的)
    C:>tkprof D:oracleadminora9iudumpora9i_ora_2060.trc d:report.txt
   
    执行完后,在reprot.txt中查询刚才的语句内容如下:
    select count(*)
   from
   sys_dept
 
 
   call     count       cpu    elapsed       disk      query    current        rows
   ------- ------  -------- ---------- ---------- ---------- ----------  ----------
   Parse        1      0.00       0.01          1         31          0           0
   Execute      1      0.00       0.00          0          0          0           0
   Fetch        1      0.00       0.01          5          7          0           1
   ------- ------  -------- ---------- ---------- ---------- ----------  ----------
   total        3      0.00       0.03          6         38          0           1
  
   Misses in library cache during parse: 1
   Optimizer goal: CHOOSE
   Parsing user id: 62     
 
   通过设置tkprof的关键字[EXPLAIN = <username/password>],也可以在跟踪文件中增加SQL语句的执行计划:
  C:>tkprof D:oracleadminora9iudumpora9i_ora_2060.trc d:report.txt explain=test/test;  
  
  ********************************************************************************
 
  select count(*)
  from
   sys_dept
 
 
  call     count       cpu    elapsed       disk      query    current        rows
  ------- ------  -------- ---------- ---------- ---------- ----------  ----------
  Parse        2      0.00       0.01          1         31          0           0
  Execute      2      0.00       0.00          0          0          0           0
  Fetch        2      0.00       0.01          5         14          0           2
  ------- ------  -------- ---------- ---------- ---------- ----------  ----------
  total        6      0.00       0.03          6         45          0           2
 
  Misses in library cache during parse: 1
  Optimizer goal: CHOOSE
  Parsing user id: 62 
 
  Rows     Row Source Operation
  -------  ---------------------------------------------------
        1  SORT AGGREGATE
       16   TABLE ACCESS FULL SYS_DEPT

sql_trace基本用法