oracle实用工具:oradebug

1、 oradebug介绍
oradebug主要是给Oracle支持人员使用的,尽管很早便有,但oracle官网很少有记载。他是个sql*plus命令行工具,有sysdba的权限就可以登入,无需特别设置。他可以被用于:

 1)追踪进程,或者是你的,或者是外部的
  2)确定进程往哪个trc文件写
  3)转储:数据文件头、内部oracle结构等
  4)挂起进程,暂时的
  5)确定实例使用了哪些共享内存块和信号量
  6)找出RAC实例使用了哪些互联地址和协议
  7)修改SGA中的数据结构
 
2、 oradebug使用步骤

 1)启动sql*plus并以sysdba身份登入
  2)连接到一个进程
  3)设置一个事件或者进行诊断转储
  4)检索trc文件名
  5)与连接到的进程断开
 
3、 oradebug命令介绍




4、 连接到一个进程

在oradebug命令执行之前,你必须加入一个目标进程。这个目标进程有如下3种情况:

命令

目的

oradebug   setmypid

连接到为你的sql*plus提供服务的进程

oradebug  setorapid   pid

连接到一个外部服务进程,且pid=v$process.pid

oradebug  setospid  spid

连接到一个外部服务进程,且spid=v$process.pid


  1)、 setmypid

    sys@ORCL> oradebug setmypid  
    Statement processed.  
    sys@ORCL> oradebug unlimit  
    Statement processed.  
    sys@ORCL> oradebug event 10046 trace name context forever,level 8   
    Statement processed.  
    sys@ORCL> select * from hr.departments where department_id=10;  
      
    DEPARTMENT_ID DEPARTMENT_NAME                MANAGER_ID LOCATION_ID  
    ------------- ------------------------------ ---------- -----------  
               10 Administration                        200        1700  
      
    sys@ORCL> oradebug tracefile_name  
    /u01/app/oracle/admin/orcl/udump/orcl_ora_5234.trc  
    sys@ORCL> oradebug event 10046 trace name context off  
    Statement processed. 

   2)、setospid(spid操作)

    sys@ORCL> host top  
      
    top - 15:14:20 up 47 min,  2 users,  load average: 0.22, 0.20, 0.26  
    Tasks: 171 total,   2 running, 168 sleeping,   0 stopped,   1 zombie  
    Cpu(s):  1.3%us,  1.3%sy,  0.0%ni, 97.4%id,  0.0%wa,  0.0%hi,  0.0%si,  0.0%st  
    Mem:    678912k total,   671192k used,     7720k free,    16672k buffers  
    Swap:        0k total,        0k used,        0k free,   401584k cached  
      
      PID USER      PR  NI  VIRT  RES  SHR S %CPU %MEM    TIME+  COMMAND                                      
     5874 oracle    15   0  2444 1084  828 R  1.6  0.2   0:00.47 top                                          
     4781 root      15   0 53900  11m 6076 S  0.7  1.7   1:00.13 Xorg                                         
     5168 oracle    16   0  491m  17m  15m S  0.3  2.6   0:02.41 oracle                                       
    sys@ORCL> oradebug setospid 5168  
    Oracle pid: 7, Unix process pid: 5168, image: oracle@localhost.localdomain (CKPT) 

  3)、setorapid(pid操作)

    sys@ORCL> select sid from v$mystat where rownum=1;                  
      
           SID  
    ----------  
           159  
      
    sys@ORCL> select pid,spid from v$process p,v$session s where s.sid=159 and s.paddr=p.addr;  
      
           PID SPID  
    ---------- ------------  
            15 5234  
      
    sys@ORCL> oradebug setorapid 15  
    Statement processed.  
    sys@ORCL> oradebug tracefile_name  
    /u01/app/oracle/admin/orcl/udump/orcl_ora_5234.trc  
    sys@ORCL> oradebug event 10046 trace name context off  
    Statement processed. 

注意,在OEM的top session也可以等价实现上述效果,即:确定哪些数据库会话消耗了较多的资源

5、 oradebug IPC

查看共享信息的内存的命令是ipcs [-m|-s|-q]。默认会列出共享内存、信号量,队列信息,-m列出共享内存,-s列出共享信号量,-q列出共享队列

    sys@ORCL> host ipcs -m | grep ora  
    0xbe3bb918 5439503    oracle    640        419438592  20       
    sys@ORCL> oradebug setmypid  
    Statement processed.  
    sys@ORCL> oradebug ipc  
    Information written to trace file.  
    sys@ORCL> oradebug tracefile_name  
    /u01/app/oracle/admin/orcl/udump/orcl_ora_5234.trc  
    sys@ORCL> oradebug event 10046 trace name context off  
    Statement processed. 

 当一台电脑的资源有限时,失败的实例占用共享内存和信号量会导致资源紧张,从而使得新的oracle实例无法启动。
 清除命令是ipcrm [-m|-s|-q] id。
 -m 删除共享内存,-s删除共享信号量,-q删除共享队列
 如:ipcrm -m 5439503  

