這篇文章給大家介紹 jvm的GC日志分析是怎樣的，內(nèi)容非常詳細，感興趣的小伙伴們可以參考借鑒，希望對大家能有所幫助。

成都創(chuàng)新互聯(lián)公司成都企業(yè)網(wǎng)站建設服務，提供成都網(wǎng)站建設、成都網(wǎng)站設計網(wǎng)站開發(fā),網(wǎng)站定制,建網(wǎng)站,網(wǎng)站搭建,網(wǎng)站設計,成都響應式網(wǎng)站建設公司,網(wǎng)頁設計師打造企業(yè)風格網(wǎng)站,提供周到的售前咨詢和貼心的售后服務。歡迎咨詢做網(wǎng)站需要多少錢:13518219792

JVM的GC日志的主要參數(shù)包括如下幾個：

-XX:+PrintGC 輸出GC日志

-XX:+PrintGCDetails 輸出GC的詳細日志

-XX:+PrintGCTimeStamps 輸出GC的時間戳（以基準時間的形式）

-XX:+PrintGCDateStamps 輸出GC的時間戳（以日期的形式，如 2013-05-04T21:53:59.234+0800）

-XX:+PrintHeapAtGC 在進行GC的前后打印出堆的信息

-XX:+PrintGCApplicationStoppedTime // 輸出GC造成應用暫停的時間

-Xloggc:../logs/gc.log 日志文件的輸出路徑

常用JVM參數(shù)
分析gc日志后，經(jīng)常需要調(diào)整jvm內(nèi)存相關參數(shù)，常用參數(shù)如下
-Xms：初始堆大小，默認為物理內(nèi)存的1/64(<1GB)；默認(MinHeapFreeRatio參數(shù)可以調(diào)整)空余堆內(nèi)存小于40%時，JVM就會增大堆直到-Xmx的最大限制
-Xmx：最大堆大小，默認(MaxHeapFreeRatio參數(shù)可以調(diào)整)空余堆內(nèi)存大于70%時，JVM會減少堆直到 -Xms的最小限制
-Xmn：新生代的內(nèi)存空間大小，注意：此處的大小是（eden+ 2 survivor space)。與jmap -heap中顯示的New gen是不同的。整個堆大小=新生代大小 + 老生代大小 + 永久代大小。 
在保證堆大小不變的情況下，增大新生代后,將會減小老生代大小。此值對系統(tǒng)性能影響較大,Sun官方推薦配置為整個堆的3/8。
-XX:SurvivorRatio：新生代中Eden區(qū)域與Survivor區(qū)域的容量比值，默認值為8。兩個Survivor區(qū)與一個Eden區(qū)的比值為2:8,一個Survivor區(qū)占整個年輕代的1/10。
-Xss：每個線程的堆棧大小。JDK5.0以后每個線程堆棧大小為1M,以前每個線程堆棧大小為256K。應根據(jù)應用的線程所需內(nèi)存大小進行適當調(diào)整。在相同物理內(nèi)存下,減小這個值能生成更多的線程。但是操作系統(tǒng)對一個進程內(nèi)的線程數(shù)還是有限制的，不能無限生成，經(jīng)驗值在3000~5000左右。一般小的應用， 如果棧不是很深， 應該是128k夠用的，大的應用建議使用256k。這個選項對性能影響比較大，需要嚴格的測試。和threadstacksize選項解釋很類似,官方文檔似乎沒有解釋,在論壇中有這樣一句話:"-Xss is translated in a VM flag named ThreadStackSize”一般設置這個值就可以了。
-XX:PermSize：設置永久代(perm gen)初始值。默認值為物理內(nèi)存的1/64。
-XX:MaxPermSize：設置持久代最大值。物理內(nèi)存的1/4。

在我做了如下的設置

[java] view plain copy

 print?

1. -XX:+PrintGCDetails -Xloggc:../logs/gc.log -XX:+PrintGCTimeStamps  

