posts - 431,  comments - 344,  trackbacks - 0

          . 如何得到這個(gè)日志文件

          如果有一個(gè)嚴(yán)重的錯(cuò)誤引起Java進(jìn)程非正常退出,我們叫Crash,這時(shí)候會(huì)產(chǎn)生一個(gè)日志文件。缺省情況下,這個(gè)文件會(huì)產(chǎn)生在工作目錄下。但是,可以在Java啟動(dòng)參數(shù)通過(guò)下面的設(shè)置,來(lái)改變這個(gè)文件的位置和命名規(guī)則。例如:
          Java -XX:ErrorFile=/var/log/java/java_error_%p.log
          就將這個(gè)錯(cuò)誤文件放在/var/log/java下,并且以java_error_pid.log的形式出現(xiàn)。

           

          .產(chǎn)生錯(cuò)誤的原因

          造成嚴(yán)重錯(cuò)誤的原因有多種可能性。Java虛擬機(jī)自身的Bug是原因之一,但是這種可能不是很大。在絕大多數(shù)情況下,是由于系統(tǒng)的庫(kù)文件、API或第三方的庫(kù)文件造成的;系統(tǒng)資源的短缺也有可能造成這種嚴(yán)重的錯(cuò)誤。在發(fā)生了Crash之后,如果無(wú)法定位根本原因,也應(yīng)該迅速找到Work Around的方法。

           

          .對(duì)日志文件的分析

          首先要檢查日志的文件頭:例如,下面是從一個(gè)客戶發(fā)過(guò)來(lái)的錯(cuò)誤日志的文件頭

          -------------------------------------
          #
          # An unexpected error has been detected by HotSpot Virtual Machine:
          #
          # EXCEPTION_ACCESS_VIOLATION (0xc0000005) at pc=0x0815e87e, pid=7268, tid=4360
          #
          # Java VM: Java HotSpot(TM) Server VM (1.4.2_13-b06 mixed mode)
          # Problematic frame:
          # V [jvm.dll+0x15e87e]
          #
          --------------------------------------

          文件頭中有很多有用的信息,“EXCEPTION_ACCESS_VIOLATION ”意味著Java應(yīng)用Crash的時(shí)候,正在運(yùn)行JVM自己的代碼,而不是外部的Java代碼或其他類(lèi)庫(kù)代碼。這種情況很可能是JVMBug,但是也不一定。除了“EXCEPTION_ACCESS_VIOLATION ”,還有可能是別的信息,例如“SIGSEGV(0xb)”,意味著JVM正在執(zhí)行本地或JNI的代碼;EXCEPTION_STACK_OVERFLOW意味著這是個(gè)棧溢出的錯(cuò)誤。

          另外一個(gè)有用的信息就是:
          # Problematic frame:
          # V [jvm.dll+0x15e87e]

          它說(shuō)明Crash的時(shí)候,JVM正在從哪個(gè)庫(kù)文件執(zhí)行代碼。除了“V”以外,還有可能是“C”、“j”、“v”、“J”。具體的表示意思如下:

          FrameType Description
          C: Native C frame
          j: Interpreted Java frame
          V: VMframe
          v: VMgenerated stub frame
          J: Other frame types, including compiled Java frames

          文件頭之后,是當(dāng)前線程的DUMP信息,線程之后是JVM進(jìn)程的DUMP信息,包括所有線程的狀態(tài)、地址和ID。最后還有JVM狀態(tài),Heap狀態(tài),動(dòng)態(tài)連接庫(kù)等等的信息。這些煩亂的信息中,包含有非常有用的信息。下面我們根據(jù)幾個(gè)具體的實(shí)例來(lái)分析Java虛擬機(jī)Crash的典型例子。


           

          .內(nèi)存回收引起的Crash

          內(nèi)存回收引起的Crash有以下的特點(diǎn):在日志文件頭一般有“ EXCEPTION_ACCESS _VIOLATION”和“# Problematic frame: # V [jvm.dll+....”的信息,意味著這是在JVM內(nèi)部處理,而且多半是JVMBug。對(duì)于這類(lèi)問(wèn)題,最快的方法就是繞過(guò)它。

          另外,在ThreadDUMP信息最后,還能看到有關(guān)內(nèi)存回收的行為例如:

          --------------- T H R E A D ---------------
          Current thread (0x00a56668): VMThread [id=4360]
          siginfo: ExceptionCode=0xc0000005, reading address 0x00000057
          Registers:
          ........

          Stack: [0x03cf0000,0x03d30000), sp=0x03d2fc18, free space=255k
          Native frames: (J=compiled Java code, j=interpreted, Vv=VM code, C=native code)
          V [jvm.dll+0x15e87e]

          VM_Operation (0x063efbac): full generation collection, mode: safepoint, requested by thread 0x040f83f8
          ------------------------------------------------------------

          可以清楚的看到JVM正在做 “full generation collection。另外還有可能看到,其他的回收行為:

          • generation collection for allocation

          • full generation collection

          • parallel gc failed allocation

          • parallel gc failed permanent allocation

          • parallel gc system gc


          對(duì)于內(nèi)存回收的錯(cuò)誤,一般采取改變回收的算法和參數(shù)的方法來(lái)繞過(guò)去。例如,來(lái)自客戶的日志除了上面的日志信息,在日志中Heap信息中還能發(fā)現(xiàn)一些其他信息:

          --------------------------------------------------------------
          Heap
          def new generation total 22592K, used 19530K [0x10010000, 0x11890000, 0x138f0000)
          eden space 20096K, 97% used [0x10010000, 0x11322bd8, 0x113b0000)
          from space 2496K, 0% used [0x113b0000, 0x113b0000, 0x11620000)
          to space 2496K, 0% used [0x11620000, 0x11620000, 0x11890000)
          tenured generation total 190696K, used 100019K [0x138f0000, 0x1f32a000, 0x30010000)
          the space 190696K, 52% used [0x138f0000, 0x19a9cf38, 0x19a9d000, 0x1f32a000)
          compacting perm gen total 38656K, used 38588K [0x30010000, 0x325d0000, 0x34010000)
          the space 38656K, 99% used [0x30010000, 0x325bf038, 0x325bf200, 0x325d0000)
          ----------------------------------------------------------------

          上面的信息能看出在Crash的時(shí)候,JVMPermSize空間幾乎已經(jīng)消耗完了,并且回收算法在壓縮Perm空間的時(shí)候出了錯(cuò)。因此,建議改變內(nèi)存回收的算法,或擴(kuò)大PermSizeMaxPermSize的數(shù)值。

           

          .棧溢出引起的Crash

           

          Java代碼引起的棧溢出,通常不會(huì)引起JVMCrash,而是拋出一個(gè)Java異常:Java.lang.StackOverflowError。但是在Java虛擬機(jī)中,Java的代碼和本地CC++代碼公用相同的Stack。這樣,在執(zhí)行本地代碼所造成的棧溢出,就有可能引起JVMCrash了。

          棧溢出引起的Crash會(huì)在日志的文件頭中看到“EXCEPTION_STACK_OVERFLOW字樣。另外,在當(dāng)前線程的Stack信息中也能發(fā)現(xiàn)一些信息。例如下面的例子:

          -----------------------------------------------------------------------------------
          # An unexpected error has been detected by HotSpot Virtual Machine:
          #
          # EXCEPTION_STACK_OVERFLOW (0xc00000fd) at pc=0x10001011, pid=296, tid=2940
          #
          # Java VM: Java HotSpot(TM) Client VM (1.6-internal mixed mode, sharing)
          # Problematic frame:
          # C [App.dll+0x1011]
          #
          --------------- T H R E A D ---------------
          Current thread (0x000367c0): JavaThread "main" [_thread_in_native, id=2940]
          :
          Stack: [0x00040000,0x00080000), sp=0x00041000, free space=4k
          Native frames: (J=compiled Java code, j=interpreted, Vv=VM code, C=native code)
          C [App.dll+0x1011]
          C [App.dll+0x1020]
          C [App.dll+0x1020]
          :
          C [App.dll+0x1020]
          C [App.dll+0x1020]
          ...<more frames>...
          Java frames: (J=compiled Java code, j=interpreted, Vv=VM code)
          j Test.foo()V+0
          j Test.main([Ljava/lang/String;)V+0
          v ~StubRoutines::call_stub

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

          在上面的信息中,可以發(fā)現(xiàn)這是個(gè)棧溢出的錯(cuò)誤。并且當(dāng)前棧剩余的空間已經(jīng)很小了(free space =4k)。因此建議將JVMStack的尺寸調(diào)大,主要設(shè)計(jì)兩個(gè)參數(shù):“-Xss” 和“-XX:StackShadowPages=n”但是,將棧的尺寸調(diào)大,也意味著在有限的內(nèi)存資源中,能打開(kāi)的最大線程數(shù)會(huì)減少。


          原文地址:http://azi.javaeye.com/blog/211534
          posted on 2009-08-12 14:13 周銳 閱讀(615) 評(píng)論(0)  編輯  收藏 所屬分類(lèi): Java
          主站蜘蛛池模板: 齐齐哈尔市| 孟津县| 盐津县| 承德县| 浏阳市| 高邮市| 江城| 美姑县| 乌拉特中旗| 巴里| 安康市| 富阳市| 岳阳市| 醴陵市| 格尔木市| 滨州市| 长治市| 城市| 阿拉善左旗| 响水县| 东海县| 大田县| 兰溪市| 新昌县| 汤原县| 吉隆县| 湖北省| 湘西| 紫阳县| 金华市| 延长县| 天台县| 乐东| 青州市| 长顺县| 吉木乃县| 高青县| 富源县| 上杭县| 博白县| 微博|