trace文件的查看

$ tkprof
Usage: tkprof tracefile outputfile [explain= ] [table= ]
              [print= ] [insert= ] [sys= ] [sort= ]
  table=schema.tablename   Use 'schema.tablename' with 'explain=' option.
  explain=user/password    Connect to ORACLE and issue EXPLAIN PLAN.
  print=integer    List only the first 'integer' SQL statements.
  aggregate=yes|no
  insert=filename  List SQL statements and data inside INSERT statements.
  sys=no           TKPROF does not list SQL statements run as user SYS.
  record=filename  Record non-recursive statements found in the trace file.
  waits=yes|no     Record summary for any wait events found in the trace file.
  sort=option      Set of zero or more of the following sort options:
    prscnt  number of times parse was called
    prscpu  cpu time parsing
    prsela  elapsed time parsing
    prsdsk  number of disk reads during parse
    prsqry  number of buffers for consistent read during parse
    prscu   number of buffers for current read during parse
    prsmis  number of misses in library cache during parse
    execnt  number of execute was called
    execpu  cpu time spent executing
    exeela  elapsed time executing
    exedsk  number of disk reads during execute
    exeqry  number of buffers for consistent read during execute
    execu   number of buffers for current read during execute
    exerow  number of rows processed during execute
    exemis  number of library cache misses during execute
    fchcnt  number of times fetch was called
    fchcpu  cpu time spent fetching
    fchela  elapsed time fetching
    fchdsk  number of disk reads during fetch
    fchqry  number of buffers for consistent read during fetch
    fchcu   number of buffers for current read during fetch
    fchrow  number of rows fetched
    userid  userid of user that parsed the cursor

 

命令解释： 

1、tracefile ：包含了SQL_TRACE统计信息的TRACE文件名

2、Output_file：输出文件名字

3、print=number：包含在输出结果中的语句数量，如果没有列出来，那么默认所有语句都列出来

4、explain=username/passwd：在trace文件里对用户的sql语句运行explain plan，这个选项可以创建自己的plan_table，这样用户就需要创建表和创建表所需要的空间的特权，在tkprof运行结束以后会删除这个表，确保使用运行查询的用户，从而确保由正确的用户进行解释

5、insert=filename：这个选项生成脚本来创建表并为每个所跟踪的SQL语句存储TRACE文件统计

6、record=filename：这个选项将生成一个保存用户所有SQL语句的文件

7、sys=ye/no：这个选项可以在输出结果中不显示递归SQL语句。递归SQL就是一些为了完成用户操作所进行的一些对数据字典的访问和操作。例如为了执行插入操作，首先需要一个递归操作：分配一个extent给表所在的段。

8、sort=parameter

有大量的排序选项可用：FCHCPU（获取的CPU时间）、FCHDSK（获取的磁盘读取）、FCHCU和FCHQRY（获取的内存读取）、FCHROW（取出的行数）、EXEDSK（执行期间的磁盘读取数）、EXECU和EXEQRY（执行期间的内存读取数）、EXEROW（执行时处理的行数）、EXECPU（执行的CPU时间）、PRSCPU（分析CPU）、PRSCNT（分析时间）

9、waits=yes/no

任何等待事件的记录概要

10、aggregate=yes/no

是否组合相同SQL文本的多个用户

11、table=schema.table

在将执行计划写入到输出文件之前临时存放的位置

 

 

1..如果需要在session级别上设置trace，可以在sqlplus中使用下列语句：
SQL> alter session set sql_trace=true;
或者SQL> exec dbms_session.set_sql_trace(true);   -- (false)
会话已更改。

或者SQL>exec dbms_monitor.session_trace_enable(null,null);  -- (disable)

PL/SQL过程已成功完成。

 