6、 oradebug SHORT_STACK

如果一个程序挂起,那么程序调用栈就可以显示它在调用路径中的哪一步挂起

    sys@ORCL> oradebug setospid 5180  
    Oracle pid: 13, Unix process pid: 5180, image: oracle@localhost.localdomain (D000)  
    sys@ORCL> oradebug short_stack  
                           ksdxfstk()+19<-ksdxcb()+1321<-sspuser()+81<-__kernel_vsyscall()+2<-ntevpque()+112<-ntevque()+606<-nsevwait()+821<-ksnwait()+111<-ksliwat()+770<-kslwaitns()+29<-  
 kskthbwt()+370<-kslwait()+57<-kmdmai()+1797<-kmmrdp()+432<-opirip()+1191<-opidrv()+864<-sou2o()+113<-opimai_real()+353<-main()+111<-__libc_start_main()+220  
    sys@ORCL> oradebug event 10046 trace name context off  
    Statement processed. 

当前的调用步骤在输出的顶部

7、 诊断转储

  可转储类型如下:

    sys@ORCL> oradebug dumplist  
    EVENTS  
    TRACE_BUFFER_ON  
    TRACE_BUFFER_OFF  
    HANGANALYZE  
    LATCHES  
    PROCESSSTATE  
    SYSTEMSTATE  
    INSTANTIATIONSTATE  
    ......... 


下面举例两个:

  1)、controlf

    sys@ORCL> oradebug setmypid  
    Statement processed.  
    sys@ORCL> oradebug dump controlf 10  
    Statement processed.  
    sys@ORCL> oradebug tracefile_name  
    /u01/app/oracle/admin/orcl/udump/orcl_ora_5234.trc 

  2)、events

  这不是真正的转储,events只是将激活的事件写入trc文件。如果你不能确定一个会话、进程或者实例中哪个事件是活动的,下面有一种很好的方式去查询:

    sys@ORCL> alter session set events '10046 trace name context forever,level 8';  
      
    Session altered.  
      
    sys@ORCL> alter session set events '4031 trace name heapdump level 3';  
      
    Session altered.  
      
    sys@ORCL> oradebug setmypid  
    Statement processed.  
    sys@ORCL> oradebug dump events 1  
    Statement processed.  
    sys@ORCL> oradebug tracefile_name  
    /u01/app/oracle/admin/orcl/udump/orcl_ora_5234.trc  
    sys@ORCL> oradebug event 10046  trace name context off  
    Statement processed. 

oradebug dump events的级别和范围

级别 事件范围 使用的命令
1 会话 alter session
2 进程 oradebug  event
4 实例 alter system



8、 小结

     oradebug对于解决问题和诊断性能是必不可少的工具。本文只是讲述了一些最常见的命令,还有更多的功能,比如RAC环境下调用全局队列服务调试器的

oradebug lkdebug命令。


=====补充=====================================================
Oradebug命令它可以启动用停止跟踪任何会话,最常用的就是它可以直接通过命令输出生成trace文件的名称(带路径的),省去不少麻烦,系统HANG住用它做分析也比较好用!


1> oradebug有哪些可用命令?

  sysdba身份登陆数据库,通过oradebug help可以看到oradebug常用命令

  sqlplus / as sysdba

  oradebug help

2> 跟踪当前会话信息

  oradebug setmypid --跟踪当前会话

  oradebug setospid --跟踪系统进程

  oradebug setorapid --跟踪ORACLE进程

  oradebug unlimit  --取消trace文件大小限制     

  oradebug tracefile_name --查看trace文件名及位置

3> oradebugsession1004610053

  oradebug setmypid

  oradebug unlimit

  oradebug session_event 10046 trace name context forever ,level 4   --启用会话级10046

  oradebug session_event 10046 trace name context off                --关闭10046事件

  oradebug tracefile_name                                            --查看tracefile文件位置及文件名

4> oradebugoracle process10046

  oradebug setorapid

  oradebug unlimit

  oradebug event 10046 trace name context forever ,level 4

  oradebug event 10046 trace name context off 

  oradebug tracefile_name

