10046 日志中几个缩写注释

*** 2011-10-19 13:24:30.053
*** ACTION NAME:() 2011-10-19 13:24:30.049
*** MODULE NAME:(SQL*Plus) 2011-10-19 13:24:30.049
*** SERVICE NAME:(SYS$USERS) 2011-10-19 13:24:30.049
*** SESSION ID:(2158.25302) 2011-10-19 13:24:30.049
=====================
PARSING IN CURSOR #1 len=33 dep=0 uid=330 oct=42 lid=330 tim=50777325294154 hv=525901419 ad='0'
alter session set sql_trace=false
END OF STMT
PARSE #1:c=0,e=1016,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=0,tim=50777325294117
EXEC #1:c=0,e=68,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=0,tim=50777325298614
在PARSING IN CURSOR行，
len：sql长度，
dep：递归调用的深度，
uid：解析sql语句的用户schema id，
oct：命令类型，
lid：对象属主的schema id，
tim：时间，
hv：sql statement id，
ad：library cache address of the cursor

在PARSE/EXEC行，
c：cpu 时间(9i之前是百分之一秒，之后是百万分之一秒)，
e：elapsed时间(9i之前是百分之一秒，之后是百万分之一秒)，
p：os read call（物理读取次数），
cr：一致读次数，
cu：当前读次数，
mis：library cache中没有此cursor而造成的miss次数，
r：返回的行数，
dep：递归调用的次数，=0表示没有，
og：优化器目标1=All_Rows, 2=First_Rows, 3=Rule, 4=Choose；
tim：时间（9i之前是百分之一秒，之后是百万分之一秒）

对于WAIT，有下面两个引用说：

9i WAIT Example  

(Full Table Scan) from Oracle9i (elapsed time in microseconds):       
    

        WAIT #1: nam="db file scattered read" ela=5010 p1=4 p2=1435 p3=25

         
               Completed WAITing under CURSOR no 1 
               for "db file scattered read" 
               We waited 5010 microseconds i.e. approx. 5 milliseconds 
               For a read of:  File 4, start block 1435, for 25 Oracle blocks

 

11g WAIT Examples

(Index Scan) from Oracle11g (elapsed time in microseconds): 

WAIT #6: nam='db file sequential read' ela= 8458 file#=110 block#=63682 blocks=1 obj#=221 tim=506028963546

               Completed WAITing under CURSOR no 6
               for "db file sequential read"
               We waited 8458 microseconds i.e. approx. 8.5 milliseconds
               For a read of:  File 110, start block 63682, for 1 Oracle block
               of Object number 221. Timestamp was 506028963546

WAIT #1: nam='library cache: mutex X' ela= 814 idn=3606132107 value=3302829850624 where=4 obj#=-1 tim=995364327604

               Completed WAITing under CURSOR no 1
               for "library cache: mutex X"
               We waited 814 microseconds i.e. approx. 0.8 milliseconds
               To get an eXclusive library cache latch with
               Identifier 3606132107 value 3302829850624 location 4
               It was not associated with any particular object (obj#=-1)
               Timestamp 995364327604

 

 metalink：39817.1