[2025-11-28T03:38:57.959Z] Running test hotspot_gc_0 ... [2025-11-28T03:38:57.959Z] =============================================== [2025-11-28T03:38:57.959Z] hotspot_gc_0 Start Time: Fri Nov 28 03:38:57 2025 Epoch Time (ms): 1764301137686 [2025-11-28T03:38:57.959Z] variation: NoOptions [2025-11-28T03:38:57.959Z] JVM_OPTIONS: [2025-11-28T03:38:57.959Z] { \ [2025-11-28T03:38:57.959Z] echo ""; echo "TEST SETUP:"; \ [2025-11-28T03:38:57.959Z] echo "Nothing to be done for setup."; \ [2025-11-28T03:38:57.959Z] mkdir -p "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17643011377569/hotspot_gc_0"; \ [2025-11-28T03:38:57.959Z] cd "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17643011377569/hotspot_gc_0"; \ [2025-11-28T03:38:57.959Z] echo ""; echo "TESTING:"; \ [2025-11-28T03:38:57.959Z] "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-11-28T03:38:57.959Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -k:'!headful' -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/openjdk-test-image/hotspot/jtreg/native" -vmoptions:"-Xmx512m -Djava.awt.headless=true" \ [2025-11-28T03:38:57.959Z] -w ""/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17643011377569/hotspot_gc_0"/work" \ [2025-11-28T03:38:57.959Z] -r ""/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17643011377569/hotspot_gc_0"/report" \ [2025-11-28T03:38:57.959Z] -jdk:"/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image" \ [2025-11-28T03:38:57.959Z] -exclude:"/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/test/hotspot/jtreg/ProblemList.txt" \ [2025-11-28T03:38:57.959Z] -exclude:"/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk26.txt" \ [2025-11-28T03:38:57.959Z] \ [2025-11-28T03:38:57.959Z] \ [2025-11-28T03:38:57.959Z] "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/test/hotspot/jtreg:hotspot_gc"; \ [2025-11-28T03:38:57.959Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "hotspot_gc_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "hotspot_gc_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-28T03:38:57.959Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-28T03:38:57.959Z] echo "Nothing to be done for teardown."; \ [2025-11-28T03:38:57.959Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17643011377569/TestTargetResult"; [2025-11-28T03:38:57.959Z] [2025-11-28T03:38:57.959Z] TEST SETUP: [2025-11-28T03:38:57.959Z] Nothing to be done for setup. [2025-11-28T03:38:57.959Z] [2025-11-28T03:38:57.959Z] TESTING: [2025-11-28T03:38:58.709Z] Directory "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17643011377569/hotspot_gc_0/work" not found: creating [2025-11-28T03:38:58.709Z] Directory "/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17643011377569/hotspot_gc_0/report" not found: creating [2025-11-28T03:39:06.877Z] XML output with verification to /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work [2025-11-28T04:53:55.345Z] -------------------------------------------------- [2025-11-28T04:53:55.345Z] TEST: gc/TestAllocHumongousFragment.java#generational [2025-11-28T04:53:55.345Z] TEST JDK: /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image [2025-11-28T04:53:55.345Z] [2025-11-28T04:53:55.345Z] ACTION: build -- Passed. Build successful [2025-11-28T04:53:55.345Z] REASON: Named class compiled on demand [2025-11-28T04:53:55.345Z] TIME: 0.181 seconds [2025-11-28T04:53:55.345Z] messages: [2025-11-28T04:53:55.345Z] command: build TestAllocHumongousFragment [2025-11-28T04:53:55.345Z] reason: Named class compiled on demand [2025-11-28T04:53:55.345Z] started: Fri Nov 28 04:53:39.519 GMT 2025 [2025-11-28T04:53:55.345Z] Test directory: [2025-11-28T04:53:55.345Z] compile: TestAllocHumongousFragment [2025-11-28T04:53:55.345Z] finished: Fri Nov 28 04:53:39.700 GMT 2025 [2025-11-28T04:53:55.345Z] elapsed time (seconds): 0.181 [2025-11-28T04:53:55.345Z] [2025-11-28T04:53:55.345Z] ACTION: compile -- Passed. Compilation successful [2025-11-28T04:53:55.345Z] REASON: .class file out of date or does not exist [2025-11-28T04:53:55.345Z] TIME: 0.18 seconds [2025-11-28T04:53:55.345Z] messages: [2025-11-28T04:53:55.345Z] command: compile /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/TestAllocHumongousFragment.java [2025-11-28T04:53:55.345Z] reason: .class file out of date or does not exist [2025-11-28T04:53:55.345Z] started: Fri Nov 28 04:53:39.520 GMT 2025 [2025-11-28T04:53:55.345Z] Mode: agentvm [2025-11-28T04:53:55.345Z] Agent id: 3 [2025-11-28T04:53:55.345Z] Process id: 2889241 [2025-11-28T04:53:55.345Z] finished: Fri Nov 28 04:53:39.700 GMT 2025 [2025-11-28T04:53:55.345Z] elapsed time (seconds): 0.18 [2025-11-28T04:53:55.345Z] configuration: [2025-11-28T04:53:55.345Z] Boot Layer (javac runtime environment) [2025-11-28T04:53:55.345Z] class path: /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-11-28T04:53:55.345Z] /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-11-28T04:53:55.345Z] patch: java.base /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/patches/java.base [2025-11-28T04:53:55.345Z] [2025-11-28T04:53:55.345Z] javac compilation environment [2025-11-28T04:53:55.345Z] source path: /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc [2025-11-28T04:53:55.345Z] /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib [2025-11-28T04:53:55.345Z] class path: /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc [2025-11-28T04:53:55.345Z] /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d [2025-11-28T04:53:55.345Z] /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d/test/lib [2025-11-28T04:53:55.345Z] [2025-11-28T04:53:55.345Z] rerun: [2025-11-28T04:53:55.345Z] cd /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/scratch/2 && \ [2025-11-28T04:53:55.345Z] DISPLAY=:0 \ [2025-11-28T04:53:55.345Z] HOME=/home/jenkins \ [2025-11-28T04:53:55.345Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-11-28T04:53:55.345Z] /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image/bin/javac \ [2025-11-28T04:53:55.345Z] -J-ea \ [2025-11-28T04:53:55.345Z] -J-esa \ [2025-11-28T04:53:55.345Z] -J-Xmx512m \ [2025-11-28T04:53:55.345Z] -J-Djava.awt.headless=true \ [2025-11-28T04:53:55.345Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -Djava.awt.headless=true' \ [2025-11-28T04:53:55.345Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-Djava.awt.headless=true' \ [2025-11-28T04:53:55.345Z] -J-Dtest.compiler.opts= \ [2025-11-28T04:53:55.345Z] -J-Dtest.java.opts= \ [2025-11-28T04:53:55.345Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image \ [2025-11-28T04:53:55.345Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image \ [2025-11-28T04:53:55.345Z] -J-Dtest.timeout.factor=8.0 \ [2025-11-28T04:53:55.345Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-11-28T04:53:55.345Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg \ [2025-11-28T04:53:55.345Z] -J-Dtest.name=gc/TestAllocHumongousFragment.java#generational \ [2025-11-28T04:53:55.345Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-11-28T04:53:55.345Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/TestAllocHumongousFragment.java \ [2025-11-28T04:53:55.345Z] -J-Dtest.main.class=TestAllocHumongousFragment \ [2025-11-28T04:53:55.345Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc \ [2025-11-28T04:53:55.345Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-11-28T04:53:55.345Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d \ [2025-11-28T04:53:55.345Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d/test/lib \ [2025-11-28T04:53:55.345Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d/test/lib \ [2025-11-28T04:53:55.345Z] -d /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d \ [2025-11-28T04:53:55.345Z] -sourcepath /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-11-28T04:53:55.345Z] -classpath /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d/test/lib /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/TestAllocHumongousFragment.java [2025-11-28T04:53:55.345Z] [2025-11-28T04:53:55.345Z] ACTION: main -- Failed. Unexpected exit from test [exit code: 134] [2025-11-28T04:53:55.345Z] REASON: User specified action: run main/othervm -Xmx1g -Xms1g -Xlog:gc -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -XX:ShenandoahTargetNumRegions=2048 -XX:+UseShenandoahGC -XX:ShenandoahGCHeuristics=adaptive -XX:ShenandoahGCMode=generational -XX:+ShenandoahVerify TestAllocHumongousFragment [2025-11-28T04:53:55.345Z] TIME: 13.887 seconds [2025-11-28T04:53:55.345Z] messages: [2025-11-28T04:53:55.345Z] command: main -Xmx1g -Xms1g -Xlog:gc -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -XX:ShenandoahTargetNumRegions=2048 -XX:+UseShenandoahGC -XX:ShenandoahGCHeuristics=adaptive -XX:ShenandoahGCMode=generational -XX:+ShenandoahVerify TestAllocHumongousFragment [2025-11-28T04:53:55.345Z] reason: User specified action: run main/othervm -Xmx1g -Xms1g -Xlog:gc -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -XX:ShenandoahTargetNumRegions=2048 -XX:+UseShenandoahGC -XX:ShenandoahGCHeuristics=adaptive -XX:ShenandoahGCMode=generational -XX:+ShenandoahVerify TestAllocHumongousFragment [2025-11-28T04:53:55.345Z] started: Fri Nov 28 04:53:39.700 GMT 2025 [2025-11-28T04:53:55.346Z] Mode: othervm [/othervm specified] [2025-11-28T04:53:55.346Z] Process id: 3020738 [2025-11-28T04:53:55.346Z] finished: Fri Nov 28 04:53:53.587 GMT 2025 [2025-11-28T04:53:55.346Z] elapsed time (seconds): 13.887 [2025-11-28T04:53:55.346Z] configuration: [2025-11-28T04:53:55.346Z] STDOUT: [2025-11-28T04:53:55.346Z] [0.001s][info][gc] Min heap equals to max heap, disabling ShenandoahUncommit [2025-11-28T04:53:55.346Z] [0.009s][info][gc] Heuristics ergonomically sets -XX:GCTimeRatio=70 [2025-11-28T04:53:55.346Z] [0.009s][info][gc] Heuristics ergonomically sets -XX:+ExplicitGCInvokesConcurrent [2025-11-28T04:53:55.346Z] [0.009s][info][gc] Heuristics ergonomically sets -XX:+ShenandoahImplicitGCInvokesConcurrent [2025-11-28T04:53:55.346Z] [0.009s][info][gc] Heuristics ergonomically sets -XX:+UseCondCardMark [2025-11-28T04:53:55.346Z] [0.009s][info][gc] Using Shenandoah [2025-11-28T04:53:55.346Z] For random generator using seed: 3723532219 [2025-11-28T04:53:55.346Z] To re-run test with same seed value please add "-Djdk.test.lib.random.seed=3723532219" to command line. [2025-11-28T04:53:55.346Z] Allocated: 51 Mb [2025-11-28T04:53:55.346Z] Allocated: 106 Mb [2025-11-28T04:53:55.346Z] Allocated: 122 Mb [2025-11-28T04:53:55.346Z] Allocated: 158 Mb [2025-11-28T04:53:55.346Z] Allocated: 216 Mb [2025-11-28T04:53:55.346Z] Allocated: 246 Mb [2025-11-28T04:53:55.346Z] [0.402s][info][gc] Trigger (Young): Learning 1 of 5. Free (698M) is below initial threshold (716M) [2025-11-28T04:53:55.346Z] [0.404s][info][gc] GC(0) Concurrent reset (Young) 1.650ms [2025-11-28T04:53:55.346Z] [0.435s][info][gc] GC(0) Verify Before Mark, Level 4 (34379 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [0.435s][info][gc] GC(0) Pause Init Mark (Young) 16.174ms [2025-11-28T04:53:55.346Z] [0.435s][info][gc] GC(0) Concurrent remembered set scanning 0.138ms [2025-11-28T04:53:55.346Z] Allocated: 269 Mb [2025-11-28T04:53:55.346Z] [0.436s][info][gc] GC(0) Concurrent marking roots 1.381ms [2025-11-28T04:53:55.346Z] Allocated: 314 Mb [2025-11-28T04:53:55.346Z] Allocated: 328 Mb [2025-11-28T04:53:55.346Z] [0.481s][info][gc] GC(0) Concurrent marking (Young) 44.165ms [2025-11-28T04:53:55.346Z] [0.526s][info][gc] GC(0) Verify Before Evacuation, Level 4 (34364 reachable, 1768 marked) [2025-11-28T04:53:55.346Z] [0.526s][info][gc] GC(0) Pause Final Mark (Young) 8.745ms [2025-11-28T04:53:55.346Z] [0.526s][info][gc] GC(0) Concurrent thread roots 0.089ms [2025-11-28T04:53:55.346Z] [0.526s][info][gc] GC(0) Concurrent weak references (Young) 0.062ms [2025-11-28T04:53:55.346Z] Allocated: 377 Mb [2025-11-28T04:53:55.346Z] [0.526s][info][gc] GC(0) Concurrent weak roots (Young) 0.227ms [2025-11-28T04:53:55.346Z] [0.526s][info][gc] GC(0) Concurrent cleanup (Young) 387M->387M(1024M) 0.029ms [2025-11-28T04:53:55.346Z] [0.527s][info][gc] GC(0) Concurrent strong roots 0.210ms [2025-11-28T04:53:55.346Z] [0.528s][info][gc] GC(0) Concurrent evacuation 1.540ms [2025-11-28T04:53:55.346Z] [0.529s][info][gc] GC(0) Concurrent Init Update Refs (Young) 0.555ms [2025-11-28T04:53:55.346Z] [0.537s][info][gc] GC(0) Verify Before Updating References, Level 4 (36180 reachable, 12417 marked) [2025-11-28T04:53:55.346Z] [0.537s][info][gc] GC(0) Pause Init Update Refs 8.047ms [2025-11-28T04:53:55.346Z] Allocated: 380 Mb [2025-11-28T04:53:55.346Z] [0.540s][info][gc] GC(0) Concurrent update references 2.747ms [2025-11-28T04:53:55.346Z] [0.584s][info][gc] GC(0) Concurrent update thread roots 44.196ms [2025-11-28T04:53:55.346Z] [0.594s][info][gc] GC(0) Verify After Updating References, Level 4 (36113 reachable, 48 marked) [2025-11-28T04:53:55.346Z] [0.595s][info][gc] GC(0) Pause Final Update Refs 10.541ms [2025-11-28T04:53:55.346Z] [0.595s][info][gc] GC(0) Concurrent cleanup (Young) 449M->449M(1024M) 0.016ms [2025-11-28T04:53:55.346Z] Allocated: 444 Mb [2025-11-28T04:53:55.346Z] [0.607s][info][gc] GC(0) Concurrent reset after collect (Young) 11.952ms [2025-11-28T04:53:55.346Z] [0.608s][info][gc] Trigger (Young): Learning 2 of 5. Free (480M) is below initial threshold (716M) [2025-11-28T04:53:55.346Z] [0.610s][info][gc] GC(1) Concurrent reset (Young) 1.632ms [2025-11-28T04:53:55.346Z] [0.645s][info][gc] GC(1) Verify Before Mark, Level 4 (34367 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [0.646s][info][gc] GC(1) Pause Init Mark (Young) 8.987ms [2025-11-28T04:53:55.346Z] [0.646s][info][gc] GC(1) Concurrent remembered set scanning 0.153ms [2025-11-28T04:53:55.346Z] Allocated: 485 Mb [2025-11-28T04:53:55.346Z] [0.648s][info][gc] GC(1) Concurrent marking roots 1.923ms [2025-11-28T04:53:55.346Z] [0.699s][info][gc] GC(1) Concurrent marking (Young) 51.428ms [2025-11-28T04:53:55.346Z] [0.711s][info][gc] GC(1) Verify Before Evacuation, Level 4 (34369 reachable, 1761 marked) [2025-11-28T04:53:55.346Z] [0.711s][info][gc] GC(1) Pause Final Mark (Young) 12.058ms [2025-11-28T04:53:55.346Z] [0.712s][info][gc] GC(1) Concurrent thread roots 0.219ms [2025-11-28T04:53:55.346Z] [0.712s][info][gc] GC(1) Concurrent weak references (Young) 0.045ms [2025-11-28T04:53:55.346Z] [0.712s][info][gc] GC(1) Concurrent weak roots (Young) 0.186ms [2025-11-28T04:53:55.346Z] [0.712s][info][gc] GC(1) Concurrent cleanup (Young) 555M->555M(1024M) 0.034ms [2025-11-28T04:53:55.346Z] [0.712s][info][gc] GC(1) Concurrent strong roots 0.227ms [2025-11-28T04:53:55.346Z] Allocated: 549 Mb [2025-11-28T04:53:55.346Z] [0.715s][info][gc] GC(1) Concurrent evacuation 2.776ms [2025-11-28T04:53:55.346Z] Allocated: 572 Mb [2025-11-28T04:53:55.346Z] [0.733s][info][gc] GC(1) Concurrent Init Update Refs (Young) 17.972ms [2025-11-28T04:53:55.346Z] [0.775s][info][gc] GC(1) Verify Before Updating References, Level 4 (36184 reachable, 12396 marked) [2025-11-28T04:53:55.346Z] [0.775s][info][gc] GC(1) Pause Init Update Refs 12.716ms [2025-11-28T04:53:55.346Z] Allocated: 610 Mb [2025-11-28T04:53:55.346Z] [0.779s][info][gc] GC(1) Concurrent update references 4.342ms [2025-11-28T04:53:55.346Z] Allocated: 626 Mb [2025-11-28T04:53:55.346Z] [0.788s][info][gc] GC(1) Concurrent update thread roots 8.875ms [2025-11-28T04:53:55.346Z] [0.834s][info][gc] GC(1) Verify After Updating References, Level 4 (36118 reachable, 45 marked) [2025-11-28T04:53:55.346Z] [0.834s][info][gc] GC(1) Pause Final Update Refs 10.472ms [2025-11-28T04:53:55.346Z] [0.834s][info][gc] GC(1) Concurrent cleanup (Young) 681M->681M(1024M) 0.020ms [2025-11-28T04:53:55.346Z] Allocated: 674 Mb [2025-11-28T04:53:55.346Z] [0.851s][info][gc] GC(1) Concurrent reset after collect (Young) 17.335ms [2025-11-28T04:53:55.346Z] [0.852s][info][gc] Trigger (Young): Learning 3 of 5. Free (231M) is below initial threshold (716M) [2025-11-28T04:53:55.346Z] [0.853s][info][gc] GC(2) Concurrent reset (Young) 0.478ms [2025-11-28T04:53:55.346Z] [0.897s][info][gc] GC(2) Verify Before Mark, Level 4 (34373 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [0.897s][info][gc] GC(2) Pause Init Mark (Young) 8.927ms [2025-11-28T04:53:55.346Z] Allocated: 733 Mb [2025-11-28T04:53:55.346Z] [0.898s][info][gc] GC(2) Concurrent remembered set scanning 1.316ms [2025-11-28T04:53:55.346Z] [0.899s][info][gc] GC(2) Concurrent marking roots 0.368ms [2025-11-28T04:53:55.346Z] Allocated: 681 Mb [2025-11-28T04:53:55.346Z] Allocated: 701 Mb [2025-11-28T04:53:55.346Z] [0.938s][info][gc] GC(2) Concurrent marking (Young) 39.033ms [2025-11-28T04:53:55.346Z] [0.953s][info][gc] GC(2) Verify Before Evacuation, Level 4 (34373 reachable, 1771 marked) [2025-11-28T04:53:55.346Z] [0.953s][info][gc] GC(2) Pause Final Mark (Young) 13.164ms [2025-11-28T04:53:55.346Z] Allocated: 655 Mb [2025-11-28T04:53:55.346Z] [0.955s][info][gc] GC(2) Concurrent thread roots 2.165ms [2025-11-28T04:53:55.346Z] [0.955s][info][gc] GC(2) Concurrent weak references (Young) 0.046ms [2025-11-28T04:53:55.346Z] Allocated: 661 Mb [2025-11-28T04:53:55.346Z] [0.960s][info][gc] GC(2) Concurrent weak roots (Young) 4.357ms [2025-11-28T04:53:55.346Z] [0.960s][info][gc] GC(2) Concurrent cleanup (Young) 847M->847M(1024M) 0.035ms [2025-11-28T04:53:55.346Z] [0.960s][info][gc] GC(2) Concurrent strong roots 0.210ms [2025-11-28T04:53:55.346Z] [0.961s][info][gc] GC(2) Concurrent evacuation 0.912ms [2025-11-28T04:53:55.346Z] [0.999s][info][gc] GC(2) Concurrent Init Update Refs (Young) 37.704ms [2025-11-28T04:53:55.346Z] [1.011s][info][gc] GC(2) Verify Before Updating References, Level 4 (2172 reachable, 12201 marked) [2025-11-28T04:53:55.346Z] [1.011s][info][gc] GC(2) Pause Init Update Refs 12.145ms [2025-11-28T04:53:55.346Z] Allocated: 711 Mb [2025-11-28T04:53:55.346Z] [1.021s][info][gc] GC(2) Concurrent update references 9.449ms [2025-11-28T04:53:55.346Z] [1.063s][info][gc] GC(2) Concurrent update thread roots 42.422ms [2025-11-28T04:53:55.346Z] [1.069s][info][gc] GC(2) Verify After Updating References, Level 4 (2172 reachable, 10514 marked) [2025-11-28T04:53:55.346Z] [1.070s][info][gc] GC(2) Pause Final Update Refs 6.435ms [2025-11-28T04:53:55.346Z] Allocated: 733 Mb [2025-11-28T04:53:55.346Z] [1.070s][info][gc] GC(2) Concurrent cleanup (Young) 910M->910M(1024M) 0.023ms [2025-11-28T04:53:55.346Z] [1.092s][info][gc] GC(2) Concurrent reset after collect (Young) 21.759ms [2025-11-28T04:53:55.346Z] [1.092s][info][gc] Trigger (Young): Free (14080K) is below minimum threshold (102M) [2025-11-28T04:53:55.346Z] [1.092s][info][gc] GC(3) Concurrent reset (Young) 0.478ms [2025-11-28T04:53:55.346Z] [1.131s][info][gc] GC(3) Verify Before Mark, Level 4 (10950 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.131s][info][gc] GC(3) Pause Init Mark (Young) 13.947ms [2025-11-28T04:53:55.346Z] [1.132s][info][gc] GC(3) Concurrent remembered set scanning 1.401ms [2025-11-28T04:53:55.346Z] [1.133s][info][gc] GC(3) Concurrent marking roots 0.226ms [2025-11-28T04:53:55.346Z] Allocated: 725 Mb [2025-11-28T04:53:55.346Z] [1.133s][info][gc] Failed to allocate Shared, 26684K [2025-11-28T04:53:55.346Z] [1.133s][info][gc] GC(3) Concurrent marking (Young) 0.291ms [2025-11-28T04:53:55.346Z] [1.133s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.346Z] [1.140s][info][gc] GC(4) Verify Before Full GC, Level 4 (34374 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.140s][info][gc] GC(4) Cancel marking: Young [2025-11-28T04:53:55.346Z] [1.140s][info][gc] GC(4) Cancel marking: Old [2025-11-28T04:53:55.346Z] [1.140s][info][gc] GC(4) Cancel marking: Global [2025-11-28T04:53:55.346Z] [1.399s][info][gc] GC(4) Verify After Full GC, Level 4 (34239 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.399s][info][gc] GC(4) Pause Full 959M->675M(1024M) 265.704ms [2025-11-28T04:53:55.346Z] [1.400s][info][gc] Trigger (Young): Learning 4 of 5. Free (269M) is below initial threshold (716M) [2025-11-28T04:53:55.346Z] [1.401s][info][gc] GC(5) Concurrent reset (Young) 0.512ms [2025-11-28T04:53:55.346Z] [1.409s][info][gc] GC(5) Verify Before Mark, Level 4 (25 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.409s][info][gc] GC(5) Pause Init Mark (Young) 3.909ms [2025-11-28T04:53:55.346Z] Allocated: 695 Mb [2025-11-28T04:53:55.346Z] [1.413s][info][gc] GC(5) Concurrent remembered set scanning 0.237ms [2025-11-28T04:53:55.346Z] [1.413s][info][gc] GC(5) Concurrent marking roots 0.267ms [2025-11-28T04:53:55.346Z] [1.414s][info][gc] GC(5) Concurrent marking (Young) 0.963ms [2025-11-28T04:53:55.346Z] [1.418s][info][gc] GC(5) Verify After Mark, Level 4 (27 reachable, 6 marked) [2025-11-28T04:53:55.346Z] [1.418s][info][gc] GC(5) Pause Final Mark (Young) 4.006ms [2025-11-28T04:53:55.346Z] Allocated: 715 Mb [2025-11-28T04:53:55.346Z] [1.418s][info][gc] GC(5) Concurrent weak references (Young) 0.020ms [2025-11-28T04:53:55.346Z] [1.418s][info][gc] GC(5) Concurrent weak roots (Young) 0.071ms [2025-11-28T04:53:55.346Z] [1.418s][info][gc] GC(5) Concurrent cleanup (Young) 722M->722M(1024M) 0.021ms [2025-11-28T04:53:55.346Z] [1.419s][info][gc] GC(5) Concurrent Final Roots (Young) 0.057ms [2025-11-28T04:53:55.346Z] Allocated: 694 Mb [2025-11-28T04:53:55.346Z] [1.427s][info][gc] GC(5) Concurrent reset after collect (Young) 8.488ms [2025-11-28T04:53:55.346Z] [1.429s][info][gc] Trigger (Young): Learning 5 of 5. Free (191M) is below initial threshold (716M) [2025-11-28T04:53:55.346Z] [1.429s][info][gc] GC(6) Concurrent reset (Young) 0.499ms [2025-11-28T04:53:55.346Z] [1.439s][info][gc] GC(6) Verify Before Mark, Level 4 (27 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.439s][info][gc] GC(6) Pause Init Mark (Young) 3.944ms [2025-11-28T04:53:55.346Z] Allocated: 736 Mb [2025-11-28T04:53:55.346Z] [1.439s][info][gc] GC(6) Concurrent remembered set scanning 0.246ms [2025-11-28T04:53:55.346Z] [1.440s][info][gc] GC(6) Concurrent marking roots 0.172ms [2025-11-28T04:53:55.346Z] [1.441s][info][gc] GC(6) Concurrent marking (Young) 1.639ms [2025-11-28T04:53:55.346Z] [1.445s][info][gc] GC(6) Verify Before Evacuation, Level 4 (27 reachable, 10 marked) [2025-11-28T04:53:55.346Z] [1.445s][info][gc] GC(6) Pause Final Mark (Young) 3.839ms [2025-11-28T04:53:55.346Z] Allocated: 662 Mb [2025-11-28T04:53:55.346Z] [1.445s][info][gc] GC(6) Concurrent thread roots 0.062ms [2025-11-28T04:53:55.346Z] [1.446s][info][gc] GC(6) Concurrent weak references (Young) 0.015ms [2025-11-28T04:53:55.346Z] [1.446s][info][gc] GC(6) Concurrent weak roots (Young) 0.065ms [2025-11-28T04:53:55.346Z] [1.446s][info][gc] GC(6) Concurrent cleanup (Young) 750M->750M(1024M) 0.023ms [2025-11-28T04:53:55.346Z] [1.446s][info][gc] GC(6) Concurrent strong roots 0.138ms [2025-11-28T04:53:55.346Z] [1.446s][info][gc] GC(6) Concurrent evacuation 0.196ms [2025-11-28T04:53:55.346Z] [1.446s][info][gc] GC(6) Concurrent Init Update Refs (Young) 0.034ms [2025-11-28T04:53:55.346Z] [1.449s][info][gc] GC(6) Verify Before Updating References, Level 4 (28 reachable, 26 marked) [2025-11-28T04:53:55.346Z] [1.449s][info][gc] GC(6) Pause Init Update Refs 3.033ms [2025-11-28T04:53:55.346Z] [1.456s][info][gc] GC(6) Concurrent update references 3.493ms [2025-11-28T04:53:55.346Z] Allocated: 702 Mb [2025-11-28T04:53:55.346Z] [1.460s][info][gc] GC(6) Concurrent update thread roots 4.297ms [2025-11-28T04:53:55.346Z] [1.469s][info][gc] GC(6) Verify After Updating References, Level 4 (5 reachable, 41 marked) [2025-11-28T04:53:55.346Z] [1.469s][info][gc] GC(6) Pause Final Update Refs 4.350ms [2025-11-28T04:53:55.346Z] Allocated: 700 Mb [2025-11-28T04:53:55.346Z] [1.470s][info][gc] GC(6) Concurrent cleanup (Young) 826M->826M(1024M) 0.028ms [2025-11-28T04:53:55.346Z] Allocated: 713 Mb [2025-11-28T04:53:55.346Z] Allocated: 677 Mb [2025-11-28T04:53:55.346Z] [1.479s][info][gc] GC(6) Concurrent reset after collect (Young) 8.635ms [2025-11-28T04:53:55.346Z] [1.480s][info][gc] Trigger (Young): Free (95744K) is below minimum threshold (102M) [2025-11-28T04:53:55.346Z] [1.480s][info][gc] GC(7) Concurrent reset (Young) 0.454ms [2025-11-28T04:53:55.346Z] [1.492s][info][gc] GC(7) Verify Before Mark, Level 4 (27 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.492s][info][gc] GC(7) Pause Init Mark (Young) 4.017ms [2025-11-28T04:53:55.346Z] Allocated: 723 Mb [2025-11-28T04:53:55.346Z] [1.492s][info][gc] GC(7) Concurrent remembered set scanning 0.175ms [2025-11-28T04:53:55.346Z] [1.492s][info][gc] GC(7) Concurrent marking roots 0.209ms [2025-11-28T04:53:55.346Z] Allocated: 703 Mb [2025-11-28T04:53:55.346Z] [1.499s][info][gc] GC(7) Concurrent marking (Young) 7.024ms [2025-11-28T04:53:55.346Z] [1.512s][info][gc] GC(7) Verify Before Evacuation, Level 4 (29 reachable, 11 marked) [2025-11-28T04:53:55.346Z] [1.513s][info][gc] GC(7) Pause Final Mark (Young) 5.580ms [2025-11-28T04:53:55.346Z] [1.513s][info][gc] GC(7) Concurrent thread roots 0.095ms [2025-11-28T04:53:55.346Z] Allocated: 708 Mb [2025-11-28T04:53:55.346Z] [1.513s][info][gc] GC(7) Concurrent weak references (Young) 0.224ms [2025-11-28T04:53:55.346Z] [1.513s][info][gc] GC(7) Concurrent weak roots (Young) 0.164ms [2025-11-28T04:53:55.346Z] [1.513s][info][gc] GC(7) Concurrent cleanup (Young) 801M->801M(1024M) 0.056ms [2025-11-28T04:53:55.346Z] [1.514s][info][gc] GC(7) Concurrent strong roots 0.437ms [2025-11-28T04:53:55.346Z] [1.514s][info][gc] GC(7) Concurrent evacuation 0.115ms [2025-11-28T04:53:55.346Z] Allocated: 689 Mb [2025-11-28T04:53:55.346Z] [1.516s][info][gc] GC(7) Concurrent Init Update Refs (Young) 2.149ms [2025-11-28T04:53:55.346Z] [1.524s][info][gc] GC(7) Verify Before Updating References, Level 4 (32 reachable, 26 marked) [2025-11-28T04:53:55.346Z] [1.524s][info][gc] GC(7) Pause Init Update Refs 3.736ms [2025-11-28T04:53:55.346Z] Allocated: 714 Mb [2025-11-28T04:53:55.346Z] Allocated: 657 Mb [2025-11-28T04:53:55.346Z] [1.528s][info][gc] GC(7) Concurrent update references 3.854ms [2025-11-28T04:53:55.346Z] [1.529s][info][gc] GC(7) Concurrent update thread roots 1.021ms [2025-11-28T04:53:55.346Z] [1.543s][info][gc] GC(7) Verify After Updating References, Level 4 (33 reachable, 30 marked) [2025-11-28T04:53:55.346Z] [1.543s][info][gc] GC(7) Pause Final Update Refs 4.240ms [2025-11-28T04:53:55.346Z] [1.543s][info][gc] GC(7) Concurrent cleanup (Young) 899M->899M(1024M) 0.020ms [2025-11-28T04:53:55.346Z] Allocated: 716 Mb [2025-11-28T04:53:55.346Z] [1.547s][info][gc] Failed to allocate Shared, 52515K [2025-11-28T04:53:55.346Z] [1.547s][info][gc] GC(7) Concurrent reset after collect (Young) 4.549ms [2025-11-28T04:53:55.346Z] [1.548s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.346Z] [1.556s][info][gc] GC(8) Verify Before Full GC, Level 4 (34346 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.770s][info][gc] GC(8) Verify After Full GC, Level 4 (34242 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.770s][info][gc] GC(8) Pause Full 899M->668M(1024M) 222.608ms [2025-11-28T04:53:55.346Z] [1.771s][info][gc] Trigger (Young): Average GC time (186.00 ms) is above the time for average allocation rate (1270 MB/s) to deplete free headroom (200M) (margin of error = 1.80) [2025-11-28T04:53:55.346Z] [1.772s][info][gc] GC(9) Concurrent reset (Young) 0.480ms [2025-11-28T04:53:55.346Z] [1.784s][info][gc] GC(9) Verify Before Mark, Level 4 (28 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.785s][info][gc] GC(9) Pause Init Mark (Young) 4.007ms [2025-11-28T04:53:55.346Z] Allocated: 712 Mb [2025-11-28T04:53:55.346Z] [1.785s][info][gc] GC(9) Concurrent remembered set scanning 0.201ms [2025-11-28T04:53:55.346Z] [1.785s][info][gc] GC(9) Concurrent marking roots 0.190ms [2025-11-28T04:53:55.346Z] [1.787s][info][gc] GC(9) Concurrent marking (Young) 1.634ms [2025-11-28T04:53:55.346Z] [1.791s][info][gc] GC(9) Verify After Mark, Level 4 (29 reachable, 10 marked) [2025-11-28T04:53:55.346Z] [1.791s][info][gc] GC(9) Pause Final Mark (Young) 3.641ms [2025-11-28T04:53:55.346Z] Allocated: 660 Mb [2025-11-28T04:53:55.346Z] [1.791s][info][gc] GC(9) Concurrent weak references (Young) 0.013ms [2025-11-28T04:53:55.346Z] [1.791s][info][gc] GC(9) Concurrent weak roots (Young) 0.070ms [2025-11-28T04:53:55.346Z] [1.791s][info][gc] GC(9) Concurrent cleanup (Young) 726M->726M(1024M) 0.018ms [2025-11-28T04:53:55.346Z] [1.791s][info][gc] GC(9) Concurrent Final Roots (Young) 0.054ms [2025-11-28T04:53:55.346Z] Allocated: 675 Mb [2025-11-28T04:53:55.346Z] [1.800s][info][gc] GC(9) Concurrent reset after collect (Young) 8.514ms [2025-11-28T04:53:55.346Z] Allocated: 684 Mb [2025-11-28T04:53:55.346Z] [1.800s][info][gc] Trigger (Young): Average GC time (141.93 ms) is above the time for average allocation rate (1270 MB/s) to deplete free headroom (141M) (margin of error = 1.80) [2025-11-28T04:53:55.346Z] [1.801s][info][gc] GC(10) Concurrent reset (Young) 0.446ms [2025-11-28T04:53:55.346Z] [1.810s][info][gc] GC(10) Verify Before Mark, Level 4 (31 reachable, 0 marked) [2025-11-28T04:53:55.346Z] [1.810s][info][gc] GC(10) Pause Init Mark (Young) 3.848ms [2025-11-28T04:53:55.346Z] Allocated: 713 Mb [2025-11-28T04:53:55.346Z] [1.811s][info][gc] GC(10) Concurrent remembered set scanning 0.200ms [2025-11-28T04:53:55.346Z] [1.811s][info][gc] GC(10) Concurrent marking roots 0.172ms [2025-11-28T04:53:55.347Z] [1.811s][info][gc] GC(10) Concurrent marking (Young) 0.207ms [2025-11-28T04:53:55.347Z] [1.815s][info][gc] GC(10) Verify Before Evacuation, Level 4 (32 reachable, 5 marked) [2025-11-28T04:53:55.347Z] [1.815s][info][gc] GC(10) Pause Final Mark (Young) 4.334ms [2025-11-28T04:53:55.347Z] [1.817s][info][gc] GC(10) Concurrent thread roots 1.132ms [2025-11-28T04:53:55.347Z] [1.817s][info][gc] GC(10) Concurrent weak references (Young) 0.015ms [2025-11-28T04:53:55.347Z] [1.817s][info][gc] GC(10) Concurrent weak roots (Young) 0.740ms [2025-11-28T04:53:55.347Z] [1.818s][info][gc] GC(10) Concurrent cleanup (Young) 731M->731M(1024M) 0.029ms [2025-11-28T04:53:55.347Z] [1.818s][info][gc] GC(10) Concurrent strong roots 0.171ms [2025-11-28T04:53:55.347Z] [1.818s][info][gc] GC(10) Concurrent evacuation 0.124ms [2025-11-28T04:53:55.347Z] [1.818s][info][gc] GC(10) Concurrent Init Update Refs (Young) 0.125ms [2025-11-28T04:53:55.347Z] [1.821s][info][gc] GC(10) Verify Before Updating References, Level 4 (6 reachable, 49 marked) [2025-11-28T04:53:55.347Z] [1.821s][info][gc] GC(10) Pause Init Update Refs 3.101ms [2025-11-28T04:53:55.347Z] Allocated: 675 Mb [2025-11-28T04:53:55.347Z] [1.825s][info][gc] GC(10) Concurrent update references 3.329ms [2025-11-28T04:53:55.347Z] Allocated: 729 Mb [2025-11-28T04:53:55.347Z] [1.834s][info][gc] GC(10) Concurrent update thread roots 9.545ms [2025-11-28T04:53:55.347Z] [1.848s][info][gc] GC(10) Verify After Updating References, Level 4 (5 reachable, 46 marked) [2025-11-28T04:53:55.347Z] [1.848s][info][gc] GC(10) Pause Final Update Refs 4.226ms [2025-11-28T04:53:55.347Z] [1.848s][info][gc] GC(10) Concurrent cleanup (Young) 835M->835M(1024M) 0.017ms [2025-11-28T04:53:55.347Z] Allocated: 749 Mb [2025-11-28T04:53:55.347Z] Allocated: 692 Mb [2025-11-28T04:53:55.347Z] [1.858s][info][gc] GC(10) Concurrent reset after collect (Young) 9.421ms [2025-11-28T04:53:55.347Z] [1.859s][info][gc] Trigger (Young): Average GC time (118.18 ms) is above the time for average allocation rate (1695 MB/s) to deplete free headroom (53043K) (margin of error = 1.81) [2025-11-28T04:53:55.347Z] [1.859s][info][gc] GC(11) Concurrent reset (Young) 0.457ms [2025-11-28T04:53:55.347Z] [1.863s][info][gc] GC(11) Verify Before Mark, Level 4 (29 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [1.864s][info][gc] GC(11) Pause Init Mark (Young) 3.755ms [2025-11-28T04:53:55.347Z] Allocated: 717 Mb [2025-11-28T04:53:55.347Z] [1.864s][info][gc] Failed to allocate Shared, 60508K [2025-11-28T04:53:55.347Z] [1.864s][info][gc] GC(11) Concurrent remembered set scanning 0.193ms [2025-11-28T04:53:55.347Z] [1.864s][info][gc] GC(11) Concurrent marking roots 0.175ms [2025-11-28T04:53:55.347Z] [1.864s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.347Z] [1.872s][info][gc] GC(12) Verify Before Full GC, Level 4 (34348 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [1.872s][info][gc] GC(12) Cancel marking: Young [2025-11-28T04:53:55.347Z] [1.872s][info][gc] GC(12) Cancel marking: Old [2025-11-28T04:53:55.347Z] [1.872s][info][gc] GC(12) Cancel marking: Global [2025-11-28T04:53:55.347Z] [2.041s][info][gc] GC(12) Verify After Full GC, Level 4 (34244 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.041s][info][gc] GC(12) Pause Full 869M->681M(1024M) 176.980ms [2025-11-28T04:53:55.347Z] Allocated: 731 Mb [2025-11-28T04:53:55.347Z] Allocated: 712 Mb [2025-11-28T04:53:55.347Z] Allocated: 697 Mb [2025-11-28T04:53:55.347Z] [2.068s][info][gc] Trigger (Young): Average GC time (118.18 ms) is above the time for average allocation rate (776 MB/s) to deplete free headroom (62003K) (margin of error = 1.81) [2025-11-28T04:53:55.347Z] [2.068s][info][gc] GC(13) Concurrent reset (Young) 0.512ms [2025-11-28T04:53:55.347Z] [2.079s][info][gc] GC(13) Verify Before Mark, Level 4 (29 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.079s][info][gc] GC(13) Pause Init Mark (Young) 3.939ms [2025-11-28T04:53:55.347Z] Allocated: 735 Mb [2025-11-28T04:53:55.347Z] [2.079s][info][gc] GC(13) Concurrent remembered set scanning 0.213ms [2025-11-28T04:53:55.347Z] [2.079s][info][gc] GC(13) Concurrent marking roots 0.198ms [2025-11-28T04:53:55.347Z] [2.080s][info][gc] GC(13) Concurrent marking (Young) 0.211ms [2025-11-28T04:53:55.347Z] [2.084s][info][gc] GC(13) Verify Before Evacuation, Level 4 (30 reachable, 5 marked) [2025-11-28T04:53:55.347Z] [2.084s][info][gc] GC(13) Pause Final Mark (Young) 4.218ms [2025-11-28T04:53:55.347Z] [2.087s][info][gc] GC(13) Concurrent thread roots 0.078ms [2025-11-28T04:53:55.347Z] [2.087s][info][gc] GC(13) Concurrent weak references (Young) 0.016ms [2025-11-28T04:53:55.347Z] Allocated: 724 Mb [2025-11-28T04:53:55.347Z] [2.096s][info][gc] GC(13) Concurrent weak roots (Young) 8.602ms [2025-11-28T04:53:55.347Z] [2.096s][info][gc] GC(13) Concurrent cleanup (Young) 843M->843M(1024M) 0.102ms [2025-11-28T04:53:55.347Z] [2.096s][info][gc] GC(13) Concurrent strong roots 0.213ms [2025-11-28T04:53:55.347Z] [2.097s][info][gc] GC(13) Concurrent evacuation 0.208ms [2025-11-28T04:53:55.347Z] Allocated: 681 Mb [2025-11-28T04:53:55.347Z] [2.104s][info][gc] GC(13) Concurrent Init Update Refs (Young) 7.541ms [2025-11-28T04:53:55.347Z] [2.115s][info][gc] GC(13) Verify Before Updating References, Level 4 (27 reachable, 28 marked) [2025-11-28T04:53:55.347Z] [2.115s][info][gc] GC(13) Pause Init Update Refs 4.078ms [2025-11-28T04:53:55.347Z] Allocated: 717 Mb [2025-11-28T04:53:55.347Z] [2.116s][info][gc] Failed to allocate Shared, 59298K [2025-11-28T04:53:55.347Z] [2.116s][info][gc] GC(13) Concurrent update references 1.156ms [2025-11-28T04:53:55.347Z] [2.116s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.347Z] [2.124s][info][gc] GC(14) Verify Before Full GC, Level 4 (34345 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.339s][info][gc] GC(14) Verify After Full GC, Level 4 (34241 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.339s][info][gc] GC(14) Pause Full 880M->695M(1024M) 223.049ms [2025-11-28T04:53:55.347Z] [2.341s][info][gc] Trigger (Young): Average GC time (118.18 ms) is above the time for average allocation rate (1567 MB/s) to deplete free headroom (167M) (margin of error = 1.81) [2025-11-28T04:53:55.347Z] [2.341s][info][gc] GC(15) Concurrent reset (Young) 0.507ms [2025-11-28T04:53:55.347Z] [2.356s][info][gc] GC(15) Verify Before Mark, Level 4 (26 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.356s][info][gc] GC(15) Pause Init Mark (Young) 3.992ms [2025-11-28T04:53:55.347Z] Allocated: 744 Mb [2025-11-28T04:53:55.347Z] [2.356s][info][gc] GC(15) Concurrent remembered set scanning 0.195ms [2025-11-28T04:53:55.347Z] [2.357s][info][gc] GC(15) Concurrent marking roots 0.176ms [2025-11-28T04:53:55.347Z] Allocated: 704 Mb [2025-11-28T04:53:55.347Z] Allocated: 725 Mb [2025-11-28T04:53:55.347Z] [2.374s][info][gc] GC(15) Concurrent marking (Young) 17.735ms [2025-11-28T04:53:55.347Z] [2.387s][info][gc] GC(15) Verify After Mark, Level 4 (25 reachable, 18 marked) [2025-11-28T04:53:55.347Z] [2.387s][info][gc] GC(15) Pause Final Mark (Young) 4.864ms [2025-11-28T04:53:55.347Z] [2.387s][info][gc] GC(15) Concurrent weak references (Young) 0.016ms [2025-11-28T04:53:55.347Z] Allocated: 700 Mb [2025-11-28T04:53:55.347Z] [2.387s][info][gc] GC(15) Concurrent weak roots (Young) 0.378ms [2025-11-28T04:53:55.347Z] [2.387s][info][gc] GC(15) Concurrent cleanup (Young) 881M->881M(1024M) 0.035ms [2025-11-28T04:53:55.347Z] Allocated: 655 Mb [2025-11-28T04:53:55.347Z] [2.390s][info][gc] GC(15) Concurrent Final Roots (Young) 2.704ms [2025-11-28T04:53:55.347Z] [2.398s][info][gc] GC(15) Concurrent reset after collect (Young) 7.663ms [2025-11-28T04:53:55.347Z] [2.398s][info][gc] Trigger (Young): Free (47871K) is below minimum threshold (102M) [2025-11-28T04:53:55.347Z] [2.399s][info][gc] GC(16) Concurrent reset (Young) 0.465ms [2025-11-28T04:53:55.347Z] [2.405s][info][gc] GC(16) Verify Before Mark, Level 4 (26 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.405s][info][gc] GC(16) Pause Init Mark (Young) 3.967ms [2025-11-28T04:53:55.347Z] Allocated: 685 Mb [2025-11-28T04:53:55.347Z] [2.406s][info][gc] GC(16) Concurrent remembered set scanning 0.216ms [2025-11-28T04:53:55.347Z] [2.406s][info][gc] GC(16) Concurrent marking roots 0.195ms [2025-11-28T04:53:55.347Z] [2.406s][info][gc] GC(16) Concurrent marking (Young) 0.117ms [2025-11-28T04:53:55.347Z] [2.411s][info][gc] GC(16) Verify After Mark, Level 4 (27 reachable, 5 marked) [2025-11-28T04:53:55.347Z] [2.411s][info][gc] GC(16) Pause Final Mark (Young) 4.584ms [2025-11-28T04:53:55.347Z] [2.411s][info][gc] GC(16) Concurrent weak references (Young) 0.013ms [2025-11-28T04:53:55.347Z] [2.411s][info][gc] GC(16) Concurrent weak roots (Young) 0.583ms [2025-11-28T04:53:55.347Z] [2.413s][info][gc] GC(16) Concurrent cleanup (Young) 735M->735M(1024M) 0.111ms [2025-11-28T04:53:55.347Z] Allocated: 726 Mb [2025-11-28T04:53:55.347Z] [2.419s][info][gc] GC(16) Concurrent Final Roots (Young) 5.711ms [2025-11-28T04:53:55.347Z] Allocated: 677 Mb [2025-11-28T04:53:55.347Z] Allocated: 694 Mb [2025-11-28T04:53:55.347Z] [2.432s][info][gc] GC(16) Concurrent reset after collect (Young) 12.827ms [2025-11-28T04:53:55.347Z] [2.433s][info][gc] Trigger (Young): Average GC time (82.57 ms) is above the time for average allocation rate (2313 MB/s) to deplete free headroom (99123K) (margin of error = 1.82) [2025-11-28T04:53:55.347Z] [2.436s][info][gc] GC(17) Concurrent reset (Young) 0.835ms [2025-11-28T04:53:55.347Z] [2.442s][info][gc] GC(17) Verify Before Mark, Level 4 (28 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.442s][info][gc] GC(17) Pause Init Mark (Young) 3.907ms [2025-11-28T04:53:55.347Z] Allocated: 758 Mb [2025-11-28T04:53:55.347Z] [2.443s][info][gc] GC(17) Concurrent remembered set scanning 0.232ms [2025-11-28T04:53:55.347Z] [2.444s][info][gc] GC(17) Concurrent marking roots 0.668ms [2025-11-28T04:53:55.347Z] Allocated: 724 Mb [2025-11-28T04:53:55.347Z] Allocated: 710 Mb [2025-11-28T04:53:55.347Z] [2.455s][info][gc] GC(17) Concurrent marking (Young) 10.842ms [2025-11-28T04:53:55.347Z] [2.463s][info][gc] GC(17) Verify After Mark, Level 4 (25 reachable, 20 marked) [2025-11-28T04:53:55.347Z] [2.463s][info][gc] GC(17) Pause Final Mark (Young) 6.307ms [2025-11-28T04:53:55.347Z] Allocated: 674 Mb [2025-11-28T04:53:55.347Z] [2.463s][info][gc] GC(17) Concurrent weak references (Young) 0.086ms [2025-11-28T04:53:55.347Z] Allocated: 717 Mb [2025-11-28T04:53:55.347Z] [2.471s][info][gc] Failed to allocate Shared, 54018K [2025-11-28T04:53:55.347Z] [2.472s][info][gc] GC(17) Concurrent weak roots (Young) 7.999ms [2025-11-28T04:53:55.347Z] [2.472s][info][gc] GC(17) Concurrent cleanup (Young) 872M->872M(1024M) 0.080ms [2025-11-28T04:53:55.347Z] [2.472s][info][gc] GC(17) Concurrent Final Roots (Young) 0.107ms [2025-11-28T04:53:55.347Z] [2.476s][info][gc] GC(17) Concurrent reset after collect (Young) 4.531ms [2025-11-28T04:53:55.347Z] [2.477s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.347Z] [2.485s][info][gc] GC(18) Verify Before Full GC, Level 4 (34345 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.676s][info][gc] GC(18) Verify After Full GC, Level 4 (34241 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.676s][info][gc] GC(18) Pause Full 872M->661M(1024M) 198.861ms [2025-11-28T04:53:55.347Z] Allocated: 706 Mb [2025-11-28T04:53:55.347Z] Allocated: 682 Mb [2025-11-28T04:53:55.347Z] Allocated: 703 Mb [2025-11-28T04:53:55.347Z] Allocated: 680 Mb [2025-11-28T04:53:55.347Z] Allocated: 726 Mb [2025-11-28T04:53:55.347Z] [2.706s][info][gc] Trigger (Young): Average GC time (69.88 ms) is above the time for average allocation rate (1436 MB/s) to deplete free headroom (88115K) (margin of error = 1.82) [2025-11-28T04:53:55.347Z] [2.707s][info][gc] GC(19) Concurrent reset (Young) 0.810ms [2025-11-28T04:53:55.347Z] [2.714s][info][gc] GC(19) Verify Before Mark, Level 4 (28 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.714s][info][gc] GC(19) Pause Init Mark (Young) 4.012ms [2025-11-28T04:53:55.347Z] [2.714s][info][gc] GC(19) Concurrent remembered set scanning 0.187ms [2025-11-28T04:53:55.347Z] Allocated: 709 Mb [2025-11-28T04:53:55.347Z] [2.715s][info][gc] GC(19) Concurrent marking roots 0.395ms [2025-11-28T04:53:55.347Z] [2.722s][info][gc] GC(19) Concurrent marking (Young) 7.080ms [2025-11-28T04:53:55.347Z] [2.729s][info][gc] GC(19) Verify After Mark, Level 4 (29 reachable, 10 marked) [2025-11-28T04:53:55.347Z] [2.729s][info][gc] GC(19) Pause Final Mark (Young) 7.495ms [2025-11-28T04:53:55.347Z] Allocated: 721 Mb [2025-11-28T04:53:55.347Z] [2.730s][info][gc] GC(19) Concurrent weak references (Young) 0.023ms [2025-11-28T04:53:55.347Z] Allocated: 725 Mb [2025-11-28T04:53:55.347Z] [2.737s][info][gc] GC(19) Concurrent weak roots (Young) 7.043ms [2025-11-28T04:53:55.347Z] [2.737s][info][gc] GC(19) Concurrent cleanup (Young) 848M->848M(1024M) 0.126ms [2025-11-28T04:53:55.347Z] Allocated: 733 Mb [2025-11-28T04:53:55.347Z] [2.750s][info][gc] GC(19) Concurrent Final Roots (Young) 13.004ms [2025-11-28T04:53:55.347Z] Allocated: 747 Mb [2025-11-28T04:53:55.347Z] [2.763s][info][gc] GC(19) Concurrent reset after collect (Young) 13.453ms [2025-11-28T04:53:55.347Z] [2.764s][info][gc] Trigger (Young): Free (57855K) is below minimum threshold (102M) [2025-11-28T04:53:55.347Z] Allocated: 663 Mb [2025-11-28T04:53:55.347Z] [2.764s][info][gc] Failed to allocate Shared, 58945K [2025-11-28T04:53:55.347Z] [2.765s][info][gc] GC(20) Concurrent reset (Young) 0.498ms [2025-11-28T04:53:55.347Z] [2.768s][info][gc] GC(20) Verify Before Mark, Level 4 (26 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.769s][info][gc] GC(20) Pause Init Mark (Young) 3.852ms [2025-11-28T04:53:55.347Z] [2.769s][info][gc] GC(20) Concurrent remembered set scanning 0.171ms [2025-11-28T04:53:55.347Z] [2.769s][info][gc] GC(20) Concurrent marking roots 0.199ms [2025-11-28T04:53:55.347Z] [2.769s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.347Z] [2.776s][info][gc] GC(21) Verify Before Full GC, Level 4 (34345 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.776s][info][gc] GC(21) Cancel marking: Young [2025-11-28T04:53:55.347Z] [2.776s][info][gc] GC(21) Cancel marking: Old [2025-11-28T04:53:55.347Z] [2.776s][info][gc] GC(21) Cancel marking: Global [2025-11-28T04:53:55.347Z] [2.997s][info][gc] GC(21) Verify After Full GC, Level 4 (34241 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [2.997s][info][gc] GC(21) Pause Full 915M->670M(1024M) 227.795ms [2025-11-28T04:53:55.347Z] Allocated: 721 Mb [2025-11-28T04:53:55.347Z] Allocated: 740 Mb [2025-11-28T04:53:55.347Z] Allocated: 666 Mb [2025-11-28T04:53:55.347Z] Allocated: 676 Mb [2025-11-28T04:53:55.347Z] Allocated: 690 Mb [2025-11-28T04:53:55.347Z] [3.028s][info][gc] Trigger (Young): Average GC time (73.42 ms) is above the time for average allocation rate (969 MB/s) to deplete free headroom (59443K) (margin of error = 1.82) [2025-11-28T04:53:55.347Z] [3.028s][info][gc] GC(22) Concurrent reset (Young) 0.524ms [2025-11-28T04:53:55.347Z] [3.038s][info][gc] GC(22) Verify Before Mark, Level 4 (26 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [3.038s][info][gc] GC(22) Pause Init Mark (Young) 4.070ms [2025-11-28T04:53:55.347Z] Allocated: 716 Mb [2025-11-28T04:53:55.347Z] [3.040s][info][gc] GC(22) Concurrent remembered set scanning 0.248ms [2025-11-28T04:53:55.347Z] [3.040s][info][gc] GC(22) Concurrent marking roots 0.211ms [2025-11-28T04:53:55.347Z] Allocated: 695 Mb [2025-11-28T04:53:55.347Z] [3.048s][info][gc] GC(22) Concurrent marking (Young) 7.674ms [2025-11-28T04:53:55.347Z] [3.052s][info][gc] GC(22) Verify After Mark, Level 4 (27 reachable, 9 marked) [2025-11-28T04:53:55.347Z] [3.052s][info][gc] GC(22) Pause Final Mark (Young) 4.843ms [2025-11-28T04:53:55.347Z] [3.056s][info][gc] GC(22) Concurrent weak references (Young) 0.023ms [2025-11-28T04:53:55.347Z] [3.057s][info][gc] GC(22) Concurrent weak roots (Young) 0.418ms [2025-11-28T04:53:55.347Z] [3.057s][info][gc] GC(22) Concurrent cleanup (Young) 724M->724M(1024M) 0.079ms [2025-11-28T04:53:55.347Z] [3.057s][info][gc] GC(22) Concurrent Final Roots (Young) 0.170ms [2025-11-28T04:53:55.347Z] Allocated: 717 Mb [2025-11-28T04:53:55.347Z] [3.064s][info][gc] GC(22) Concurrent reset after collect (Young) 6.203ms [2025-11-28T04:53:55.347Z] [3.065s][info][gc] Trigger (Young): Average GC time (63.80 ms) is above the time for average allocation rate (2778 MB/s) to deplete free headroom (170M) (margin of error = 1.81) [2025-11-28T04:53:55.347Z] [3.065s][info][gc] GC(23) Concurrent reset (Young) 0.474ms [2025-11-28T04:53:55.347Z] [3.071s][info][gc] GC(23) Verify Before Mark, Level 4 (27 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [3.071s][info][gc] GC(23) Pause Init Mark (Young) 3.809ms [2025-11-28T04:53:55.347Z] Allocated: 707 Mb [2025-11-28T04:53:55.347Z] [3.072s][info][gc] GC(23) Concurrent remembered set scanning 0.198ms [2025-11-28T04:53:55.347Z] [3.072s][info][gc] GC(23) Concurrent marking roots 0.196ms [2025-11-28T04:53:55.347Z] [3.072s][info][gc] GC(23) Concurrent marking (Young) 0.218ms [2025-11-28T04:53:55.347Z] [3.076s][info][gc] GC(23) Verify Before Evacuation, Level 4 (28 reachable, 5 marked) [2025-11-28T04:53:55.347Z] [3.076s][info][gc] GC(23) Pause Final Mark (Young) 3.364ms [2025-11-28T04:53:55.347Z] [3.077s][info][gc] GC(23) Concurrent thread roots 0.068ms [2025-11-28T04:53:55.347Z] [3.077s][info][gc] GC(23) Concurrent weak references (Young) 0.014ms [2025-11-28T04:53:55.347Z] Allocated: 698 Mb [2025-11-28T04:53:55.347Z] [3.081s][info][gc] GC(23) Concurrent weak roots (Young) 4.294ms [2025-11-28T04:53:55.347Z] [3.081s][info][gc] GC(23) Concurrent cleanup (Young) 791M->791M(1024M) 0.036ms [2025-11-28T04:53:55.347Z] [3.082s][info][gc] GC(23) Concurrent strong roots 0.142ms [2025-11-28T04:53:55.347Z] [3.082s][info][gc] GC(23) Concurrent evacuation 0.075ms [2025-11-28T04:53:55.347Z] [3.091s][info][gc] GC(23) Concurrent Init Update Refs (Young) 9.705ms [2025-11-28T04:53:55.347Z] [3.095s][info][gc] GC(23) Verify Before Updating References, Level 4 (29 reachable, 17 marked) [2025-11-28T04:53:55.347Z] [3.095s][info][gc] GC(23) Pause Init Update Refs 3.760ms [2025-11-28T04:53:55.347Z] Allocated: 751 Mb [2025-11-28T04:53:55.347Z] [3.097s][info][gc] Failed to allocate Shared, 62450K [2025-11-28T04:53:55.347Z] [3.097s][info][gc] GC(23) Concurrent update references 1.127ms [2025-11-28T04:53:55.347Z] [3.097s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.347Z] [3.104s][info][gc] GC(24) Verify Before Full GC, Level 4 (34346 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [3.307s][info][gc] GC(24) Verify After Full GC, Level 4 (34242 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [3.307s][info][gc] GC(24) Pause Full 791M->693M(1024M) 210.497ms [2025-11-28T04:53:55.347Z] Allocated: 748 Mb [2025-11-28T04:53:55.347Z] Allocated: 727 Mb [2025-11-28T04:53:55.347Z] Allocated: 711 Mb [2025-11-28T04:53:55.347Z] Allocated: 689 Mb [2025-11-28T04:53:55.347Z] Allocated: 691 Mb [2025-11-28T04:53:55.347Z] [3.332s][info][gc] Trigger (Young): Average GC time (63.80 ms) is above the time for average allocation rate (1309 MB/s) to deplete free headroom (53299K) (margin of error = 1.81) [2025-11-28T04:53:55.347Z] [3.332s][info][gc] GC(25) Concurrent reset (Young) 0.511ms [2025-11-28T04:53:55.347Z] [3.345s][info][gc] GC(25) Verify Before Mark, Level 4 (27 reachable, 0 marked) [2025-11-28T04:53:55.347Z] [3.345s][info][gc] GC(25) Pause Init Mark (Young) 3.981ms [2025-11-28T04:53:55.347Z] Allocated: 736 Mb [2025-11-28T04:53:55.347Z] [3.346s][info][gc] GC(25) Concurrent remembered set scanning 0.205ms [2025-11-28T04:53:55.347Z] [3.346s][info][gc] GC(25) Concurrent marking roots 0.178ms [2025-11-28T04:53:55.347Z] Allocated: 692 Mb [2025-11-28T04:53:55.347Z] Allocated: 734 Mb [2025-11-28T04:53:55.347Z] [3.360s][info][gc] GC(25) Concurrent marking (Young) 14.063ms [2025-11-28T04:53:55.347Z] [3.367s][info][gc] GC(25) Verify Before Evacuation, Level 4 (24 reachable, 20 marked) [2025-11-28T04:53:55.347Z] [3.367s][info][gc] GC(25) Pause Final Mark (Young) 4.752ms [2025-11-28T04:53:55.347Z] Allocated: 676 Mb [2025-11-28T04:53:55.347Z] [3.368s][info][gc] GC(25) Concurrent thread roots 0.063ms [2025-11-28T04:53:55.347Z] [3.368s][info][gc] GC(25) Concurrent weak references (Young) 0.015ms [2025-11-28T04:53:55.347Z] [3.368s][info][gc] GC(25) Concurrent weak roots (Young) 0.153ms [2025-11-28T04:53:55.347Z] [3.368s][info][gc] GC(25) Concurrent cleanup (Young) 826M->826M(1024M) 0.051ms [2025-11-28T04:53:55.347Z] [3.368s][info][gc] GC(25) Concurrent strong roots 0.156ms [2025-11-28T04:53:55.347Z] [3.368s][info][gc] GC(25) Concurrent evacuation 0.155ms [2025-11-28T04:53:55.347Z] [3.368s][info][gc] GC(25) Concurrent Init Update Refs (Young) 0.041ms [2025-11-28T04:53:55.347Z] [3.371s][info][gc] GC(25) Verify Before Updating References, Level 4 (25 reachable, 39 marked) [2025-11-28T04:53:55.347Z] [3.371s][info][gc] GC(25) Pause Init Update Refs 2.862ms [2025-11-28T04:53:55.347Z] [3.378s][info][gc] GC(25) Concurrent update references 2.384ms [2025-11-28T04:53:55.348Z] Allocated: 722 Mb [2025-11-28T04:53:55.348Z] [3.409s][info][gc] Failed to allocate Shared, 51227K [2025-11-28T04:53:55.348Z] [3.409s][info][gc] GC(25) Concurrent update thread roots 31.175ms [2025-11-28T04:53:55.348Z] [3.409s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.348Z] [3.418s][info][gc] GC(26) Verify Before Full GC, Level 4 (34343 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [3.654s][info][gc] GC(26) Verify After Full GC, Level 4 (34239 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [3.654s][info][gc] GC(26) Pause Full 872M->661M(1024M) 244.901ms [2025-11-28T04:53:55.348Z] Allocated: 706 Mb [2025-11-28T04:53:55.348Z] Allocated: 736 Mb [2025-11-28T04:53:55.348Z] Allocated: 679 Mb [2025-11-28T04:53:55.348Z] Allocated: 704 Mb [2025-11-28T04:53:55.348Z] [3.680s][info][gc] Trigger (Young): Average GC time (63.80 ms) is above the time for average allocation rate (1238 MB/s) to deplete free headroom (68147K) (margin of error = 1.81) [2025-11-28T04:53:55.348Z] [3.680s][info][gc] GC(27) Concurrent reset (Young) 0.501ms [2025-11-28T04:53:55.348Z] [3.694s][info][gc] GC(27) Verify Before Mark, Level 4 (25 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [3.694s][info][gc] GC(27) Pause Init Mark (Young) 3.930ms [2025-11-28T04:53:55.348Z] Allocated: 733 Mb [2025-11-28T04:53:55.348Z] [3.694s][info][gc] GC(27) Concurrent remembered set scanning 0.203ms [2025-11-28T04:53:55.348Z] [3.695s][info][gc] GC(27) Concurrent marking roots 0.202ms [2025-11-28T04:53:55.348Z] [3.695s][info][gc] GC(27) Concurrent marking (Young) 0.240ms [2025-11-28T04:53:55.348Z] [3.698s][info][gc] GC(27) Verify Before Evacuation, Level 4 (26 reachable, 5 marked) [2025-11-28T04:53:55.348Z] [3.698s][info][gc] GC(27) Pause Final Mark (Young) 3.373ms [2025-11-28T04:53:55.348Z] [3.701s][info][gc] GC(27) Concurrent thread roots 0.076ms [2025-11-28T04:53:55.348Z] [3.701s][info][gc] GC(27) Concurrent weak references (Young) 0.039ms [2025-11-28T04:53:55.348Z] Allocated: 736 Mb [2025-11-28T04:53:55.348Z] [3.711s][info][gc] GC(27) Concurrent weak roots (Young) 9.696ms [2025-11-28T04:53:55.348Z] [3.711s][info][gc] GC(27) Concurrent cleanup (Young) 831M->831M(1024M) 0.118ms [2025-11-28T04:53:55.348Z] [3.712s][info][gc] GC(27) Concurrent strong roots 0.230ms [2025-11-28T04:53:55.348Z] [3.712s][info][gc] GC(27) Concurrent evacuation 0.231ms [2025-11-28T04:53:55.348Z] Allocated: 712 Mb [2025-11-28T04:53:55.348Z] [3.717s][info][gc] GC(27) Concurrent Init Update Refs (Young) 5.351ms [2025-11-28T04:53:55.348Z] [3.725s][info][gc] GC(27) Verify Before Updating References, Level 4 (25 reachable, 26 marked) [2025-11-28T04:53:55.348Z] [3.725s][info][gc] GC(27) Pause Init Update Refs 3.868ms [2025-11-28T04:53:55.348Z] Allocated: 709 Mb [2025-11-28T04:53:55.348Z] Allocated: 672 Mb [2025-11-28T04:53:55.348Z] [3.731s][info][gc] GC(27) Concurrent update references 4.945ms [2025-11-28T04:53:55.348Z] [3.731s][info][gc] GC(27) Concurrent update thread roots 0.179ms [2025-11-28T04:53:55.348Z] [3.735s][info][gc] GC(27) Verify After Updating References, Level 4 (26 reachable, 28 marked) [2025-11-28T04:53:55.348Z] [3.735s][info][gc] GC(27) Pause Final Update Refs 3.890ms [2025-11-28T04:53:55.348Z] [3.736s][info][gc] GC(27) Concurrent cleanup (Young) 891M->891M(1024M) 0.025ms [2025-11-28T04:53:55.348Z] Allocated: 695 Mb [2025-11-28T04:53:55.348Z] [3.744s][info][gc] GC(27) Concurrent reset after collect (Young) 8.009ms [2025-11-28T04:53:55.348Z] Allocated: 699 Mb [2025-11-28T04:53:55.348Z] [3.745s][info][gc] Trigger (Young): Free (50688K) is below minimum threshold (102M) [2025-11-28T04:53:55.348Z] [3.746s][info][gc] GC(28) Concurrent reset (Young) 0.450ms [2025-11-28T04:53:55.348Z] [3.755s][info][gc] GC(28) Verify Before Mark, Level 4 (28 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [3.755s][info][gc] GC(28) Pause Init Mark (Young) 3.715ms [2025-11-28T04:53:55.348Z] Allocated: 726 Mb [2025-11-28T04:53:55.348Z] [3.755s][info][gc] GC(28) Concurrent remembered set scanning 0.201ms [2025-11-28T04:53:55.348Z] [3.756s][info][gc] GC(28) Concurrent marking roots 0.193ms [2025-11-28T04:53:55.348Z] [3.756s][info][gc] GC(28) Concurrent marking (Young) 0.200ms [2025-11-28T04:53:55.348Z] [3.760s][info][gc] GC(28) Verify Before Evacuation, Level 4 (29 reachable, 5 marked) [2025-11-28T04:53:55.348Z] [3.760s][info][gc] GC(28) Pause Final Mark (Young) 3.731ms [2025-11-28T04:53:55.348Z] [3.760s][info][gc] GC(28) Concurrent thread roots 0.071ms [2025-11-28T04:53:55.348Z] [3.760s][info][gc] GC(28) Concurrent weak references (Young) 0.012ms [2025-11-28T04:53:55.348Z] Allocated: 713 Mb [2025-11-28T04:53:55.348Z] [3.768s][info][gc] GC(28) Concurrent weak roots (Young) 8.444ms [2025-11-28T04:53:55.348Z] [3.768s][info][gc] GC(28) Concurrent cleanup (Young) 781M->781M(1024M) 0.089ms [2025-11-28T04:53:55.348Z] [3.769s][info][gc] GC(28) Concurrent strong roots 0.201ms [2025-11-28T04:53:55.348Z] [3.769s][info][gc] GC(28) Concurrent evacuation 0.125ms [2025-11-28T04:53:55.348Z] Allocated: 697 Mb [2025-11-28T04:53:55.348Z] [3.771s][info][gc] GC(28) Concurrent Init Update Refs (Young) 2.105ms [2025-11-28T04:53:55.348Z] [3.779s][info][gc] GC(28) Verify Before Updating References, Level 4 (28 reachable, 20 marked) [2025-11-28T04:53:55.348Z] [3.779s][info][gc] GC(28) Pause Init Update Refs 3.790ms [2025-11-28T04:53:55.348Z] Allocated: 723 Mb [2025-11-28T04:53:55.348Z] [3.785s][info][gc] GC(28) Concurrent update references 6.141ms [2025-11-28T04:53:55.348Z] [3.786s][info][gc] GC(28) Concurrent update thread roots 0.780ms [2025-11-28T04:53:55.348Z] [3.790s][info][gc] GC(28) Verify After Updating References, Level 4 (29 reachable, 25 marked) [2025-11-28T04:53:55.348Z] [3.790s][info][gc] GC(28) Pause Final Update Refs 3.981ms [2025-11-28T04:53:55.348Z] [3.790s][info][gc] GC(28) Concurrent cleanup (Young) 830M->830M(1024M) 0.015ms [2025-11-28T04:53:55.348Z] Allocated: 722 Mb [2025-11-28T04:53:55.348Z] [3.798s][info][gc] GC(28) Concurrent reset after collect (Young) 7.496ms [2025-11-28T04:53:55.348Z] [3.800s][info][gc] Trigger (Young): Free (94464K) is below minimum threshold (102M) [2025-11-28T04:53:55.348Z] [3.800s][info][gc] GC(29) Concurrent reset (Young) 0.457ms [2025-11-28T04:53:55.348Z] [3.809s][info][gc] GC(29) Verify Before Mark, Level 4 (28 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [3.809s][info][gc] GC(29) Pause Init Mark (Young) 3.845ms [2025-11-28T04:53:55.348Z] Allocated: 729 Mb [2025-11-28T04:53:55.348Z] [3.810s][info][gc] GC(29) Concurrent remembered set scanning 0.209ms [2025-11-28T04:53:55.348Z] [3.810s][info][gc] GC(29) Concurrent marking roots 0.190ms [2025-11-28T04:53:55.348Z] [3.810s][info][gc] GC(29) Concurrent marking (Young) 0.225ms [2025-11-28T04:53:55.348Z] [3.815s][info][gc] GC(29) Verify Before Evacuation, Level 4 (29 reachable, 5 marked) [2025-11-28T04:53:55.348Z] [3.815s][info][gc] GC(29) Pause Final Mark (Young) 4.784ms [2025-11-28T04:53:55.348Z] [3.816s][info][gc] GC(29) Concurrent thread roots 0.077ms [2025-11-28T04:53:55.348Z] [3.816s][info][gc] GC(29) Concurrent weak references (Young) 0.016ms [2025-11-28T04:53:55.348Z] Allocated: 720 Mb [2025-11-28T04:53:55.348Z] [3.822s][info][gc] GC(29) Concurrent weak roots (Young) 5.389ms [2025-11-28T04:53:55.348Z] [3.822s][info][gc] GC(29) Concurrent cleanup (Young) 792M->792M(1024M) 0.062ms [2025-11-28T04:53:55.348Z] [3.822s][info][gc] GC(29) Concurrent strong roots 0.174ms [2025-11-28T04:53:55.348Z] [3.822s][info][gc] GC(29) Concurrent evacuation 0.096ms [2025-11-28T04:53:55.348Z] Allocated: 713 Mb [2025-11-28T04:53:55.348Z] [3.828s][info][gc] GC(29) Concurrent Init Update Refs (Young) 5.343ms [2025-11-28T04:53:55.348Z] [3.836s][info][gc] GC(29) Verify Before Updating References, Level 4 (28 reachable, 20 marked) [2025-11-28T04:53:55.348Z] [3.836s][info][gc] GC(29) Pause Init Update Refs 3.758ms [2025-11-28T04:53:55.348Z] Allocated: 703 Mb [2025-11-28T04:53:55.348Z] [3.841s][info][gc] GC(29) Concurrent update references 4.793ms [2025-11-28T04:53:55.348Z] Allocated: 720 Mb [2025-11-28T04:53:55.348Z] [3.846s][info][gc] Failed to allocate Shared, 61786K [2025-11-28T04:53:55.348Z] [3.847s][info][gc] GC(29) Concurrent update thread roots 6.451ms [2025-11-28T04:53:55.348Z] [3.847s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.348Z] [3.856s][info][gc] GC(30) Verify Before Full GC, Level 4 (34347 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.067s][info][gc] GC(30) Verify After Full GC, Level 4 (34243 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.067s][info][gc] GC(30) Pause Full 855M->705M(1024M) 219.961ms [2025-11-28T04:53:55.348Z] Allocated: 757 Mb [2025-11-28T04:53:55.348Z] Allocated: 670 Mb [2025-11-28T04:53:55.348Z] [4.084s][info][gc] Trigger (Young): Average GC time (70.62 ms) is above the time for average allocation rate (1400 MB/s) to deplete free headroom (71731K) (margin of error = 1.81) [2025-11-28T04:53:55.348Z] [4.085s][info][gc] GC(31) Concurrent reset (Young) 0.496ms [2025-11-28T04:53:55.348Z] [4.098s][info][gc] GC(31) Verify Before Mark, Level 4 (28 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.098s][info][gc] GC(31) Pause Init Mark (Young) 3.787ms [2025-11-28T04:53:55.348Z] Allocated: 727 Mb [2025-11-28T04:53:55.348Z] [4.100s][info][gc] GC(31) Concurrent remembered set scanning 1.356ms [2025-11-28T04:53:55.348Z] [4.100s][info][gc] GC(31) Concurrent marking roots 0.244ms [2025-11-28T04:53:55.348Z] Allocated: 673 Mb [2025-11-28T04:53:55.348Z] Allocated: 727 Mb [2025-11-28T04:53:55.348Z] [4.115s][info][gc] Failed to allocate Shared, 63713K [2025-11-28T04:53:55.348Z] [4.115s][info][gc] GC(31) Concurrent marking (Young) 15.178ms [2025-11-28T04:53:55.348Z] [4.116s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.348Z] [4.124s][info][gc] GC(32) Verify Before Full GC, Level 4 (34347 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.124s][info][gc] GC(32) Cancel marking: Young [2025-11-28T04:53:55.348Z] [4.124s][info][gc] GC(32) Cancel marking: Old [2025-11-28T04:53:55.348Z] [4.124s][info][gc] GC(32) Cancel marking: Global [2025-11-28T04:53:55.348Z] [4.374s][info][gc] GC(32) Verify After Full GC, Level 4 (34243 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.374s][info][gc] GC(32) Pause Full 931M->696M(1024M) 258.498ms [2025-11-28T04:53:55.348Z] Allocated: 750 Mb [2025-11-28T04:53:55.348Z] [4.386s][info][gc] Trigger (Young): Average GC time (70.62 ms) is above the time for average allocation rate (1571 MB/s) to deplete free headroom (100M) (margin of error = 1.81) [2025-11-28T04:53:55.348Z] [4.387s][info][gc] GC(33) Concurrent reset (Young) 0.514ms [2025-11-28T04:53:55.348Z] [4.402s][info][gc] GC(33) Verify Before Mark, Level 4 (27 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.402s][info][gc] GC(33) Pause Init Mark (Young) 3.990ms [2025-11-28T04:53:55.348Z] Allocated: 735 Mb [2025-11-28T04:53:55.348Z] [4.402s][info][gc] GC(33) Concurrent remembered set scanning 0.229ms [2025-11-28T04:53:55.348Z] [4.403s][info][gc] GC(33) Concurrent marking roots 0.180ms [2025-11-28T04:53:55.348Z] Allocated: 720 Mb [2025-11-28T04:53:55.348Z] [4.407s][info][gc] GC(33) Concurrent marking (Young) 4.781ms [2025-11-28T04:53:55.348Z] [4.412s][info][gc] GC(33) Verify After Mark, Level 4 (27 reachable, 11 marked) [2025-11-28T04:53:55.348Z] [4.412s][info][gc] GC(33) Pause Final Mark (Young) 4.110ms [2025-11-28T04:53:55.348Z] [4.415s][info][gc] GC(33) Concurrent weak references (Young) 0.028ms [2025-11-28T04:53:55.348Z] Allocated: 721 Mb [2025-11-28T04:53:55.348Z] [4.422s][info][gc] GC(33) Concurrent weak roots (Young) 6.473ms [2025-11-28T04:53:55.348Z] [4.422s][info][gc] GC(33) Concurrent cleanup (Young) 826M->826M(1024M) 0.097ms [2025-11-28T04:53:55.348Z] Allocated: 684 Mb [2025-11-28T04:53:55.348Z] [4.424s][info][gc] GC(33) Concurrent Final Roots (Young) 2.204ms [2025-11-28T04:53:55.348Z] [4.432s][info][gc] GC(33) Concurrent reset after collect (Young) 7.714ms [2025-11-28T04:53:55.348Z] Allocated: 704 Mb [2025-11-28T04:53:55.348Z] [4.434s][info][gc] Trigger (Young): Free (100863K) is below minimum threshold (102M) [2025-11-28T04:53:55.348Z] [4.435s][info][gc] GC(34) Concurrent reset (Young) 0.474ms [2025-11-28T04:53:55.348Z] [4.442s][info][gc] GC(34) Verify Before Mark, Level 4 (26 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.442s][info][gc] GC(34) Pause Init Mark (Young) 3.938ms [2025-11-28T04:53:55.348Z] Allocated: 702 Mb [2025-11-28T04:53:55.348Z] Allocated: 682 Mb [2025-11-28T04:53:55.348Z] [4.444s][info][gc] GC(34) Concurrent remembered set scanning 1.120ms [2025-11-28T04:53:55.348Z] [4.445s][info][gc] GC(34) Concurrent marking roots 0.206ms [2025-11-28T04:53:55.348Z] [4.445s][info][gc] GC(34) Concurrent marking (Young) 0.204ms [2025-11-28T04:53:55.348Z] [4.450s][info][gc] GC(34) Verify After Mark, Level 4 (27 reachable, 9 marked) [2025-11-28T04:53:55.348Z] [4.450s][info][gc] GC(34) Pause Final Mark (Young) 5.268ms [2025-11-28T04:53:55.348Z] [4.453s][info][gc] GC(34) Concurrent weak references (Young) 0.019ms [2025-11-28T04:53:55.348Z] Allocated: 724 Mb [2025-11-28T04:53:55.348Z] [4.459s][info][gc] Failed to allocate Shared, 59331K [2025-11-28T04:53:55.348Z] [4.459s][info][gc] GC(34) Concurrent weak roots (Young) 5.400ms [2025-11-28T04:53:55.348Z] [4.459s][info][gc] GC(34) Concurrent cleanup (Young) 733M->733M(1024M) 0.104ms [2025-11-28T04:53:55.348Z] [4.459s][info][gc] GC(34) Concurrent Final Roots (Young) 0.092ms [2025-11-28T04:53:55.348Z] [4.463s][info][gc] GC(34) Concurrent reset after collect (Young) 4.141ms [2025-11-28T04:53:55.348Z] [4.463s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.348Z] [4.472s][info][gc] GC(35) Verify Before Full GC, Level 4 (34345 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.675s][info][gc] GC(35) Verify After Full GC, Level 4 (34241 reachable, 0 marked) [2025-11-28T04:53:55.348Z] [4.675s][info][gc] GC(35) Pause Full 733M->647M(1024M) 211.802ms [2025-11-28T04:53:55.350Z] Allocated: 697 Mb [2025-11-28T04:53:55.350Z] Allocated: 699 Mb [2025-11-28T04:53:55.350Z] Allocated: 705 Mb [2025-11-28T04:53:55.350Z] Allocated: 733 Mb [2025-11-28T04:53:55.350Z] Allocated: 676 Mb [2025-11-28T04:53:55.350Z] Allocated: 688 Mb [2025-11-28T04:53:55.350Z] Allocated: 731 Mb [2025-11-28T04:53:55.350Z] [4.711s][info][gc] Trigger (Young): Free (73471K) is below minimum threshold (102M) [2025-11-28T04:53:55.350Z] [4.712s][info][gc] GC(36) Concurrent reset (Young) 0.492ms [2025-11-28T04:53:55.350Z] [4.726s][info][gc] GC(36) Verify Before Mark, Level 4 (24 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [4.726s][info][gc] GC(36) Pause Init Mark (Young) 3.956ms [2025-11-28T04:53:55.350Z] Allocated: 759 Mb [2025-11-28T04:53:55.350Z] [4.727s][info][gc] GC(36) Concurrent remembered set scanning 0.234ms [2025-11-28T04:53:55.350Z] [4.727s][info][gc] GC(36) Concurrent marking roots 0.185ms [2025-11-28T04:53:55.350Z] [4.728s][info][gc] GC(36) Concurrent marking (Young) 0.227ms [2025-11-28T04:53:55.350Z] [4.732s][info][gc] GC(36) Verify After Mark, Level 4 (25 reachable, 5 marked) [2025-11-28T04:53:55.350Z] [4.732s][info][gc] GC(36) Pause Final Mark (Young) 4.855ms [2025-11-28T04:53:55.350Z] [4.733s][info][gc] Failed to allocate Shared, 64734K [2025-11-28T04:53:55.350Z] [4.733s][info][gc] GC(36) Concurrent weak references (Young) 0.016ms [2025-11-28T04:53:55.350Z] [4.733s][info][gc] GC(36) Concurrent weak roots (Young) 0.165ms [2025-11-28T04:53:55.350Z] [4.733s][info][gc] GC(36) Concurrent cleanup (Young) 768M->768M(1024M) 0.041ms [2025-11-28T04:53:55.350Z] [4.733s][info][gc] GC(36) Concurrent Final Roots (Young) 0.056ms [2025-11-28T04:53:55.350Z] [4.737s][info][gc] GC(36) Concurrent reset after collect (Young) 4.535ms [2025-11-28T04:53:55.350Z] [4.738s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.350Z] [4.746s][info][gc] GC(37) Verify Before Full GC, Level 4 (34346 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [4.929s][info][gc] GC(37) Verify After Full GC, Level 4 (34242 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [4.929s][info][gc] GC(37) Pause Full 768M->702M(1024M) 191.185ms [2025-11-28T04:53:55.350Z] Allocated: 758 Mb [2025-11-28T04:53:55.350Z] Allocated: 664 Mb [2025-11-28T04:53:55.350Z] Allocated: 715 Mb [2025-11-28T04:53:55.350Z] Allocated: 708 Mb [2025-11-28T04:53:55.350Z] [4.958s][info][gc] Trigger (Young): Free (65791K) is below minimum threshold (102M) [2025-11-28T04:53:55.350Z] [4.959s][info][gc] GC(38) Concurrent reset (Young) 0.505ms [2025-11-28T04:53:55.350Z] [4.972s][info][gc] GC(38) Verify Before Mark, Level 4 (20 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [4.972s][info][gc] GC(38) Pause Init Mark (Young) 4.210ms [2025-11-28T04:53:55.350Z] Allocated: 737 Mb [2025-11-28T04:53:55.350Z] [4.972s][info][gc] GC(38) Concurrent remembered set scanning 0.218ms [2025-11-28T04:53:55.350Z] [4.973s][info][gc] GC(38) Concurrent marking roots 0.200ms [2025-11-28T04:53:55.350Z] [4.973s][info][gc] Failed to allocate Shared, 57672K [2025-11-28T04:53:55.350Z] [4.973s][info][gc] GC(38) Concurrent marking (Young) 0.281ms [2025-11-28T04:53:55.350Z] [4.973s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.350Z] [4.981s][info][gc] GC(39) Verify Before Full GC, Level 4 (34342 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [4.981s][info][gc] GC(39) Cancel marking: Young [2025-11-28T04:53:55.350Z] [4.981s][info][gc] GC(39) Cancel marking: Old [2025-11-28T04:53:55.350Z] [4.981s][info][gc] GC(39) Cancel marking: Global [2025-11-28T04:53:55.350Z] [5.210s][info][gc] GC(39) Verify After Full GC, Level 4 (34238 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.210s][info][gc] GC(39) Pause Full 908M->655M(1024M) 237.238ms [2025-11-28T04:53:55.350Z] Allocated: 705 Mb [2025-11-28T04:53:55.350Z] Allocated: 673 Mb [2025-11-28T04:53:55.350Z] Allocated: 737 Mb [2025-11-28T04:53:55.350Z] Allocated: 699 Mb [2025-11-28T04:53:55.350Z] Allocated: 715 Mb [2025-11-28T04:53:55.350Z] [5.244s][info][gc] Trigger (Young): Free (95999K) is below minimum threshold (102M) [2025-11-28T04:53:55.350Z] [5.245s][info][gc] GC(40) Concurrent reset (Young) 0.510ms [2025-11-28T04:53:55.350Z] [5.257s][info][gc] GC(40) Verify Before Mark, Level 4 (20 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.257s][info][gc] GC(40) Pause Init Mark (Young) 3.754ms [2025-11-28T04:53:55.350Z] Allocated: 723 Mb [2025-11-28T04:53:55.350Z] [5.258s][info][gc] GC(40) Concurrent remembered set scanning 0.268ms [2025-11-28T04:53:55.350Z] [5.258s][info][gc] GC(40) Concurrent marking roots 0.221ms [2025-11-28T04:53:55.350Z] [5.258s][info][gc] GC(40) Concurrent marking (Young) 0.213ms [2025-11-28T04:53:55.350Z] [5.262s][info][gc] GC(40) Verify After Mark, Level 4 (21 reachable, 5 marked) [2025-11-28T04:53:55.350Z] [5.263s][info][gc] GC(40) Pause Final Mark (Young) 4.190ms [2025-11-28T04:53:55.350Z] [5.263s][info][gc] GC(40) Concurrent weak references (Young) 0.016ms [2025-11-28T04:53:55.350Z] [5.263s][info][gc] GC(40) Concurrent weak roots (Young) 0.153ms [2025-11-28T04:53:55.350Z] [5.263s][info][gc] GC(40) Concurrent cleanup (Young) 731M->731M(1024M) 0.040ms [2025-11-28T04:53:55.350Z] [5.263s][info][gc] GC(40) Concurrent Final Roots (Young) 0.138ms [2025-11-28T04:53:55.350Z] [5.272s][info][gc] GC(40) Concurrent reset after collect (Young) 8.741ms [2025-11-28T04:53:55.350Z] Allocated: 694 Mb [2025-11-28T04:53:55.350Z] [5.275s][info][gc] Trigger (Young): Average GC time (44.97 ms) is above the time for average allocation rate (3289 MB/s) to deplete free headroom (103M) (margin of error = 1.81) [2025-11-28T04:53:55.350Z] [5.276s][info][gc] GC(41) Concurrent reset (Young) 0.466ms [2025-11-28T04:53:55.350Z] [5.288s][info][gc] GC(41) Verify Before Mark, Level 4 (20 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.288s][info][gc] GC(41) Pause Init Mark (Young) 3.853ms [2025-11-28T04:53:55.350Z] Allocated: 743 Mb [2025-11-28T04:53:55.350Z] [5.289s][info][gc] GC(41) Concurrent remembered set scanning 0.207ms [2025-11-28T04:53:55.350Z] [5.289s][info][gc] GC(41) Concurrent marking roots 0.175ms [2025-11-28T04:53:55.350Z] [5.289s][info][gc] GC(41) Concurrent marking (Young) 0.246ms [2025-11-28T04:53:55.350Z] [5.295s][info][gc] GC(41) Verify Before Evacuation, Level 4 (21 reachable, 5 marked) [2025-11-28T04:53:55.350Z] [5.295s][info][gc] GC(41) Pause Final Mark (Young) 5.255ms [2025-11-28T04:53:55.350Z] [5.295s][info][gc] GC(41) Concurrent thread roots 0.091ms [2025-11-28T04:53:55.350Z] [5.295s][info][gc] GC(41) Concurrent weak references (Young) 0.012ms [2025-11-28T04:53:55.350Z] [5.296s][info][gc] GC(41) Concurrent weak roots (Young) 0.928ms [2025-11-28T04:53:55.350Z] [5.296s][info][gc] GC(41) Concurrent cleanup (Young) 756M->756M(1024M) 0.029ms [2025-11-28T04:53:55.350Z] [5.296s][info][gc] GC(41) Concurrent strong roots 0.155ms [2025-11-28T04:53:55.350Z] [5.296s][info][gc] GC(41) Concurrent evacuation 0.065ms [2025-11-28T04:53:55.350Z] [5.297s][info][gc] GC(41) Concurrent Init Update Refs (Young) 0.877ms [2025-11-28T04:53:55.350Z] [5.300s][info][gc] GC(41) Verify Before Updating References, Level 4 (20 reachable, 9 marked) [2025-11-28T04:53:55.350Z] [5.300s][info][gc] GC(41) Pause Init Update Refs 3.271ms [2025-11-28T04:53:55.350Z] Allocated: 691 Mb [2025-11-28T04:53:55.350Z] [5.304s][info][gc] GC(41) Concurrent update references 3.420ms [2025-11-28T04:53:55.350Z] Allocated: 707 Mb [2025-11-28T04:53:55.350Z] [5.307s][info][gc] GC(41) Concurrent update thread roots 3.230ms [2025-11-28T04:53:55.350Z] [5.319s][info][gc] GC(41) Verify After Updating References, Level 4 (20 reachable, 19 marked) [2025-11-28T04:53:55.350Z] [5.319s][info][gc] GC(41) Pause Final Update Refs 4.360ms [2025-11-28T04:53:55.350Z] [5.319s][info][gc] GC(41) Concurrent cleanup (Young) 818M->818M(1024M) 0.023ms [2025-11-28T04:53:55.350Z] Allocated: 710 Mb [2025-11-28T04:53:55.350Z] Allocated: 712 Mb [2025-11-28T04:53:55.350Z] [5.328s][info][gc] GC(41) Concurrent reset after collect (Young) 9.157ms [2025-11-28T04:53:55.350Z] [5.330s][info][gc] Trigger (Young): Average GC time (64.67 ms) is above the time for average allocation rate (3049 MB/s) to deplete free headroom (76339K) (margin of error = 1.81) [2025-11-28T04:53:55.350Z] [5.330s][info][gc] GC(42) Concurrent reset (Young) 0.474ms [2025-11-28T04:53:55.350Z] [5.334s][info][gc] GC(42) Verify Before Mark, Level 4 (21 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.334s][info][gc] GC(42) Pause Init Mark (Young) 3.810ms [2025-11-28T04:53:55.350Z] Allocated: 662 Mb [2025-11-28T04:53:55.350Z] [5.335s][info][gc] GC(42) Concurrent remembered set scanning 0.192ms [2025-11-28T04:53:55.350Z] [5.335s][info][gc] GC(42) Concurrent marking roots 0.218ms [2025-11-28T04:53:55.350Z] [5.335s][info][gc] GC(42) Concurrent marking (Young) 0.207ms [2025-11-28T04:53:55.350Z] [5.341s][info][gc] GC(42) Verify Before Evacuation, Level 4 (21 reachable, 4 marked) [2025-11-28T04:53:55.350Z] [5.341s][info][gc] GC(42) Pause Final Mark (Young) 6.079ms [2025-11-28T04:53:55.350Z] Allocated: 677 Mb [2025-11-28T04:53:55.350Z] [5.344s][info][gc] GC(42) Concurrent thread roots 0.080ms [2025-11-28T04:53:55.350Z] [5.344s][info][gc] GC(42) Concurrent weak references (Young) 0.025ms [2025-11-28T04:53:55.350Z] [5.344s][info][gc] GC(42) Concurrent weak roots (Young) 0.077ms [2025-11-28T04:53:55.350Z] [5.344s][info][gc] GC(42) Concurrent cleanup (Young) 686M->686M(1024M) 0.077ms [2025-11-28T04:53:55.350Z] [5.345s][info][gc] GC(42) Concurrent strong roots 0.189ms [2025-11-28T04:53:55.350Z] [5.345s][info][gc] GC(42) Concurrent evacuation 0.098ms [2025-11-28T04:53:55.350Z] [5.345s][info][gc] GC(42) Concurrent Init Update Refs (Young) 0.041ms [2025-11-28T04:53:55.350Z] [5.348s][info][gc] GC(42) Verify Before Updating References, Level 4 (22 reachable, 14 marked) [2025-11-28T04:53:55.350Z] [5.348s][info][gc] GC(42) Pause Init Update Refs 3.508ms [2025-11-28T04:53:55.350Z] [5.350s][info][gc] GC(42) Concurrent update references 2.159ms [2025-11-28T04:53:55.350Z] [5.351s][info][gc] GC(42) Concurrent update thread roots 0.093ms [2025-11-28T04:53:55.350Z] [5.354s][info][gc] GC(42) Verify After Updating References, Level 4 (22 reachable, 11 marked) [2025-11-28T04:53:55.350Z] [5.354s][info][gc] GC(42) Pause Final Update Refs 3.381ms [2025-11-28T04:53:55.350Z] [5.354s][info][gc] GC(42) Concurrent cleanup (Young) 685M->685M(1024M) 0.015ms [2025-11-28T04:53:55.350Z] Allocated: 686 Mb [2025-11-28T04:53:55.350Z] [5.359s][info][gc] GC(42) Concurrent reset after collect (Young) 5.213ms [2025-11-28T04:53:55.350Z] Allocated: 731 Mb [2025-11-28T04:53:55.350Z] Allocated: 726 Mb [2025-11-28T04:53:55.350Z] [5.373s][info][gc] Trigger (Young): Average GC time (55.10 ms) is above the time for average allocation rate (2431 MB/s) to deplete free headroom (108M) (margin of error = 1.80) [2025-11-28T04:53:55.350Z] [5.374s][info][gc] GC(43) Concurrent reset (Young) 0.466ms [2025-11-28T04:53:55.350Z] [5.385s][info][gc] GC(43) Verify Before Mark, Level 4 (21 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.385s][info][gc] GC(43) Pause Init Mark (Young) 3.889ms [2025-11-28T04:53:55.350Z] Allocated: 736 Mb [2025-11-28T04:53:55.350Z] [5.386s][info][gc] GC(43) Concurrent remembered set scanning 0.207ms [2025-11-28T04:53:55.350Z] [5.386s][info][gc] GC(43) Concurrent marking roots 0.205ms [2025-11-28T04:53:55.350Z] [5.386s][info][gc] GC(43) Concurrent marking (Young) 0.210ms [2025-11-28T04:53:55.350Z] [5.391s][info][gc] GC(43) Verify Before Evacuation, Level 4 (22 reachable, 5 marked) [2025-11-28T04:53:55.350Z] [5.391s][info][gc] GC(43) Pause Final Mark (Young) 4.545ms [2025-11-28T04:53:55.350Z] [5.394s][info][gc] GC(43) Concurrent thread roots 0.078ms [2025-11-28T04:53:55.350Z] [5.394s][info][gc] GC(43) Concurrent weak references (Young) 0.036ms [2025-11-28T04:53:55.350Z] Allocated: 704 Mb [2025-11-28T04:53:55.350Z] [5.398s][info][gc] GC(43) Concurrent weak roots (Young) 3.238ms [2025-11-28T04:53:55.350Z] [5.398s][info][gc] GC(43) Concurrent cleanup (Young) 806M->806M(1024M) 0.056ms [2025-11-28T04:53:55.350Z] [5.398s][info][gc] GC(43) Concurrent strong roots 0.191ms [2025-11-28T04:53:55.350Z] [5.398s][info][gc] GC(43) Concurrent evacuation 0.104ms [2025-11-28T04:53:55.350Z] Allocated: 694 Mb [2025-11-28T04:53:55.350Z] [5.404s][info][gc] GC(43) Concurrent Init Update Refs (Young) 5.356ms [2025-11-28T04:53:55.350Z] [5.412s][info][gc] GC(43) Verify Before Updating References, Level 4 (22 reachable, 19 marked) [2025-11-28T04:53:55.350Z] [5.412s][info][gc] GC(43) Pause Init Update Refs 3.862ms [2025-11-28T04:53:55.350Z] Allocated: 714 Mb [2025-11-28T04:53:55.350Z] [5.415s][info][gc] GC(43) Concurrent update references 3.497ms [2025-11-28T04:53:55.350Z] [5.421s][info][gc] GC(43) Concurrent update thread roots 5.426ms [2025-11-28T04:53:55.350Z] [5.425s][info][gc] GC(43) Verify After Updating References, Level 4 (23 reachable, 26 marked) [2025-11-28T04:53:55.350Z] [5.425s][info][gc] GC(43) Pause Final Update Refs 4.140ms [2025-11-28T04:53:55.350Z] Allocated: 690 Mb [2025-11-28T04:53:55.350Z] [5.425s][info][gc] GC(43) Concurrent cleanup (Young) 858M->858M(1024M) 0.018ms [2025-11-28T04:53:55.350Z] Allocated: 703 Mb [2025-11-28T04:53:55.350Z] [5.431s][info][gc] Failed to allocate Shared, 49327K [2025-11-28T04:53:55.350Z] [5.432s][info][gc] GC(43) Concurrent reset after collect (Young) 7.130ms [2025-11-28T04:53:55.350Z] [5.433s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.350Z] [5.441s][info][gc] GC(44) Verify Before Full GC, Level 4 (34346 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.649s][info][gc] GC(44) Verify After Full GC, Level 4 (34242 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.649s][info][gc] GC(44) Pause Full 872M->680M(1024M) 216.454ms [2025-11-28T04:53:55.350Z] Allocated: 720 Mb [2025-11-28T04:53:55.350Z] Allocated: 717 Mb [2025-11-28T04:53:55.350Z] Allocated: 722 Mb [2025-11-28T04:53:55.350Z] Allocated: 695 Mb [2025-11-28T04:53:55.350Z] [5.677s][info][gc] Trigger (Young): Free (97536K) is below minimum threshold (102M) [2025-11-28T04:53:55.350Z] [5.678s][info][gc] GC(45) Concurrent reset (Young) 0.511ms [2025-11-28T04:53:55.350Z] [5.690s][info][gc] GC(45) Verify Before Mark, Level 4 (23 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.690s][info][gc] GC(45) Pause Init Mark (Young) 4.021ms [2025-11-28T04:53:55.350Z] Allocated: 744 Mb [2025-11-28T04:53:55.350Z] [5.691s][info][gc] GC(45) Concurrent remembered set scanning 0.210ms [2025-11-28T04:53:55.350Z] [5.691s][info][gc] GC(45) Concurrent marking roots 0.199ms [2025-11-28T04:53:55.350Z] [5.691s][info][gc] GC(45) Concurrent marking (Young) 0.247ms [2025-11-28T04:53:55.350Z] [5.695s][info][gc] GC(45) Verify After Mark, Level 4 (24 reachable, 5 marked) [2025-11-28T04:53:55.350Z] [5.695s][info][gc] GC(45) Pause Final Mark (Young) 3.959ms [2025-11-28T04:53:55.350Z] [5.697s][info][gc] GC(45) Concurrent weak references (Young) 1.072ms [2025-11-28T04:53:55.350Z] Allocated: 711 Mb [2025-11-28T04:53:55.350Z] [5.705s][info][gc] GC(45) Concurrent weak roots (Young) 8.630ms [2025-11-28T04:53:55.350Z] [5.705s][info][gc] GC(45) Concurrent cleanup (Young) 815M->815M(1024M) 0.087ms [2025-11-28T04:53:55.350Z] Allocated: 709 Mb [2025-11-28T04:53:55.350Z] [5.709s][info][gc] GC(45) Concurrent Final Roots (Young) 3.262ms [2025-11-28T04:53:55.350Z] [5.717s][info][gc] GC(45) Concurrent reset after collect (Young) 7.918ms [2025-11-28T04:53:55.350Z] [5.719s][info][gc] Trigger (Young): Average GC time (62.95 ms) is above the time for average allocation rate (3559 MB/s) to deplete free headroom (65843K) (margin of error = 1.81) [2025-11-28T04:53:55.350Z] [5.719s][info][gc] GC(46) Concurrent reset (Young) 0.488ms [2025-11-28T04:53:55.350Z] [5.725s][info][gc] GC(46) Verify Before Mark, Level 4 (22 reachable, 0 marked) [2025-11-28T04:53:55.350Z] [5.725s][info][gc] GC(46) Pause Init Mark (Young) 3.832ms [2025-11-28T04:53:55.351Z] Allocated: 735 Mb [2025-11-28T04:53:55.351Z] [5.726s][info][gc] GC(46) Concurrent remembered set scanning 0.207ms [2025-11-28T04:53:55.351Z] [5.726s][info][gc] GC(46) Concurrent marking roots 0.185ms [2025-11-28T04:53:55.351Z] Allocated: 694 Mb [2025-11-28T04:53:55.351Z] [5.730s][info][gc] GC(46) Concurrent marking (Young) 3.783ms [2025-11-28T04:53:55.351Z] [5.740s][info][gc] GC(46) Verify After Mark, Level 4 (23 reachable, 11 marked) [2025-11-28T04:53:55.351Z] [5.740s][info][gc] GC(46) Pause Final Mark (Young) 4.313ms [2025-11-28T04:53:55.351Z] [5.740s][info][gc] GC(46) Concurrent weak references (Young) 0.019ms [2025-11-28T04:53:55.351Z] [5.740s][info][gc] GC(46) Concurrent weak roots (Young) 0.179ms [2025-11-28T04:53:55.351Z] [5.740s][info][gc] GC(46) Concurrent cleanup (Young) 791M->791M(1024M) 0.048ms [2025-11-28T04:53:55.351Z] Allocated: 723 Mb [2025-11-28T04:53:55.351Z] [5.740s][info][gc] GC(46) Concurrent Final Roots (Young) 0.297ms [2025-11-28T04:53:55.351Z] Allocated: 705 Mb [2025-11-28T04:53:55.351Z] Allocated: 691 Mb [2025-11-28T04:53:55.351Z] [5.754s][info][gc] GC(46) Concurrent reset after collect (Young) 13.606ms [2025-11-28T04:53:55.351Z] [5.755s][info][gc] Trigger (Young): Average GC time (55.22 ms) is above the time for average allocation rate (3030 MB/s) to deplete free headroom (56371K) (margin of error = 1.81) [2025-11-28T04:53:55.351Z] [5.756s][info][gc] GC(47) Concurrent reset (Young) 0.801ms [2025-11-28T04:53:55.351Z] [5.764s][info][gc] GC(47) Verify Before Mark, Level 4 (23 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [5.764s][info][gc] GC(47) Pause Init Mark (Young) 3.921ms [2025-11-28T04:53:55.351Z] Allocated: 718 Mb [2025-11-28T04:53:55.351Z] [5.764s][info][gc] GC(47) Concurrent remembered set scanning 0.252ms [2025-11-28T04:53:55.351Z] [5.765s][info][gc] GC(47) Concurrent marking roots 0.660ms [2025-11-28T04:53:55.351Z] Allocated: 690 Mb [2025-11-28T04:53:55.351Z] [5.767s][info][gc] GC(47) Concurrent marking (Young) 2.391ms [2025-11-28T04:53:55.351Z] [5.767s][info][gc] Failed to allocate Shared, 55562K [2025-11-28T04:53:55.351Z] [5.768s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.351Z] [5.776s][info][gc] GC(48) Verify Before Full GC, Level 4 (34346 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [5.776s][info][gc] GC(48) Cancel marking: Young [2025-11-28T04:53:55.351Z] [5.776s][info][gc] GC(48) Cancel marking: Old [2025-11-28T04:53:55.351Z] [5.776s][info][gc] GC(48) Cancel marking: Global [2025-11-28T04:53:55.351Z] [6.011s][info][gc] GC(48) Verify After Full GC, Level 4 (34242 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.011s][info][gc] GC(48) Pause Full 878M->697M(1024M) 243.544ms [2025-11-28T04:53:55.351Z] Allocated: 744 Mb [2025-11-28T04:53:55.351Z] Allocated: 684 Mb [2025-11-28T04:53:55.351Z] Allocated: 718 Mb [2025-11-28T04:53:55.351Z] Allocated: 723 Mb [2025-11-28T04:53:55.351Z] [6.037s][info][gc] Trigger (Young): Free (89855K) is below minimum threshold (102M) [2025-11-28T04:53:55.351Z] [6.038s][info][gc] GC(49) Concurrent reset (Young) 0.795ms [2025-11-28T04:53:55.351Z] [6.049s][info][gc] GC(49) Verify Before Mark, Level 4 (23 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.050s][info][gc] GC(49) Pause Init Mark (Young) 3.963ms [2025-11-28T04:53:55.351Z] Allocated: 715 Mb [2025-11-28T04:53:55.351Z] Allocated: 708 Mb [2025-11-28T04:53:55.351Z] [6.054s][info][gc] GC(49) Concurrent remembered set scanning 0.246ms [2025-11-28T04:53:55.351Z] [6.054s][info][gc] GC(49) Concurrent marking roots 0.262ms [2025-11-28T04:53:55.351Z] Allocated: 697 Mb [2025-11-28T04:53:55.351Z] Allocated: 737 Mb [2025-11-28T04:53:55.351Z] [6.065s][info][gc] Failed to allocate Shared, 64705K [2025-11-28T04:53:55.351Z] [6.065s][info][gc] GC(49) Concurrent marking (Young) 10.829ms [2025-11-28T04:53:55.351Z] [6.065s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.351Z] [6.074s][info][gc] GC(50) Verify Before Full GC, Level 4 (34343 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.074s][info][gc] GC(50) Cancel marking: Young [2025-11-28T04:53:55.351Z] [6.074s][info][gc] GC(50) Cancel marking: Old [2025-11-28T04:53:55.351Z] [6.074s][info][gc] GC(50) Cancel marking: Global [2025-11-28T04:53:55.351Z] [6.275s][info][gc] GC(50) Verify After Full GC, Level 4 (34239 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.275s][info][gc] GC(50) Pause Full 956M->698M(1024M) 210.186ms [2025-11-28T04:53:55.351Z] Allocated: 754 Mb [2025-11-28T04:53:55.351Z] Allocated: 698 Mb [2025-11-28T04:53:55.351Z] Allocated: 731 Mb [2025-11-28T04:53:55.351Z] Allocated: 729 Mb [2025-11-28T04:53:55.351Z] [6.302s][info][gc] Trigger (Young): Free (78591K) is below minimum threshold (102M) [2025-11-28T04:53:55.351Z] [6.303s][info][gc] GC(51) Concurrent reset (Young) 0.814ms [2025-11-28T04:53:55.351Z] [6.320s][info][gc] GC(51) Verify Before Mark, Level 4 (20 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.320s][info][gc] GC(51) Pause Init Mark (Young) 6.669ms [2025-11-28T04:53:55.351Z] Allocated: 727 Mb [2025-11-28T04:53:55.351Z] [6.322s][info][gc] GC(51) Concurrent remembered set scanning 0.236ms [2025-11-28T04:53:55.351Z] [6.322s][info][gc] GC(51) Concurrent marking roots 0.230ms [2025-11-28T04:53:55.351Z] [6.322s][info][gc] GC(51) Concurrent marking (Young) 0.259ms [2025-11-28T04:53:55.351Z] [6.331s][info][gc] GC(51) Verify After Mark, Level 4 (21 reachable, 5 marked) [2025-11-28T04:53:55.351Z] [6.331s][info][gc] GC(51) Pause Final Mark (Young) 8.661ms [2025-11-28T04:53:55.351Z] [6.331s][info][gc] GC(51) Concurrent weak references (Young) 0.022ms [2025-11-28T04:53:55.351Z] [6.331s][info][gc] GC(51) Concurrent weak roots (Young) 0.260ms [2025-11-28T04:53:55.351Z] [6.331s][info][gc] GC(51) Concurrent cleanup (Young) 736M->736M(1024M) 0.055ms [2025-11-28T04:53:55.351Z] Allocated: 699 Mb [2025-11-28T04:53:55.351Z] Allocated: 710 Mb [2025-11-28T04:53:55.351Z] [6.334s][info][gc] GC(51) Concurrent Final Roots (Young) 2.815ms [2025-11-28T04:53:55.351Z] [6.343s][info][gc] GC(51) Concurrent reset after collect (Young) 8.255ms [2025-11-28T04:53:55.351Z] [6.344s][info][gc] Trigger (Young): Average GC time (51.13 ms) is above the time for average allocation rate (3459 MB/s) to deplete free headroom (120M) (margin of error = 1.81) [2025-11-28T04:53:55.351Z] [6.344s][info][gc] GC(52) Concurrent reset (Young) 0.762ms [2025-11-28T04:53:55.351Z] [6.362s][info][gc] GC(52) Verify Before Mark, Level 4 (21 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.362s][info][gc] GC(52) Pause Init Mark (Young) 8.750ms [2025-11-28T04:53:55.351Z] [6.363s][info][gc] GC(52) Concurrent remembered set scanning 0.222ms [2025-11-28T04:53:55.351Z] Allocated: 751 Mb [2025-11-28T04:53:55.351Z] [6.363s][info][gc] GC(52) Concurrent marking roots 0.246ms [2025-11-28T04:53:55.351Z] [6.363s][info][gc] GC(52) Concurrent marking (Young) 0.236ms [2025-11-28T04:53:55.351Z] [6.371s][info][gc] GC(52) Verify Before Evacuation, Level 4 (22 reachable, 5 marked) [2025-11-28T04:53:55.351Z] [6.371s][info][gc] GC(52) Pause Final Mark (Young) 7.609ms [2025-11-28T04:53:55.351Z] [6.371s][info][gc] GC(52) Concurrent thread roots 0.074ms [2025-11-28T04:53:55.351Z] [6.373s][info][gc] GC(52) Concurrent weak references (Young) 1.711ms [2025-11-28T04:53:55.351Z] Allocated: 709 Mb [2025-11-28T04:53:55.351Z] [6.376s][info][gc] GC(52) Concurrent weak roots (Young) 3.515ms [2025-11-28T04:53:55.351Z] [6.376s][info][gc] GC(52) Concurrent cleanup (Young) 807M->807M(1024M) 0.037ms [2025-11-28T04:53:55.351Z] [6.377s][info][gc] GC(52) Concurrent strong roots 0.215ms [2025-11-28T04:53:55.351Z] [6.377s][info][gc] GC(52) Concurrent evacuation 0.184ms [2025-11-28T04:53:55.351Z] Allocated: 733 Mb [2025-11-28T04:53:55.351Z] [6.388s][info][gc] GC(52) Concurrent Init Update Refs (Young) 10.717ms [2025-11-28T04:53:55.351Z] [6.394s][info][gc] GC(52) Verify Before Updating References, Level 4 (21 reachable, 19 marked) [2025-11-28T04:53:55.351Z] [6.394s][info][gc] GC(52) Pause Init Update Refs 6.834ms [2025-11-28T04:53:55.351Z] [6.397s][info][gc] GC(52) Concurrent update references 2.390ms [2025-11-28T04:53:55.351Z] [6.397s][info][gc] Failed to allocate Shared, 60361K [2025-11-28T04:53:55.351Z] [6.397s][info][gc] GC(52) Concurrent update thread roots 0.191ms [2025-11-28T04:53:55.351Z] [6.397s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.351Z] [6.412s][info][gc] GC(53) Verify Before Full GC, Level 4 (34343 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.721s][info][gc] GC(53) Verify After Full GC, Level 4 (34239 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.721s][info][gc] GC(53) Pause Full 807M->678M(1024M) 323.586ms [2025-11-28T04:53:55.351Z] Allocated: 731 Mb [2025-11-28T04:53:55.351Z] Allocated: 748 Mb [2025-11-28T04:53:55.351Z] Allocated: 675 Mb [2025-11-28T04:53:55.351Z] [6.769s][info][gc] Trigger (Young): Free (99072K) is below minimum threshold (102M) [2025-11-28T04:53:55.351Z] [6.770s][info][gc] GC(54) Concurrent reset (Young) 0.751ms [2025-11-28T04:53:55.351Z] [6.792s][info][gc] GC(54) Verify Before Mark, Level 4 (20 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.792s][info][gc] GC(54) Pause Init Mark (Young) 7.758ms [2025-11-28T04:53:55.351Z] [6.792s][info][gc] GC(54) Concurrent remembered set scanning 0.206ms [2025-11-28T04:53:55.351Z] [6.793s][info][gc] GC(54) Concurrent marking roots 0.226ms [2025-11-28T04:53:55.351Z] [6.796s][info][gc] GC(54) Concurrent marking (Young) 3.320ms [2025-11-28T04:53:55.351Z] [6.805s][info][gc] GC(54) Verify After Mark, Level 4 (21 reachable, 5 marked) [2025-11-28T04:53:55.351Z] [6.805s][info][gc] GC(54) Pause Final Mark (Young) 8.453ms [2025-11-28T04:53:55.351Z] [6.805s][info][gc] GC(54) Concurrent weak references (Young) 0.018ms [2025-11-28T04:53:55.351Z] Allocated: 725 Mb [2025-11-28T04:53:55.351Z] [6.805s][info][gc] GC(54) Concurrent weak roots (Young) 0.331ms [2025-11-28T04:53:55.351Z] [6.805s][info][gc] GC(54) Concurrent cleanup (Young) 732M->790M(1024M) 0.077ms [2025-11-28T04:53:55.351Z] Allocated: 736 Mb [2025-11-28T04:53:55.351Z] [6.824s][info][gc] GC(54) Concurrent Final Roots (Young) 18.355ms [2025-11-28T04:53:55.351Z] Allocated: 689 Mb [2025-11-28T04:53:55.351Z] [6.830s][info][gc] GC(54) Concurrent reset after collect (Young) 5.973ms [2025-11-28T04:53:55.351Z] [6.830s][info][gc] Trigger (Young): Average GC time (70.77 ms) is above the time for average allocation rate (2558 MB/s) to deplete free headroom (96051K) (margin of error = 1.81) [2025-11-28T04:53:55.351Z] [6.831s][info][gc] GC(55) Concurrent reset (Young) 0.765ms [2025-11-28T04:53:55.351Z] [6.843s][info][gc] GC(55) Verify Before Mark, Level 4 (21 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [6.843s][info][gc] GC(55) Pause Init Mark (Young) 8.827ms [2025-11-28T04:53:55.351Z] [6.843s][info][gc] GC(55) Concurrent remembered set scanning 0.199ms [2025-11-28T04:53:55.351Z] [6.843s][info][gc] GC(55) Concurrent marking roots 0.249ms [2025-11-28T04:53:55.351Z] Allocated: 722 Mb [2025-11-28T04:53:55.351Z] [6.847s][info][gc] GC(55) Concurrent marking (Young) 3.834ms [2025-11-28T04:53:55.351Z] [6.873s][info][gc] GC(55) Verify After Mark, Level 4 (18 reachable, 10 marked) [2025-11-28T04:53:55.351Z] [6.873s][info][gc] GC(55) Pause Final Mark (Young) 9.542ms [2025-11-28T04:53:55.351Z] [6.873s][info][gc] GC(55) Concurrent weak references (Young) 0.020ms [2025-11-28T04:53:55.351Z] Allocated: 726 Mb [2025-11-28T04:53:55.351Z] [6.873s][info][gc] Failed to allocate Shared, 50632K [2025-11-28T04:53:55.351Z] [6.873s][info][gc] GC(55) Concurrent weak roots (Young) 0.180ms [2025-11-28T04:53:55.351Z] [6.873s][info][gc] GC(55) Concurrent cleanup (Young) 773M->773M(1024M) 0.056ms [2025-11-28T04:53:55.351Z] [6.873s][info][gc] GC(55) Concurrent Final Roots (Young) 0.084ms [2025-11-28T04:53:55.351Z] [6.878s][info][gc] GC(55) Concurrent reset after collect (Young) 4.394ms [2025-11-28T04:53:55.351Z] [6.878s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.351Z] [6.890s][info][gc] GC(56) Verify Before Full GC, Level 4 (34341 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [7.309s][info][gc] GC(56) Verify After Full GC, Level 4 (34237 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [7.309s][info][gc] GC(56) Pause Full 773M->673M(1024M) 430.283ms [2025-11-28T04:53:55.351Z] Allocated: 717 Mb [2025-11-28T04:53:55.351Z] Allocated: 737 Mb [2025-11-28T04:53:55.351Z] Allocated: 712 Mb [2025-11-28T04:53:55.351Z] Allocated: 697 Mb [2025-11-28T04:53:55.351Z] Allocated: 751 Mb [2025-11-28T04:53:55.351Z] [7.382s][info][gc] Trigger (Young): Free (95487K) is below minimum threshold (102M) [2025-11-28T04:53:55.351Z] [7.383s][info][gc] GC(57) Concurrent reset (Young) 0.787ms [2025-11-28T04:53:55.351Z] [7.388s][info][gc] GC(57) Verify Before Mark, Level 4 (18 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [7.388s][info][gc] GC(57) Pause Init Mark (Young) 3.724ms [2025-11-28T04:53:55.351Z] Allocated: 677 Mb [2025-11-28T04:53:55.351Z] Allocated: 682 Mb [2025-11-28T04:53:55.351Z] Allocated: 688 Mb [2025-11-28T04:53:55.351Z] [7.395s][info][gc] GC(57) Concurrent remembered set scanning 0.276ms [2025-11-28T04:53:55.351Z] [7.395s][info][gc] GC(57) Concurrent marking roots 0.300ms [2025-11-28T04:53:55.351Z] Allocated: 747 Mb [2025-11-28T04:53:55.351Z] [7.416s][info][gc] Failed to allocate Shared, 22702K [2025-11-28T04:53:55.351Z] [7.416s][info][gc] GC(57) Concurrent marking (Young) 20.693ms [2025-11-28T04:53:55.351Z] [7.416s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.351Z] [7.433s][info][gc] GC(58) Verify Before Full GC, Level 4 (34344 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [7.433s][info][gc] GC(58) Cancel marking: Young [2025-11-28T04:53:55.351Z] [7.433s][info][gc] GC(58) Cancel marking: Old [2025-11-28T04:53:55.351Z] [7.433s][info][gc] GC(58) Cancel marking: Global [2025-11-28T04:53:55.351Z] [7.785s][info][gc] GC(58) Verify After Full GC, Level 4 (34240 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [7.785s][info][gc] GC(58) Pause Full 950M->700M(1024M) 368.819ms [2025-11-28T04:53:55.351Z] Allocated: 716 Mb [2025-11-28T04:53:55.351Z] Allocated: 725 Mb [2025-11-28T04:53:55.351Z] Allocated: 730 Mb [2025-11-28T04:53:55.351Z] [7.811s][info][gc] Trigger (Young): Free (93439K) is below minimum threshold (102M) [2025-11-28T04:53:55.351Z] [7.812s][info][gc] GC(59) Concurrent reset (Young) 0.497ms [2025-11-28T04:53:55.351Z] [7.823s][info][gc] GC(59) Verify Before Mark, Level 4 (21 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [7.824s][info][gc] GC(59) Pause Init Mark (Young) 4.099ms [2025-11-28T04:53:55.351Z] Allocated: 724 Mb [2025-11-28T04:53:55.351Z] [7.824s][info][gc] GC(59) Concurrent remembered set scanning 0.196ms [2025-11-28T04:53:55.351Z] [7.824s][info][gc] GC(59) Concurrent marking roots 0.212ms [2025-11-28T04:53:55.351Z] [7.825s][info][gc] GC(59) Concurrent marking (Young) 0.223ms [2025-11-28T04:53:55.351Z] [7.830s][info][gc] GC(59) Verify After Mark, Level 4 (22 reachable, 5 marked) [2025-11-28T04:53:55.351Z] [7.830s][info][gc] GC(59) Pause Final Mark (Young) 5.105ms [2025-11-28T04:53:55.351Z] [7.830s][info][gc] GC(59) Concurrent weak references (Young) 0.017ms [2025-11-28T04:53:55.351Z] Allocated: 692 Mb [2025-11-28T04:53:55.351Z] [7.835s][info][gc] GC(59) Concurrent weak roots (Young) 5.365ms [2025-11-28T04:53:55.351Z] [7.835s][info][gc] GC(59) Concurrent cleanup (Young) 816M->816M(1024M) 0.072ms [2025-11-28T04:53:55.351Z] Allocated: 754 Mb [2025-11-28T04:53:55.351Z] [7.847s][info][gc] GC(59) Concurrent Final Roots (Young) 11.467ms [2025-11-28T04:53:55.351Z] Allocated: 708 Mb [2025-11-28T04:53:55.351Z] [7.855s][info][gc] GC(59) Concurrent reset after collect (Young) 7.958ms [2025-11-28T04:53:55.351Z] [7.856s][info][gc] Trigger (Young): Average GC time (57.90 ms) is above the time for average allocation rate (3557 MB/s) to deplete free headroom (67891K) (margin of error = 1.80) [2025-11-28T04:53:55.351Z] [7.857s][info][gc] GC(60) Concurrent reset (Young) 0.480ms [2025-11-28T04:53:55.351Z] [7.863s][info][gc] GC(60) Verify Before Mark, Level 4 (22 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [7.863s][info][gc] GC(60) Pause Init Mark (Young) 3.924ms [2025-11-28T04:53:55.351Z] Allocated: 716 Mb [2025-11-28T04:53:55.351Z] [7.864s][info][gc] GC(60) Concurrent remembered set scanning 0.219ms [2025-11-28T04:53:55.351Z] [7.864s][info][gc] GC(60) Concurrent marking roots 0.193ms [2025-11-28T04:53:55.351Z] Allocated: 694 Mb [2025-11-28T04:53:55.351Z] [7.872s][info][gc] GC(60) Concurrent marking (Young) 7.478ms [2025-11-28T04:53:55.351Z] [7.876s][info][gc] GC(60) Verify After Mark, Level 4 (23 reachable, 14 marked) [2025-11-28T04:53:55.351Z] [7.876s][info][gc] GC(60) Pause Final Mark (Young) 4.119ms [2025-11-28T04:53:55.351Z] [7.876s][info][gc] GC(60) Concurrent weak references (Young) 0.027ms [2025-11-28T04:53:55.351Z] [7.876s][info][gc] GC(60) Concurrent weak roots (Young) 0.147ms [2025-11-28T04:53:55.351Z] Allocated: 698 Mb [2025-11-28T04:53:55.351Z] [7.876s][info][gc] GC(60) Concurrent cleanup (Young) 761M->774M(1024M) 0.052ms [2025-11-28T04:53:55.351Z] Allocated: 711 Mb [2025-11-28T04:53:55.351Z] [7.883s][info][gc] GC(60) Concurrent Final Roots (Young) 6.917ms [2025-11-28T04:53:55.351Z] Allocated: 697 Mb [2025-11-28T04:53:55.351Z] [7.894s][info][gc] GC(60) Concurrent reset after collect (Young) 10.201ms [2025-11-28T04:53:55.351Z] Allocated: 715 Mb [2025-11-28T04:53:55.351Z] Allocated: 649 Mb [2025-11-28T04:53:55.351Z] Allocated: 666 Mb [2025-11-28T04:53:55.351Z] Allocated: 699 Mb [2025-11-28T04:53:55.351Z] [7.905s][info][gc] Failed to allocate Shared, 23736K [2025-11-28T04:53:55.351Z] [7.927s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.351Z] [7.936s][info][gc] GC(61) Verify Before Full GC, Level 4 (34349 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [8.139s][info][gc] GC(61) Verify After Full GC, Level 4 (34245 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [8.139s][info][gc] GC(61) Pause Full 898M->706M(1024M) 211.983ms [2025-11-28T04:53:55.351Z] Allocated: 722 Mb [2025-11-28T04:53:55.351Z] Allocated: 695 Mb [2025-11-28T04:53:55.351Z] Allocated: 712 Mb [2025-11-28T04:53:55.351Z] Allocated: 677 Mb [2025-11-28T04:53:55.351Z] Allocated: 737 Mb [2025-11-28T04:53:55.351Z] [8.166s][info][gc] Trigger (Young): Average GC time (53.82 ms) is above the time for average allocation rate (1427 MB/s) to deplete free headroom (77875K) (margin of error = 1.81) [2025-11-28T04:53:55.351Z] [8.167s][info][gc] GC(62) Concurrent reset (Young) 0.529ms [2025-11-28T04:53:55.351Z] [8.172s][info][gc] GC(62) Verify Before Mark, Level 4 (26 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [8.172s][info][gc] GC(62) Pause Init Mark (Young) 3.978ms [2025-11-28T04:53:55.351Z] Allocated: 695 Mb [2025-11-28T04:53:55.351Z] [8.173s][info][gc] GC(62) Concurrent remembered set scanning 0.197ms [2025-11-28T04:53:55.351Z] [8.173s][info][gc] GC(62) Concurrent marking roots 0.208ms [2025-11-28T04:53:55.351Z] Allocated: 713 Mb [2025-11-28T04:53:55.351Z] [8.179s][info][gc] GC(62) Concurrent marking (Young) 6.003ms [2025-11-28T04:53:55.351Z] [8.195s][info][gc] GC(62) Verify After Mark, Level 4 (25 reachable, 13 marked) [2025-11-28T04:53:55.351Z] [8.195s][info][gc] GC(62) Pause Final Mark (Young) 5.118ms [2025-11-28T04:53:55.351Z] Allocated: 716 Mb [2025-11-28T04:53:55.351Z] [8.195s][info][gc] GC(62) Concurrent weak references (Young) 0.028ms [2025-11-28T04:53:55.351Z] [8.195s][info][gc] GC(62) Concurrent weak roots (Young) 0.174ms [2025-11-28T04:53:55.351Z] [8.195s][info][gc] GC(62) Concurrent cleanup (Young) 781M->781M(1024M) 0.059ms [2025-11-28T04:53:55.351Z] [8.196s][info][gc] GC(62) Concurrent Final Roots (Young) 0.728ms [2025-11-28T04:53:55.351Z] [8.204s][info][gc] GC(62) Concurrent reset after collect (Young) 8.103ms [2025-11-28T04:53:55.351Z] [8.206s][info][gc] Trigger (Young): Average GC time (49.16 ms) is above the time for average allocation rate (2946 MB/s) to deplete free headroom (89395K) (margin of error = 1.81) [2025-11-28T04:53:55.351Z] [8.206s][info][gc] GC(63) Concurrent reset (Young) 0.484ms [2025-11-28T04:53:55.351Z] [8.214s][info][gc] GC(63) Verify Before Mark, Level 4 (25 reachable, 0 marked) [2025-11-28T04:53:55.351Z] [8.214s][info][gc] GC(63) Pause Init Mark (Young) 3.833ms [2025-11-28T04:53:55.351Z] Allocated: 709 Mb [2025-11-28T04:53:55.351Z] [8.215s][info][gc] GC(63) Concurrent remembered set scanning 0.201ms [2025-11-28T04:53:55.352Z] [8.215s][info][gc] GC(63) Concurrent marking roots 0.192ms [2025-11-28T04:53:55.352Z] [8.216s][info][gc] GC(63) Concurrent marking (Young) 0.608ms [2025-11-28T04:53:55.352Z] [8.230s][info][gc] GC(63) Verify Before Evacuation, Level 4 (25 reachable, 7 marked) [2025-11-28T04:53:55.352Z] [8.230s][info][gc] GC(63) Pause Final Mark (Young) 6.841ms [2025-11-28T04:53:55.352Z] Allocated: 701 Mb [2025-11-28T04:53:55.352Z] [8.230s][info][gc] GC(63) Concurrent thread roots 0.073ms [2025-11-28T04:53:55.352Z] [8.230s][info][gc] GC(63) Concurrent weak references (Young) 0.016ms [2025-11-28T04:53:55.352Z] [8.231s][info][gc] GC(63) Concurrent weak roots (Young) 0.071ms [2025-11-28T04:53:55.352Z] [8.231s][info][gc] GC(63) Concurrent cleanup (Young) 755M->755M(1024M) 0.055ms [2025-11-28T04:53:55.352Z] [8.231s][info][gc] GC(63) Concurrent strong roots 0.176ms [2025-11-28T04:53:55.352Z] [8.231s][info][gc] GC(63) Concurrent evacuation 0.099ms [2025-11-28T04:53:55.352Z] [8.231s][info][gc] GC(63) Concurrent Init Update Refs (Young) 0.035ms [2025-11-28T04:53:55.352Z] [8.234s][info][gc] GC(63) Verify Before Updating References, Level 4 (26 reachable, 13 marked) [2025-11-28T04:53:55.352Z] [8.234s][info][gc] GC(63) Pause Init Update Refs 3.334ms [2025-11-28T04:53:55.352Z] [8.241s][info][gc] GC(63) Concurrent update references 2.318ms [2025-11-28T04:53:55.352Z] Allocated: 722 Mb [2025-11-28T04:53:55.352Z] [8.248s][info][gc] GC(63) Concurrent update thread roots 7.631ms [2025-11-28T04:53:55.352Z] [8.260s][info][gc] GC(63) Verify After Updating References, Level 4 (24 reachable, 20 marked) [2025-11-28T04:53:55.352Z] [8.260s][info][gc] GC(63) Pause Final Update Refs 4.465ms [2025-11-28T04:53:55.352Z] [8.260s][info][gc] GC(63) Concurrent cleanup (Young) 853M->853M(1024M) 0.024ms [2025-11-28T04:53:55.352Z] Allocated: 731 Mb [2025-11-28T04:53:55.352Z] [8.264s][info][gc] Failed to allocate Shared, 56632K [2025-11-28T04:53:55.352Z] [8.266s][info][gc] GC(63) Concurrent reset after collect (Young) 5.169ms [2025-11-28T04:53:55.352Z] [8.266s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.352Z] [8.274s][info][gc] GC(64) Verify Before Full GC, Level 4 (34347 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.483s][info][gc] GC(64) Verify After Full GC, Level 4 (34243 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.483s][info][gc] GC(64) Pause Full 853M->684M(1024M) 217.112ms [2025-11-28T04:53:55.352Z] Allocated: 732 Mb [2025-11-28T04:53:55.352Z] Allocated: 718 Mb [2025-11-28T04:53:55.352Z] Allocated: 708 Mb [2025-11-28T04:53:55.352Z] [8.510s][info][gc] Trigger (Young): Average GC time (69.15 ms) is above the time for average allocation rate (1367 MB/s) to deplete free headroom (57907K) (margin of error = 1.81) [2025-11-28T04:53:55.352Z] [8.510s][info][gc] GC(65) Concurrent reset (Young) 0.521ms [2025-11-28T04:53:55.352Z] [8.525s][info][gc] GC(65) Verify Before Mark, Level 4 (23 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.525s][info][gc] GC(65) Pause Init Mark (Young) 3.952ms [2025-11-28T04:53:55.352Z] Allocated: 730 Mb [2025-11-28T04:53:55.352Z] [8.527s][info][gc] GC(65) Concurrent remembered set scanning 0.227ms [2025-11-28T04:53:55.352Z] [8.527s][info][gc] GC(65) Concurrent marking roots 0.203ms [2025-11-28T04:53:55.352Z] [8.536s][info][gc] GC(65) Concurrent marking (Young) 8.711ms [2025-11-28T04:53:55.352Z] [8.542s][info][gc] GC(65) Verify After Mark, Level 4 (23 reachable, 10 marked) [2025-11-28T04:53:55.352Z] [8.542s][info][gc] GC(65) Pause Final Mark (Young) 6.405ms [2025-11-28T04:53:55.352Z] Allocated: 695 Mb [2025-11-28T04:53:55.352Z] [8.546s][info][gc] GC(65) Concurrent weak references (Young) 0.024ms [2025-11-28T04:53:55.352Z] Allocated: 728 Mb [2025-11-28T04:53:55.352Z] [8.550s][info][gc] GC(65) Concurrent weak roots (Young) 4.073ms [2025-11-28T04:53:55.352Z] [8.551s][info][gc] GC(65) Concurrent cleanup (Young) 819M->819M(1024M) 0.095ms [2025-11-28T04:53:55.352Z] Allocated: 693 Mb [2025-11-28T04:53:55.352Z] Allocated: 696 Mb [2025-11-28T04:53:55.352Z] [8.556s][info][gc] GC(65) Concurrent Final Roots (Young) 5.451ms [2025-11-28T04:53:55.352Z] [8.563s][info][gc] GC(65) Concurrent reset after collect (Young) 7.250ms [2025-11-28T04:53:55.352Z] [8.564s][info][gc] Trigger (Young): Average GC time (65.76 ms) is above the time for average allocation rate (3217 MB/s) to deplete free headroom (52531K) (margin of error = 1.83) [2025-11-28T04:53:55.352Z] [8.565s][info][gc] GC(66) Concurrent reset (Young) 0.486ms [2025-11-28T04:53:55.352Z] [8.574s][info][gc] GC(66) Verify Before Mark, Level 4 (25 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.574s][info][gc] GC(66) Pause Init Mark (Young) 4.023ms [2025-11-28T04:53:55.352Z] Allocated: 744 Mb [2025-11-28T04:53:55.352Z] [8.577s][info][gc] GC(66) Concurrent remembered set scanning 2.032ms [2025-11-28T04:53:55.352Z] [8.577s][info][gc] GC(66) Concurrent marking roots 0.243ms [2025-11-28T04:53:55.352Z] Allocated: 712 Mb [2025-11-28T04:53:55.352Z] [8.580s][info][gc] Failed to allocate Shared, 53874K [2025-11-28T04:53:55.352Z] [8.580s][info][gc] GC(66) Concurrent marking (Young) 3.359ms [2025-11-28T04:53:55.352Z] [8.580s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.352Z] [8.589s][info][gc] GC(67) Verify Before Full GC, Level 4 (34348 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.589s][info][gc] GC(67) Cancel marking: Young [2025-11-28T04:53:55.352Z] [8.589s][info][gc] GC(67) Cancel marking: Old [2025-11-28T04:53:55.352Z] [8.589s][info][gc] GC(67) Cancel marking: Global [2025-11-28T04:53:55.352Z] [8.798s][info][gc] GC(67) Verify After Full GC, Level 4 (34244 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.798s][info][gc] GC(67) Pause Full 892M->666M(1024M) 217.922ms [2025-11-28T04:53:55.352Z] Allocated: 712 Mb [2025-11-28T04:53:55.352Z] Allocated: 726 Mb [2025-11-28T04:53:55.352Z] Allocated: 725 Mb [2025-11-28T04:53:55.352Z] Allocated: 692 Mb [2025-11-28T04:53:55.352Z] [8.828s][info][gc] Trigger (Young): Average GC time (65.76 ms) is above the time for average allocation rate (1127 MB/s) to deplete free headroom (63539K) (margin of error = 1.83) [2025-11-28T04:53:55.352Z] [8.829s][info][gc] GC(68) Concurrent reset (Young) 0.501ms [2025-11-28T04:53:55.352Z] [8.838s][info][gc] GC(68) Verify Before Mark, Level 4 (24 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.838s][info][gc] GC(68) Pause Init Mark (Young) 3.945ms [2025-11-28T04:53:55.352Z] Allocated: 723 Mb [2025-11-28T04:53:55.352Z] [8.839s][info][gc] GC(68) Concurrent remembered set scanning 0.193ms [2025-11-28T04:53:55.352Z] [8.839s][info][gc] GC(68) Concurrent marking roots 0.205ms [2025-11-28T04:53:55.352Z] [8.839s][info][gc] GC(68) Concurrent marking (Young) 0.209ms [2025-11-28T04:53:55.352Z] [8.845s][info][gc] GC(68) Verify After Mark, Level 4 (25 reachable, 5 marked) [2025-11-28T04:53:55.352Z] [8.845s][info][gc] GC(68) Pause Final Mark (Young) 5.304ms [2025-11-28T04:53:55.352Z] [8.848s][info][gc] GC(68) Concurrent weak references (Young) 0.021ms [2025-11-28T04:53:55.352Z] Allocated: 733 Mb [2025-11-28T04:53:55.352Z] [8.857s][info][gc] GC(68) Concurrent weak roots (Young) 8.621ms [2025-11-28T04:53:55.352Z] [8.857s][info][gc] GC(68) Concurrent cleanup (Young) 838M->838M(1024M) 0.099ms [2025-11-28T04:53:55.352Z] Allocated: 732 Mb [2025-11-28T04:53:55.352Z] [8.867s][info][gc] GC(68) Concurrent Final Roots (Young) 9.774ms [2025-11-28T04:53:55.352Z] Allocated: 716 Mb [2025-11-28T04:53:55.352Z] [8.875s][info][gc] GC(68) Concurrent reset after collect (Young) 7.978ms [2025-11-28T04:53:55.352Z] [8.876s][info][gc] Trigger (Young): Free (55296K) is below minimum threshold (102M) [2025-11-28T04:53:55.352Z] [8.877s][info][gc] GC(69) Concurrent reset (Young) 0.482ms [2025-11-28T04:53:55.352Z] [8.890s][info][gc] GC(69) Verify Before Mark, Level 4 (21 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [8.890s][info][gc] GC(69) Pause Init Mark (Young) 3.980ms [2025-11-28T04:53:55.352Z] Allocated: 738 Mb [2025-11-28T04:53:55.352Z] [8.891s][info][gc] GC(69) Concurrent remembered set scanning 0.220ms [2025-11-28T04:53:55.352Z] [8.891s][info][gc] GC(69) Concurrent marking roots 0.197ms [2025-11-28T04:53:55.352Z] [8.891s][info][gc] GC(69) Concurrent marking (Young) 0.198ms [2025-11-28T04:53:55.352Z] [8.896s][info][gc] GC(69) Verify After Mark, Level 4 (22 reachable, 5 marked) [2025-11-28T04:53:55.352Z] [8.896s][info][gc] GC(69) Pause Final Mark (Young) 4.655ms [2025-11-28T04:53:55.352Z] [8.896s][info][gc] Failed to allocate Shared, 30450K [2025-11-28T04:53:55.352Z] [8.896s][info][gc] GC(69) Concurrent weak references (Young) 0.014ms [2025-11-28T04:53:55.352Z] [8.896s][info][gc] GC(69) Concurrent weak roots (Young) 0.163ms [2025-11-28T04:53:55.352Z] [8.896s][info][gc] GC(69) Concurrent cleanup (Young) 744M->744M(1024M) 0.046ms [2025-11-28T04:53:55.352Z] [8.896s][info][gc] GC(69) Concurrent Final Roots (Young) 0.060ms [2025-11-28T04:53:55.352Z] [8.901s][info][gc] GC(69) Concurrent reset after collect (Young) 4.504ms [2025-11-28T04:53:55.352Z] [8.901s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.352Z] [8.911s][info][gc] GC(70) Verify Before Full GC, Level 4 (34343 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.130s][info][gc] GC(70) Verify After Full GC, Level 4 (34239 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.130s][info][gc] GC(70) Pause Full 744M->653M(1024M) 228.489ms [2025-11-28T04:53:55.352Z] Allocated: 678 Mb [2025-11-28T04:53:55.352Z] Allocated: 739 Mb [2025-11-28T04:53:55.352Z] Allocated: 697 Mb [2025-11-28T04:53:55.352Z] Allocated: 731 Mb [2025-11-28T04:53:55.352Z] Allocated: 747 Mb [2025-11-28T04:53:55.352Z] Allocated: 676 Mb [2025-11-28T04:53:55.352Z] [9.166s][info][gc] Trigger (Young): Free (102M) is below minimum threshold (102M) [2025-11-28T04:53:55.352Z] [9.167s][info][gc] GC(71) Concurrent reset (Young) 0.493ms [2025-11-28T04:53:55.352Z] [9.174s][info][gc] GC(71) Verify Before Mark, Level 4 (21 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.174s][info][gc] GC(71) Pause Init Mark (Young) 3.942ms [2025-11-28T04:53:55.352Z] Allocated: 693 Mb [2025-11-28T04:53:55.352Z] [9.175s][info][gc] GC(71) Concurrent remembered set scanning 0.195ms [2025-11-28T04:53:55.352Z] [9.175s][info][gc] GC(71) Concurrent marking roots 0.198ms [2025-11-28T04:53:55.352Z] Allocated: 721 Mb [2025-11-28T04:53:55.352Z] [9.181s][info][gc] GC(71) Concurrent marking (Young) 5.915ms [2025-11-28T04:53:55.352Z] [9.191s][info][gc] GC(71) Verify After Mark, Level 4 (21 reachable, 12 marked) [2025-11-28T04:53:55.352Z] [9.191s][info][gc] GC(71) Pause Final Mark (Young) 4.783ms [2025-11-28T04:53:55.352Z] Allocated: 683 Mb [2025-11-28T04:53:55.352Z] [9.191s][info][gc] GC(71) Concurrent weak references (Young) 0.017ms [2025-11-28T04:53:55.352Z] [9.191s][info][gc] GC(71) Concurrent weak roots (Young) 0.086ms [2025-11-28T04:53:55.352Z] [9.191s][info][gc] GC(71) Concurrent cleanup (Young) 752M->752M(1024M) 0.081ms [2025-11-28T04:53:55.352Z] [9.192s][info][gc] GC(71) Concurrent Final Roots (Young) 0.806ms [2025-11-28T04:53:55.352Z] [9.201s][info][gc] GC(71) Concurrent reset after collect (Young) 8.380ms [2025-11-28T04:53:55.352Z] [9.202s][info][gc] Trigger (Young): Average GC time (52.72 ms) is above the time for average allocation rate (3366 MB/s) to deplete free headroom (113M) (margin of error = 1.86) [2025-11-28T04:53:55.352Z] [9.202s][info][gc] GC(72) Concurrent reset (Young) 0.486ms [2025-11-28T04:53:55.352Z] [9.210s][info][gc] GC(72) Verify Before Mark, Level 4 (22 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.210s][info][gc] GC(72) Pause Init Mark (Young) 3.953ms [2025-11-28T04:53:55.352Z] Allocated: 738 Mb [2025-11-28T04:53:55.352Z] [9.211s][info][gc] GC(72) Concurrent remembered set scanning 0.214ms [2025-11-28T04:53:55.352Z] [9.211s][info][gc] GC(72) Concurrent marking roots 0.210ms [2025-11-28T04:53:55.352Z] [9.211s][info][gc] GC(72) Concurrent marking (Young) 0.234ms [2025-11-28T04:53:55.352Z] [9.215s][info][gc] GC(72) Verify After Mark, Level 4 (23 reachable, 5 marked) [2025-11-28T04:53:55.352Z] [9.216s][info][gc] GC(72) Pause Final Mark (Young) 4.036ms [2025-11-28T04:53:55.352Z] Allocated: 695 Mb [2025-11-28T04:53:55.352Z] [9.219s][info][gc] GC(72) Concurrent weak references (Young) 0.026ms [2025-11-28T04:53:55.352Z] Allocated: 725 Mb [2025-11-28T04:53:55.352Z] [9.225s][info][gc] GC(72) Concurrent weak roots (Young) 5.379ms [2025-11-28T04:53:55.352Z] [9.225s][info][gc] GC(72) Concurrent cleanup (Young) 850M->850M(1024M) 0.080ms [2025-11-28T04:53:55.352Z] Allocated: 726 Mb [2025-11-28T04:53:55.352Z] [9.236s][info][gc] GC(72) Concurrent Final Roots (Young) 10.811ms [2025-11-28T04:53:55.352Z] [9.244s][info][gc] GC(72) Concurrent reset after collect (Young) 8.175ms [2025-11-28T04:53:55.352Z] [9.245s][info][gc] Trigger (Young): Free (82176K) is below minimum threshold (102M) [2025-11-28T04:53:55.352Z] [9.245s][info][gc] GC(73) Concurrent reset (Young) 0.501ms [2025-11-28T04:53:55.352Z] [9.254s][info][gc] GC(73) Verify Before Mark, Level 4 (20 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.254s][info][gc] GC(73) Pause Init Mark (Young) 3.987ms [2025-11-28T04:53:55.352Z] Allocated: 725 Mb [2025-11-28T04:53:55.352Z] [9.254s][info][gc] GC(73) Concurrent remembered set scanning 0.223ms [2025-11-28T04:53:55.352Z] [9.255s][info][gc] GC(73) Concurrent marking roots 0.192ms [2025-11-28T04:53:55.352Z] [9.255s][info][gc] GC(73) Concurrent marking (Young) 0.209ms [2025-11-28T04:53:55.352Z] [9.259s][info][gc] GC(73) Verify After Mark, Level 4 (21 reachable, 5 marked) [2025-11-28T04:53:55.352Z] [9.260s][info][gc] GC(73) Pause Final Mark (Young) 4.696ms [2025-11-28T04:53:55.352Z] Allocated: 699 Mb [2025-11-28T04:53:55.352Z] [9.260s][info][gc] GC(73) Concurrent weak references (Young) 0.018ms [2025-11-28T04:53:55.352Z] [9.261s][info][gc] GC(73) Concurrent weak roots (Young) 0.068ms [2025-11-28T04:53:55.352Z] [9.261s][info][gc] GC(73) Concurrent cleanup (Young) 736M->736M(1024M) 0.042ms [2025-11-28T04:53:55.352Z] [9.261s][info][gc] GC(73) Concurrent Final Roots (Young) 0.066ms [2025-11-28T04:53:55.352Z] [9.269s][info][gc] GC(73) Concurrent reset after collect (Young) 8.212ms [2025-11-28T04:53:55.352Z] Allocated: 727 Mb [2025-11-28T04:53:55.352Z] [9.270s][info][gc] Trigger (Young): Average GC time (48.19 ms) is above the time for average allocation rate (3323 MB/s) to deplete free headroom (156M) (margin of error = 1.87) [2025-11-28T04:53:55.352Z] [9.271s][info][gc] GC(74) Concurrent reset (Young) 0.477ms [2025-11-28T04:53:55.352Z] [9.275s][info][gc] GC(74) Verify Before Mark, Level 4 (22 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.275s][info][gc] GC(74) Pause Init Mark (Young) 3.806ms [2025-11-28T04:53:55.352Z] [9.278s][info][gc] GC(74) Concurrent remembered set scanning 0.232ms [2025-11-28T04:53:55.352Z] [9.278s][info][gc] GC(74) Concurrent marking roots 0.257ms [2025-11-28T04:53:55.352Z] Allocated: 714 Mb [2025-11-28T04:53:55.352Z] Allocated: 706 Mb [2025-11-28T04:53:55.352Z] [9.291s][info][gc] GC(74) Concurrent marking (Young) 12.940ms [2025-11-28T04:53:55.352Z] [9.304s][info][gc] GC(74) Verify Before Evacuation, Level 4 (20 reachable, 15 marked) [2025-11-28T04:53:55.352Z] [9.304s][info][gc] GC(74) Pause Final Mark (Young) 6.576ms [2025-11-28T04:53:55.352Z] Allocated: 723 Mb [2025-11-28T04:53:55.352Z] [9.306s][info][gc] GC(74) Concurrent thread roots 0.082ms [2025-11-28T04:53:55.352Z] [9.306s][info][gc] GC(74) Concurrent weak references (Young) 0.012ms [2025-11-28T04:53:55.352Z] [9.311s][info][gc] GC(74) Concurrent weak roots (Young) 5.378ms [2025-11-28T04:53:55.352Z] [9.311s][info][gc] GC(74) Concurrent cleanup (Young) 856M->856M(1024M) 0.073ms [2025-11-28T04:53:55.352Z] [9.311s][info][gc] GC(74) Concurrent strong roots 0.246ms [2025-11-28T04:53:55.352Z] [9.312s][info][gc] GC(74) Concurrent evacuation 0.146ms [2025-11-28T04:53:55.352Z] Allocated: 720 Mb [2025-11-28T04:53:55.352Z] [9.312s][info][gc] GC(74) Concurrent Init Update Refs (Young) 0.130ms [2025-11-28T04:53:55.352Z] [9.315s][info][gc] GC(74) Verify Before Updating References, Level 4 (21 reachable, 28 marked) [2025-11-28T04:53:55.352Z] [9.316s][info][gc] GC(74) Pause Init Update Refs 3.688ms [2025-11-28T04:53:55.352Z] [9.322s][info][gc] GC(74) Concurrent update references 2.318ms [2025-11-28T04:53:55.352Z] Allocated: 693 Mb [2025-11-28T04:53:55.352Z] [9.325s][info][gc] Failed to allocate Shared, 46417K [2025-11-28T04:53:55.352Z] [9.325s][info][gc] GC(74) Concurrent update thread roots 3.218ms [2025-11-28T04:53:55.352Z] [9.325s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.352Z] [9.334s][info][gc] GC(75) Verify Before Full GC, Level 4 (34344 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.628s][info][gc] GC(75) Verify After Full GC, Level 4 (34240 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.628s][info][gc] GC(75) Pause Full 892M->701M(1024M) 303.117ms [2025-11-28T04:53:55.352Z] Allocated: 739 Mb [2025-11-28T04:53:55.352Z] Allocated: 713 Mb [2025-11-28T04:53:55.352Z] Allocated: 714 Mb [2025-11-28T04:53:55.352Z] [9.656s][info][gc] Trigger (Young): Average GC time (48.19 ms) is above the time for average allocation rate (1438 MB/s) to deplete free headroom (65587K) (margin of error = 1.87) [2025-11-28T04:53:55.352Z] [9.657s][info][gc] GC(76) Concurrent reset (Young) 0.525ms [2025-11-28T04:53:55.352Z] [9.661s][info][gc] GC(76) Verify Before Mark, Level 4 (20 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.662s][info][gc] GC(76) Pause Init Mark (Young) 3.909ms [2025-11-28T04:53:55.352Z] Allocated: 668 Mb [2025-11-28T04:53:55.352Z] [9.662s][info][gc] GC(76) Concurrent remembered set scanning 0.176ms [2025-11-28T04:53:55.352Z] [9.662s][info][gc] GC(76) Concurrent marking roots 0.219ms [2025-11-28T04:53:55.352Z] Allocated: 679 Mb [2025-11-28T04:53:55.352Z] [9.665s][info][gc] GC(76) Concurrent marking (Young) 2.374ms [2025-11-28T04:53:55.352Z] [9.669s][info][gc] GC(76) Verify After Mark, Level 4 (22 reachable, 9 marked) [2025-11-28T04:53:55.352Z] [9.669s][info][gc] GC(76) Pause Final Mark (Young) 3.861ms [2025-11-28T04:53:55.352Z] [9.672s][info][gc] GC(76) Concurrent weak references (Young) 0.022ms [2025-11-28T04:53:55.352Z] Allocated: 716 Mb [2025-11-28T04:53:55.352Z] [9.677s][info][gc] GC(76) Concurrent weak roots (Young) 4.340ms [2025-11-28T04:53:55.352Z] [9.677s][info][gc] GC(76) Concurrent cleanup (Young) 742M->742M(1024M) 0.087ms [2025-11-28T04:53:55.352Z] Allocated: 686 Mb [2025-11-28T04:53:55.352Z] [9.680s][info][gc] GC(76) Concurrent Final Roots (Young) 3.217ms [2025-11-28T04:53:55.352Z] [9.687s][info][gc] GC(76) Concurrent reset after collect (Young) 7.305ms [2025-11-28T04:53:55.352Z] Allocated: 712 Mb [2025-11-28T04:53:55.352Z] [9.689s][info][gc] Trigger (Young): Average GC time (43.02 ms) is above the time for average allocation rate (2887 MB/s) to deplete free headroom (108M) (margin of error = 1.86) [2025-11-28T04:53:55.352Z] [9.690s][info][gc] GC(77) Concurrent reset (Young) 0.459ms [2025-11-28T04:53:55.352Z] [9.702s][info][gc] GC(77) Verify Before Mark, Level 4 (22 reachable, 0 marked) [2025-11-28T04:53:55.352Z] [9.702s][info][gc] GC(77) Pause Init Mark (Young) 3.943ms [2025-11-28T04:53:55.352Z] Allocated: 696 Mb [2025-11-28T04:53:55.352Z] [9.703s][info][gc] GC(77) Concurrent remembered set scanning 0.209ms [2025-11-28T04:53:55.352Z] [9.703s][info][gc] GC(77) Concurrent marking roots 0.196ms [2025-11-28T04:53:55.352Z] [9.703s][info][gc] GC(77) Concurrent marking (Young) 0.239ms [2025-11-28T04:53:55.352Z] [9.707s][info][gc] GC(77) Verify After Mark, Level 4 (23 reachable, 5 marked) [2025-11-28T04:53:55.352Z] [9.707s][info][gc] GC(77) Pause Final Mark (Young) 3.988ms [2025-11-28T04:53:55.352Z] [9.711s][info][gc] GC(77) Concurrent weak references (Young) 0.023ms [2025-11-28T04:53:55.352Z] Allocated: 755 Mb [2025-11-28T04:53:55.352Z] [9.720s][info][gc] GC(77) Concurrent weak roots (Young) 8.675ms [2025-11-28T04:53:55.353Z] [9.720s][info][gc] GC(77) Concurrent cleanup (Young) 771M->771M(1024M) 0.105ms [2025-11-28T04:53:55.353Z] Allocated: 690 Mb [2025-11-28T04:53:55.353Z] Allocated: 693 Mb [2025-11-28T04:53:55.353Z] [9.722s][info][gc] GC(77) Concurrent Final Roots (Young) 2.230ms [2025-11-28T04:53:55.353Z] [9.730s][info][gc] GC(77) Concurrent reset after collect (Young) 7.231ms [2025-11-28T04:53:55.353Z] Allocated: 718 Mb [2025-11-28T04:53:55.353Z] [9.732s][info][gc] Trigger (Young): Average GC time (47.93 ms) is above the time for average allocation rate (3523 MB/s) to deplete free headroom (102M) (margin of error = 1.85) [2025-11-28T04:53:55.353Z] [9.732s][info][gc] GC(78) Concurrent reset (Young) 0.478ms [2025-11-28T04:53:55.353Z] [9.740s][info][gc] GC(78) Verify Before Mark, Level 4 (22 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [9.740s][info][gc] GC(78) Pause Init Mark (Young) 3.883ms [2025-11-28T04:53:55.353Z] Allocated: 686 Mb [2025-11-28T04:53:55.353Z] [9.741s][info][gc] GC(78) Concurrent remembered set scanning 0.210ms [2025-11-28T04:53:55.353Z] [9.741s][info][gc] GC(78) Concurrent marking roots 0.197ms [2025-11-28T04:53:55.353Z] [9.741s][info][gc] GC(78) Concurrent marking (Young) 0.216ms [2025-11-28T04:53:55.353Z] [9.746s][info][gc] GC(78) Verify After Mark, Level 4 (23 reachable, 5 marked) [2025-11-28T04:53:55.353Z] [9.746s][info][gc] GC(78) Pause Final Mark (Young) 4.836ms [2025-11-28T04:53:55.353Z] Allocated: 691 Mb [2025-11-28T04:53:55.353Z] [9.747s][info][gc] GC(78) Concurrent weak references (Young) 0.020ms [2025-11-28T04:53:55.353Z] [9.747s][info][gc] GC(78) Concurrent weak roots (Young) 0.088ms [2025-11-28T04:53:55.353Z] [9.747s][info][gc] GC(78) Concurrent cleanup (Young) 699M->699M(1024M) 0.041ms [2025-11-28T04:53:55.353Z] [9.747s][info][gc] GC(78) Concurrent Final Roots (Young) 0.056ms [2025-11-28T04:53:55.353Z] Allocated: 696 Mb [2025-11-28T04:53:55.353Z] Allocated: 722 Mb [2025-11-28T04:53:55.353Z] [9.757s][info][gc] GC(78) Concurrent reset after collect (Young) 9.818ms [2025-11-28T04:53:55.353Z] Allocated: 702 Mb [2025-11-28T04:53:55.353Z] [9.765s][info][gc] Trigger (Young): Average GC time (43.71 ms) is above the time for average allocation rate (3120 MB/s) to deplete free headroom (129M) (margin of error = 1.83) [2025-11-28T04:53:55.353Z] [9.765s][info][gc] GC(79) Concurrent reset (Young) 0.506ms [2025-11-28T04:53:55.353Z] [9.774s][info][gc] GC(79) Verify Before Mark, Level 4 (23 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [9.774s][info][gc] GC(79) Pause Init Mark (Young) 3.953ms [2025-11-28T04:53:55.353Z] Allocated: 687 Mb [2025-11-28T04:53:55.353Z] [9.774s][info][gc] GC(79) Concurrent remembered set scanning 0.201ms [2025-11-28T04:53:55.353Z] [9.775s][info][gc] GC(79) Concurrent marking roots 0.224ms [2025-11-28T04:53:55.353Z] [9.775s][info][gc] GC(79) Concurrent marking (Young) 0.200ms [2025-11-28T04:53:55.353Z] [9.779s][info][gc] GC(79) Verify Before Evacuation, Level 4 (24 reachable, 5 marked) [2025-11-28T04:53:55.353Z] [9.779s][info][gc] GC(79) Pause Final Mark (Young) 4.622ms [2025-11-28T04:53:55.353Z] [9.781s][info][gc] GC(79) Concurrent thread roots 0.062ms [2025-11-28T04:53:55.353Z] [9.781s][info][gc] GC(79) Concurrent weak references (Young) 0.015ms [2025-11-28T04:53:55.353Z] [9.781s][info][gc] GC(79) Concurrent weak roots (Young) 0.400ms [2025-11-28T04:53:55.353Z] [9.781s][info][gc] GC(79) Concurrent cleanup (Young) 702M->702M(1024M) 0.034ms [2025-11-28T04:53:55.353Z] [9.781s][info][gc] GC(79) Concurrent strong roots 0.202ms [2025-11-28T04:53:55.353Z] [9.781s][info][gc] GC(79) Concurrent evacuation 0.130ms [2025-11-28T04:53:55.353Z] Allocated: 694 Mb [2025-11-28T04:53:55.353Z] Allocated: 738 Mb [2025-11-28T04:53:55.353Z] [9.790s][info][gc] GC(79) Concurrent Init Update Refs (Young) 8.233ms [2025-11-28T04:53:55.353Z] [9.796s][info][gc] GC(79) Verify Before Updating References, Level 4 (24 reachable, 25 marked) [2025-11-28T04:53:55.353Z] [9.796s][info][gc] GC(79) Pause Init Update Refs 3.858ms [2025-11-28T04:53:55.353Z] Allocated: 682 Mb [2025-11-28T04:53:55.353Z] Allocated: 690 Mb [2025-11-28T04:53:55.353Z] [9.800s][info][gc] GC(79) Concurrent update references 3.970ms [2025-11-28T04:53:55.353Z] [9.800s][info][gc] GC(79) Concurrent update thread roots 0.187ms [2025-11-28T04:53:55.353Z] [9.804s][info][gc] GC(79) Verify After Updating References, Level 4 (26 reachable, 26 marked) [2025-11-28T04:53:55.353Z] [9.804s][info][gc] GC(79) Pause Final Update Refs 4.095ms [2025-11-28T04:53:55.353Z] [9.807s][info][gc] GC(79) Concurrent cleanup (Young) 794M->794M(1024M) 0.035ms [2025-11-28T04:53:55.353Z] Allocated: 719 Mb [2025-11-28T04:53:55.353Z] [9.814s][info][gc] GC(79) Concurrent reset after collect (Young) 7.420ms [2025-11-28T04:53:55.353Z] [9.815s][info][gc] Trigger (Young): Average GC time (58.87 ms) is above the time for average allocation rate (3046 MB/s) to deplete free headroom (101683K) (margin of error = 1.83) [2025-11-28T04:53:55.353Z] [9.818s][info][gc] GC(80) Concurrent reset (Young) 0.786ms [2025-11-28T04:53:55.353Z] Allocated: 671 Mb [2025-11-28T04:53:55.353Z] [9.830s][info][gc] GC(80) Verify Before Mark, Level 4 (25 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [9.830s][info][gc] GC(80) Pause Init Mark (Young) 3.962ms [2025-11-28T04:53:55.353Z] Allocated: 708 Mb [2025-11-28T04:53:55.353Z] [9.830s][info][gc] GC(80) Concurrent remembered set scanning 0.201ms [2025-11-28T04:53:55.353Z] [9.830s][info][gc] GC(80) Concurrent marking roots 0.243ms [2025-11-28T04:53:55.353Z] Allocated: 706 Mb [2025-11-28T04:53:55.353Z] Allocated: 715 Mb [2025-11-28T04:53:55.353Z] [9.842s][info][gc] Failed to allocate Shared, 36756K [2025-11-28T04:53:55.353Z] [9.843s][info][gc] GC(80) Concurrent marking (Young) 11.996ms [2025-11-28T04:53:55.353Z] [9.843s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.353Z] [9.851s][info][gc] GC(81) Verify Before Full GC, Level 4 (34347 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [9.851s][info][gc] GC(81) Cancel marking: Young [2025-11-28T04:53:55.353Z] [9.851s][info][gc] GC(81) Cancel marking: Old [2025-11-28T04:53:55.353Z] [9.851s][info][gc] GC(81) Cancel marking: Global [2025-11-28T04:53:55.353Z] [10.072s][info][gc] GC(81) Verify After Full GC, Level 4 (34243 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [10.072s][info][gc] GC(81) Pause Full 917M->686M(1024M) 229.020ms [2025-11-28T04:53:55.353Z] Allocated: 714 Mb [2025-11-28T04:53:55.353Z] Allocated: 661 Mb [2025-11-28T04:53:55.353Z] Allocated: 665 Mb [2025-11-28T04:53:55.353Z] Allocated: 698 Mb [2025-11-28T04:53:55.353Z] Allocated: 747 Mb [2025-11-28T04:53:55.353Z] [10.095s][info][gc] Trigger (Young): Average GC time (58.87 ms) is above the time for average allocation rate (1636 MB/s) to deplete free headroom (56371K) (margin of error = 1.83) [2025-11-28T04:53:55.353Z] [10.096s][info][gc] GC(82) Concurrent reset (Young) 0.510ms [2025-11-28T04:53:55.353Z] [10.109s][info][gc] GC(82) Verify Before Mark, Level 4 (26 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [10.109s][info][gc] GC(82) Pause Init Mark (Young) 3.946ms [2025-11-28T04:53:55.353Z] Allocated: 737 Mb [2025-11-28T04:53:55.353Z] [10.111s][info][gc] GC(82) Concurrent remembered set scanning 0.829ms [2025-11-28T04:53:55.353Z] [10.111s][info][gc] GC(82) Concurrent marking roots 0.242ms [2025-11-28T04:53:55.353Z] Allocated: 727 Mb [2025-11-28T04:53:55.353Z] Allocated: 705 Mb [2025-11-28T04:53:55.353Z] [10.122s][info][gc] GC(82) Concurrent marking (Young) 10.668ms [2025-11-28T04:53:55.353Z] [10.135s][info][gc] GC(82) Verify After Mark, Level 4 (25 reachable, 18 marked) [2025-11-28T04:53:55.353Z] [10.136s][info][gc] GC(82) Pause Final Mark (Young) 4.308ms [2025-11-28T04:53:55.353Z] Allocated: 741 Mb [2025-11-28T04:53:55.353Z] [10.136s][info][gc] Failed to allocate Shared, 54745K [2025-11-28T04:53:55.353Z] [10.136s][info][gc] GC(82) Concurrent weak references (Young) 0.184ms [2025-11-28T04:53:55.353Z] [10.136s][info][gc] GC(82) Concurrent weak roots (Young) 0.253ms [2025-11-28T04:53:55.353Z] [10.136s][info][gc] GC(82) Concurrent cleanup (Young) 849M->849M(1024M) 0.063ms [2025-11-28T04:53:55.353Z] [10.136s][info][gc] GC(82) Concurrent Final Roots (Young) 0.093ms [2025-11-28T04:53:55.353Z] [10.141s][info][gc] GC(82) Concurrent reset after collect (Young) 4.447ms [2025-11-28T04:53:55.353Z] [10.141s][info][gc] Trigger (Young): Handle Allocation Failure [2025-11-28T04:53:55.353Z] [10.150s][info][gc] GC(83) Verify Before Full GC, Level 4 (34346 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [10.388s][info][gc] GC(83) Verify After Full GC, Level 4 (34242 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [10.388s][info][gc] GC(83) Pause Full 849M->677M(1024M) 247.238ms [2025-11-28T04:53:55.353Z] Allocated: 724 Mb [2025-11-28T04:53:55.353Z] Allocated: 697 Mb [2025-11-28T04:53:55.353Z] Allocated: 715 Mb [2025-11-28T04:53:55.353Z] [10.406s][info][gc] Trigger (Young): Average GC time (57.01 ms) is above the time for average allocation rate (1619 MB/s) to deplete free headroom (85555K) (margin of error = 1.84) [2025-11-28T04:53:55.353Z] [10.407s][info][gc] GC(84) Concurrent reset (Young) 0.502ms [2025-11-28T04:53:55.353Z] [10.423s][info][gc] GC(84) Verify Before Mark, Level 4 (23 reachable, 0 marked) [2025-11-28T04:53:55.353Z] [10.423s][info][gc] GC(84) Pause Init Mark (Young) 4.386ms [2025-11-28T04:53:55.353Z] Allocated: 751 Mb [2025-11-28T04:53:55.353Z] [10.424s][info][gc] GC(84) Concurrent remembered set scanning 0.367ms [2025-11-28T04:53:55.353Z] [10.425s][info][gc] GC(84) Concurrent marking roots 1.003ms [2025-11-28T04:53:55.353Z] Allocated: 689 Mb [2025-11-28T04:53:55.353Z] [10.432s][info][gc] GC(84) Concurrent marking (Young) 7.353ms [2025-11-28T04:53:55.353Z] # [2025-11-28T04:53:55.353Z] # A fatal error has been detected by the Java Runtime Environment: [2025-11-28T04:53:55.353Z] # [2025-11-28T04:53:55.353Z] # Internal Error (shenandoahVerifier.cpp:105), pid=3020738, tid=3020743 [2025-11-28T04:53:55.353Z] # Error: After Mark, Roots; Object end should be within the region [2025-11-28T04:53:55.353Z] [2025-11-28T04:53:55.353Z] Referenced from: [2025-11-28T04:53:55.353Z] interior location: 0x00000000c017e6cc [2025-11-28T04:53:55.353Z] inside Java heap [2025-11-28T04:53:55.353Z] not in collection set [2025-11-28T04:53:55.353Z] region: | 2|R |O|BTE c0100000, c017e728, c0180000|TAMS c0100000|UWM c017e728|U 505K|T 0B|G 0B|P 0B|S 505K|L 505K|CP 0 [2025-11-28T04:53:55.353Z] [2025-11-28T04:53:55.353Z] Object: [2025-11-28T04:53:55.353Z] 0x00000000d2c80000 - safe print, no details [2025-11-28T04:53:55.353Z] region: | 601|TR |Y|BTE d2c80000, d2d00000, d2d00000|TAMS d2d00000|UWM d2d00000|U 512K|T 0B|G 0B|P 0B|S 512K|L 0B|CP 0 [2025-11-28T04:53:55.353Z] [2025-11-28T04:53:55.353Z] Raw heap memory: [2025-11-28T04:53:55.353Z] 0x00000000d2c80000: 00000001 00000000 00175a00 00847390 .........Z...s.. [2025-11-28T04:53:55.353Z] 0x00000000d2c80010: 00000000 00000000 00000000 00000000 ................ [2025-11-28T04:53:55.353Z] 0x00000000d2c80020: 00000000 00000000 00000000 00000000 ................ [2025-11-28T04:53:55.353Z] 0x00000000d2c80030: 00000000 00000000 00000000 00000000 ................ [2025-11-28T04:53:55.353Z] 0x00000000d2c80040: 00000000 00000000 00000000 00000000 ................ [2025-11-28T04:53:55.353Z] 0x00000000d2c80050: 00000000 00000000 00000000 00000000 ................ [2025-11-28T04:53:55.353Z] 0x00000000d2c80060: 00000000 00000000 00000000 00000000 ................ [2025-11-28T04:53:55.353Z] 0x00000000d2c80070: 00000000 00000000 00000000 00000000 ................ [2025-11-28T04:53:55.353Z] [2025-11-28T04:53:55.353Z] [2025-11-28T04:53:55.353Z] # [2025-11-28T04:53:55.353Z] # JRE version: OpenJDK Runtime Environment Temurin-26+26-202511272135 (26.0+26) (build 26-beta+26-ea) [2025-11-28T04:53:55.353Z] # Java VM: OpenJDK 64-Bit Server VM Temurin-26+26-202511272135 (26-beta+26-ea, mixed mode, sharing, tiered, compressed oops, compressed class ptrs, shenandoah gc, linux-amd64) [2025-11-28T04:53:55.353Z] # Core dump will be written. Default location: Determined by the following: "/usr/share/apport/apport -p%p -s%s -c%c -d%d -P%P -u%u -g%g -F%F -- %E" (alternatively, falling back to /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/scratch/2/core.3020738) [2025-11-28T04:53:55.353Z] # [2025-11-28T04:53:55.353Z] # An error report file with more information is saved as: [2025-11-28T04:53:55.353Z] # /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/scratch/2/hs_err_pid3020738.log [2025-11-28T04:53:55.353Z] [thread 3020742 also had an error] [2025-11-28T04:53:55.353Z] # [2025-11-28T04:53:55.353Z] # If you would like to submit a bug report, please visit: [2025-11-28T04:53:55.353Z] # https://github.com/adoptium/adoptium-support/issues [2025-11-28T04:53:55.353Z] # [2025-11-28T04:53:55.353Z] STDERR: [2025-11-28T04:53:55.353Z] rerun: [2025-11-28T04:53:55.353Z] cd /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/scratch/2 && \ [2025-11-28T04:53:55.353Z] DISPLAY=:0 \ [2025-11-28T04:53:55.353Z] HOME=/home/jenkins \ [2025-11-28T04:53:55.353Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-11-28T04:53:55.353Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d/test/lib:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-11-28T04:53:55.353Z] /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image/bin/java \ [2025-11-28T04:53:55.353Z] -Dtest.vm.opts='-ea -esa -Xmx512m -Djava.awt.headless=true' \ [2025-11-28T04:53:55.353Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-Djava.awt.headless=true' \ [2025-11-28T04:53:55.353Z] -Dtest.compiler.opts= \ [2025-11-28T04:53:55.353Z] -Dtest.java.opts= \ [2025-11-28T04:53:55.353Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image \ [2025-11-28T04:53:55.353Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/j2sdk-image \ [2025-11-28T04:53:55.353Z] -Dtest.timeout.factor=8.0 \ [2025-11-28T04:53:55.353Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-11-28T04:53:55.353Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg \ [2025-11-28T04:53:55.353Z] -Dtest.name=gc/TestAllocHumongousFragment.java#generational \ [2025-11-28T04:53:55.353Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-11-28T04:53:55.353Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/TestAllocHumongousFragment.java \ [2025-11-28T04:53:55.353Z] -Dtest.main.class=TestAllocHumongousFragment \ [2025-11-28T04:53:55.353Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc \ [2025-11-28T04:53:55.353Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-11-28T04:53:55.353Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d \ [2025-11-28T04:53:55.353Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d/test/lib \ [2025-11-28T04:53:55.353Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc:/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/classes/1/gc/TestAllocHumongousFragment_generational.d/test/lib \ [2025-11-28T04:53:55.353Z] -ea \ [2025-11-28T04:53:55.353Z] -esa \ [2025-11-28T04:53:55.353Z] -Xmx512m \ [2025-11-28T04:53:55.353Z] -Djava.awt.headless=true \ [2025-11-28T04:53:55.353Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-11-28T04:53:55.353Z] -Xmx1g \ [2025-11-28T04:53:55.353Z] -Xms1g \ [2025-11-28T04:53:55.353Z] -Xlog:gc \ [2025-11-28T04:53:55.353Z] -XX:+UnlockDiagnosticVMOptions \ [2025-11-28T04:53:55.353Z] -XX:+UnlockExperimentalVMOptions \ [2025-11-28T04:53:55.353Z] -XX:ShenandoahTargetNumRegions=2048 \ [2025-11-28T04:53:55.353Z] -XX:+UseShenandoahGC \ [2025-11-28T04:53:55.353Z] -XX:ShenandoahGCHeuristics=adaptive \ [2025-11-28T04:53:55.353Z] -XX:ShenandoahGCMode=generational \ [2025-11-28T04:53:55.353Z] -XX:+ShenandoahVerify \ [2025-11-28T04:53:55.353Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work/gc/TestAllocHumongousFragment_generational.d/main.0.jta [2025-11-28T04:53:55.353Z] [2025-11-28T04:53:55.353Z] TEST RESULT: Failed. Unexpected exit from test [exit code: 134] [2025-11-28T04:53:55.353Z] -------------------------------------------------- [2025-11-28T05:00:37.718Z] Test results: passed: 548; failed: 1; skipped: 4; excluded: 11; did not meet platform requirements: 24 [2025-11-28T05:00:56.303Z] Report written to /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/report/html/report.html [2025-11-28T05:00:56.303Z] Results written to /home/jenkins/workspace/Test_openjdk26_hs_extended.openjdk_x86-64_alpine-linux_testList_1/aqa-tests/TKG/output_17643011377569/hotspot_gc_0/work [2025-11-28T05:00:56.303Z] Error: Some tests failed or other problems occurred. [2025-11-28T05:00:56.303Z] ----------------------------------- [2025-11-28T05:00:56.303Z] hotspot_gc_0_FAILED [2025-11-28T05:00:56.303Z] ----------------------------------- [2025-11-28T05:00:56.303Z] [2025-11-28T05:00:56.303Z] TEST TEARDOWN: [2025-11-28T05:00:56.303Z] Nothing to be done for teardown. [2025-11-28T05:00:56.303Z] hotspot_gc_0 Finish Time: Fri Nov 28 05:00:55 2025 Epoch Time (ms): 1764306055170