java9中gc log參數遷移

序

本文主要研究一下java9 gc log參數的遷移。

統一JVM及GC的Logging

java9引進了一個統一的日誌框架，把gc相關的log輸出及配置也給納入進來了。

相關JEP(JDK Enhancement Proposal)

• JEP 158: Unified JVM Logging
• JEP 264: Platform Logging API and Service
• JEP 271: Unified GC Logging
  

Xlog語法

-Xlog[:option] option := [<what>][:[<output>][:[<decorators>][:<output-options>]]] 'help' 'disable' what := <selector>[,...] selector := <tag-set>[*][=<level>] tag-set := <tag>[+...] 'all' tag := name of tag level := trace debug info warning error output := 'stderr' 'stdout' [file=]<filename> decorators := <decorator>[,...] 'none' decorator := time uptime timemillis uptimemillis timenanos uptimenanos pid tid level tags output-options := <output_option>[,...] output-option := filecount=<file count> filesize=<file size in kb> parameter=value

what

主要是配置tag及level

tag

其中all代表所有的tag，其他的如下：

 add，age，alloc，annotation，aot，arguments，attach，barrier，biasedlocking，blocks，bot，breakpoint，bytecode，census，class，classhisto，cleanup，compaction，comparator，constraints，constantpool，coops，cpu，cset，data，defaultmethods，dump，ergo，event，exceptions，exit，fingerprint，freelist，gc，hashtables，heap，humongous，ihop，iklass，init，itables，jfr，jni，jvmti，liveness，load，loader，logging，mark，marking，metadata，metaspace，method，mmu，modules，monitorinflation，monitormismatch，nmethod，normalize，objecttagging，obsolete，oopmap，os，pagesize，parser，patch，path，phases，plab，preorder，promotion，protectiondomain，purge，redefine，ref，refine，region，remset，resolve，safepoint，scavenge，scrub，setting，stackmap，stacktrace，stackwalk，start，startuptime，state，stats，stringdedup，stringtable，subclass，survivor，sweep，system，task，thread，time，timer，tlab，unload，update，verification，verify，vmoperation，vtables，workgang

level

主要分off，trace，debug，info，warning，error

output

 - stdout(`Sends output to stdout`)- stderr(`Sends output to stderr`)- file=filename(`Sends output to text file(s)`)

有如上三種，其中指定file的話，可以使用%p變量表示當前jvm的pid，用%t表示jvm的啟動時間戳。比如

-Xlog:gc:demoapp-gc-%p-%t.log

輸出的文件名如下：

 demoapp-gc-1678-2018-03-01_21-44-18.log

decorators

• time -- Current time and date in ISO-8601 format
• uptime -- Time since the start of the JVM in seconds and milliseconds (eg, 6.567s)
• timemillis -- The same value as generated by System.currentTimeMillis()
• uptimemillis -- Milliseconds since the JVM started
• timenanos -- The same value as generated by System.nanoTime()
• uptimenanos -- Nanoseconds since the JVM started
• pid -- The process identifier
• tid -- The thread identifier
• level -- The level associated with the log message
• tags -- The tag-set associated with the log message

不指定的話，默認是uptime, level, and tags這三個。比如

[3.080s][info][gc,cpu ] GC(5) User=0.03s Sys=0.00s Real=0.01s

實例

-Xlog:gc=trace:file=gctrace.txt:uptimemillis,pid:filecount=5,filesize=1024

tag為gc，levle為trace，rotate文件數為5，每個文件1M，文件名為gctrace.txt，decrotators為uptimemillis和pid

輸出實例

[1110ms][1867] GC(2) Pause Remark 17M->17M(256M) 2.024ms[1110ms][1867] GC(2) Finalize Live Data 0.000ms[1110ms][1867] GC(2) Pause Cleanup 17M->17M(256M) 0.177ms[1112ms][1867] GC(2) Concurrent Cycle 7.470ms[2951ms][1867] GC(3) Pause Initial Mark (Metadata GC Threshold) 149M->30M(256M) 27.175ms[2951ms][1867] GC(4) Concurrent Cycle[2972ms][1867] GC(4) Pause Remark 32M->32M(25​​6M) 5.132ms[2974ms][1867] GC(4) Finalize Live Data 0.000ms[2974ms][1867] GC(4) Pause Cleanup 32M->32M(25​​6M) 0.214ms[2976ms][1867] GC(4) Concurrent Cycle 25.422ms

遷移

舊版GC相關參數遷移

舊版運行時參數遷移

小結

java9把gc log的選型及輸出也給統一到了Xlog中，可以按照官方給出的遷移表進行遷移。