Requirement for ZFragmentationLimit tuning
Florian Weimer
fw at deneb.enyo.de
Sat Oct 23 10:44:25 UTC 2021
I have an application that doesn't run well with ZGC. It auto-tunes
itself to use a live set of about 60% to 70% of the heap. However,
with the default value for ZFragmentationLimit (25), it happens that
too little relocation happens, and the used set is not reduced at all.
Lowering ZFragmentationLimit to 10 or so avoids this. But I had hoped
that the collector would perform more aggressive relocation on its own
when necessary.
I'm including a GC log snippet below. Back-to-back collections
continue after that for a while until the VM aborts. This trace has a
peak live set of 67%, but I think I have seen the failure with just
60% live set. Allocation rate is quite low after startup, so that
level of heap utilization should not be a problem (and isn't if
ZFragmentationLimit is adjusted).
[9.724s][info][gc ] GC(3) Garbage Collection (Proactive) 712M(70%)->718M(70%)
[9.897s][info][gc,start ] GC(4) Garbage Collection (Allocation Rate)
[9.897s][info][gc,task ] GC(4) Using 1 workers
[9.898s][info][gc,phases ] GC(4) Pause Mark Start 0.026ms
[10.194s][info][gc,phases ] GC(4) Concurrent Mark 294.900ms
[10.195s][info][gc,phases ] GC(4) Pause Mark End 0.036ms
[10.195s][info][gc,phases ] GC(4) Concurrent Mark Free 0.005ms
[10.220s][info][gc,phases ] GC(4) Concurrent Process Non-Strong References 24.759ms
[10.220s][info][gc,phases ] GC(4) Concurrent Reset Relocation Set 0.005ms
[10.251s][info][gc,phases ] GC(4) Concurrent Select Relocation Set 30.645ms
[10.252s][info][gc,phases ] GC(4) Pause Relocate Start 0.030ms
[10.252s][info][gc,phases ] GC(4) Concurrent Relocate 0.078ms
[10.252s][info][gc,load ] GC(4) Load: 1.36/0.53/0.24
[10.252s][info][gc,mmu ] GC(4) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[10.252s][info][gc,marking ] GC(4) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[10.252s][info][gc,marking ] GC(4) Mark Stack Usage: 32M
[10.252s][info][gc,nmethod ] GC(4) NMethods: 2254 registered, 0 unregistered
[10.252s][info][gc,metaspace] GC(4) Metaspace: 9M used, 9M committed, 1040M reserved
[10.253s][info][gc,ref ] GC(4) Soft: 3460 encountered, 0 discovered, 0 enqueued
[10.253s][info][gc,ref ] GC(4) Weak: 664 encountered, 5 discovered, 0 enqueued
[10.253s][info][gc,ref ] GC(4) Final: 2 encountered, 0 discovered, 0 enqueued
[10.253s][info][gc,ref ] GC(4) Phantom: 12 encountered, 8 discovered, 0 enqueued
[10.253s][info][gc,reloc ] GC(4) Small Pages: 345 / 690M, Empty: 4M, Relocated: 0M, In-Place: 0
[10.253s][info][gc,reloc ] GC(4) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[10.253s][info][gc,reloc ] GC(4) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[10.253s][info][gc,reloc ] GC(4) Forwarding Usage: 0M
[10.253s][info][gc,heap ] GC(4) Min Capacity: 8M(1%)
[10.253s][info][gc,heap ] GC(4) Max Capacity: 1024M(100%)
[10.253s][info][gc,heap ] GC(4) Soft Max Capacity: 1024M(100%)
[10.253s][info][gc,heap ] GC(4) Mark Start Mark End Relocate Start Relocate End High Low
[10.253s][info][gc,heap ] GC(4) Capacity: 724M (71%) 730M (71%) 732M (71%) 732M (71%) 732M (71%) 724M (71%)
[10.253s][info][gc,heap ] GC(4) Free: 302M (29%) 294M (29%) 296M (29%) 296M (29%) 302M (29%) 292M (29%)
[10.253s][info][gc,heap ] GC(4) Used: 722M (71%) 730M (71%) 728M (71%) 728M (71%) 732M (71%) 722M (71%)
[10.253s][info][gc,heap ] GC(4) Live: - 474M (46%) 474M (46%) 474M (46%) - -
[10.253s][info][gc,heap ] GC(4) Allocated: - 8M (1%) 10M (1%) 10M (1%) - -
[10.254s][info][gc,heap ] GC(4) Garbage: - 247M (24%) 243M (24%) 243M (24%) - -
[10.254s][info][gc,heap ] GC(4) Reclaimed: - - 4M (0%) 4M (0%) - -
[10.254s][info][gc ] GC(4) Garbage Collection (Allocation Rate) 722M(71%)->728M(71%)
[11.697s][info][gc,start ] GC(5) Garbage Collection (Allocation Rate)
[11.697s][info][gc,task ] GC(5) Using 1 workers
[11.697s][info][gc,phases ] GC(5) Pause Mark Start 0.006ms
[11.723s][info][gc,phases ] GC(5) Concurrent Mark 26.148ms
[11.723s][info][gc,phases ] GC(5) Pause Mark End 0.008ms
[11.723s][info][gc,phases ] GC(5) Concurrent Mark Free 0.001ms
[11.727s][info][gc,phases ] GC(5) Concurrent Process Non-Strong References 3.637ms
[11.727s][info][gc,phases ] GC(5) Concurrent Reset Relocation Set 0.000ms
[11.732s][info][gc,phases ] GC(5) Concurrent Select Relocation Set 4.560ms
[11.732s][info][gc,phases ] GC(5) Pause Relocate Start 0.010ms
[11.733s][info][gc,phases ] GC(5) Concurrent Relocate 1.277ms
[11.733s][info][gc,load ] GC(5) Load: 1.36/0.53/0.24
[11.733s][info][gc,mmu ] GC(5) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[11.733s][info][gc,marking ] GC(5) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[11.733s][info][gc,marking ] GC(5) Mark Stack Usage: 32M
[11.733s][info][gc,nmethod ] GC(5) NMethods: 2257 registered, 0 unregistered
[11.734s][info][gc,metaspace] GC(5) Metaspace: 9M used, 9M committed, 1040M reserved
[11.734s][info][gc,ref ] GC(5) Soft: 3460 encountered, 0 discovered, 0 enqueued
[11.734s][info][gc,ref ] GC(5) Weak: 664 encountered, 5 discovered, 0 enqueued
[11.734s][info][gc,ref ] GC(5) Final: 2 encountered, 2 discovered, 0 enqueued
[11.734s][info][gc,ref ] GC(5) Phantom: 12 encountered, 8 discovered, 0 enqueued
[11.734s][info][gc,reloc ] GC(5) Small Pages: 398 / 796M, Empty: 2M, Relocated: 1M, In-Place: 0
[11.734s][info][gc,reloc ] GC(5) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[11.734s][info][gc,reloc ] GC(5) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[11.734s][info][gc,reloc ] GC(5) Forwarding Usage: 0M
[11.734s][info][gc,heap ] GC(5) Min Capacity: 8M(1%)
[11.734s][info][gc,heap ] GC(5) Max Capacity: 1024M(100%)
[11.734s][info][gc,heap ] GC(5) Soft Max Capacity: 1024M(100%)
[11.734s][info][gc,heap ] GC(5) Mark Start Mark End Relocate Start Relocate End High Low
[11.734s][info][gc,heap ] GC(5) Capacity: 828M (81%) 832M (81%) 834M (81%) 834M (81%) 834M (81%) 828M (81%)
[11.734s][info][gc,heap ] GC(5) Free: 196M (19%) 192M (19%) 192M (19%) 198M (19%) 198M (19%) 190M (19%)
[11.734s][info][gc,heap ] GC(5) Used: 828M (81%) 832M (81%) 832M (81%) 826M (81%) 834M (81%) 826M (81%)
[11.734s][info][gc,heap ] GC(5) Live: - 544M (53%) 544M (53%) 544M (53%) - -
[11.734s][info][gc,heap ] GC(5) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[11.734s][info][gc,heap ] GC(5) Garbage: - 283M (28%) 281M (28%) 275M (27%) - -
[11.734s][info][gc,heap ] GC(5) Reclaimed: - - 2M (0%) 8M (1%) - -
[11.734s][info][gc ] GC(5) Garbage Collection (Allocation Rate) 828M(81%)->826M(81%)
[11.797s][info][gc,start ] GC(6) Garbage Collection (Allocation Rate)
[11.797s][info][gc,task ] GC(6) Using 1 workers
[11.797s][info][gc,phases ] GC(6) Pause Mark Start 0.006ms
[11.833s][info][gc,phases ] GC(6) Concurrent Mark 36.314ms
[11.834s][info][gc,phases ] GC(6) Pause Mark End 0.013ms
[11.834s][info][gc,phases ] GC(6) Concurrent Mark Free 0.002ms
[11.840s][info][gc,phases ] GC(6) Concurrent Process Non-Strong References 5.748ms
[11.840s][info][gc,phases ] GC(6) Concurrent Reset Relocation Set 0.001ms
[11.843s][info][gc,phases ] GC(6) Concurrent Select Relocation Set 3.269ms
[11.843s][info][gc,phases ] GC(6) Pause Relocate Start 0.007ms
[11.845s][info][gc,phases ] GC(6) Concurrent Relocate 2.125ms
[11.845s][info][gc,load ] GC(6) Load: 1.36/0.53/0.24
[11.845s][info][gc,mmu ] GC(6) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[11.845s][info][gc,marking ] GC(6) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[11.845s][info][gc,marking ] GC(6) Mark Stack Usage: 32M
[11.845s][info][gc,nmethod ] GC(6) NMethods: 2257 registered, 0 unregistered
[11.845s][info][gc,metaspace] GC(6) Metaspace: 9M used, 9M committed, 1040M reserved
[11.845s][info][gc,ref ] GC(6) Soft: 3460 encountered, 0 discovered, 0 enqueued
[11.845s][info][gc,ref ] GC(6) Weak: 664 encountered, 5 discovered, 0 enqueued
[11.845s][info][gc,ref ] GC(6) Final: 2 encountered, 2 discovered, 0 enqueued
[11.845s][info][gc,ref ] GC(6) Phantom: 12 encountered, 8 discovered, 0 enqueued
[11.845s][info][gc,reloc ] GC(6) Small Pages: 402 / 804M, Empty: 0M, Relocated: 3M, In-Place: 0
[11.845s][info][gc,reloc ] GC(6) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[11.845s][info][gc,reloc ] GC(6) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[11.845s][info][gc,reloc ] GC(6) Forwarding Usage: 0M
[11.845s][info][gc,heap ] GC(6) Min Capacity: 8M(1%)
[11.845s][info][gc,heap ] GC(6) Max Capacity: 1024M(100%)
[11.845s][info][gc,heap ] GC(6) Soft Max Capacity: 1024M(100%)
[11.845s][info][gc,heap ] GC(6) Mark Start Mark End Relocate Start Relocate End High Low
[11.845s][info][gc,heap ] GC(6) Capacity: 836M (82%) 840M (82%) 842M (82%) 844M (82%) 844M (82%) 836M (82%)
[11.845s][info][gc,heap ] GC(6) Free: 188M (18%) 184M (18%) 182M (18%) 184M (18%) 188M (18%) 180M (18%)
[11.845s][info][gc,heap ] GC(6) Used: 836M (82%) 840M (82%) 842M (82%) 840M (82%) 844M (82%) 836M (82%)
[11.845s][info][gc,heap ] GC(6) Live: - 554M (54%) 554M (54%) 554M (54%) - -
[11.845s][info][gc,heap ] GC(6) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[11.845s][info][gc,heap ] GC(6) Garbage: - 281M (27%) 281M (27%) 279M (27%) - -
[11.845s][info][gc,heap ] GC(6) Reclaimed: - - 0M (0%) 2M (0%) - -
[11.845s][info][gc ] GC(6) Garbage Collection (Allocation Rate) 836M(82%)->840M(82%)
[11.897s][info][gc,start ] GC(7) Garbage Collection (Allocation Rate)
[11.897s][info][gc,task ] GC(7) Using 1 workers
[11.897s][info][gc,phases ] GC(7) Pause Mark Start 0.007ms
[11.919s][info][gc,phases ] GC(7) Concurrent Mark 22.145ms
[11.919s][info][gc,phases ] GC(7) Pause Mark End 0.009ms
[11.920s][info][gc,phases ] GC(7) Concurrent Mark Free 0.001ms
[11.923s][info][gc,phases ] GC(7) Concurrent Process Non-Strong References 3.417ms
[11.923s][info][gc,phases ] GC(7) Concurrent Reset Relocation Set 0.001ms
[11.927s][info][gc,phases ] GC(7) Concurrent Select Relocation Set 3.683ms
[11.927s][info][gc,phases ] GC(7) Pause Relocate Start 0.008ms
[11.928s][info][gc,phases ] GC(7) Concurrent Relocate 1.578ms
[11.929s][info][gc,load ] GC(7) Load: 1.36/0.53/0.24
[11.929s][info][gc,mmu ] GC(7) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[11.929s][info][gc,marking ] GC(7) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[11.929s][info][gc,marking ] GC(7) Mark Stack Usage: 32M
[11.929s][info][gc,nmethod ] GC(7) NMethods: 2257 registered, 0 unregistered
[11.929s][info][gc,metaspace] GC(7) Metaspace: 9M used, 9M committed, 1040M reserved
[11.929s][info][gc,ref ] GC(7) Soft: 3460 encountered, 0 discovered, 0 enqueued
[11.929s][info][gc,ref ] GC(7) Weak: 664 encountered, 5 discovered, 0 enqueued
[11.929s][info][gc,ref ] GC(7) Final: 2 encountered, 2 discovered, 0 enqueued
[11.929s][info][gc,ref ] GC(7) Phantom: 12 encountered, 8 discovered, 0 enqueued
[11.929s][info][gc,reloc ] GC(7) Small Pages: 408 / 816M, Empty: 0M, Relocated: 1M, In-Place: 0
[11.929s][info][gc,reloc ] GC(7) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[11.929s][info][gc,reloc ] GC(7) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[11.929s][info][gc,reloc ] GC(7) Forwarding Usage: 0M
[11.929s][info][gc,heap ] GC(7) Min Capacity: 8M(1%)
[11.929s][info][gc,heap ] GC(7) Max Capacity: 1024M(100%)
[11.929s][info][gc,heap ] GC(7) Soft Max Capacity: 1024M(100%)
[11.929s][info][gc,heap ] GC(7) Mark Start Mark End Relocate Start Relocate End High Low
[11.929s][info][gc,heap ] GC(7) Capacity: 848M (83%) 852M (83%) 854M (83%) 856M (84%) 856M (84%) 848M (83%)
[11.929s][info][gc,heap ] GC(7) Free: 176M (17%) 172M (17%) 170M (17%) 172M (17%) 176M (17%) 168M (16%)
[11.929s][info][gc,heap ] GC(7) Used: 848M (83%) 852M (83%) 854M (83%) 852M (83%) 856M (84%) 848M (83%)
[11.929s][info][gc,heap ] GC(7) Live: - 563M (55%) 563M (55%) 563M (55%) - -
[11.929s][info][gc,heap ] GC(7) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[11.929s][info][gc,heap ] GC(7) Garbage: - 284M (28%) 284M (28%) 282M (28%) - -
[11.929s][info][gc,heap ] GC(7) Reclaimed: - - 0M (0%) 2M (0%) - -
[11.929s][info][gc ] GC(7) Garbage Collection (Allocation Rate) 848M(83%)->852M(83%)
[12.097s][info][gc,start ] GC(8) Garbage Collection (Allocation Rate)
[12.097s][info][gc,task ] GC(8) Using 1 workers
[12.097s][info][gc,phases ] GC(8) Pause Mark Start 0.006ms
[12.123s][info][gc,phases ] GC(8) Concurrent Mark 25.507ms
[12.123s][info][gc,phases ] GC(8) Pause Mark End 0.009ms
[12.123s][info][gc,phases ] GC(8) Concurrent Mark Free 0.001ms
[12.128s][info][gc,phases ] GC(8) Concurrent Process Non-Strong References 5.394ms
[12.128s][info][gc,phases ] GC(8) Concurrent Reset Relocation Set 0.001ms
[12.133s][info][gc,phases ] GC(8) Concurrent Select Relocation Set 4.438ms
[12.133s][info][gc,phases ] GC(8) Pause Relocate Start 0.011ms
[12.135s][info][gc,phases ] GC(8) Concurrent Relocate 1.720ms
[12.135s][info][gc,load ] GC(8) Load: 1.41/0.55/0.25
[12.135s][info][gc,mmu ] GC(8) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[12.135s][info][gc,marking ] GC(8) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.135s][info][gc,marking ] GC(8) Mark Stack Usage: 32M
[12.135s][info][gc,nmethod ] GC(8) NMethods: 2258 registered, 0 unregistered
[12.135s][info][gc,metaspace] GC(8) Metaspace: 9M used, 9M committed, 1040M reserved
[12.135s][info][gc,ref ] GC(8) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.135s][info][gc,ref ] GC(8) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.135s][info][gc,ref ] GC(8) Final: 3 encountered, 3 discovered, 1 enqueued
[12.135s][info][gc,ref ] GC(8) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.135s][info][gc,reloc ] GC(8) Small Pages: 423 / 846M, Empty: 0M, Relocated: 1M, In-Place: 0
[12.135s][info][gc,reloc ] GC(8) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.135s][info][gc,reloc ] GC(8) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.135s][info][gc,reloc ] GC(8) Forwarding Usage: 0M
[12.135s][info][gc,heap ] GC(8) Min Capacity: 8M(1%)
[12.135s][info][gc,heap ] GC(8) Max Capacity: 1024M(100%)
[12.135s][info][gc,heap ] GC(8) Soft Max Capacity: 1024M(100%)
[12.135s][info][gc,heap ] GC(8) Mark Start Mark End Relocate Start Relocate End High Low
[12.135s][info][gc,heap ] GC(8) Capacity: 878M (86%) 882M (86%) 884M (86%) 886M (87%) 886M (87%) 878M (86%)
[12.135s][info][gc,heap ] GC(8) Free: 146M (14%) 142M (14%) 140M (14%) 142M (14%) 146M (14%) 138M (13%)
[12.135s][info][gc,heap ] GC(8) Used: 878M (86%) 882M (86%) 884M (86%) 882M (86%) 886M (87%) 878M (86%)
[12.135s][info][gc,heap ] GC(8) Live: - 583M (57%) 583M (57%) 583M (57%) - -
[12.135s][info][gc,heap ] GC(8) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[12.135s][info][gc,heap ] GC(8) Garbage: - 294M (29%) 294M (29%) 292M (29%) - -
[12.135s][info][gc,heap ] GC(8) Reclaimed: - - 0M (0%) 2M (0%) - -
[12.135s][info][gc ] GC(8) Garbage Collection (Allocation Rate) 878M(86%)->882M(86%)
[12.197s][info][gc,start ] GC(9) Garbage Collection (Allocation Rate)
[12.197s][info][gc,task ] GC(9) Using 1 workers
[12.197s][info][gc,phases ] GC(9) Pause Mark Start 0.006ms
[12.221s][info][gc,phases ] GC(9) Concurrent Mark 23.248ms
[12.221s][info][gc,phases ] GC(9) Pause Mark End 0.012ms
[12.221s][info][gc,phases ] GC(9) Concurrent Mark Free 0.001ms
[12.225s][info][gc,phases ] GC(9) Concurrent Process Non-Strong References 4.649ms
[12.226s][info][gc,phases ] GC(9) Concurrent Reset Relocation Set 0.001ms
[12.230s][info][gc,phases ] GC(9) Concurrent Select Relocation Set 4.096ms
[12.230s][info][gc,phases ] GC(9) Pause Relocate Start 0.008ms
[12.231s][info][gc,phases ] GC(9) Concurrent Relocate 1.476ms
[12.232s][info][gc,load ] GC(9) Load: 1.41/0.55/0.25
[12.232s][info][gc,mmu ] GC(9) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[12.232s][info][gc,marking ] GC(9) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.232s][info][gc,marking ] GC(9) Mark Stack Usage: 32M
[12.232s][info][gc,nmethod ] GC(9) NMethods: 2258 registered, 0 unregistered
[12.232s][info][gc,metaspace] GC(9) Metaspace: 9M used, 9M committed, 1040M reserved
[12.232s][info][gc,ref ] GC(9) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.232s][info][gc,ref ] GC(9) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.232s][info][gc,ref ] GC(9) Final: 2 encountered, 2 discovered, 0 enqueued
[12.232s][info][gc,ref ] GC(9) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.232s][info][gc,reloc ] GC(9) Small Pages: 431 / 862M, Empty: 2M, Relocated: 3M, In-Place: 0
[12.232s][info][gc,reloc ] GC(9) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.232s][info][gc,reloc ] GC(9) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.232s][info][gc,reloc ] GC(9) Forwarding Usage: 0M
[12.232s][info][gc,heap ] GC(9) Min Capacity: 8M(1%)
[12.232s][info][gc,heap ] GC(9) Max Capacity: 1024M(100%)
[12.232s][info][gc,heap ] GC(9) Soft Max Capacity: 1024M(100%)
[12.232s][info][gc,heap ] GC(9) Mark Start Mark End Relocate Start Relocate End High Low
[12.232s][info][gc,heap ] GC(9) Capacity: 894M (87%) 898M (88%) 900M (88%) 900M (88%) 900M (88%) 894M (87%)
[12.232s][info][gc,heap ] GC(9) Free: 130M (13%) 126M (12%) 126M (12%) 128M (12%) 130M (13%) 124M (12%)
[12.232s][info][gc,heap ] GC(9) Used: 894M (87%) 898M (88%) 898M (88%) 896M (88%) 900M (88%) 894M (87%)
[12.232s][info][gc,heap ] GC(9) Live: - 593M (58%) 593M (58%) 593M (58%) - -
[12.232s][info][gc,heap ] GC(9) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[12.232s][info][gc,heap ] GC(9) Garbage: - 300M (29%) 298M (29%) 296M (29%) - -
[12.232s][info][gc,heap ] GC(9) Reclaimed: - - 2M (0%) 4M (0%) - -
[12.232s][info][gc ] GC(9) Garbage Collection (Allocation Rate) 894M(87%)->896M(88%)
[12.396s][info][gc,start ] GC(10) Garbage Collection (Allocation Rate)
[12.396s][info][gc,task ] GC(10) Using 1 workers
[12.396s][info][gc,phases ] GC(10) Pause Mark Start 0.021ms
[12.421s][info][gc,phases ] GC(10) Concurrent Mark 24.997ms
[12.422s][info][gc,phases ] GC(10) Pause Mark End 0.012ms
[12.422s][info][gc,phases ] GC(10) Concurrent Mark Free 0.000ms
[12.427s][info][gc,phases ] GC(10) Concurrent Process Non-Strong References 5.247ms
[12.427s][info][gc,phases ] GC(10) Concurrent Reset Relocation Set 0.001ms
[12.431s][info][gc,phases ] GC(10) Concurrent Select Relocation Set 3.687ms
[12.431s][info][gc,phases ] GC(10) Pause Relocate Start 0.010ms
[12.435s][info][gc,phases ] GC(10) Concurrent Relocate 3.561ms
[12.435s][info][gc,load ] GC(10) Load: 1.41/0.55/0.25
[12.435s][info][gc,mmu ] GC(10) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[12.435s][info][gc,marking ] GC(10) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.435s][info][gc,marking ] GC(10) Mark Stack Usage: 32M
[12.435s][info][gc,nmethod ] GC(10) NMethods: 2258 registered, 0 unregistered
[12.435s][info][gc,metaspace] GC(10) Metaspace: 9M used, 9M committed, 1040M reserved
[12.435s][info][gc,ref ] GC(10) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.435s][info][gc,ref ] GC(10) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.435s][info][gc,ref ] GC(10) Final: 2 encountered, 0 discovered, 0 enqueued
[12.435s][info][gc,ref ] GC(10) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.435s][info][gc,reloc ] GC(10) Small Pages: 445 / 890M, Empty: 0M, Relocated: 3M, In-Place: 0
[12.435s][info][gc,reloc ] GC(10) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.435s][info][gc,reloc ] GC(10) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.435s][info][gc,reloc ] GC(10) Forwarding Usage: 0M
[12.435s][info][gc,heap ] GC(10) Min Capacity: 8M(1%)
[12.435s][info][gc,heap ] GC(10) Max Capacity: 1024M(100%)
[12.435s][info][gc,heap ] GC(10) Soft Max Capacity: 1024M(100%)
[12.435s][info][gc,heap ] GC(10) Mark Start Mark End Relocate Start Relocate End High Low
[12.435s][info][gc,heap ] GC(10) Capacity: 922M (90%) 926M (90%) 928M (91%) 930M (91%) 930M (91%) 922M (90%)
[12.435s][info][gc,heap ] GC(10) Free: 102M (10%) 98M (10%) 96M (9%) 98M (10%) 102M (10%) 94M (9%)
[12.435s][info][gc,heap ] GC(10) Used: 922M (90%) 926M (90%) 928M (91%) 926M (90%) 930M (91%) 922M (90%)
[12.435s][info][gc,heap ] GC(10) Live: - 615M (60%) 615M (60%) 615M (60%) - -
[12.435s][info][gc,heap ] GC(10) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[12.435s][info][gc,heap ] GC(10) Garbage: - 306M (30%) 306M (30%) 304M (30%) - -
[12.435s][info][gc,heap ] GC(10) Reclaimed: - - 0M (0%) 2M (0%) - -
[12.435s][info][gc ] GC(10) Garbage Collection (Allocation Rate) 922M(90%)->926M(90%)
[12.496s][info][gc,start ] GC(11) Garbage Collection (Allocation Rate)
[12.496s][info][gc,task ] GC(11) Using 1 workers
[12.497s][info][gc,phases ] GC(11) Pause Mark Start 0.019ms
[12.536s][info][gc,phases ] GC(11) Concurrent Mark 39.763ms
[12.537s][info][gc,phases ] GC(11) Pause Mark End 0.009ms
[12.537s][info][gc,phases ] GC(11) Concurrent Mark Free 0.001ms
[12.540s][info][gc,phases ] GC(11) Concurrent Process Non-Strong References 3.541ms
[12.540s][info][gc,phases ] GC(11) Concurrent Reset Relocation Set 0.001ms
[12.543s][info][gc,phases ] GC(11) Concurrent Select Relocation Set 3.154ms
[12.544s][info][gc,phases ] GC(11) Pause Relocate Start 0.007ms
[12.545s][info][gc,phases ] GC(11) Concurrent Relocate 1.235ms
[12.545s][info][gc,load ] GC(11) Load: 1.41/0.55/0.25
[12.545s][info][gc,mmu ] GC(11) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[12.545s][info][gc,marking ] GC(11) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.545s][info][gc,marking ] GC(11) Mark Stack Usage: 32M
[12.545s][info][gc,nmethod ] GC(11) NMethods: 2258 registered, 0 unregistered
[12.545s][info][gc,metaspace] GC(11) Metaspace: 9M used, 9M committed, 1040M reserved
[12.545s][info][gc,ref ] GC(11) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.545s][info][gc,ref ] GC(11) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.545s][info][gc,ref ] GC(11) Final: 2 encountered, 2 discovered, 0 enqueued
[12.545s][info][gc,ref ] GC(11) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.545s][info][gc,reloc ] GC(11) Small Pages: 453 / 906M, Empty: 0M, Relocated: 1M, In-Place: 0
[12.545s][info][gc,reloc ] GC(11) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.545s][info][gc,reloc ] GC(11) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.545s][info][gc,reloc ] GC(11) Forwarding Usage: 0M
[12.545s][info][gc,heap ] GC(11) Min Capacity: 8M(1%)
[12.545s][info][gc,heap ] GC(11) Max Capacity: 1024M(100%)
[12.545s][info][gc,heap ] GC(11) Soft Max Capacity: 1024M(100%)
[12.545s][info][gc,heap ] GC(11) Mark Start Mark End Relocate Start Relocate End High Low
[12.545s][info][gc,heap ] GC(11) Capacity: 938M (92%) 942M (92%) 944M (92%) 946M (92%) 946M (92%) 938M (92%)
[12.545s][info][gc,heap ] GC(11) Free: 86M (8%) 82M (8%) 80M (8%) 84M (8%) 86M (8%) 78M (8%)
[12.545s][info][gc,heap ] GC(11) Used: 938M (92%) 942M (92%) 944M (92%) 940M (92%) 946M (92%) 938M (92%)
[12.545s][info][gc,heap ] GC(11) Live: - 625M (61%) 625M (61%) 625M (61%) - -
[12.545s][info][gc,heap ] GC(11) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[12.545s][info][gc,heap ] GC(11) Garbage: - 312M (31%) 312M (31%) 308M (30%) - -
[12.545s][info][gc,heap ] GC(11) Reclaimed: - - 0M (0%) 4M (0%) - -
[12.545s][info][gc ] GC(11) Garbage Collection (Allocation Rate) 938M(92%)->940M(92%)
[12.596s][info][gc,start ] GC(12) Garbage Collection (Allocation Rate)
[12.596s][info][gc,task ] GC(12) Using 1 workers
[12.597s][info][gc,phases ] GC(12) Pause Mark Start 0.005ms
[12.620s][info][gc,phases ] GC(12) Concurrent Mark 23.219ms
[12.620s][info][gc,phases ] GC(12) Pause Mark End 0.010ms
[12.620s][info][gc,phases ] GC(12) Concurrent Mark Free 0.001ms
[12.624s][info][gc,phases ] GC(12) Concurrent Process Non-Strong References 3.953ms
[12.624s][info][gc,phases ] GC(12) Concurrent Reset Relocation Set 0.001ms
[12.628s][info][gc,phases ] GC(12) Concurrent Select Relocation Set 4.199ms
[12.629s][info][gc,phases ] GC(12) Pause Relocate Start 0.021ms
[12.630s][info][gc,phases ] GC(12) Concurrent Relocate 1.683ms
[12.631s][info][gc,load ] GC(12) Load: 1.41/0.55/0.25
[12.631s][info][gc,mmu ] GC(12) MMU: 2ms/98.2%, 5ms/99.3%, 10ms/99.6%, 20ms/99.8%, 50ms/99.9%, 100ms/99.9%
[12.631s][info][gc,marking ] GC(12) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.631s][info][gc,marking ] GC(12) Mark Stack Usage: 32M
[12.631s][info][gc,nmethod ] GC(12) NMethods: 2258 registered, 0 unregistered
[12.631s][info][gc,metaspace] GC(12) Metaspace: 9M used, 9M committed, 1040M reserved
[12.631s][info][gc,ref ] GC(12) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.631s][info][gc,ref ] GC(12) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.631s][info][gc,ref ] GC(12) Final: 2 encountered, 2 discovered, 0 enqueued
[12.631s][info][gc,ref ] GC(12) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.631s][info][gc,reloc ] GC(12) Small Pages: 458 / 916M, Empty: 0M, Relocated: 1M, In-Place: 0
[12.631s][info][gc,reloc ] GC(12) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.631s][info][gc,reloc ] GC(12) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.631s][info][gc,reloc ] GC(12) Forwarding Usage: 0M
[12.631s][info][gc,heap ] GC(12) Min Capacity: 8M(1%)
[12.631s][info][gc,heap ] GC(12) Max Capacity: 1024M(100%)
[12.631s][info][gc,heap ] GC(12) Soft Max Capacity: 1024M(100%)
[12.631s][info][gc,heap ] GC(12) Mark Start Mark End Relocate Start Relocate End High Low
[12.631s][info][gc,heap ] GC(12) Capacity: 948M (93%) 954M (93%) 956M (93%) 958M (94%) 958M (94%) 948M (93%)
[12.631s][info][gc,heap ] GC(12) Free: 76M (7%) 70M (7%) 68M (7%) 70M (7%) 76M (7%) 66M (6%)
[12.631s][info][gc,heap ] GC(12) Used: 948M (93%) 954M (93%) 956M (93%) 954M (93%) 958M (94%) 948M (93%)
[12.631s][info][gc,heap ] GC(12) Live: - 633M (62%) 633M (62%) 633M (62%) - -
[12.631s][info][gc,heap ] GC(12) Allocated: - 6M (1%) 8M (1%) 8M (1%) - -
[12.631s][info][gc,heap ] GC(12) Garbage: - 314M (31%) 314M (31%) 312M (31%) - -
[12.631s][info][gc,heap ] GC(12) Reclaimed: - - 0M (0%) 2M (0%) - -
[12.631s][info][gc ] GC(12) Garbage Collection (Allocation Rate) 948M(93%)->954M(93%)
[12.697s][info][gc,start ] GC(13) Garbage Collection (Allocation Rate)
[12.697s][info][gc,task ] GC(13) Using 1 workers
[12.697s][info][gc,phases ] GC(13) Pause Mark Start 0.007ms
[12.722s][info][gc,phases ] GC(13) Concurrent Mark 25.535ms
[12.723s][info][gc,phases ] GC(13) Pause Mark End 0.235ms
[12.723s][info][gc,phases ] GC(13) Concurrent Mark Free 0.001ms
[12.728s][info][gc,phases ] GC(13) Concurrent Process Non-Strong References 4.692ms
[12.728s][info][gc,phases ] GC(13) Concurrent Reset Relocation Set 0.002ms
[12.732s][info][gc,phases ] GC(13) Concurrent Select Relocation Set 3.742ms
[12.732s][info][gc,phases ] GC(13) Pause Relocate Start 0.009ms
[12.732s][info][gc,phases ] GC(13) Concurrent Relocate 0.015ms
[12.732s][info][gc,load ] GC(13) Load: 1.41/0.55/0.25
[12.732s][info][gc,mmu ] GC(13) MMU: 2ms/88.2%, 5ms/95.3%, 10ms/97.6%, 20ms/98.8%, 50ms/99.5%, 100ms/99.7%
[12.732s][info][gc,marking ] GC(13) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.732s][info][gc,marking ] GC(13) Mark Stack Usage: 32M
[12.732s][info][gc,nmethod ] GC(13) NMethods: 2258 registered, 0 unregistered
[12.732s][info][gc,metaspace] GC(13) Metaspace: 9M used, 9M committed, 1040M reserved
[12.732s][info][gc,ref ] GC(13) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.732s][info][gc,ref ] GC(13) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.732s][info][gc,ref ] GC(13) Final: 2 encountered, 2 discovered, 0 enqueued
[12.732s][info][gc,ref ] GC(13) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.732s][info][gc,reloc ] GC(13) Small Pages: 465 / 930M, Empty: 2M, Relocated: 0M, In-Place: 0
[12.732s][info][gc,reloc ] GC(13) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.732s][info][gc,reloc ] GC(13) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.732s][info][gc,reloc ] GC(13) Forwarding Usage: 0M
[12.732s][info][gc,heap ] GC(13) Min Capacity: 8M(1%)
[12.732s][info][gc,heap ] GC(13) Max Capacity: 1024M(100%)
[12.732s][info][gc,heap ] GC(13) Soft Max Capacity: 1024M(100%)
[12.732s][info][gc,heap ] GC(13) Mark Start Mark End Relocate Start Relocate End High Low
[12.732s][info][gc,heap ] GC(13) Capacity: 962M (94%) 966M (94%) 968M (95%) 968M (95%) 968M (95%) 962M (94%)
[12.732s][info][gc,heap ] GC(13) Free: 62M (6%) 58M (6%) 58M (6%) 58M (6%) 62M (6%) 56M (5%)
[12.732s][info][gc,heap ] GC(13) Used: 962M (94%) 966M (94%) 966M (94%) 966M (94%) 968M (95%) 962M (94%)
[12.732s][info][gc,heap ] GC(13) Live: - 642M (63%) 642M (63%) 642M (63%) - -
[12.732s][info][gc,heap ] GC(13) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[12.732s][info][gc,heap ] GC(13) Garbage: - 319M (31%) 317M (31%) 317M (31%) - -
[12.732s][info][gc,heap ] GC(13) Reclaimed: - - 2M (0%) 2M (0%) - -
[12.732s][info][gc ] GC(13) Garbage Collection (Allocation Rate) 962M(94%)->966M(94%)
[12.797s][info][gc,start ] GC(14) Garbage Collection (Allocation Rate)
[12.797s][info][gc,task ] GC(14) Using 1 workers
[12.797s][info][gc,phases ] GC(14) Pause Mark Start 0.007ms
[12.822s][info][gc,phases ] GC(14) Concurrent Mark 24.747ms
[12.822s][info][gc,phases ] GC(14) Pause Mark End 0.015ms
[12.822s][info][gc,phases ] GC(14) Concurrent Mark Free 0.000ms
[12.826s][info][gc,phases ] GC(14) Concurrent Process Non-Strong References 4.423ms
[12.826s][info][gc,phases ] GC(14) Concurrent Reset Relocation Set 0.000ms
[12.830s][info][gc,phases ] GC(14) Concurrent Select Relocation Set 3.528ms
[12.830s][info][gc,phases ] GC(14) Pause Relocate Start 0.008ms
[12.835s][info][gc,phases ] GC(14) Concurrent Relocate 4.378ms
[12.835s][info][gc,load ] GC(14) Load: 1.41/0.55/0.25
[12.835s][info][gc,mmu ] GC(14) MMU: 2ms/88.2%, 5ms/95.3%, 10ms/97.6%, 20ms/98.8%, 50ms/99.5%, 100ms/99.7%
[12.835s][info][gc,marking ] GC(14) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.835s][info][gc,marking ] GC(14) Mark Stack Usage: 32M
[12.835s][info][gc,nmethod ] GC(14) NMethods: 2258 registered, 0 unregistered
[12.835s][info][gc,metaspace] GC(14) Metaspace: 9M used, 9M committed, 1040M reserved
[12.835s][info][gc,ref ] GC(14) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.835s][info][gc,ref ] GC(14) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.835s][info][gc,ref ] GC(14) Final: 2 encountered, 2 discovered, 0 enqueued
[12.835s][info][gc,ref ] GC(14) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.835s][info][gc,reloc ] GC(14) Small Pages: 472 / 944M, Empty: 0M, Relocated: 3M, In-Place: 0
[12.835s][info][gc,reloc ] GC(14) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.835s][info][gc,reloc ] GC(14) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.835s][info][gc,reloc ] GC(14) Forwarding Usage: 0M
[12.835s][info][gc,heap ] GC(14) Min Capacity: 8M(1%)
[12.835s][info][gc,heap ] GC(14) Max Capacity: 1024M(100%)
[12.835s][info][gc,heap ] GC(14) Soft Max Capacity: 1024M(100%)
[12.835s][info][gc,heap ] GC(14) Mark Start Mark End Relocate Start Relocate End High Low
[12.835s][info][gc,heap ] GC(14) Capacity: 976M (95%) 980M (96%) 982M (96%) 984M (96%) 984M (96%) 976M (95%)
[12.835s][info][gc,heap ] GC(14) Free: 48M (5%) 44M (4%) 42M (4%) 44M (4%) 48M (5%) 40M (4%)
[12.835s][info][gc,heap ] GC(14) Used: 976M (95%) 980M (96%) 982M (96%) 980M (96%) 984M (96%) 976M (95%)
[12.835s][info][gc,heap ] GC(14) Live: - 653M (64%) 653M (64%) 653M (64%) - -
[12.835s][info][gc,heap ] GC(14) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[12.835s][info][gc,heap ] GC(14) Garbage: - 322M (32%) 322M (32%) 320M (31%) - -
[12.835s][info][gc,heap ] GC(14) Reclaimed: - - 0M (0%) 2M (0%) - -
[12.835s][info][gc ] GC(14) Garbage Collection (Allocation Rate) 976M(95%)->980M(96%)
[12.897s][info][gc,start ] GC(15) Garbage Collection (Allocation Rate)
[12.897s][info][gc,task ] GC(15) Using 1 workers
[12.897s][info][gc,phases ] GC(15) Pause Mark Start 0.053ms
[12.923s][info][gc,phases ] GC(15) Concurrent Mark 25.566ms
[12.923s][info][gc,phases ] GC(15) Pause Mark End 0.010ms
[12.923s][info][gc,phases ] GC(15) Concurrent Mark Free 0.001ms
[12.927s][info][gc,phases ] GC(15) Concurrent Process Non-Strong References 3.647ms
[12.927s][info][gc,phases ] GC(15) Concurrent Reset Relocation Set 0.001ms
[12.931s][info][gc,phases ] GC(15) Concurrent Select Relocation Set 4.187ms
[12.931s][info][gc,phases ] GC(15) Pause Relocate Start 0.009ms
[12.934s][info][gc,phases ] GC(15) Concurrent Relocate 3.352ms
[12.935s][info][gc,load ] GC(15) Load: 1.41/0.55/0.25
[12.935s][info][gc,mmu ] GC(15) MMU: 2ms/88.2%, 5ms/95.3%, 10ms/97.6%, 20ms/98.8%, 50ms/99.5%, 100ms/99.7%
[12.935s][info][gc,marking ] GC(15) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[12.935s][info][gc,marking ] GC(15) Mark Stack Usage: 32M
[12.935s][info][gc,nmethod ] GC(15) NMethods: 2258 registered, 0 unregistered
[12.935s][info][gc,metaspace] GC(15) Metaspace: 9M used, 9M committed, 1040M reserved
[12.935s][info][gc,ref ] GC(15) Soft: 3460 encountered, 0 discovered, 0 enqueued
[12.935s][info][gc,ref ] GC(15) Weak: 664 encountered, 5 discovered, 0 enqueued
[12.935s][info][gc,ref ] GC(15) Final: 3 encountered, 1 discovered, 1 enqueued
[12.935s][info][gc,ref ] GC(15) Phantom: 12 encountered, 8 discovered, 0 enqueued
[12.935s][info][gc,reloc ] GC(15) Small Pages: 479 / 958M, Empty: 0M, Relocated: 3M, In-Place: 0
[12.935s][info][gc,reloc ] GC(15) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.935s][info][gc,reloc ] GC(15) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[12.935s][info][gc,reloc ] GC(15) Forwarding Usage: 0M
[12.935s][info][gc,heap ] GC(15) Min Capacity: 8M(1%)
[12.935s][info][gc,heap ] GC(15) Max Capacity: 1024M(100%)
[12.935s][info][gc,heap ] GC(15) Soft Max Capacity: 1024M(100%)
[12.935s][info][gc,heap ] GC(15) Mark Start Mark End Relocate Start Relocate End High Low
[12.935s][info][gc,heap ] GC(15) Capacity: 990M (97%) 994M (97%) 996M (97%) 998M (97%) 998M (97%) 990M (97%)
[12.935s][info][gc,heap ] GC(15) Free: 34M (3%) 30M (3%) 28M (3%) 30M (3%) 34M (3%) 26M (3%)
[12.935s][info][gc,heap ] GC(15) Used: 990M (97%) 994M (97%) 996M (97%) 994M (97%) 998M (97%) 990M (97%)
[12.935s][info][gc,heap ] GC(15) Live: - 663M (65%) 663M (65%) 663M (65%) - -
[12.935s][info][gc,heap ] GC(15) Allocated: - 4M (0%) 6M (1%) 5M (1%) - -
[12.935s][info][gc,heap ] GC(15) Garbage: - 326M (32%) 326M (32%) 324M (32%) - -
[12.935s][info][gc,heap ] GC(15) Reclaimed: - - 0M (0%) 1M (0%) - -
[12.935s][info][gc ] GC(15) Garbage Collection (Allocation Rate) 990M(97%)->994M(97%)
[12.997s][info][gc,start ] GC(16) Garbage Collection (Allocation Rate)
[12.997s][info][gc,task ] GC(16) Using 1 workers
[12.997s][info][gc,phases ] GC(16) Pause Mark Start 0.006ms
[13.026s][info][gc,phases ] GC(16) Concurrent Mark 29.089ms
[13.026s][info][gc,phases ] GC(16) Pause Mark End 0.008ms
[13.026s][info][gc,phases ] GC(16) Concurrent Mark Free 0.001ms
[13.031s][info][gc,phases ] GC(16) Concurrent Process Non-Strong References 4.620ms
[13.031s][info][gc,phases ] GC(16) Concurrent Reset Relocation Set 0.001ms
[13.036s][info][gc,phases ] GC(16) Concurrent Select Relocation Set 4.656ms
[13.036s][info][gc,phases ] GC(16) Pause Relocate Start 0.012ms
[13.036s][info][gc,phases ] GC(16) Concurrent Relocate 0.018ms
[13.036s][info][gc,load ] GC(16) Load: 1.41/0.55/0.25
[13.036s][info][gc,mmu ] GC(16) MMU: 2ms/88.2%, 5ms/95.3%, 10ms/97.6%, 20ms/98.8%, 50ms/99.5%, 100ms/99.7%
[13.036s][info][gc,marking ] GC(16) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[13.036s][info][gc,marking ] GC(16) Mark Stack Usage: 32M
[13.036s][info][gc,nmethod ] GC(16) NMethods: 2258 registered, 0 unregistered
[13.036s][info][gc,metaspace] GC(16) Metaspace: 9M used, 9M committed, 1040M reserved
[13.036s][info][gc,ref ] GC(16) Soft: 3460 encountered, 0 discovered, 0 enqueued
[13.036s][info][gc,ref ] GC(16) Weak: 664 encountered, 5 discovered, 0 enqueued
[13.036s][info][gc,ref ] GC(16) Final: 2 encountered, 2 discovered, 0 enqueued
[13.036s][info][gc,ref ] GC(16) Phantom: 12 encountered, 8 discovered, 0 enqueued
[13.036s][info][gc,reloc ] GC(16) Small Pages: 485 / 970M, Empty: 0M, Relocated: 0M, In-Place: 0
[13.036s][info][gc,reloc ] GC(16) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[13.036s][info][gc,reloc ] GC(16) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[13.036s][info][gc,reloc ] GC(16) Forwarding Usage: 0M
[13.036s][info][gc,heap ] GC(16) Min Capacity: 8M(1%)
[13.036s][info][gc,heap ] GC(16) Max Capacity: 1024M(100%)
[13.036s][info][gc,heap ] GC(16) Soft Max Capacity: 1024M(100%)
[13.036s][info][gc,heap ] GC(16) Mark Start Mark End Relocate Start Relocate End High Low
[13.036s][info][gc,heap ] GC(16) Capacity: 1002M (98%) 1006M (98%) 1008M (98%) 1008M (98%) 1008M (98%) 1002M (98%)
[13.036s][info][gc,heap ] GC(16) Free: 22M (2%) 18M (2%) 16M (2%) 16M (2%) 22M (2%) 16M (2%)
[13.036s][info][gc,heap ] GC(16) Used: 1002M (98%) 1006M (98%) 1008M (98%) 1008M (98%) 1008M (98%) 1002M (98%)
[13.036s][info][gc,heap ] GC(16) Live: - 672M (66%) 672M (66%) 672M (66%) - -
[13.036s][info][gc,heap ] GC(16) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[13.037s][info][gc,heap ] GC(16) Garbage: - 329M (32%) 329M (32%) 329M (32%) - -
[13.037s][info][gc,heap ] GC(16) Reclaimed: - - 0M (0%) 0M (0%) - -
[13.037s][info][gc ] GC(16) Garbage Collection (Allocation Rate) 1002M(98%)->1008M(98%)
[13.097s][info][gc,start ] GC(17) Garbage Collection (Allocation Rate)
[13.097s][info][gc,task ] GC(17) Using 1 workers
[13.097s][info][gc,phases ] GC(17) Pause Mark Start 0.005ms
[13.133s][info][gc,phases ] GC(17) Concurrent Mark 36.056ms
[13.134s][info][gc,phases ] GC(17) Pause Mark End 0.015ms
[13.134s][info][gc,phases ] GC(17) Concurrent Mark Free 0.001ms
[13.138s][info][gc,phases ] GC(17) Concurrent Process Non-Strong References 4.411ms
[13.138s][info][gc,phases ] GC(17) Concurrent Reset Relocation Set 0.000ms
[13.142s][info][gc,phases ] GC(17) Concurrent Select Relocation Set 3.592ms
[13.142s][info][gc,phases ] GC(17) Pause Relocate Start 0.025ms
[13.144s][info][gc,phases ] GC(17) Concurrent Relocate 2.098ms
[13.144s][info][gc,load ] GC(17) Load: 1.41/0.55/0.25
[13.144s][info][gc,mmu ] GC(17) MMU: 2ms/88.2%, 5ms/95.3%, 10ms/97.6%, 20ms/98.8%, 50ms/99.5%, 100ms/99.7%
[13.144s][info][gc,marking ] GC(17) Mark: 1 stripe(s), 2 proactive flush(es), 1 terminate flush(es), 0 completion(s), 0 continuation(s)
[13.144s][info][gc,marking ] GC(17) Mark Stack Usage: 32M
[13.144s][info][gc,nmethod ] GC(17) NMethods: 2258 registered, 0 unregistered
[13.144s][info][gc,metaspace] GC(17) Metaspace: 9M used, 9M committed, 1040M reserved
[13.144s][info][gc,ref ] GC(17) Soft: 3460 encountered, 0 discovered, 0 enqueued
[13.144s][info][gc,ref ] GC(17) Weak: 664 encountered, 5 discovered, 0 enqueued
[13.144s][info][gc,ref ] GC(17) Final: 2 encountered, 2 discovered, 0 enqueued
[13.144s][info][gc,ref ] GC(17) Phantom: 12 encountered, 8 discovered, 0 enqueued
[13.144s][info][gc,reloc ] GC(17) Small Pages: 492 / 984M, Empty: 0M, Relocated: 3M, In-Place: 0
[13.144s][info][gc,reloc ] GC(17) Medium Pages: 1 / 32M, Empty: 0M, Relocated: 0M, In-Place: 0
[13.144s][info][gc,reloc ] GC(17) Large Pages: 0 / 0M, Empty: 0M, Relocated: 0M, In-Place: 0
[13.144s][info][gc,reloc ] GC(17) Forwarding Usage: 0M
[13.144s][info][gc,heap ] GC(17) Min Capacity: 8M(1%)
[13.144s][info][gc,heap ] GC(17) Max Capacity: 1024M(100%)
[13.144s][info][gc,heap ] GC(17) Soft Max Capacity: 1024M(100%)
[13.144s][info][gc,heap ] GC(17) Mark Start Mark End Relocate Start Relocate End High Low
[13.144s][info][gc,heap ] GC(17) Capacity: 1016M (99%) 1020M (100%) 1022M (100%) 1024M (100%) 1024M (100%) 1016M (99%)
[13.144s][info][gc,heap ] GC(17) Free: 8M (1%) 4M (0%) 2M (0%) 4M (0%) 8M (1%) 0M (0%)
[13.144s][info][gc,heap ] GC(17) Used: 1016M (99%) 1020M (100%) 1022M (100%) 1020M (100%) 1024M (100%) 1016M (99%)
[13.144s][info][gc,heap ] GC(17) Live: - 681M (67%) 681M (67%) 681M (67%) - -
[13.144s][info][gc,heap ] GC(17) Allocated: - 4M (0%) 6M (1%) 6M (1%) - -
[13.144s][info][gc,heap ] GC(17) Garbage: - 334M (33%) 334M (33%) 332M (32%) - -
[13.144s][info][gc,heap ] GC(17) Reclaimed: - - 0M (0%) 2M (0%) - -
[13.144s][info][gc ] GC(17) Garbage Collection (Allocation Rate) 1016M(99%)->1020M(100%)
More information about the zgc-dev
mailing list