GC 日志格式

http://ganlv.iteye.com/blog/1583181

引用

下面是通过使用-XX:+UseParallelOldGC或者-XX:+UseParallelGC选项来打印出来的垃圾回收信息,而且使用了前面列出的3个选项。
     45.152: [GC [PSYoungGen: 295648K->32968K(306432K)] 296198K->33518K(1006848K), 0.1083183 secs][Times: user=1.83 sys=0.01, real=0.11 secs]
45.152: [GC [PSYoungGen: 295648K->32968K(306432K)] 296198K->33518K(1006848K), 0.1083183 secs][Times: user=1.83 sys=0.01, real=0.11 secs]
     45.152是表明距离JVM启动到垃圾回收的秒数，GC标签表明是Minor GC或者young代垃圾回收。
     [PSYoungGen: 295648K->32968K(306432K)]提供了young代的空间信息,PSYoungGen表示young代的垃圾回收是使用throughput垃圾回收器。其他可能的young代垃圾回收有ParNew（使用CMS垃圾回收器多线程回收young代空间）、DefNew（使用serial垃圾回收器单线程回收young代空间）。
     在“->”左边的数字（295648K）表示垃圾回收前young代的空间大小，右边数字（32968K）表示垃圾回收后的young代空间大小。young代被分为eden区域和survivor区域。由于在垃圾回收之后，eden区域是空的，右边的数字其实就是survivor区域的空间。在括号里面的数字（306432K）表示young代的总空间。
     296198K->33518K(1006848K)提供了Java堆在垃圾回收前后的使用情况。另外，他提供Java堆的总大小，是young代和old代的和。在->左边的数字（296198K）表示，在垃圾回收前Java堆占用的空间，->右边的数字（33518K）表示垃圾回收后Java堆占用空间。括号里面的数字（1006848K）表示Java堆总共的空间。
     通过young代的占用空间和Java堆占用的空间，可以快速的计算出old代占用的空间。比如：Java堆的大小是1006848K，young代的空间大小是306432K，因此可以计算出old代的空间大小是1006848K-306432K=700416K。在垃圾回收之前，296198K-295648K=550K是old代使用了的空间。在垃圾回收后33518K-32968K=550K。在这个例子中，在垃圾回收前后没有对象从young代移动到old代。这是一个重要的观察说明了Minor GC回收原则。如果有对象被移动到old代，然后变成不可读取的，就不是最大量的对象被回收，会违反Minor GC回收原则。
     0.1083183 secs表明垃圾回收执行的时间。
     [Times: user=1.83 sys=0.01, real=0.11 secs]提供了CPU和占用时间。user表明垃圾回收在用户模式下执行消耗的CPU时间，即：在JVM里面运行的时间，在这个例子中，垃圾回收器在用户模式下消耗1.83秒的CPU时间。sys表示操作系统代表垃圾回收器消耗的时间，在这里例子中，垃圾回收器使用0.01秒的操作系统CPU时间。real表示垃圾回收执行的时间的。这几个数字精确到0.01秒。