5> oradebug系统hang住原因分析

  如果系统HANG住,只要sys用户可以登陆,那么用oradebug做原因分析是非常有用的

  oradebug setmypid

  oradebug unlimit

  oradebug setinst all  --RAC环境

  oradebug hanganalyze 3 -- 级别一般指定为3足够了

  oradebug -g def dump systemstate 10 --RAC环境

  oradebug tracefile_name

使用oradebug 命令 -- —针对rac的用法
ORADEBUG setmypid
oradebug unlimit
ORADEBUG setinst all
ORADEBUG -g def hanganalyze 3
oradebug close_trace
oradebug tracefile_name
   
对于单实例,我们通常进行如下操作即可:
oradebug setmypid
oradebug unlimit
oradebug hanganalyze 3
oradebug close_trace
oradebug tracefile_name

6> 获取某进程的状态信息

  oradebug setospid 22180

   oradebug dump processstate 10

  oradebug tracefile_name

7> 获取进程错误信息状态

  oradebug setospid 22180

  oradebug dump errorstack 3

8> 追踪造成错误信息的原因,如ORA-04031

  oradebug event 4031 trace name errorstack level 3


   实验
oradebug session
级别的10046事件跟踪:

——设置当前会话pid

SYS@ORA11GR2>oradebug setmypid

Statement processed.

 

——开启10046事件跟踪:

SYS@ORA11GR2>oradebug session_event 10046 trace name context forever,level 12;

Statement processed.

SYS@ORA11GR2>

——进行操作以生成trace文件:

SYS@ORA11GR2>create table t1 as select * from user_objects;

 

Table created.

 

SYS@ORA11GR2>select count(*) from t1;

 

  COUNT(*)

----------

     37793

 

——关闭10046事件:

SYS@ORA11GR2>oradebug session_event 10046 trace name context off;

Statement processed.

 

——查看跟踪问位置:

SYS@ORA11GR2>oradebug tracefile_name

/u01/app/oracle/diag/rdbms/ora11gr2/ORA11GR2/trace/ORA11GR2_ora_30254.trc

SYS@ORA11GR2>

SYS@ORA11GR2>!ls /u01/app/oracle/diag/rdbms/ora11gr2/ORA11GR2/trace/ORA11GR2_ora_30254.trc

/u01/app/oracle/diag/rdbms/ora11gr2/ORA11GR2/trace/ORA11GR2_ora_30254.trc

验证:

[oracle@wang trace]$ pwd

/u01/app/oracle/diag/rdbms/ora11gr2/ORA11GR2/trace

[oracle@wang trace]$ ls –lrt

-rw-r----- 1 oracle oinstall      91 Oct 15 23:10 ORA11GR2_mmon_27426.trm

-rw-r----- 1 oracle oinstall    1172 Oct 15 23:10 ORA11GR2_mmon_27426.trc

-rw-r----- 1 oracle oinstall    2344 Oct 15 23:11 ORA11GR2_ora_30254.trm

-rw-r----- 1 oracle oinstall  895526 Oct 15 23:11 ORA11GR2_ora_30254.trc

[oracle@wang trace]$

 

——利用tkprof工具格式化trace文件:

[oracle@wang trace]$ tkprof ORA11GR2_ora_30254.trc 2311

 

TKPROF: Release 11.2.0.4.0 - Development on Sat Oct 15 23:15:21 2016

 

Copyright (c) 1982, 2011, Oracle and/or its affiliates.  All rights reserved.

 

验证:

[oracle@wang trace]$ ls 2311.prf

2311.prf

[oracle@wang trace]$

 

——查看生成的trace文件:

[oracle@wang trace]$ cat 2311.prf

省略………………………..

*******************************************************************************

SQL ID: f9cw1jf3v3nvk Plan Hash: 1647312333

 

create table t1 as select

 

call     count       cpu    elapsed       disk      query    current        rows

------- ------  -------- ---------- ---------- ---------- ----------  ----------

Parse        1      0.02       0.01          0          0          0           0

Execute      1      0.21       0.25          0       1371        758       37793

Fetch        0      0.00       0.00          0          0          0           0

------- ------  -------- ---------- ---------- ---------- ----------  ----------

total        2      0.23       0.27          0       1371        758       37793

 

Misses in library cache during parse: 1

Optimizer mode: ALL_ROWS

Parsing user id: SYS

Number of plan statistics captured: 1

 

Rows (1st) Rows (avg) Rows (max)  Row Source Operation

