SQL_TRACE的作用

使 SQL_TRACE 设置SQL 跟踪非常简单，SQL_TRACE是一个参数，只需要在会话层将它设置为 TRUE，就开启了 SQL 跟踪，Oracle 将会把 SQL 语句的执行过程记录到跟踪文件中。通过查阅跟踪文件，将利于你了解 SQL 语句的执行过程，这将帮助你调优、排故 SQL语句。 

 

跟踪文件的位置在 user_dump_dest 初始化参数中，如下方法可以显示出跟踪文件的位置： 

SQL> show parameter user_dump_dest 
NAME                                 TYPE        VALUE 
------------------------------------ ----------- ------------------------------ 
user_dump_dest                       string      E:\ORACLE\PRODUCT\10.2.0\ADMIN 
                                                 \JJONE\UDUMP 
  在我的主机中，跟踪文件在 E:\ORACLE\PRODUCT\10.2.0\ADMIN\JJONE\UDUMP 中。 

下面我们练习一次 SQL跟踪。 

步 1：启用跟踪： 
SQL> alter session set sql_trace=true; 
会话已更改。 

  注意要在会话层设置此参数，不要在实例层设置。 

步 2：执行需要跟踪的 SQL 语句 

SQL> select * from ui1 where id=1; 
        ID NAME 
---------- ----- 
         1 1 
  我们在此随变执行个什么语句都行，Oracle 会将此语句的执行过程记录到跟踪文件中。  

步 3：关闭跟踪 
SQL> alter session set sql_trace=false; 
会话已更改。 
  注意，在执行完想要跟踪的语句后，要马上关闭跟踪。以免不必要的语句的执行过程也被记录到跟踪文件中。这将影响阅读跟踪文件的结果。 

步 4：查阅跟踪文件： 
  到 E:\ORACLE\PRODUCT\10.2.0\ADMIN\JJONE\UDUMP 目录中，找到日期最新的文件，它就是 Oracle刚刚生成的跟踪文件。在本例中，它的名字“jjone_ora_3600.trc” 。打开它查看，此时它的信息还不是太容易理解，Oracle 为了帮助我们阅读 SQL 的跟踪文件，专门提供了一个 TKPROF 工具，在操作系统命令提示符下（注意不是在 SQLPLUS 中），输入如下命令： 

C:\>tkprof E:\ORACLE\PRODUCT\10.2.0\ADMIN\JJONE\UDUMP\jjone_ora_3600.trc sql1.txt 
TKPROF: Release 10.2.0.1.0 - Production on 星期三 10 月 15 12:01:00 2008 
Copyright (c) 1982， 2005， Oracle.  All rights reserved. 
 

tkporf 工具的使用非常简单，只需输入：“tkprof 跟踪文件 目标文件”即可，Tkprof将会把跟踪文件处理为更容易阅读的格式，并把处理结果保存到你指定的目标文件中。目标
文件也是普通的文本型文件，可以使用任何文本编辑软件打开。 

  在目标文件中，我们搜索 UI1，可以方便的找到所跟踪的语句，你将看到如下信息： 
select *  from  ui1 where id=1 

call     count       cpu    elapsed       disk      query    current        rows 
------- ------  -------- ---------- ---------- ---------- ----------  ---------- 
Parse        1      0.00       0.02          0          0          0           0 
Execute      1      0.00       0.00          0          0          0           0 
Fetch        2      0.00       0.02          3          4          0           1 
------- ------  -------- ---------- ---------- ---------- ----------  ---------- 
total        4      0.00       0.04          3          4          0           1 
Misses in library cache during parse: 1 
Optimizer mode: ALL_ROWS 
Parsing user id: 66   
Rows     Row Source Operation 
-------  --------------------------------------------------- 
      1  TABLE ACCESS BY INDEX ROWID UI1 (cr=4 pr=3 pw=0 time=27320 us) 
      1   INDEX RANGE SCAN UI1_ID (cr=3 pr=2 pw=0 time=23332 us)(object id 52405) 

  在你的语句之下，首先是一个表格，它通常有三行组成，它显示该查询各阶段的重要的执行统计数据。这三行代表查询的三个主要阶段： 

解析（Parse）：此阶段是Oracle 的优化器为 SQL语句生成执行计划的阶段。 

执行（Execute）：此阶段是服务器进程按照执行计划执行语句的阶段。

抓取（Fetch）：此阶段是服务器进程从表中抓取结果的阶段。只有 Select 语句才需要此阶段，Update、Insert、Delete 等这些 DML 语句并不需要抓取行。

这个表格通常包括八列，这八列意义如下： 
Call：说明了语句执行的每个阶段。 
Count：此阶段的执行次数。 
CPU：完成此阶段工作所耗的 CPU 时间，单位是毫秒。 
Elapsed：完成此阶段工作所耗费的 CPU 时间再加上等待的时间，单位也是毫秒。 
Disk：完成此阶段工作所用的物理读次数。 
Query：完成此阶段工作所用的一致读次数。 
Current：完成此阶段工作所用的当前读次数。Query和 Current 加起来就是逻辑读。 
Rows：完成此阶段工作所操作的行数。 

接下来一行：“Misses in library cache during parse:”说明硬解析的次数，本例中语句的执行进行了一次硬解析。 

“Optimizer mode”是优化器模式，这个我们会在 SQL 调优章节中详细讲述它的意义。 

最后几行是执行计划，这也是后面章节的内容。 
  另外，我们在目标文件中还会发现大量的其他语句，注意，我们在跟踪其间，只执行了一条 SQL 语句，跟踪文件中其他的语句，其实就是所谓的递归调用。也就是为了完成我们的语句，Oracle 内部执行的一些其他的 SQL 语句。 

  通过观察跟踪文件的目标文件，我们可以观察到比较精确的 CPU 时间、物理读逻辑读等信息，这有助于我们了解一条 SQL语句是否有效。