以后打印出來的日志為：

[java] view plain copy

 print?

1. 0.756: [Full GC (System) 0.756: [CMS: 0K->1696K(204800K), 0.0347096 secs] 11488K->1696K(252608K), [CMS Perm : 10328K->10320K(131072K)], 0.0347949 secs] [Times: user=0.06 sys=0.00, real=0.05 secs]  

2. 1.728: [GC 1.728: [ParNew: 38272K->2323K(47808K), 0.0092276 secs] 39968K->4019K(252608K), 0.0093169 secs] [Times: user=0.01 sys=0.00, real=0.00 secs]  

3. 2.642: [GC 2.643: [ParNew: 40595K->3685K(47808K), 0.0075343 secs] 42291K->5381K(252608K), 0.0075972 secs] [Times: user=0.03 sys=0.00, real=0.02 secs]  

4. 4.349: [GC 4.349: [ParNew: 41957K->5024K(47808K), 0.0106558 secs] 43653K->6720K(252608K), 0.0107390 secs] [Times: user=0.03 sys=0.00, real=0.02 secs]  

5. 5.617: [GC 5.617: [ParNew: 43296K->7006K(47808K), 0.0136826 secs] 44992K->8702K(252608K), 0.0137904 secs] [Times: user=0.03 sys=0.00, real=0.02 secs]  

6. 7.429: [GC 7.429: [ParNew: 45278K->6723K(47808K), 0.0251993 secs] 46974K->10551K(252608K), 0.0252421 secs]  

我們?nèi)〉箶?shù)第二條記錄分析一下各個字段都代表了什么含義

[java] view plain copy

 print?

1. 5.617（時間戳）: [GC（Young GC） 5.617（時間戳）: [ParNew（GC的區(qū)域）: 43296K（垃圾回收前的大?。?>7006K（垃圾回收以后的大?。?47808K)（該區(qū)域總大小）, 0.0136826 secs（回收時間）] 44992K（堆區(qū)垃圾回收前的大?。?>8702K（堆區(qū)垃圾回收后的大?。?252608K)（堆區(qū)總大小）, 0.0137904 secs（回收時間）] [Times: user=0.03（GC用戶耗時） sys=0.00（GC系統(tǒng)耗時）, real=0.02 secs（GC實際耗時）]  

我們再對數(shù)據(jù)做一個簡單的分析

從最后一條GC記錄中我們可以看到 Young GC回收了 45278-6723=38555K的內(nèi)存

Heap區(qū)通過這次回收總共減少了 46974-10551=36423K的內(nèi)存。

38555-36423=2132K說明通過該次Young GC有2132K的內(nèi)存被移動到了Old Gen，

我們來驗證一下

在最后一次Young GC的回收以前 Old Gen的大小為8702-7006=1696

回收以后Old Gen的內(nèi)存使用為10551-6723=3828

Old Gen在該次Young GC以后內(nèi)存增加了3828-1696=2132K 與預計的相符

[java] view plain copy

 print?

1. 4.231: [GC 4.231: [DefNew: 4928K->512K(4928K), 0.0044047 secs] 6835K->3468K(15872K), 0.0045291 secs] [Times: user=0.00 sys=0.00, real=0.00 secs]  

2. 4.445: [Full GC (System) 4.445: [Tenured: 2956K->3043K(10944K), 0.1869806 secs] 4034K->3043K(15872K), [Perm : 3400K->3400K(12288K)], 0.1870847 secs] [Times: user=0.05 sys=0.00, real=0.19 secs]  

最前面的數(shù)字 4.231 和 4.445 代表虛擬機啟動以來的秒數(shù)。

