通过jinfo工具在Java程序运行时开启GC日志
Java中GC类型
| 参数 | 描述 |
| UseSerialGC | 虚拟机运行在Client模式的默认值，打开此开关参数后，使用Serial+Serial Old收集器组合进行垃圾收集。 |
| UseParNewGC | 打开此开关参数后，使用ParNew+Serial Old收集器组合进行垃圾收集。 |
| UseConcMarkSweepGC | 打开此开关参数后，使用ParNew+CMS+Serial Old收集器组合进行垃圾收集。Serial Old作为CMS收集器出现Concurrent Mode Failure的备用垃圾收集器。 |
| UseParallelGC | 虚拟机运行在Server模式的默认值，打开此开关参数后，使用Parallel Scavenge+Serial Old收集器组合进行垃圾收集。 |
| UseParallelOldGC | 打开此开关参数后，使用Parallel Scavenge+Parallel Old收集器组合进行垃圾收集。 |
Tomcat配置输出保存JVM GC日志文件
Windows下
找到tomcat的解压目录，进入bin文件夹，修改catalina.bat，在第一行加入如下代码
set "JAVA_OPTS=%JAVA_OPTS% -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -Xloggc:D:\MyDisk\gc.log"
Linux下
找到tomcat的安装目录，修改catalina.sh，在第一行加入如下代码：
JAVA_OPTS="-XX:+PrintGCDetails -XX:+PrintGCTimeStamps -Xloggc:/usr/local/tomcat/apache-tomcat-8.5.0/bin/gc.log"
GC 主要参数
JVM的GC日志的主要参数包括如下几个：
-XX:+PrintGC 输出GC日志
-XX:+PrintGCDetails 输出GC的详细日志
-XX:+PrintGCTimeStamps 输出GC的时间戳（以基准时间的形式）
-XX:+PrintGCDateStamps 输出GC的时间戳（以日期的形式，如 2013-05-04T21:53:59.234+0800）
-XX:+PrintHeapAtGC 在进行GC的前后打印出堆的信息
-Xloggc:../logs/gc.log 日志文件的输出路径
GC日志的输出
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]
表示意思
5.617（时间戳）: [GC（Young GC） 5.617（时间戳）: [ParNew（使用ParNew作为年轻代的垃圾回收期）: 43296K（年轻代垃圾回收前的大小）->7006K（年轻代垃圾回收以后的大小）(47808K)（年轻代的总大小）, 0.0136826 secs（回收时间）] 44992K（堆区垃圾回收前的大小）->8702K（堆区垃圾回收后的大小）(252608K)（堆区总大小）, 0.0137904 secs（回收时间）] [Times: user=0.03（Young GC用户耗时） sys=0.00（Young GC系统耗时）, real=0.02 secs（Young GC实际耗时）]
jinfo
我们经常会遇到JVM运行时出错的情况，每当面对如此窘境，我们只能关闭JVM，修改启动参数（startup parameter），然后默默祈祷，希望问题场景（problematic situation）能在重启之后得以重现。
在JDK bundle中隐藏着一个精悍的小工具——jinfo。作为一个命令行工具，jinfo用于收集正在运行的Java进程的配置信息。jinfo吸引眼球的地方在于，它能通过-flag选项动态修改指定的Java进程中的某些JVM flag的值。虽然这样的flag数量有限，但它们偶尔能够帮助到你。
通过以下的命令你便能看到JVM中哪些flag可以被jinfo动态修改：
my-precious me$ java -XX:+PrintFlagsFinal -version|grep manageable
intx CMSAbortablePrecleanWaitMillis = 100 {manageable}
intx CMSWaitDuration = 2000 {manageable}
bool HeapDumpAfterFullGC = false {manageable}
bool HeapDumpBeforeFullGC = false {manageable}
bool HeapDumpOnOutOfMemoryError = false {manageable}
... cut for brevity ...
bool PrintGC = false {manageable}
bool PrintGCDateStamps = false {manageable}
bool PrintGCDetails = false {manageable}
bool PrintGCTimeStamps = false {manageable}通过选项-XX:+PrintFlagsFinal可以列出所有的JVM flag，而其中的标注为manageable 的flag则是值得我们关注的部分。这些flag可通过JDK management interface（-XX:+PrintFlagsFinal）动态修改。
jinfo开启gc日志收集
让我们通过实战来学习如何使用jinfo。在下面的例子中，我们将在一个正在运行的JVM中动态开启GC日志功能
my-precious me$ jps 12278 HighAllocationRate 12279 Jps 12269 JConsole my-precious me$ jinfo -flag +PrintGCDetails 12278 my-precious me$ jinfo -flag +PrintGC 12278 my-precious me$
在jinfo中需要打开-XX:+PrintGC和 -XX:+PrintGCDetails两个选项才能开启GC日志，这与用命令行参数的方式实现有着细微的差别——如果你通过启动脚本（startup script）来设置参数，仅需-XX:+PrintGCDetails即可，因为-XX:+PrintGC会被自动打开。
开启后，可以在 catalina.out 中查看相应的输出信息
jinfo关闭gc日志收集
若想关闭GC日志功能，只需要执行jinfo -flag -PrintGCDetails 12278和 jinfo -flag -PrintGC 12278命令即可。
my-precious me$ jinfo -flag -PrintGCDetails 12278 my-precious me$ jinfo -flag -PrintGC 12278
共 0 条评论