Java gc日志是什么？動(dòng)力節(jié)點(diǎn)小編來為大家進(jìn)行介紹。GC日志是處理Java虛擬機(jī)內(nèi)存管理問題的基礎(chǔ)技能，它只是一些人為確定的規(guī)則，沒有太多技術(shù)含量。

每一種收集器的日志形式都是由它們自身的實(shí)現(xiàn)所決定的，換而言之，每個(gè)收集器的日志格式都可以不一樣。但虛擬機(jī)設(shè)計(jì)者為了方便用戶閱讀，將各個(gè)收集器的日志都維持一定的共性，例如以下兩段典型的GC日志：

33.125: [GC [DefNew: 3324K->152K(3712K), 0.0025925 secs] 3324K->152K(11904K), 0.0031680 secs]
100.667: [Full GC [Tenured: 0K->210K(10240K), 0.0149142 secs] 4603K->210K(19456K), [Perm : 2999K->2999K(21248K)], 0.0150007 secs] [Times: user=0.01 sys=0.00, real=0.02 secs]

最前面的數(shù)字“33.125：”和“100.667：”代表了GC發(fā)生的時(shí)間，這個(gè)數(shù)字的含義是從Java虛擬機(jī)啟動(dòng)以來經(jīng)過的秒數(shù)。

GC日志開頭的“[GC”和“[Full GC”說明了這次垃圾收集的停頓類型，而不是用來區(qū)分新生代GC還是老年代GC的。如果有“Full”，說明這次GC是發(fā)生了Stop-The-World的，例如下面這段新生代收集器ParNew的日志也會(huì)出現(xiàn)“[Full GC”(這一般是因?yàn)槌霈F(xiàn)了分配擔(dān)保失敗之類的問題，所以才導(dǎo)致STW)。如果是調(diào)用System.gc()方法所觸發(fā)的收集，那么在這里將顯示“[Full GC (System)”。

[Full GC 283.736: [ParNew: 261599K->261599K(261952K), 0.0000288 secs]

接下來的“[DefNew”、“[Tenured”、“[Perm”表示GC發(fā)生的區(qū)域，這里顯示的區(qū)域名稱與使用的GC收集器是密切相關(guān)的，例如上面樣例所使用的Serial收集器中的新生代名為“Default New Generation”，所以顯示的是“[DefNew”。如果是ParNew收集器，新生代名稱就會(huì)變?yōu)?ldquo;[ParNew”，意為“Parallel New Generation”。如果采用Parallel Scavenge收集器，那它配套的新生代稱為“PSYoungGen”，老年代和永久代同理，名稱也是由收集器決定的。

后面方括號(hào)內(nèi)部的“3324K->152K(3712K)”含義是“GC前該內(nèi)存區(qū)域已使用容量-> GC后該內(nèi)存區(qū)域已使用容量 (該內(nèi)存區(qū)域總?cè)萘?”。而在方括號(hào)之外的“3324K->152K(11904K)”表示“GC前Java堆已使用容量 -> GC后Java堆已使用容量 (Java堆總?cè)萘?”。

再往后，“0.0025925 secs”表示該內(nèi)存區(qū)域GC所占用的時(shí)間，單位是秒。有的收集器會(huì)給出更具體的時(shí)間數(shù)據(jù)，如“[Times： user=0.01 sys=0.00， real=0.02 secs]”，這里面的user、sys和real與Linux的time命令所輸出的時(shí)間含義一致，分別代表用戶態(tài)消耗的CPU時(shí)間、內(nèi)核態(tài)消耗的CPU事件和操作從開始到結(jié)束所經(jīng)過的墻鐘時(shí)間(Wall Clock Time)。CPU時(shí)間與墻鐘時(shí)間的區(qū)別是，墻鐘時(shí)間包括各種非運(yùn)算的等待耗時(shí)，例如等待磁盤I/O、等待線程阻塞，而CPU時(shí)間不包括這些耗時(shí)，但當(dāng)系統(tǒng)有多CPU或者多核的話，多線程操作會(huì)疊加這些CPU時(shí)間，所以讀者看到user或sys時(shí)間超過real時(shí)間是完全正常的。