G1GC gc.log
2018-10-11 本文已影响0人
天高s
Java HotSpot(TM) 64-Bit Server VM (25.181-b13) for bsd-amd64 JRE (1.8.0_181-b13), built on Jul 7 2018 01:02:31 by "java_re" with gcc 4.2.1 (Based on Apple Inc. build 5658) (LLVM build 2336.11.00)
Memory: 4k page, physical 16777216k(752900k free)
/proc/meminfo:
CommandLine flags: -XX:-BytecodeVerificationLocal -XX:-BytecodeVerificationRemote -XX:InitialHeapSize=3246391296 -XX:+ManagementServer -XX:MaxHeapSize=3246391296 -XX:+PrintGC -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -XX:TieredStopAtLevel=1 -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseG1GC
0.812: [GC pause (Metadata GC Threshold) (young) (initial-mark), 0.0155484 secs]
[Parallel Time: 6.0 ms, GC Workers: 10]
[GC Worker Start (ms): Min: 812.2, Avg: 812.3, Max: 812.4, Diff: 0.1]
[Ext Root Scanning (ms): Min: 1.1, Avg: 1.3, Max: 1.5, Diff: 0.4, Sum: 12.6]
[Update RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Processed Buffers: Min: 0, Avg: 0.0, Max: 0, Diff: 0, Sum: 0]
[Scan RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.1]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.1, Max: 0.4, Diff: 0.4, Sum: 1.1]
[Object Copy (ms): Min: 3.8, Avg: 4.2, Max: 4.4, Diff: 0.6, Sum: 42.0]
[Termination (ms): Min: 0.0, Avg: 0.2, Max: 0.2, Diff: 0.2, Sum: 1.8]
[Termination Attempts: Min: 1, Avg: 10.0, Max: 19, Diff: 18, Sum: 100]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.1]
[GC Worker Total (ms): Min: 5.7, Avg: 5.8, Max: 5.9, Diff: 0.1, Sum: 57.8]
[GC Worker End (ms): Min: 818.1, Avg: 818.1, Max: 818.1, Diff: 0.1]
[Code Root Fixup: 0.1 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 0.2 ms]
[Other: 9.2 ms]
[Choose CSet: 0.0 ms]
[Ref Proc: 8.5 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 0.1 ms]
[Humongous Register: 0.0 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 0.1 ms]
[Eden: 138.0M(154.0M)->0.0B(139.0M) Survivors: 0.0B->15.0M Heap: 138.0M(3096.0M)->14.5M(3096.0M)]
[Times: user=0.05 sys=0.01, real=0.02 secs]
0.828: [GC concurrent-root-region-scan-start]
0.831: [GC concurrent-root-region-scan-end, 0.0034528 secs]
0.831: [GC concurrent-mark-start]
0.832: [GC concurrent-mark-end, 0.0005190 secs]
0.832: [GC remark 0.832: [Finalize Marking, 0.0002237 secs] 0.832: [GC ref-proc, 0.0000930 secs] 0.832: [Unloading, 0.0019197 secs], 0.0025942 secs]
[Times: user=0.02 sys=0.00, real=0.00 secs]
0.835: [GC cleanup 15M->15M(3096M), 0.0016250 secs]
[Times: user=0.01 sys=0.00, real=0.01 secs]
1.389: [GC pause (G1 Evacuation Pause) (young), 0.0133412 secs]
[Parallel Time: 7.9 ms, GC Workers: 10]
[GC Worker Start (ms): Min: 1389.2, Avg: 1389.3, Max: 1389.3, Diff: 0.1]
[Ext Root Scanning (ms): Min: 0.1, Avg: 0.5, Max: 3.2, Diff: 3.2, Sum: 5.0]
[Update RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Processed Buffers: Min: 0, Avg: 0.0, Max: 0, Diff: 0, Sum: 0]
[Scan RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.1]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.3, Max: 1.7, Diff: 1.7, Sum: 2.8]
[Object Copy (ms): Min: 4.5, Avg: 6.9, Max: 7.5, Diff: 3.0, Sum: 68.5]
[Termination (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.3]
[Termination Attempts: Min: 1, Avg: 47.9, Max: 63, Diff: 62, Sum: 479]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.1, Diff: 0.0, Sum: 0.3]
[GC Worker Total (ms): Min: 7.7, Avg: 7.7, Max: 7.8, Diff: 0.1, Sum: 77.0]
[GC Worker End (ms): Min: 1396.9, Avg: 1397.0, Max: 1397.0, Diff: 0.0]
[Code Root Fixup: 0.1 ms]
[Code Root Purge: 0.1 ms]
[Clear CT: 0.2 ms]
[Other: 5.1 ms]
[Choose CSet: 0.0 ms]
[Ref Proc: 4.5 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 0.1 ms]
[Humongous Register: 0.1 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 0.2 ms]
[Eden: 139.0M(139.0M)->0.0B(368.0M) Survivors: 15.0M->18.0M Heap: 153.5M(3096.0M)->17.5M(3096.0M)]
[Times: user=0.06 sys=0.02, real=0.01 secs]
2.536: [GC pause (Metadata GC Threshold) (young) (initial-mark), 0.0206809 secs]
[Parallel Time: 15.6 ms, GC Workers: 10]
[GC Worker Start (ms): Min: 2535.9, Avg: 2536.0, Max: 2536.0, Diff: 0.2]
[Ext Root Scanning (ms): Min: 1.5, Avg: 1.8, Max: 2.2, Diff: 0.7, Sum: 18.0]
[Update RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Processed Buffers: Min: 0, Avg: 0.0, Max: 0, Diff: 0, Sum: 0]
[Scan RS (ms): Min: 0.0, Avg: 0.0, Max: 0.1, Diff: 0.0, Sum: 0.2]
[Code Root Scanning (ms): Min: 0.1, Avg: 0.5, Max: 1.2, Diff: 1.1, Sum: 5.3]
[Object Copy (ms): Min: 12.2, Avg: 12.5, Max: 13.0, Diff: 0.8, Sum: 125.5]
[Termination (ms): Min: 0.0, Avg: 0.4, Max: 0.6, Diff: 0.6, Sum: 4.3]
[Termination Attempts: Min: 1, Avg: 63.4, Max: 83, Diff: 82, Sum: 634]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.2]
[GC Worker Total (ms): Min: 15.3, Avg: 15.4, Max: 15.4, Diff: 0.1, Sum: 153.6]
[GC Worker End (ms): Min: 2551.3, Avg: 2551.3, Max: 2551.4, Diff: 0.0]
[Code Root Fixup: 0.1 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 0.2 ms]
[Other: 4.7 ms]
[Choose CSet: 0.0 ms]
[Ref Proc: 3.8 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 0.1 ms]
[Humongous Register: 0.0 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 0.4 ms]
[Eden: 246.0M(368.0M)->0.0B(285.0M) Survivors: 18.0M->30.0M Heap: 263.5M(3096.0M)->29.5M(3096.0M)]
[Times: user=0.11 sys=0.02, real=0.03 secs]
2.556: [GC concurrent-root-region-scan-start]
2.565: [GC concurrent-root-region-scan-end, 0.0083652 secs]
2.565: [GC concurrent-mark-start]
2.565: [GC concurrent-mark-end, 0.0004998 secs]
2.565: [GC remark 2.566: [Finalize Marking, 0.0001980 secs] 2.566: [GC ref-proc, 0.0000858 secs] 2.566: [Unloading, 0.0030749 secs], 0.0037523 secs]
[Times: user=0.03 sys=0.00, real=0.01 secs]
2.569: [GC cleanup 32M->32M(3096M), 0.0014173 secs]
[Times: user=0.00 sys=0.00, real=0.00 secs]
99.343: [GC pause (G1 Evacuation Pause) (young) (initial-mark), 0.0298366 secs]
[Parallel Time: 20.2 ms, GC Workers: 10]
[GC Worker Start (ms): Min: 99343.4, Avg: 99343.5, Max: 99343.6, Diff: 0.2]
[Ext Root Scanning (ms): Min: 2.9, Avg: 3.1, Max: 3.8, Diff: 0.9, Sum: 31.3]
[Update RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Processed Buffers: Min: 0, Avg: 0.0, Max: 0, Diff: 0, Sum: 0]
[Scan RS (ms): Min: 0.0, Avg: 0.0, Max: 0.1, Diff: 0.0, Sum: 0.3]
[Code Root Scanning (ms): Min: 0.1, Avg: 0.9, Max: 2.2, Diff: 2.1, Sum: 8.8]
[Object Copy (ms): Min: 13.9, Avg: 15.8, Max: 16.7, Diff: 2.8, Sum: 157.9]
[Termination (ms): Min: 0.0, Avg: 0.1, Max: 0.1, Diff: 0.1, Sum: 0.8]
[Termination Attempts: Min: 1, Avg: 127.8, Max: 157, Diff: 156, Sum: 1278]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.1, Diff: 0.1, Sum: 0.4]
[GC Worker Total (ms): Min: 19.8, Avg: 19.9, Max: 20.1, Diff: 0.2, Sum: 199.5]
[GC Worker End (ms): Min: 99363.4, Avg: 99363.4, Max: 99363.5, Diff: 0.1]
[Code Root Fixup: 0.2 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 0.2 ms]
[Other: 9.2 ms]
[Choose CSet: 0.0 ms]
[Ref Proc: 7.8 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 0.1 ms]
[Humongous Register: 0.0 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 0.5 ms]
[Eden: 285.0M(285.0M)->0.0B(397.0M) Survivors: 30.0M->32.0M Heap: 314.5M(3096.0M)->36.6M(3096.0M)]
[Times: user=0.16 sys=0.02, real=0.03 secs]
99.373: [GC concurrent-root-region-scan-start]
99.381: [GC concurrent-root-region-scan-end, 0.0083648 secs]
99.381: [GC concurrent-mark-start]
99.385: [GC concurrent-mark-end, 0.0035198 secs]
99.385: [GC remark 99.385: [Finalize Marking, 0.0002423 secs] 99.385: [GC ref-proc, 0.0001350 secs] 99.385: [Unloading, 0.0042121 secs], 0.0050455 secs]
[Times: user=0.04 sys=0.01, real=0.00 secs]
99.390: [GC cleanup 38M->38M(3096M), 0.0016159 secs]
[Times: user=0.01 sys=0.00, real=0.00 secs]
Heap
garbage-first heap total 3170304K, used 43619K [0x00000006fe800000, 0x00000006fe9060c0, 0x00000007c0000000)
region size 1024K, 39 young (39936K), 32 survivors (32768K)
Metaspace used 46484K, capacity 48802K, committed 49144K, reserved 1091584K
class space used 6333K, capacity 6789K, committed 6904K, reserved 1048576K
