解读未被tkprof格式化的trace文件！

继续使用前面的trace文件，截取一段来说明：

=====================
PARSING IN CURSOR #3 len=37 dep=0 uid=65 oct=3 lid=65 tim=1288930120824471 hv=556034074 ad='29aafa1c'
select * from t where object_id = 100
END OF STMT
PARSE #3:c=10998,e=10464,p=0,cr=27,cu=0,mis=1,r=0,dep=0,og=1,tim=1288930120824464
EXEC #3:c=0,e=15,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=1,tim=1288930120824542
FETCH #3:c=3000,e=2544,p=1,cr=551,cu=0,mis=0,r=1,dep=0,og=1,tim=1288930120827291
FETCH #3:c=1000,e=1094,p=0,cr=180,cu=0,mis=0,r=0,dep=0,og=1,tim=1288930120839484
STAT #3 id=1 cnt=1 pid=0 pos=1 obj=52968 op='TABLE ACCESS FULL T (cr=731 pr=1 pw=0 time=2532 us)'
=====================

PARSING IN CURSOR部分

CURSOR #3 这个号在整个trace文件中不是唯一的，当一条sql语句执行完毕后，这个号会被另外的sql语句重用。

len：被分析的sql的长度

dep：产生递归sql的深度

uid：user id

oct：oracle command type 命令的类型

lid：私有的用户id

tim：时间戳

hv：hash value

ad：sql address

PARSE，EXEC，FETCH部分

c：消耗的cpu time

e：elapsed time操作的用时

p：physical reads 物理读的次数

cr：consistent reads 一致性方式读取的数据块

cu：current方式读取的数据块

mis：cursor miss in cache硬分析次数

r：row 处理的行数

dep：depth 递归sql的深度

og：Optimizer goal 优化器模式

tim：timstamp 时间戳

STAT部分

id：执行计划的行源号

cnt：当前行源返回的行数

pid：当前行源的父号

pos：执行计划中的位置

obj：当前操作的对象id（如果当前行原始一个对象的话）

op：当前行源的数据访问操作

cr：consistent read 一致性方式读取的数据块，相当于query列上Fetch步骤的值。

pr：物理读取的数据块，相当于disk列上Fetch步骤的值。

pw：物理写。

time：当前操作执行的时间。

[oracle@linux udump]$ cat orcl_ora_3679.trc
/u01/app/oracle/admin/orcl/udump/orcl_ora_3679.trc
Oracle Database 10g Enterprise Edition Release 10.2.0.4.0 - Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
ORACLE_HOME = /u01/app/oracle/product/10.2.0/db_1
System name:    Linux
Node name:      linux
Release:        2.6.18-164.el5
Version:        #1 SMP Tue Aug 18 15:51:54 EDT 2009
Machine:        i686
Instance name: orcl
Redo thread mounted by this instance: 1
Oracle process number: 15
Unix process pid: 3679, image: oracle@linux (TNS V1-V3)

*** 2011-10-29 13:00:43.719
*** ACTION NAME:() 2011-10-29 13:00:43.718
*** MODULE NAME:(SQL*Plus) 2011-10-29 13:00:43.718
*** SERVICE NAME:(SYS$USERS) 2011-10-29 13:00:43.718
*** SESSION ID:(159.11) 2011-10-29 13:00:43.718

在trace文件的头部还记录了很多数据库和操作系统的信息。