[GC 和 [Full GC 是垃圾回收的停頓類型，而不是區(qū)分是新生代還是年老代，如果有 Full 說明發(fā)生了Stop-The-World 。如果是調(diào)用 System.gc() 觸發(fā)的，那么將顯示的是 [Full GC (System) 。

接下來的 [DefNew, [Tenured, [Perm 表示 GC 發(fā)生的區(qū)域，區(qū)域的名稱與使用的 GC 收集器相關。
Serial 收集器中新生代名為 “Default New Generation”，顯示的名字為 “[DefNew”。對于ParNew收集器，顯示的是 “[ParNew”，表示 “Parallel New Generation”。 對于 Parallel Scavenge 收集器，新生代名為 “PSYoungGen”。年老代和永久代也相同，名稱都由收集器決定。

方括號內(nèi)部顯示的 “4928K->512K(4928K)” 表示 “GC 前該區(qū)域已使用容量 -> GC 后該區(qū)域已使用容量 (該區(qū)域內(nèi)存總?cè)萘? ”。

再往后的 “0.0044047 secs” 表示該區(qū)域GC所用時間，單位是秒。

再往后的 “6835K->3468K(15872K)” 表示 “GC 前Java堆已使用容量 -> GC后Java堆已使用容量 （Java堆總?cè)萘浚薄?/p>

再往后的 “0.0045291 secs” 是Java堆GC所用的總時間。

最后的 “[Times: user=0.00 sys=0.00, real=0.00 secs]” 分別代表 用戶態(tài)消耗的CPU時間、內(nèi)核態(tài)消耗的CPU時間 和 操作從開始到結(jié)束所經(jīng)過的墻鐘時間。墻鐘時間包括各種非運算的等待耗時，如IO等待、線程阻塞。CPU時間不包括等待時間，當系統(tǒng)有多核時，多線程操作會疊加這些CPU時間，所以user或sys時間會超過real時間。

堆的分代

• young區(qū)域就是新生代，存放新創(chuàng)建對象；

• tenured是年老代，存放在新生代經(jīng)歷多次垃圾回收后仍存活的對象；

• perm是永生代，存放類定義信息、元數(shù)據(jù)等信息。

當GC發(fā)生在新生代時，稱為Minor GC，次收集；當GC發(fā)生在年老代時，稱為Major GC，主收集。 一般的，Minor GC的發(fā)生頻率要比Major GC高很多。

重新設置GC日志的輸出

[java] view plain copy

 print?

1. -XX:+PrintGCDetails  

2. -XX:+PrintHeapAtGC  

3. -XX:+PrintGCDateStamps  

4. -XX:+PrintTenuringDistribution  

5. -verbose:gc  

6. -Xloggc:gc.log  

后可以看到進行GC前后的堆內(nèi)存信息 

[java] view plain copy

 print?

1. {Heap before GC invocations=1 (full 0):  

2.  PSYoungGen      total 152896K, used 131072K [0x00000000f5560000, 0x0000000100000000, 0x0000000100000000)  

3.   eden space 131072K, 100% used [0x00000000f5560000,0x00000000fd560000,0x00000000fd560000)  

4.   from space 21824K, 0% used [0x00000000feab0000,0x00000000feab0000,0x0000000100000000)  

5.   to   space 21824K, 0% used [0x00000000fd560000,0x00000000fd560000,0x00000000feab0000)  

6.  PSOldGen        total 349568K, used 0K [0x00000000e0000000, 0x00000000f5560000, 0x00000000f5560000)  

7.   object space 349568K, 0% used [0x00000000e0000000,0x00000000e0000000,0x00000000f5560000)  

8.  PSPermGen       total 26432K, used 26393K [0x00000000d0000000, 0x00000000d19d0000, 0x00000000e0000000)  

9.   object space 26432K, 99% used [0x00000000d0000000,0x00000000d19c64a0,0x00000000d19d0000)  

10. 2013-05-05T23:16:10.480+0800: 5.228: [GC  

11. Desired survivor size 22347776 bytes, new threshold 7 (max 15)  

12.  [PSYoungGen: 131072K->8319K(152896K)] 131072K->8319K(502464K), 0.0176346 secs] [Times: user=0.03 sys=0.00, real=0.02 secs]   

13. Heap after GC invocations=1 (full 0):  

14.  PSYoungGen      total 152896K, used 8319K [0x00000000f5560000, 0x0000000100000000, 0x0000000100000000)  

15.   eden space 131072K, 0% used [0x00000000f5560000,0x00000000f5560000,0x00000000fd560000)  

16.   from space 21824K, 38% used [0x00000000fd560000,0x00000000fdd7ff78,0x00000000feab0000)  

17.   to   space 21824K, 0% used [0x00000000feab0000,0x00000000feab0000,0x0000000100000000)  

18.  PSOldGen        total 349568K, used 0K [0x00000000e0000000, 0x00000000f5560000, 0x00000000f5560000)  

19.   object space 349568K, 0% used [0x00000000e0000000,0x00000000e0000000,0x00000000f5560000)  

20.  PSPermGen       total 26432K, used 26393K [0x00000000d0000000, 0x00000000d19d0000, 0x00000000e0000000)  

21.   object space 26432K, 99% used [0x00000000d0000000,0x00000000d19c64a0,0x00000000d19d0000)  

22. }  

[java] view plain copy

 print?

1. [0x00000000f5560000,0x00000000f5560000,0x00000000fd560000)  

這種形式的日志有兩種意義： 
當這種日志出現(xiàn)在generation的詳細信息里的時候，三個數(shù)字在HotSpot里分別稱為low_boundary、high、high_boundary。 
low_boundary: reserved space的最低地址邊界；通常也跟“l(fā)ow”相等，這是commited space的最低地址邊界 
high: commited space的最高地址邊界 
high_boundary: reserved space的最高地址邊界。 

[low_boundary, high_boundary)范圍內(nèi)的就是reserved space，這個space的大小就是max capacity。 
[low, high)范圍內(nèi)的就是commited space，而這個space的大小就是current capacity（當前容量），簡稱capacity。 
capacity有可能在一對最小值和最大值之間浮動。最大值就是上面說的max capacity。 

Gc日志分析工具

(1)GCHisto
http://java.net/projects/gchisto
直接點擊gchisto.jar就可以運行，點add載入gc.log
統(tǒng)計了總共gc次數(shù)，youngGC次數(shù)，F(xiàn)ullGC次數(shù)，次數(shù)的百分比，GC消耗的時間，百分比，平均消耗時間，消耗時間最小最大值等

(2)GCLogViewer
http://code.google.com/p/gclogviewer/
點擊run.bat運行
整個過程gc情況的趨勢圖，還顯示了gc類型，吞吐量，平均gc頻率，內(nèi)存變化趨勢等
Tools里還能比較不同gc日志

關于 jvm的GC日志分析是怎樣的就分享到這里了，希望以上內(nèi)容可以對大家有一定的幫助，可以學到更多知識。如果覺得文章不錯，可以把它分享出去讓更多的人看到。

標題名稱：jvm的GC日志分析是怎樣的
路徑分享：http://aaarwkj.com/article4/ijppoe.html

成都網(wǎng)站建設公司_創(chuàng)新互聯(lián)，為您提供電子商務、App設計、網(wǎng)站內(nèi)鏈、商城網(wǎng)站、Google、建站公司

廣告

聲明：本網(wǎng)站發(fā)布的內(nèi)容（圖片、視頻和文字）以用戶投稿、用戶轉(zhuǎn)載內(nèi)容為主，如果涉及侵權(quán)請盡快告知，我們將會在第一時間刪除。文章觀點不代表本網(wǎng)站立場，如需處理請聯(lián)系客服。電話：028-86922220；郵箱：631063699@qq.com。內(nèi)容未經(jīng)允許不得轉(zhuǎn)載，或轉(zhuǎn)載時需注明來源： 創(chuàng)新互聯(lián)