Skip to content

Instantly share code, notes, and snippets.

Embed
What would you like to do?
mixed pauses with STW on 16GB. reduced by moving heap to 4GB. but that's added a new concern of 3-6 20ms youngs per second
2018-04-11T08:14:28.741+0000: 529814.699: [GC pause (G1 Evacuation Pause) (mixed), 0.2134632 secs]
[Parallel Time: 200.0 ms, GC Workers: 38]
[GC Worker Start (ms): Min: 529814699.6, Avg: 529814701.6, Max: 529814706.9, Diff: 7.3]
[Ext Root Scanning (ms): Min: 0.0, Avg: 0.5, Max: 1.1, Diff: 1.0, Sum: 19.0]
[Update RS (ms): Min: 0.0, Avg: 1.8, Max: 3.1, Diff: 3.1, Sum: 70.0]
[Processed Buffers: Min: 0, Avg: 2.8, Max: 12, Diff: 12, Sum: 106]
[Scan RS (ms): Min: 76.1, Avg: 122.7, Max: 192.8, Diff: 116.7, Sum: 4661.8]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Object Copy (ms): Min: 0.0, Avg: 1.3, Max: 10.0, Diff: 10.0, Sum: 48.7]
[Termination (ms): Min: 0.0, Avg: 69.2, Max: 104.6, Diff: 104.6, Sum: 2631.3]
[Termination Attempts: Min: 1, Avg: 4.7, Max: 24, Diff: 23, Sum: 179]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.1, Diff: 0.1, Sum: 0.7]
[GC Worker Total (ms): Min: 190.2, Avg: 195.6, Max: 197.9, Diff: 7.7, Sum: 7431.6]
[GC Worker End (ms): Min: 529814897.1, Avg: 529814897.2, Max: 529814897.5, Diff: 0.4]
[Code Root Fixup: 0.1 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 4.1 ms]
[Other: 9.2 ms]
[Choose CSet: 0.5 ms]
[Ref Proc: 3.9 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 2.6 ms]
[Humongous Register: 0.1 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 1.6 ms]
[Eden: 808.0M(808.0M)->0.0B(808.0M) Survivors: 8192.0K->8192.0K Heap: 5815.6M(16.0G)->4398.1M(16.0G)]
[Times: user=1.97 sys=0.95, real=0.21 secs]
2018-04-11T08:14:29.806+0000: 529815.763: [GC pause (G1 Evacuation Pause) (mixed), 0.0760621 secs]
[Parallel Time: 63.5 ms, GC Workers: 38]
[GC Worker Start (ms): Min: 529815764.1, Avg: 529815765.2, Max: 529815769.7, Diff: 5.6]
[Ext Root Scanning (ms): Min: 0.0, Avg: 0.5, Max: 1.1, Diff: 1.1, Sum: 19.5]
[Update RS (ms): Min: 0.0, Avg: 3.2, Max: 5.8, Diff: 5.8, Sum: 120.5]
[Processed Buffers: Min: 0, Avg: 2.9, Max: 8, Diff: 8, Sum: 109]
[Scan RS (ms): Min: 6.2, Avg: 20.9, Max: 57.0, Diff: 50.8, Sum: 793.9]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Object Copy (ms): Min: 0.0, Avg: 2.1, Max: 6.3, Diff: 6.3, Sum: 81.0]
[Termination (ms): Min: 0.0, Avg: 34.1, Max: 44.9, Diff: 44.9, Sum: 1296.0]
[Termination Attempts: Min: 1, Avg: 9.8, Max: 33, Diff: 32, Sum: 372]
[GC Worker Other (ms): Min: 0.0, Avg: 0.1, Max: 0.4, Diff: 0.4, Sum: 2.6]
[GC Worker Total (ms): Min: 56.2, Avg: 60.9, Max: 62.3, Diff: 6.1, Sum: 2313.5]
[GC Worker End (ms): Min: 529815825.9, Avg: 529815826.0, Max: 529815826.7, Diff: 0.9]
[Code Root Fixup: 0.3 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 2.9 ms]
[Other: 9.4 ms]
[Choose CSet: 0.6 ms]
[Ref Proc: 3.8 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 2.7 ms]
[Humongous Register: 0.1 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 1.8 ms]
[Eden: 808.0M(808.0M)->0.0B(808.0M) Survivors: 8192.0K->8192.0K Heap: 5206.1M(16.0G)->3791.1M(16.0G)]
[Times: user=1.16 sys=0.56, real=0.08 secs]
2018-04-11T08:14:30.724+0000: 529816.682: [GC pause (G1 Evacuation Pause) (mixed), 0.0493432 secs]
[Parallel Time: 37.0 ms, GC Workers: 38]
[GC Worker Start (ms): Min: 529816682.6, Avg: 529816685.2, Max: 529816691.6, Diff: 9.0]
[Ext Root Scanning (ms): Min: 0.0, Avg: 0.5, Max: 1.2, Diff: 1.2, Sum: 18.0]
[Update RS (ms): Min: 0.0, Avg: 1.6, Max: 3.1, Diff: 3.1, Sum: 62.3]
[Processed Buffers: Min: 0, Avg: 2.8, Max: 8, Diff: 8, Sum: 105]
[Scan RS (ms): Min: 1.7, Avg: 7.8, Max: 30.7, Diff: 29.0, Sum: 295.1]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Object Copy (ms): Min: 0.0, Avg: 2.3, Max: 3.3, Diff: 3.3, Sum: 87.6]
[Termination (ms): Min: 0.0, Avg: 19.8, Max: 21.5, Diff: 21.5, Sum: 752.6]
[Termination Attempts: Min: 1, Avg: 2.3, Max: 4, Diff: 3, Sum: 86]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.2, Diff: 0.2, Sum: 1.5]
[GC Worker Total (ms): Min: 25.6, Avg: 32.0, Max: 34.8, Diff: 9.1, Sum: 1217.2]
[GC Worker End (ms): Min: 529816717.2, Avg: 529816717.2, Max: 529816717.4, Diff: 0.2]
[Code Root Fixup: 0.3 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 2.7 ms]
[Other: 9.4 ms]
[Choose CSet: 0.6 ms]
[Ref Proc: 3.7 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 2.6 ms]
[Humongous Register: 0.1 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 1.9 ms]
[Eden: 808.0M(808.0M)->0.0B(808.0M) Survivors: 8192.0K->8192.0K Heap: 4599.1M(16.0G)->3182.5M(16.0G)]
[Times: user=0.77 sys=0.36, real=0.05 secs]
2018-04-11T08:14:31.604+0000: 529817.561: [GC pause (G1 Evacuation Pause) (mixed), 0.0450896 secs]
[Parallel Time: 32.5 ms, GC Workers: 38]
[GC Worker Start (ms): Min: 529817562.1, Avg: 529817570.2, Max: 529817584.1, Diff: 22.0]
[Ext Root Scanning (ms): Min: 0.0, Avg: 0.4, Max: 1.1, Diff: 1.1, Sum: 14.5]
[Update RS (ms): Min: 0.0, Avg: 1.1, Max: 2.5, Diff: 2.5, Sum: 43.5]
[Processed Buffers: Min: 0, Avg: 2.9, Max: 11, Diff: 11, Sum: 109]
[Scan RS (ms): Min: 0.2, Avg: 5.7, Max: 26.6, Diff: 26.5, Sum: 216.6]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Object Copy (ms): Min: 0.0, Avg: 2.5, Max: 10.6, Diff: 10.6, Sum: 95.6]
[Termination (ms): Min: 0.0, Avg: 12.2, Max: 14.1, Diff: 14.1, Sum: 463.2]
[Termination Attempts: Min: 1, Avg: 2.8, Max: 8, Diff: 7, Sum: 105]
[GC Worker Other (ms): Min: 0.0, Avg: 0.1, Max: 0.7, Diff: 0.6, Sum: 5.1]
[GC Worker Total (ms): Min: 8.1, Avg: 22.1, Max: 30.2, Diff: 22.1, Sum: 838.4]
[GC Worker End (ms): Min: 529817592.1, Avg: 529817592.3, Max: 529817592.8, Diff: 0.7]
[Code Root Fixup: 0.2 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 2.5 ms]
[Other: 9.9 ms]
[Choose CSet: 0.6 ms]
[Ref Proc: 4.7 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 2.3 ms]
[Humongous Register: 0.1 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 1.9 ms]
[Eden: 808.0M(808.0M)->0.0B(808.0M) Survivors: 8192.0K->8192.0K Heap: 3990.5M(16.0G)->2576.4M(16.0G)]
[Times: user=0.49 sys=0.24, real=0.05 secs]
2018-04-11T08:14:32.455+0000: 529818.412: [GC pause (G1 Evacuation Pause) (mixed), 0.0379609 secs]
[Parallel Time: 24.8 ms, GC Workers: 38]
[GC Worker Start (ms): Min: 529818412.8, Avg: 529818417.1, Max: 529818427.8, Diff: 15.0]
[Ext Root Scanning (ms): Min: 0.0, Avg: 0.5, Max: 1.2, Diff: 1.2, Sum: 20.8]
[Update RS (ms): Min: 0.0, Avg: 2.4, Max: 3.6, Diff: 3.6, Sum: 91.6]
[Processed Buffers: Min: 0, Avg: 3.2, Max: 8, Diff: 8, Sum: 120]
[Scan RS (ms): Min: 0.2, Avg: 4.1, Max: 18.1, Diff: 18.0, Sum: 154.0]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Object Copy (ms): Min: 0.0, Avg: 3.8, Max: 5.9, Diff: 5.9, Sum: 145.3]
[Termination (ms): Min: 0.0, Avg: 7.4, Max: 7.8, Diff: 7.8, Sum: 283.1]
[Termination Attempts: Min: 1, Avg: 6.9, Max: 12, Diff: 11, Sum: 264]
[GC Worker Other (ms): Min: 0.0, Avg: 0.2, Max: 0.7, Diff: 0.7, Sum: 6.4]
[GC Worker Total (ms): Min: 7.6, Avg: 18.5, Max: 22.8, Diff: 15.2, Sum: 701.2]
[GC Worker End (ms): Min: 529818435.3, Avg: 529818435.5, Max: 529818436.1, Diff: 0.7]
[Code Root Fixup: 0.2 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 2.7 ms]
[Other: 10.3 ms]
[Choose CSet: 0.7 ms]
[Ref Proc: 3.7 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 3.8 ms]
[Humongous Register: 0.1 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 1.7 ms]
[Eden: 808.0M(808.0M)->0.0B(808.0M) Survivors: 8192.0K->8192.0K Heap: 3384.4M(16.0G)->1968.3M(16.0G)]
[Times: user=0.47 sys=0.23, real=0.04 secs]
2018-04-11T08:14:33.366+0000: 529819.323: [GC pause (G1 Evacuation Pause) (mixed), 0.0658806 secs]
[Parallel Time: 52.7 ms, GC Workers: 38]
[GC Worker Start (ms): Min: 529819324.0, Avg: 529819324.9, Max: 529819327.7, Diff: 3.7]
[Ext Root Scanning (ms): Min: 0.0, Avg: 0.5, Max: 1.1, Diff: 1.1, Sum: 20.3]
[Update RS (ms): Min: 0.0, Avg: 1.8, Max: 8.2, Diff: 8.2, Sum: 69.9]
[Processed Buffers: Min: 0, Avg: 2.4, Max: 8, Diff: 8, Sum: 90]
[Scan RS (ms): Min: 0.5, Avg: 7.8, Max: 47.2, Diff: 46.7, Sum: 297.8]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Object Copy (ms): Min: 0.0, Avg: 3.2, Max: 20.1, Diff: 20.1, Sum: 121.3]
[Termination (ms): Min: 0.0, Avg: 35.9, Max: 41.1, Diff: 41.1, Sum: 1365.5]
[Termination Attempts: Min: 1, Avg: 2.8, Max: 6, Diff: 5, Sum: 105]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.2, Diff: 0.2, Sum: 1.6]
[GC Worker Total (ms): Min: 46.6, Avg: 49.4, Max: 50.3, Diff: 3.7, Sum: 1876.3]
[GC Worker End (ms): Min: 529819374.2, Avg: 529819374.3, Max: 529819374.5, Diff: 0.2]
[Code Root Fixup: 0.2 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 2.6 ms]
[Other: 10.4 ms]
[Choose CSet: 0.7 ms]
[Ref Proc: 3.7 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 2.9 ms]
[Humongous Register: 0.1 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 2.5 ms]
[Eden: 808.0M(808.0M)->0.0B(808.0M) Survivors: 8192.0K->8192.0K Heap: 2776.3M(16.0G)->1360.4M(16.0G)]
[Times: user=1.13 sys=0.52, real=0.07 secs]
2018-04-11T08:14:34.290+0000: 529820.248: [GC pause (G1 Evacuation Pause) (mixed), 0.1133639 secs]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment