Oracle数据库trace文件解析

        oracletrace文件解析                         oracletrace文件解析***2006-02-2322:11:45.000=====================PARSINGINCURSOR#1len=68dep=0uid=59oct=42lid=59tim=12047812267hv=570864185ad='66bd0bc4'altersessionsetevents'10046tracenamecontextforever,level12'ENDOFSTMTEXEC#1:c=0,e=89,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=12047812255WAIT#1:nam='SQL*Netmessagetoclient'ela=5p1=1111838976p2=1p3=0WAIT#1:nam='SQL*Netmessagefromclient'ela=3350384p1=1111838976p2=1p3=0=====================PARSINGINCURSOR#1len=57dep=0uid=59oct=3lid=59tim=12051164358hv=1391558827ad='66bfe7d8'selectcount(*)fromempa,deptbwherea.deptno=b.deptnoENDOFSTMTPARSE#1:c=0,e=76,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=12051164349BINDS#1:EXEC#1:c=0,e=192,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=12051165308WAIT#1:nam='SQL*Netmessagetoclient'ela=7p1=1111838976p2=1p3=0FETCH#1:c=0,e=140,p=0,cr=5,cu=0,mis=0,r=1,dep=0,og=4,tim=12051165720WAIT#1:nam='SQL*Netmessagefromclient'ela=302p1=1111838976p2=1p3=0FETCH#1:c=0,e=4,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=0,tim=12051166486WAIT#1:nam='SQL*Netmessagetoclient'ela=4p1=1111838976p2=1p3=0WAIT#1:nam='SQL*Netmessagefromclient'ela=3248265p1=1111838976p2=1p3=0STAT#1id=1cnt=1pid=0pos=1obj=0op='SORTAGGREGATE'STAT#1id=2cnt=14pid=1pos=1obj=0op='NESTEDLOOPS'STAT#1id=3cnt=14pid=2pos=1obj=30139op='TABLEACCESSFULLEMP'STAT#1id=4cnt=14pid=2pos=2obj=30138op='INDEXUNIQUESCANPK_DEPT'=====================PARSINGINCURSOR#1len=55dep=0uid=59oct=42lid=59tim=12054418195hv=3381932903ad='66bd7b34'altersessionsetevents'10046tracenamecontextoff'ENDOFSTMTPARSE#1:c=15625,e=703,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=12054418182BINDS#1:EXEC#1:c=0,e=321,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=12054419670#######################################PARSINGINCURSOR#1len=68dep=0uid=59oct=42lid=59tim=12047812267hv=570864185ad='66bd0bc4'Cursor#游标号lenSQL语句的长度depSQL语句的递归深度Uid当前模式中的用户IDOctOracle命令类型Lid用于核对访问权限的用户IDTim一个计时器，精度以1%秒为单位HaSQL语句的散列ID号Ad指向SQL语句的V$SQLAREA的ADDR列EXECCursor#:c=%d,e=%d,p=%d,cr=%d,cu=%d,mis=%d,r=%d,dep=%d,og=%d,tim=%dEXEC#1:c=0,e=89,p=0,cr=0,cu=0,mis=0,r=0,dep=0,og=4,tim=12047812255Cursor#光标号c以1%秒为单位的CPU运行时间e以1%秒为单位的经过的时间p所执行的物理读的数量crConsistent模式下的读（逻辑输入/输出）cuCurrent模式下的读（逻辑输入/输出）mis丢失在数据库缓存中的游标，指出由于它在数据共享区中老化，或不在数据共享池里，或其他造成无效的原因r处理的行数depSQL语句的递归深度og优化器目标，1=所有行，2=起始行，3=规则，4=选择tim计时器，精度以1%秒为单位的时间PARSE分析一个语句FETCH从游标中取出所需行时UNMAP用以从程序运行中间结果中释放一些不再用到的临时段SORTUNMAP和unmap类似，只不过用于排序段WAITCursor#:nam='%s'ela=%dp1=%ulp2=%ulp3=%ulWAIT#1:nam='SQL*Netmessagetoclient'ela=5p1=1111838976p2=1p3=0WAIT#1:nam='SQL*Netmessagefromclient'ela=3350384p1=1111838976p2=1p3=0Cursor#游标号nam等待事件的名称。OracleServerReference中列出了全部等待事件，并有详细解释ela以1%秒为单位的事件经过的时间p1,p2,p3专门用于等待事件的参数。每一个事件都有它自己的一套参数。参考OracleServerReference中关于特定等待事件的参数p1,p2,p3的含义BINDS#4:bind0:dty=2mxl=22(21)mal=00scl=00pre=00oacflg=03oacf12=1size=24offset=0bfp=07425360bln=22avl=03flg=05value=7698cursor#游标号bindN绑定位置，从0开始(0是第一个绑定变量)dty数据类型，dty数据类型的数字用USER_TAB_COLUMNS视图的信息来解码mxl绑定变量的最大长度mal最大最组的长度(当用到数组绑定变量或批操作时)scl比例pre精度oacflg内部标记，这个数字若是奇数，绑定变量就是空(允许有空值)ocaf12内部标记的扩展size缓冲区的大小bfp绑定地址bln绑定缓冲区的长度avl实际值的长度flg内部标记value绑定值的字符串的表示(如果可能，是16进制转储)，这正是想要得到的如何解析等待资源？WAIT#4:nam='enqueue'ela=308p1=1415053318p2=393290p3=2947createorreplacefunctionenqueue_decode(l_p1innumber)returnvarchar2asl_strvarchar2(25);beginselectchr(bitand(l_p1,-16777216)/16777215)||chr(bitand(l_p1,16711680)/65535)||''||decode(bitand(l_p1,65535),0,'Nolock',1,'Nolock',2,'Row-Share',3,'Row-Exclusive',4,'Share',5,'ShareRow-Excl',6,'Exclusive')intol_strfromdual;returnl_str;end;/selectenqueue_decode(1415053318)fromdual;XCTENDrlbk=0,rd_only=0rlbk返回标记，0表示提交过了，1表示返回rd_only只读标记，1表示事务是只读的，0可以进行改动，提交或返回WAIT#0:nam='logfilesync'ela=0p1=988p2=0p3=0STAT#4id=1cnt=1pid=0pos=0obj=0op='UPDATEEMP'STAT#4id=1cnt=1pid=1pos=1obj=24767op='TABLEACCESSFULLEMP'cursor#游标号id解释中的行，从1到该方案中的行数cnt通过查询方案此阶段的行数pid方案中这一步的父ID。用于以缩进恰当地反映方案的层次结构pos解释方案中的位置obj可用情况下，引用对象的目标IDop已执行操作的原文描述PARSEERROR#3:len=15dep=0uid=69oct=3lid=69tim=7160573err=903Cursor#游标号lenSQL语句的长度depSQL语句的递归深度Uid当前模式中的用户IDOctOracle命令类型Lid用于核对访问权限的用户IDTim一个计时器，精度以1%秒为单位errORA错误代码，可以执行如下方式得到错误的内容：EXECDBMS_OUTPUT.PUT_LINE(SQLERRM(-903));