教你熟练使用hanganalyze来分析数据库

来源:岁月联盟 编辑:zhuzhu 时间:2007-08-17

1.为什么要使用hanganalyze?

Oracle数据库“真的”hang住了,可以理解为数据库内部发生死锁。因为普通的DML死锁,oracle服务器会自动监测他们的依赖关系,并回滚其中一个操作,终止这种相互等待的局面。而当这种死锁发生在争夺内核级别的资源(比如说是pins或latches)时,Oracle并不能自动的监测并处理这种死锁。

其实很多时候数据库并没有hang住,而只是由于数据库的性能问题,处理的时间比较长而已。

Hanganalyze工具使用内核调用检测会话在等待什么资源,报告出占有者和等待者的相互关系。另外,它还会将一些比较”interesting”的进程状态dump出来,这个取决于我们使用hanganalyze的分析级别。

使用hanganalyze

hanganalyze工具从oracle8i第二版开始提供,到9i增强了诊断RAC环境下的“集群范围”的信息,这意味着它将会报告出整个集群下的所有会话的信息。

目前有三种使用hanganalyze的方法:

一种是会话级别的:

 

ALTER SESSION SET EVENTS 'immediate trace name HANGANALYZE level <level>';

一种是实例级别:

 

ORADEBUG hanganalyze <level>

一种是集群范围的:

 

ORADEBUG setmypid ORADEBUG setinst all ORADEBUG -g def hanganalyze <level>

先解释下各个level的含义:

1-2:只有hanganalyze输出,不dump任何进程

3:Level2+Dump出在IN_HANG状态的进程

4:Level3+Dump出在等待链里面的blockers(状态为LEAF/LEAF_NW/IGN_DMP)

5:Level4+Dump出所有在等待链中的进程(状态为NLEAF)

hanganalyze报告会分作许多片断,会话片断信息总是由一个header详尽描述被提取的的会话信息。Oracle8i和9i的信息略有不同:

 

Oracle 8.x chain header: <sid/sess_srno/proc_ptr/ospid/wait_event> Oracle9i chain header: <cnode/sid/sess_srno/proc_ptr/ospidd/wait_event> :

先把在trace file中看到的一些缩略语解释一下:

 

sid是 Session IDsess_srno是serial#proc_ptr是Process Pointerospid 是OS Process IDcnode是Node Id,Oracle9i才用Nodenum是hanganalyze自己为了记录这些会话而定制的编号,从0开始排起。State 是node的状态Adjlist是临近的node(通常代表一个blocker node)Predecessor是Predecessor node ,通常代表一个 waiter node

 

 

接着解释一下比较重要的一些node state:

IN_HANG:这表示该node处于死锁状态,通常还有其他node(blocker)也处于该状态

LEAF/LEAF_NW:该node通常是blocker。通过条目的”predecessor”列可以判断这个node是否是blocker。LEAF说明该NODE没有等待其他资源,而LEAF_NW则可能是没有等待其他资源或者是在使用CPU.

如下的实例说明了node16阻塞了node19的资源:

 

nodenum]/cnode/sid/sess_srno/session/ospid/state/start/finish/[adjlist]/predecessor [16]/0/17/154/0x24617be0/26800/LEAF/29/30//19 [19]/0/20/13/0x24619830/26791/NLEAF/33/34/[16]/186

NLEAF:通常可以看作这些会话是被阻塞的资源。发生这种情况一般说明数据库发生性能问题而不是数据库hang

IGN/IGN_DMP:这类会话通常被认为是空闲会话,除非其adjlist列里存在node。如果是非空闲会话则说明其adjlist里的node正在等待其他node释放资源。

SINGLE_NODE/SINGLE_NODE_NW:近似于空闲会话

实战hanganalyze:

 

生成跟踪文件SQL> oradebug setmypid已处理的语句SQL> oradebug hanganalyze 3

查看跟踪文件

 

============== HANG ANALYSIS: ============== Open chains found: Chain 1 : <sid/sess_srno/proc_ptr/ospid/wait_event> : <5/1/0x843630f8/2531/No Wait> Chain 2 : <sid/sess_srno/proc_ptr/ospid/wait_event> : <12/1/0x84364e48/2521/instance state change>

有一个等待事件,操作系统进程是2521,经检查,是smon,占用了一个CPU的98%的资源

 

Other chains found: Extra information that will be dumped at higher levels: [level  4] :   2 node dumps -- [LEAF] [LEAF_NW] [IGN_DMP] [level 10] :   6 node dumps -- [IGN] State of nodes ([nodenum]/sid/sess_srno/session/state/start/finish/[adjlist]/predecessor): [0]/1/1/0x84405460/IGN/1/2//none [1]/2/1/0x84405de0/IGN/3/4//none [2]/3/1/0x84406760/IGN/5/6//none [3]/4/1/0x844070e0/IGN/7/8//none [4]/5/1/0x84407a60/LEAF_NW/9/10//none [5]/6/1/0x844083e0/IGN/11/12//none [10]/11/1/0x8440b360/IGN/13/14//none [11]/12/1/0x8440bce0/LEAF/15/16//none Dumping System_State and Fixed_SGA in process with ospid 2521 Dumping Process information for process with ospid 2531 Dumping Process information for process with ospid 2521 *** 2004-12-09 00:07:49.680 ==================== END OF HANG ANALYSIS ====================

我们看到,并没有发生死锁,Smon进程忙,说明在正确释放资源。