性能问答>【赏金20元】G1发生Full GC之后,gc日志显示堆的总大小也变小了,感觉突破尝试了>
14回复
2年前

【赏金20元】G1发生Full GC之后,gc日志显示堆的总大小也变小了,感觉突破尝试了



我们用的是G1回收器,堆大小配置为1G。今天生产上发生了oom,于是去看gc日志,但是看到神奇的一幕了。从日志可以看到,在9点57分05秒的时候,发生了两次full GC,但这两次full GC日志显示,堆的总大小也被改变了,真是神奇。有大神知道原因吗,感觉突破我的认知了。 日志如下,第一段是是启动参数,后面是日志详情。

Java HotSpot(TM) 64-Bit Server VM (25.141-b15) for linux-amd64 JRE (1.8.0_141-b15), built on Jul 12 2017 04:21:34 by "java_re" with gcc 4.3.0 20080428 (Red Hat 4.3.0-8)
Memory: 4k page, physical 65808472k(11203444k free), swap 41943032k(30453876k free)
CommandLine flags: -XX:InitialHeapSize=1052935552 -XX:MaxHeapSize=1073741824 -XX:+PrintGC -XX:+PrintGCDateStamps -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseG1GC 

2022-09-30T09:57:05.926+0800: 49600.505: [GC concurrent-mark-start]
, 0.0112612 secs]
   [Root Region Scan Waiting: 3.9 ms]
   [Parallel Time: 5.2 ms, GC Workers: 13]
      [GC Worker Start (ms): Min: 49600505.2, Avg: 49600506.3, Max: 49600510.2, Diff: 5.0]
      [Ext Root Scanning (ms): Min: 0.0, Avg: 0.7, Max: 2.8, Diff: 2.8, Sum: 8.7]
      [Update RS (ms): Min: 0.0, Avg: 0.3, Max: 0.5, Diff: 0.5, Sum: 3.5]
         [Processed Buffers: Min: 0, Avg: 1.0, Max: 3, Diff: 3, Sum: 13]
      [Scan RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
      [Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.2, Diff: 0.2, Sum: 0.2]
      [Object Copy (ms): Min: 0.0, Avg: 1.9, Max: 2.8, Diff: 2.8, Sum: 24.8]
      [Termination (ms): Min: 0.0, Avg: 1.1, Max: 1.4, Diff: 1.4, Sum: 14.5]
         [Termination Attempts: Min: 1, Avg: 1.8, Max: 4, Diff: 3, Sum: 24]
      [GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.1]
      [GC Worker Total (ms): Min: 0.0, Avg: 4.0, Max: 5.1, Diff: 5.1, Sum: 51.8]
      [GC Worker End (ms): Min: 49600510.2, Avg: 49600510.3, Max: 49600510.4, Diff: 0.2]
   [Code Root Fixup: 0.1 ms]
   [Code Root Purge: 0.0 ms]
   [Clear CT: 0.3 ms]
   [Other: 1.7 ms]
      [Choose CSet: 0.0 ms]
      [Ref Proc: 1.2 ms]
      [Ref Enq: 0.0 ms]
      [Redirty Cards: 0.3 ms]
      [Humongous Register: 0.0 ms]
      [Humongous Reclaim: 0.0 ms]
      [Free CSet: 0.0 ms]
   [Eden: 1024.0K(587.0M)->0.0B(586.0M) Survivors: 16.0M->17.0M Heap: 261.4M(1006.0M)->263.0M(1006.0M)]
 [Times: user=0.00 sys=0.00, real=0.01 secs] 
2022-09-30T09:57:05.934+0800: 49600.513: [Full GC (Allocation Failure)  262M->97M(326M), 0.3911815 secs]
   [Eden: 1024.0K(586.0M)->0.0B(190.0M) Survivors: 17.0M->0.0B Heap: 263.0M(1024.0M)->97.5M(326.0M)], [Metaspace: 117451K->117155K(1155072K)]
 [Times: user=0.00 sys=0.00, real=0.39 secs] 
2022-09-30T09:57:06.325+0800: 49600.905: [Full GC (Allocation Failure)  97M->95M(319M), 0.2844190 secs]
   [Eden: 0.0B(190.0M)->0.0B(186.0M) Survivors: 0.0B->0.0B Heap: 97.5M(326.0M)->95.6M(319.0M)], [Metaspace: 117155K->117021K(1155072K)]
 [Times: user=0.00 sys=0.00, real=0.28 secs] 
2022-09-30T09:57:06.610+0800: 49601.189: [GC concurrent-mark-abort]
Heap
 garbage-first heap   total 326656K, used 122466K [0x00000000c0000000, 0x00000000c01009f8, 0x0000000100000000)
  region size 1024K, 25 young (25600K), 0 survivors (0K)
 Metaspace       used 117146K, capacity 121418K, committed 122428K, reserved 1155072K
  class space    used 15173K, capacity 15988K, committed 16188K, reserved 1048576K
1146 阅读
请先登录,查看14条精彩评论吧
快去登录吧,你将获得
  • 浏览更多精彩评论
  • 和开发者讨论交流,共同进步