---------- ---------- ----------  ---------------------------------------------------

         0          0          0  LOAD AS SELECT  (cr=1559 pr=0 pw=514 time=255298 us)

     37793      37793      37793   VIEW  USER_OBJECTS (cr=1350 pr=0 pw=0 time=187371 us cost=312 size=538650 card=2835)

     37793      37793      37793    UNION-ALL  (cr=1350 pr=0 pw=0 time=177792 us)

         0          0          0     TABLE ACCESS BY INDEX ROWID SUM$ (cr=0 pr=0 pw=0 time=0 us cost=1 size=9 card=1)

         0          0          0      INDEX UNIQUE SCAN I_SUM$_1 (cr=0 pr=0 pw=0 time=0 us cost=0 size=0 card=1)(object id 1035)

         0          0          0     TABLE ACCESS BY INDEX ROWID OBJ$ (cr=0 pr=0 pw=0 time=0 us cost=3 size=30 card=1)

         0          0          0      INDEX RANGE SCAN I_OBJ1 (cr=0 pr=0 pw=0 time=0 us cost=2 size=0 card=1)(object id 36)

     37793      37793      37793     FILTER  (cr=1349 pr=0 pw=0 time=108189 us)

     37793      37793      37793      HASH JOIN  (cr=1078 pr=0 pw=0 time=39878 us cost=295 size=317894 card=2999)

        92         92         92       INDEX FULL SCAN I_USER2 (cr=1 pr=0 pw=0 time=10 us cost=1 size=2024 card=92)(object id 47)

     37793      37793      37793       TABLE ACCESS FULL OBJ$ (cr=1077 pr=0 pw=0 time=22663 us cost=294 size=251916 card=2999)

      1251       1251       1251      TABLE ACCESS BY INDEX ROWID IND$ (cr=271 pr=0 pw=0 time=4705 us cost=2 size=8 card=1)

      1251       1251       1251       INDEX UNIQUE SCAN I_IND1 (cr=52 pr=0 pw=0 time=1233 us cost=1 size=0 card=1)(object id 41)

         0          0          0      NESTED LOOPS  (cr=0 pr=0 pw=0 time=0 us cost=2 size=29 card=1)

         0          0          0       INDEX SKIP SCAN I_USER2 (cr=0 pr=0 pw=0 time=0 us cost=1 size=20 card=1)(object id 47)

         0          0          0       INDEX RANGE SCAN I_OBJ4 (cr=0 pr=0 pw=0 time=0 us cost=1 size=9 card=1)(object id 39)

         0          0          0     TABLE ACCESS BY INDEX ROWID LINK$ (cr=1 pr=0 pw=0 time=19 us cost=0 size=88 card=1)

         0          0          0      INDEX RANGE SCAN I_LINK1 (cr=1 pr=0 pw=0 time=18 us cost=0 size=0 card=1)(object id 138)

 

 

Elapsed times include waiting on following events:

  Event waited on                             Times   Max. Wait  Total Waited

  ----------------------------------------   Waited  ----------  ------------

  Disk file operations I/O                        2        0.00          0.00

  direct path write                              18        0.00          0.00

  direct path sync                                1        0.04          0.04

  log file sync                                   1        0.00          0.00

  SQL*Net message to client                       1        0.00          0.00

  SQL*Net message from client                     1        0.00          0.00

**************************************************************************************************************************************************************

SQL ID: 5bc0v4my7dvr5 Plan Hash: 3724264953

 

select count(*)

from

 t1

 

call     count       cpu    elapsed       disk      query    current        rows

------- ------  -------- ---------- ---------- ---------- ----------  ----------

Parse        1      0.00       0.00          0          1          0           0

Execute      1      0.00       0.00          0          0          0           0

Fetch        2      0.00       0.00        120        518          0           1

------- ------  -------- ---------- ---------- ---------- ----------  ----------

total        4      0.00       0.00        120        519          0           1

 

Misses in library cache during parse: 1

Optimizer mode: ALL_ROWS

Parsing user id: SYS

Number of plan statistics captured: 1

 

Rows (1st) Rows (avg) Rows (max)  Row Source Operation

---------- ---------- ----------  ---------------------------------------------------

         1          1          1  SORT AGGREGATE (cr=518 pr=120 pw=0 time=4122 us)

     37793      37793      37793   TABLE ACCESS FULL T1 (cr=518 pr=120 pw=0 time=7913 us cost=141 size=0 card=37628)

 

 

Elapsed times include waiting on following events:

  Event waited on                             Times   Max. Wait  Total Waited

  ----------------------------------------   Waited  ----------  ------------

  SQL*Net message to client                       2        0.00          0.00

  db file scattered read                         20        0.00          0.00

  db file sequential read                         1        0.00          0.00

  SQL*Net message from client                     2        0.00          0.00

 

***********************************************************************

请使用浏览器的分享功能分享到微信等