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 (e.g., 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(256M) 5.132ms
[2974ms][1867] GC(4) Finalize Live Data 0.000ms
[2974ms][1867] GC(4) Pause Cleanup 32M->32M(256M) 0.214ms
[2976ms][1867] GC(4) Concurrent Cycle 25.422ms

迁移

旧版GC相关参数迁移

旧版运行时参数迁移

小结

java9把gc log的选型及输出也给统一到了Xlog中，可以按照官方给出的迁移表进行迁移。

来源：https://segmentfault.com/a/1190000013475524