2..如果要在PL/SQL中对session级别上设置trace，可以使用dbms_session这个包：
SQL>exec dbms_system.set_sql_trace_in_session(sid,serial#,true);
PL/SQL 过程已成功完成。

或者SQL> exec dbms_monitor.session_trace_enable(sid,serial#,true,false);

还可以通过基于客户端标识符设置跟踪。通过查看v$session的client_identifier字段确定客户端是否使用了标识符。客户端设置标识符的方法：

SQL> exec dbms_session.set_identifier('123456');

然后就可以跟踪这个会话：SQL>exec dbms_monitor.client_id_trace_enable('123456',true,false);     SQL>exec dbma_monitor.client_id_trace_disable('123456');

3.. 在user_dump_dest下找到该trc文件,文件最大容量由 max_dump_file_size决定

4.. 使用tkprof生成相关文件,tkprof放在$ORACLE_HOME/bin目录下，如无法执行请检查环境变量和PATH
tkprof erptest_ora_27576.trc session.txt explain=system/manager aggregate=yes sys=no waits=yes sort=fchela
相关说明:
sys=no：表示阻止所有以sys用户执行的sql被显示出来，默认为YES
aggregate=yes|no 若用户指定AGGREGATE=NO，TKPROF将不会对相同SQL文本的多个用户进行汇总
waits=yes|no Record summary for any wait events found in the trace file.

CALL： 每次SQL语句的处理都分成三个部分（Parse，Execute,Fetch）
Parse： 这步将SQL语句转换成执行计划，包括检查是否有正确的授权和所需要用到的表、列以及其他引用到的对象是否存在。
Execute： 这步是真正的由Oracle来执行语句。对于insert、update、delete操作，这步会修改数据，对于select操作,这步就只是确定选择的记录。
Fetch： 返回查询语句中所获得的记录，这步只有select语句会被执行。
COUNT: 这个语句被parse、execute、fetch的次数。

CPU： 这个语句对于所有的parse、execute、fetch所消耗的cpu的时间，以秒为单位。
ELAPSED： 这个语句所有消耗在parse、execute、fetch的总的时间。
DISK： 从磁盘上的数据文件中物理读取的块的数量。一般来说更想知道的是正在从缓存中读取的数据而不是从磁盘上读取的数据。
QUERY： 在一致性读模式下，所有parse、execute、fetch所获得的buffer的数量。 一致性模式的buffer是用于给一个长时间运行的事务提供一个一致性读的快照，缓存实际上在头部存储了状态。
CURRENT： 在current模式下所获得的buffer的数量。一般在current模式下执行insert、update、delete操作都会获取buffer。在current模式下如果在高速缓存区发现有新的缓存足够给当前的事务使用，则这些buffer都会被读入了缓存区中。
ROWS: 所有SQL语句返回的记录数目，但是不包括子查询中返回的记录数目。对于select语句，返回记录是在fetch这步，
对于insert、update、delete操作，返回记录则是在execute这步。

CR：一致性度 PR：物理读，PW:物理写，TIME就不用解释了吧单位是us

tkprof产生出来的文件示例:
call count cpu elapsed disk query current rows
------- ------ -------- ---------- ---------- ---------- ---------- ----------
Parse 5 0.00 0.00 0 0 0 0
Execute 7 0.10 0.14 0 0 0 0
Fetch 12 0.00 0.06 5 38 0 9
------- ------ -------- ---------- ---------- ---------- ---------- ----------
total 24 0.11 0.21 5 38 0 9

问题判断：
1. (query+current)/rows 平均每行所需的block数，太大的话（超过20）SQL语句效率太低
2. Parse count/Execute count parse count应尽量接近1，如果太高的话，SQL会进行不必要的reparse。
要检查Pro*C程序的MAXOPENCURSORS是不是太低了，或不适当的使用的RELEASE_CURSOR选项
3. rows Fetch/Fetch Fetch Array的大小，太小的话就没有充分利用批量Fetch的功能，
增加了数据在客户端和服务器之间的往返次数。在Pro*C中可以用prefetch=NN,Java/JDBC中可调用SETROWPREFETCH,
在PL/SQL中可以用BULK COLLECT,SQLPLUS中的arraysize(缺省是15)　　
4. disk/(query+current) 磁盘IO所占逻辑IO的比例，太大的话有可能是db_buffer_size过小(也跟SQL的具体特性有关)　　
5. elapsed/cpu 太大表示执行过程中花费了大量的时间等待某种资源　　
6. cpu　OR　elapsed 太大表示执行时间过长，或消耗了大量的CPU时间，应该考虑优化
7.　执行计划中的Rows 表示在该处理阶段所访问的行数，要尽量减少

来自 “ ITPUB博客 ” ，链接：http://blog.itpub.net/16705111/viewspace-733348/，如需转载，请注明出处，否则将追究法律责任。

转载于:http://blog.itpub.net/16705111/viewspace-733348/