[2025-09-04T05:49:00.327Z] Running test jdk_jfr_0 ... [2025-09-04T05:49:00.327Z] =============================================== [2025-09-04T05:49:00.646Z] jdk_jfr_0 Start Time: Thu Sep 4 05:49:00 2025 Epoch Time (ms): 1756964940418 [2025-09-04T05:49:00.646Z] variation: Mode150 [2025-09-04T05:49:00.646Z] JVM_OPTIONS: -XX:+UseCompressedOops [2025-09-04T05:49:00.978Z] { \ [2025-09-04T05:49:00.978Z] echo ""; echo "TEST SETUP:"; \ [2025-09-04T05:49:00.978Z] echo "Nothing to be done for setup."; \ [2025-09-04T05:49:00.978Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\TKG\\output_17569536838139\\jdk_jfr_0"; \ [2025-09-04T05:49:00.978Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\TKG\\output_17569536838139\\jdk_jfr_0"; \ [2025-09-04T05:49:00.978Z] echo ""; echo "TESTING:"; \ [2025-09-04T05:49:00.978Z] "c:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/jdkbinary/j2sdk-image\\bin\\java" -Xmx512m -jar "C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests///..//jvmtest\\openjdk\\jtreg\\lib\\jtreg.jar" \ [2025-09-04T05:49:00.978Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:2 -nativepath:"c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/jdkbinary/openjdk-test-image\\jdk\\jtreg\\native" -vmoptions:"-Xmx768m -XX:+UseCompressedOops " \ [2025-09-04T05:49:00.978Z] -w ""C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\TKG\\output_17569536838139\\jdk_jfr_0"\\work" \ [2025-09-04T05:49:00.978Z] -r ""C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\TKG\\output_17569536838139\\jdk_jfr_0"\\report" \ [2025-09-04T05:49:00.978Z] -jdk:"c:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/jdkbinary/j2sdk-image" \ [2025-09-04T05:49:00.978Z] -exclude:"C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\openjdk\\openjdk-jdk\\test\\jdk\\ProblemList.txt" \ [2025-09-04T05:49:00.978Z] -exclude:"C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests///..//jvmtest\\openjdk\\excludes/ProblemList_openjdk21.txt" \ [2025-09-04T05:49:00.978Z] \ [2025-09-04T05:49:00.978Z] -exclude:"C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\openjdk\\excludes\\vendors\\eclipse\\ProblemList_openjdk21.txt" \ [2025-09-04T05:49:00.978Z] "C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\openjdk\\openjdk-jdk\\test\\jdk:jdk_jfr"; \ [2025-09-04T05:49:00.978Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_jfr_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/; else echo "-----------------------------------"; echo "jdk_jfr_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-09-04T05:49:00.978Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-09-04T05:49:00.978Z] echo "Nothing to be done for teardown."; \ [2025-09-04T05:49:00.978Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1/aqa-tests/\\TKG\\output_17569536838139\\TestTargetResult"; [2025-09-04T05:49:00.978Z] [2025-09-04T05:49:00.978Z] TEST SETUP: [2025-09-04T05:49:00.978Z] Nothing to be done for setup. [2025-09-04T05:49:00.978Z] [2025-09-04T05:49:00.978Z] TESTING: [2025-09-04T05:49:01.700Z] Directory "C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work" not found: creating [2025-09-04T05:49:01.700Z] Directory "C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\report" not found: creating [2025-09-04T05:49:09.138Z] XML output with verification to C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work [2025-09-04T06:15:28.156Z] -------------------------------------------------- [2025-09-04T06:15:28.156Z] TEST: jdk/jfr/event/gc/stacktrace/TestG1OldAllocationPendingStackTrace.java [2025-09-04T06:15:28.156Z] TEST JDK: c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image [2025-09-04T06:15:28.156Z] [2025-09-04T06:15:28.156Z] ACTION: build -- Passed. Build successful [2025-09-04T06:15:28.156Z] REASON: Named class compiled on demand [2025-09-04T06:15:28.156Z] TIME: 0.244 seconds [2025-09-04T06:15:28.156Z] messages: [2025-09-04T06:15:28.156Z] command: build jdk.jfr.event.gc.stacktrace.TestG1OldAllocationPendingStackTrace [2025-09-04T06:15:28.156Z] reason: Named class compiled on demand [2025-09-04T06:15:28.156Z] started: Thu Sep 04 05:59:23 UTC 2025 [2025-09-04T06:15:28.156Z] Test directory: [2025-09-04T06:15:28.156Z] compile: jdk.jfr.event.gc.stacktrace.TestG1OldAllocationPendingStackTrace [2025-09-04T06:15:28.156Z] finished: Thu Sep 04 05:59:23 UTC 2025 [2025-09-04T06:15:28.156Z] elapsed time (seconds): 0.244 [2025-09-04T06:15:28.156Z] [2025-09-04T06:15:28.156Z] ACTION: compile -- Passed. Compilation successful [2025-09-04T06:15:28.156Z] REASON: .class file out of date or does not exist [2025-09-04T06:15:28.156Z] TIME: 0.243 seconds [2025-09-04T06:15:28.156Z] messages: [2025-09-04T06:15:28.156Z] command: compile C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.java [2025-09-04T06:15:28.156Z] reason: .class file out of date or does not exist [2025-09-04T06:15:28.156Z] started: Thu Sep 04 05:59:23 UTC 2025 [2025-09-04T06:15:28.156Z] Additional options from @modules: --add-modules jdk.jfr,java.management,jdk.management [2025-09-04T06:15:28.156Z] Mode: agentvm [2025-09-04T06:15:28.156Z] Agent id: 1 [2025-09-04T06:15:28.156Z] finished: Thu Sep 04 05:59:23 UTC 2025 [2025-09-04T06:15:28.156Z] elapsed time (seconds): 0.243 [2025-09-04T06:15:28.156Z] configuration: [2025-09-04T06:15:28.156Z] Boot Layer (javac runtime environment) [2025-09-04T06:15:28.156Z] class path: C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jvmtest\openjdk\jtreg\lib\javatest.jar [2025-09-04T06:15:28.156Z] C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jvmtest\openjdk\jtreg\lib\jtreg.jar [2025-09-04T06:15:28.156Z] patch: java.base C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\patches\java.base [2025-09-04T06:15:28.156Z] [2025-09-04T06:15:28.156Z] javac compilation environment [2025-09-04T06:15:28.156Z] add modules: jdk.jfr java.management jdk.management [2025-09-04T06:15:28.156Z] source path: C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace [2025-09-04T06:15:28.156Z] C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\lib [2025-09-04T06:15:28.156Z] C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk [2025-09-04T06:15:28.156Z] class path: C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace [2025-09-04T06:15:28.156Z] C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d [2025-09-04T06:15:28.156Z] C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\lib [2025-09-04T06:15:28.156Z] C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\jdk [2025-09-04T06:15:28.156Z] [2025-09-04T06:15:28.156Z] rerun: [2025-09-04T06:15:28.156Z] cd 'C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\scratch\0' && \ [2025-09-04T06:15:28.156Z] PATH='C:\cygwin64\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0;C:\Windows\System32\OpenSSH;C:\Users\adoptopenjdk\AppData\Local\Microsoft\WindowsApps;C:\Strawberry\perl\bin;C:\Program Files\Git\cmd;C:\openjdk\jdk-8\bin;C:\apache-ant\apache-ant-1.10.15\bin;C:\Program Files (x86)\Windows Kits\10\Windows Performance Toolkit;C:\Program Files (x86)\Incredibuild;C:\rust\bin;C:\Program Files\IcedTeaWEB\bin;C:\Program Files\dotnet;C:\Users\jenkins\AppData\Local\Microsoft\WindowsApps' \ [2025-09-04T06:15:28.156Z] SystemDrive=C: \ [2025-09-04T06:15:28.156Z] SystemRoot='C:\Windows' \ [2025-09-04T06:15:28.156Z] TEMP='C:\Users\jenkins\AppData\Local\Temp' \ [2025-09-04T06:15:28.156Z] TMP='C:\Users\jenkins\AppData\Local\Temp' \ [2025-09-04T06:15:28.156Z] windir='C:\Windows' \ [2025-09-04T06:15:28.156Z] 'c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image\bin\javac' \ [2025-09-04T06:15:28.156Z] -J-ea \ [2025-09-04T06:15:28.156Z] -J-esa \ [2025-09-04T06:15:28.156Z] -J-Xmx768m \ [2025-09-04T06:15:28.156Z] -J-XX:+UseCompressedOops \ [2025-09-04T06:15:28.156Z] -J-Dtest.vm.opts='-ea -esa -Xmx768m -XX:+UseCompressedOops' \ [2025-09-04T06:15:28.156Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx768m -J-XX:+UseCompressedOops' \ [2025-09-04T06:15:28.156Z] -J-Dtest.compiler.opts= \ [2025-09-04T06:15:28.156Z] -J-Dtest.java.opts= \ [2025-09-04T06:15:28.156Z] -J-Dtest.jdk='c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image' \ [2025-09-04T06:15:28.156Z] -J-Dcompile.jdk='c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image' \ [2025-09-04T06:15:28.156Z] -J-Dtest.timeout.factor=8.0 \ [2025-09-04T06:15:28.156Z] -J-Dtest.nativepath='c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\openjdk-test-image\jdk\jtreg\native' \ [2025-09-04T06:15:28.156Z] -J-Dtest.root='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk' \ [2025-09-04T06:15:28.156Z] -J-Dtest.name=jdk/jfr/event/gc/stacktrace/TestG1OldAllocationPendingStackTrace.java \ [2025-09-04T06:15:28.156Z] -J-Dtest.file='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.java' \ [2025-09-04T06:15:28.156Z] -J-Dtest.src='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace' \ [2025-09-04T06:15:28.156Z] -J-Dtest.src.path='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk' \ [2025-09-04T06:15:28.156Z] -J-Dtest.classes='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d' \ [2025-09-04T06:15:28.156Z] -J-Dtest.class.path='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\jdk' \ [2025-09-04T06:15:28.157Z] -J-Dtest.class.path.prefix='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\jdk' \ [2025-09-04T06:15:28.157Z] -J-Dtest.modules='jdk.jfr java.management jdk.management' \ [2025-09-04T06:15:28.157Z] --add-modules jdk.jfr,java.management,jdk.management \ [2025-09-04T06:15:28.157Z] -d 'C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d' \ [2025-09-04T06:15:28.157Z] -sourcepath 'C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk' \ [2025-09-04T06:15:28.157Z] -classpath 'C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\jdk' 'C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.java' [2025-09-04T06:15:28.157Z] direct: [2025-09-04T06:15:28.157Z] Note: C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace\AllocationStackTrace.java uses or overrides a deprecated API. [2025-09-04T06:15:28.157Z] Note: Recompile with -Xlint:deprecation for details. [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] ACTION: main -- Error. Program `c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image\bin\java' timed out (timeout set to 960000ms, elapsed time including timeout handling was 962465ms). [2025-09-04T06:15:28.157Z] REASON: User specified action: run main/othervm -XX:MaxNewSize=10M -Xmx128M -XX:+UseG1GC -Xlog:gc* jdk.jfr.event.gc.stacktrace.TestG1OldAllocationPendingStackTrace [2025-09-04T06:15:28.157Z] TIME: 962.654 seconds [2025-09-04T06:15:28.157Z] messages: [2025-09-04T06:15:28.157Z] command: main -XX:MaxNewSize=10M -Xmx128M -XX:+UseG1GC -Xlog:gc* jdk.jfr.event.gc.stacktrace.TestG1OldAllocationPendingStackTrace [2025-09-04T06:15:28.157Z] reason: User specified action: run main/othervm -XX:MaxNewSize=10M -Xmx128M -XX:+UseG1GC -Xlog:gc* jdk.jfr.event.gc.stacktrace.TestG1OldAllocationPendingStackTrace [2025-09-04T06:15:28.157Z] started: Thu Sep 04 05:59:23 UTC 2025 [2025-09-04T06:15:28.157Z] Mode: othervm [/othervm specified] [2025-09-04T06:15:28.157Z] Additional options from @modules: --add-modules jdk.jfr,java.management,jdk.management [2025-09-04T06:15:28.157Z] Timeout information: [2025-09-04T06:15:28.157Z] Running jstack on process 97984 [2025-09-04T06:15:28.157Z] 2025-09-04 06:15:25 [2025-09-04T06:15:28.157Z] Full thread dump OpenJDK 64-Bit Server VM (21.0.9-beta+6-ea mixed mode, sharing): [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] Threads class SMR info: [2025-09-04T06:15:28.157Z] _java_thread_list=0x0000026b9131adf0, length=14, elements={ [2025-09-04T06:15:28.157Z] 0x0000026b30762810, 0x0000026b4be492d0, 0x0000026b4be4aa40, 0x0000026b4be4e1c0, [2025-09-04T06:15:28.157Z] 0x0000026b4be4ec10, 0x0000026b4be4f660, 0x0000026b4be500b0, 0x0000026b4be50e30, [2025-09-04T06:15:28.157Z] 0x0000026b4be58b60, 0x0000026b9110be70, 0x0000026b91155a10, 0x0000026b91210b70, [2025-09-04T06:15:28.157Z] 0x0000026b91464900, 0x0000026b91891060 [2025-09-04T06:15:28.157Z] } [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "main" #1 [24420] prio=5 os_prio=0 cpu=125.00ms elapsed=962.31s tid=0x0000026b30762810 nid=24420 in Object.wait() [0x000000de634ff000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: WAITING (on object monitor) [2025-09-04T06:15:28.157Z] at java.lang.Object.wait0(java.base@21.0.9-beta/Native Method) [2025-09-04T06:15:28.157Z] - waiting on <0x00000000f8117430> (a java.lang.Thread) [2025-09-04T06:15:28.157Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:366) [2025-09-04T06:15:28.157Z] at java.lang.Thread.join(java.base@21.0.9-beta/Thread.java:2079) [2025-09-04T06:15:28.157Z] - locked <0x00000000f8117430> (a java.lang.Thread) [2025-09-04T06:15:28.157Z] at java.lang.Thread.join(java.base@21.0.9-beta/Thread.java:2155) [2025-09-04T06:15:28.157Z] at com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:85) [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Reference Handler" #9 [24048] daemon prio=10 os_prio=2 cpu=1484.38ms elapsed=962.27s tid=0x0000026b4be492d0 nid=24048 waiting on condition [0x000000de63cff000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@21.0.9-beta/Native Method) [2025-09-04T06:15:28.157Z] at java.lang.ref.Reference.processPendingReferences(java.base@21.0.9-beta/Reference.java:246) [2025-09-04T06:15:28.157Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@21.0.9-beta/Reference.java:208) [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Finalizer" #10 [65304] daemon prio=8 os_prio=1 cpu=0.00ms elapsed=962.27s tid=0x0000026b4be4aa40 nid=65304 in Object.wait() [0x000000de63dff000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: WAITING (on object monitor) [2025-09-04T06:15:28.157Z] at java.lang.Object.wait0(java.base@21.0.9-beta/Native Method) [2025-09-04T06:15:28.157Z] - waiting on <0x00000000f81178c8> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-09-04T06:15:28.157Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:366) [2025-09-04T06:15:28.157Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:339) [2025-09-04T06:15:28.157Z] at java.lang.ref.NativeReferenceQueue.await(java.base@21.0.9-beta/NativeReferenceQueue.java:48) [2025-09-04T06:15:28.157Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.9-beta/ReferenceQueue.java:158) [2025-09-04T06:15:28.157Z] at java.lang.ref.NativeReferenceQueue.remove(java.base@21.0.9-beta/NativeReferenceQueue.java:89) [2025-09-04T06:15:28.157Z] - locked <0x00000000f81178c8> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-09-04T06:15:28.157Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@21.0.9-beta/Finalizer.java:173) [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Signal Dispatcher" #11 [66144] daemon prio=9 os_prio=2 cpu=0.00ms elapsed=962.27s tid=0x0000026b4be4e1c0 nid=66144 waiting on condition [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Attach Listener" #12 [65904] daemon prio=5 os_prio=2 cpu=0.00ms elapsed=962.27s tid=0x0000026b4be4ec10 nid=65904 waiting on condition [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Service Thread" #13 [95236] daemon prio=9 os_prio=0 cpu=15.62ms elapsed=962.27s tid=0x0000026b4be4f660 nid=95236 runnable [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Monitor Deflation Thread" #14 [78228] daemon prio=9 os_prio=0 cpu=31.25ms elapsed=962.27s tid=0x0000026b4be500b0 nid=78228 runnable [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "C2 CompilerThread0" #15 [81588] daemon prio=9 os_prio=2 cpu=1609.38ms elapsed=962.27s tid=0x0000026b4be50e30 nid=81588 waiting on condition [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] No compile task [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "C1 CompilerThread0" #16 [96932] daemon prio=9 os_prio=2 cpu=671.88ms elapsed=962.27s tid=0x0000026b4be58b60 nid=96932 waiting on condition [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] No compile task [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Notification Thread" #17 [74128] daemon prio=9 os_prio=0 cpu=0.00ms elapsed=962.15s tid=0x0000026b9110be70 nid=74128 runnable [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "Common-Cleaner" #18 [96848] daemon prio=8 os_prio=1 cpu=0.00ms elapsed=962.14s tid=0x0000026b91155a10 nid=96848 waiting on condition [0x000000de645fe000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-09-04T06:15:28.157Z] at jdk.internal.misc.Unsafe.park(java.base@21.0.9-beta/Native Method) [2025-09-04T06:15:28.157Z] - parking to wait for <0x00000000f8100388> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-09-04T06:15:28.157Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.9-beta/LockSupport.java:269) [2025-09-04T06:15:28.157Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@21.0.9-beta/AbstractQueuedSynchronizer.java:1886) [2025-09-04T06:15:28.157Z] at java.lang.ref.ReferenceQueue.await(java.base@21.0.9-beta/ReferenceQueue.java:71) [2025-09-04T06:15:28.157Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.9-beta/ReferenceQueue.java:143) [2025-09-04T06:15:28.157Z] at java.lang.ref.ReferenceQueue.remove(java.base@21.0.9-beta/ReferenceQueue.java:218) [2025-09-04T06:15:28.157Z] at jdk.internal.ref.CleanerImpl.run(java.base@21.0.9-beta/CleanerImpl.java:140) [2025-09-04T06:15:28.157Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:15:28.157Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:15:28.157Z] at jdk.internal.misc.InnocuousThread.run(java.base@21.0.9-beta/InnocuousThread.java:186) [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "MainThread" #19 [70988] prio=5 os_prio=0 cpu=127187.50ms elapsed=962.09s tid=0x0000026b91210b70 nid=70988 waiting on condition [0x000000de646fe000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] at jdk.jfr.event.gc.stacktrace.OldGenMemoryAllocator.allocate(AllocationStackTrace.java:87) [2025-09-04T06:15:28.157Z] at jdk.jfr.event.gc.stacktrace.AllocationStackTrace.allocAndCheck(AllocationStackTrace.java:377) [2025-09-04T06:15:28.157Z] at jdk.jfr.event.gc.stacktrace.AllocationStackTrace.testAllocEvent(AllocationStackTrace.java:343) [2025-09-04T06:15:28.157Z] at jdk.jfr.event.gc.stacktrace.AllocationStackTrace.testG1OldAllocEvent(AllocationStackTrace.java:283) [2025-09-04T06:15:28.157Z] at jdk.jfr.event.gc.stacktrace.TestG1OldAllocationPendingStackTrace.main(TestG1OldAllocationPendingStackTrace.java:37) [2025-09-04T06:15:28.157Z] at java.lang.invoke.LambdaForm$DMH/0x0000026b4d002000.invokeStatic(java.base@21.0.9-beta/LambdaForm$DMH) [2025-09-04T06:15:28.157Z] at java.lang.invoke.LambdaForm$MH/0x0000026b4d003400.invoke(java.base@21.0.9-beta/LambdaForm$MH) [2025-09-04T06:15:28.157Z] at java.lang.invoke.Invokers$Holder.invokeExact_MT(java.base@21.0.9-beta/Invokers$Holder) [2025-09-04T06:15:28.157Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@21.0.9-beta/DirectMethodHandleAccessor.java:154) [2025-09-04T06:15:28.157Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@21.0.9-beta/DirectMethodHandleAccessor.java:103) [2025-09-04T06:15:28.157Z] at java.lang.reflect.Method.invoke(java.base@21.0.9-beta/Method.java:580) [2025-09-04T06:15:28.157Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-09-04T06:15:28.157Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:15:28.157Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "JFR Recorder Thread" #22 [19980] daemon prio=5 os_prio=0 cpu=93.75ms elapsed=960.75s tid=0x0000026b91464900 nid=19980 runnable [0x0000000000000000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "JFR Periodic Tasks" #23 [69512] daemon prio=5 os_prio=0 cpu=109.38ms elapsed=959.81s tid=0x0000026b91891060 nid=69512 in Object.wait() [0x000000de649ff000] [2025-09-04T06:15:28.157Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-09-04T06:15:28.157Z] at java.lang.Object.wait0(java.base@21.0.9-beta/Native Method) [2025-09-04T06:15:28.157Z] - waiting on <no object reference available> [2025-09-04T06:15:28.157Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:366) [2025-09-04T06:15:28.157Z] at jdk.jfr.internal.PlatformRecorder.takeNap(jdk.jfr@21.0.9-beta/PlatformRecorder.java:559) [2025-09-04T06:15:28.157Z] - locked <0x00000000f82ba788> (a jdk.jfr.internal.JVM$ChunkRotationMonitor) [2025-09-04T06:15:28.157Z] at jdk.jfr.internal.PlatformRecorder.periodicTask(jdk.jfr@21.0.9-beta/PlatformRecorder.java:527) [2025-09-04T06:15:28.157Z] at jdk.jfr.internal.PlatformRecorder.lambda$startDiskMonitor$1(jdk.jfr@21.0.9-beta/PlatformRecorder.java:446) [2025-09-04T06:15:28.157Z] at jdk.jfr.internal.PlatformRecorder$$Lambda/0x0000026b4d021d20.run(jdk.jfr@21.0.9-beta/Unknown Source) [2025-09-04T06:15:28.157Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:15:28.157Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "GC Thread#1" os_prio=2 cpu=96468.75ms elapsed=961.22s tid=0x0000026b91309ea0 nid=14112 runnable [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "VM Thread" os_prio=2 cpu=45843.75ms elapsed=962.29s tid=0x0000026b4be2a490 nid=42276 runnable [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "VM Periodic Task Thread" os_prio=2 cpu=171.88ms elapsed=962.29s tid=0x0000026b4be19fc0 nid=20424 waiting on condition [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "G1 Conc#0" os_prio=2 cpu=276828.12ms elapsed=962.30s tid=0x0000026b307856f0 nid=72992 runnable [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "GC Thread#0" os_prio=2 cpu=96640.62ms elapsed=962.30s tid=0x0000026b30782df0 nid=67592 runnable [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "G1 Service" os_prio=2 cpu=11812.50ms elapsed=962.30s tid=0x0000026b30806af0 nid=55776 runnable [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "G1 Refine#0" os_prio=2 cpu=552296.88ms elapsed=962.30s tid=0x0000026b30804160 nid=48976 runnable [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] "G1 Main Marker" os_prio=2 cpu=6109.38ms elapsed=962.30s tid=0x0000026b30784ce0 nid=43324 runnable [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] JNI global refs: 25, weak refs: 4 [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] --- Timeout information end. [2025-09-04T06:15:28.157Z] finished: Thu Sep 04 06:15:25 UTC 2025 [2025-09-04T06:15:28.157Z] elapsed time (seconds): 962.654 [2025-09-04T06:15:28.157Z] configuration: [2025-09-04T06:15:28.157Z] Boot Layer [2025-09-04T06:15:28.157Z] add modules: jdk.jfr java.management jdk.management [2025-09-04T06:15:28.157Z] [2025-09-04T06:15:28.157Z] STDOUT: [2025-09-04T06:15:28.157Z] [0.018s][info][gc,init] CardTable entry size: 512 [2025-09-04T06:15:28.158Z] [0.019s][info][gc ] Using G1 [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Version: 21.0.9-beta+6-ea (release) [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] CPUs: 2 total, 2 available [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Memory: 8140M [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Large Page Support: Disabled [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] NUMA Support: Disabled [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Compressed Oops: Enabled (32-bit) [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Heap Region Size: 1M [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Heap Min Capacity: 8M [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Heap Initial Capacity: 128M [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Heap Max Capacity: 128M [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Pre-touch: Disabled [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Parallel Workers: 2 [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Concurrent Workers: 1 [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Concurrent Refinement Workers: 2 [2025-09-04T06:15:28.158Z] [0.020s][info][gc,init] Periodic GC: Disabled [2025-09-04T06:15:28.158Z] [0.028s][info][gc,metaspace] CDS archive(s) mapped at: [0x0000026b4c000000-0x0000026b4cc80000-0x0000026b4cc80000), size 13107200, SharedBaseAddress: 0x0000026b4c000000, ArchiveRelocationMode: 1. [2025-09-04T06:15:28.158Z] [0.028s][info][gc,metaspace] Compressed class space mapped at: 0x0000026b4d000000-0x0000026b8d000000, reserved size: 1073741824 [2025-09-04T06:15:28.158Z] [0.028s][info][gc,metaspace] Narrow klass base: 0x0000026b4c000000, Narrow klass shift: 0, Narrow klass range: 0x100000000 [2025-09-04T06:15:28.158Z] [1.099s][info][gc,start ] GC(0) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [1.100s][info][gc,task ] GC(0) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [1.107s][info][gc,phases ] GC(0) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.158Z] [1.107s][info][gc,phases ] GC(0) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.158Z] [1.107s][info][gc,phases ] GC(0) Evacuate Collection Set: 6.75ms [2025-09-04T06:15:28.158Z] [1.107s][info][gc,phases ] GC(0) Post Evacuate Collection Set: 0.29ms [2025-09-04T06:15:28.158Z] [1.107s][info][gc,phases ] GC(0) Other: 0.14ms [2025-09-04T06:15:28.158Z] [1.107s][info][gc,heap ] GC(0) Eden regions: 6->0(5) [2025-09-04T06:15:28.158Z] [1.107s][info][gc,heap ] GC(0) Survivor regions: 0->1(1) [2025-09-04T06:15:28.158Z] [1.107s][info][gc,heap ] GC(0) Old regions: 0->1 [2025-09-04T06:15:28.158Z] [1.107s][info][gc,heap ] GC(0) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [1.107s][info][gc,metaspace] GC(0) Metaspace: 3468K(3648K)->3468K(3648K) NonClass: 3113K(3200K)->3113K(3200K) Class: 355K(448K)->355K(448K) [2025-09-04T06:15:28.158Z] [1.107s][info][gc ] GC(0) Pause Young (Normal) (G1 Evacuation Pause) 6M->2M(128M) 7.486ms [2025-09-04T06:15:28.158Z] [1.107s][info][gc,cpu ] GC(0) User=0.00s Sys=0.00s Real=0.01s [2025-09-04T06:15:28.158Z] [1.881s][info][gc,start ] GC(1) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [1.881s][info][gc,task ] GC(1) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [1.885s][info][gc,phases ] GC(1) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.158Z] [1.885s][info][gc,phases ] GC(1) Merge Heap Roots: 0.03ms [2025-09-04T06:15:28.158Z] [1.885s][info][gc,phases ] GC(1) Evacuate Collection Set: 3.23ms [2025-09-04T06:15:28.158Z] [1.885s][info][gc,phases ] GC(1) Post Evacuate Collection Set: 0.23ms [2025-09-04T06:15:28.158Z] [1.885s][info][gc,phases ] GC(1) Other: 0.05ms [2025-09-04T06:15:28.158Z] [1.885s][info][gc,heap ] GC(1) Eden regions: 5->0(9) [2025-09-04T06:15:28.158Z] [1.885s][info][gc,heap ] GC(1) Survivor regions: 1->1(1) [2025-09-04T06:15:28.158Z] [1.885s][info][gc,heap ] GC(1) Old regions: 1->3 [2025-09-04T06:15:28.158Z] [1.885s][info][gc,heap ] GC(1) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [1.885s][info][gc,metaspace] GC(1) Metaspace: 4652K(4928K)->4652K(4928K) NonClass: 4139K(4288K)->4139K(4288K) Class: 512K(640K)->512K(640K) [2025-09-04T06:15:28.158Z] [1.885s][info][gc ] GC(1) Pause Young (Normal) (G1 Evacuation Pause) 7M->3M(128M) 3.757ms [2025-09-04T06:15:28.158Z] [1.885s][info][gc,cpu ] GC(1) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.158Z] [2.399s][info][gc,start ] GC(2) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.399s][info][gc,task ] GC(2) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.403s][info][gc,phases ] GC(2) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.158Z] [2.403s][info][gc,phases ] GC(2) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.158Z] [2.403s][info][gc,phases ] GC(2) Evacuate Collection Set: 3.91ms [2025-09-04T06:15:28.158Z] [2.403s][info][gc,phases ] GC(2) Post Evacuate Collection Set: 0.19ms [2025-09-04T06:15:28.158Z] [2.403s][info][gc,phases ] GC(2) Other: 0.05ms [2025-09-04T06:15:28.158Z] [2.403s][info][gc,heap ] GC(2) Eden regions: 9->0(8) [2025-09-04T06:15:28.158Z] [2.403s][info][gc,heap ] GC(2) Survivor regions: 1->2(2) [2025-09-04T06:15:28.158Z] [2.403s][info][gc,heap ] GC(2) Old regions: 3->3 [2025-09-04T06:15:28.158Z] [2.403s][info][gc,heap ] GC(2) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.403s][info][gc,metaspace] GC(2) Metaspace: 5814K(6016K)->5814K(6016K) NonClass: 5219K(5312K)->5219K(5312K) Class: 594K(704K)->594K(704K) [2025-09-04T06:15:28.158Z] [2.403s][info][gc ] GC(2) Pause Young (Normal) (G1 Evacuation Pause) 12M->4M(128M) 4.377ms [2025-09-04T06:15:28.158Z] [2.403s][info][gc,cpu ] GC(2) User=0.00s Sys=0.00s Real=0.01s [2025-09-04T06:15:28.158Z] [2.695s][info][gc,start ] GC(3) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.695s][info][gc,task ] GC(3) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.699s][info][gc,phases ] GC(3) Pre Evacuate Collection Set: 0.08ms [2025-09-04T06:15:28.158Z] [2.699s][info][gc,phases ] GC(3) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.158Z] [2.699s][info][gc,phases ] GC(3) Evacuate Collection Set: 3.84ms [2025-09-04T06:15:28.158Z] [2.699s][info][gc,phases ] GC(3) Post Evacuate Collection Set: 0.20ms [2025-09-04T06:15:28.158Z] [2.699s][info][gc,phases ] GC(3) Other: 0.05ms [2025-09-04T06:15:28.158Z] [2.699s][info][gc,heap ] GC(3) Eden regions: 8->0(8) [2025-09-04T06:15:28.158Z] [2.699s][info][gc,heap ] GC(3) Survivor regions: 2->2(2) [2025-09-04T06:15:28.158Z] [2.699s][info][gc,heap ] GC(3) Old regions: 3->7 [2025-09-04T06:15:28.158Z] [2.699s][info][gc,heap ] GC(3) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.699s][info][gc,metaspace] GC(3) Metaspace: 6044K(6208K)->6044K(6208K) NonClass: 5434K(5504K)->5434K(5504K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.158Z] [2.699s][info][gc ] GC(3) Pause Young (Normal) (G1 Evacuation Pause) 12M->9M(128M) 4.356ms [2025-09-04T06:15:28.158Z] [2.699s][info][gc,cpu ] GC(3) User=0.00s Sys=0.00s Real=0.01s [2025-09-04T06:15:28.158Z] [2.726s][info][gc,start ] GC(4) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.726s][info][gc,task ] GC(4) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.728s][info][gc,phases ] GC(4) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.158Z] [2.728s][info][gc,phases ] GC(4) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.158Z] [2.728s][info][gc,phases ] GC(4) Evacuate Collection Set: 2.06ms [2025-09-04T06:15:28.158Z] [2.728s][info][gc,phases ] GC(4) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.158Z] [2.728s][info][gc,phases ] GC(4) Other: 0.05ms [2025-09-04T06:15:28.158Z] [2.728s][info][gc,heap ] GC(4) Eden regions: 8->0(8) [2025-09-04T06:15:28.158Z] [2.728s][info][gc,heap ] GC(4) Survivor regions: 2->2(2) [2025-09-04T06:15:28.158Z] [2.728s][info][gc,heap ] GC(4) Old regions: 7->16 [2025-09-04T06:15:28.158Z] [2.728s][info][gc,heap ] GC(4) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.728s][info][gc,metaspace] GC(4) Metaspace: 6058K(6272K)->6058K(6272K) NonClass: 5448K(5568K)->5448K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.158Z] [2.728s][info][gc ] GC(4) Pause Young (Normal) (G1 Evacuation Pause) 16M->17M(128M) 2.493ms [2025-09-04T06:15:28.158Z] [2.728s][info][gc,cpu ] GC(4) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.158Z] [2.740s][info][gc,start ] GC(5) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.740s][info][gc,task ] GC(5) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.742s][info][gc,phases ] GC(5) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.158Z] [2.742s][info][gc,phases ] GC(5) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.158Z] [2.742s][info][gc,phases ] GC(5) Evacuate Collection Set: 1.45ms [2025-09-04T06:15:28.158Z] [2.742s][info][gc,phases ] GC(5) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.158Z] [2.742s][info][gc,phases ] GC(5) Other: 0.04ms [2025-09-04T06:15:28.158Z] [2.742s][info][gc,heap ] GC(5) Eden regions: 8->0(8) [2025-09-04T06:15:28.158Z] [2.742s][info][gc,heap ] GC(5) Survivor regions: 2->2(2) [2025-09-04T06:15:28.158Z] [2.742s][info][gc,heap ] GC(5) Old regions: 16->24 [2025-09-04T06:15:28.158Z] [2.742s][info][gc,heap ] GC(5) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.742s][info][gc,metaspace] GC(5) Metaspace: 6058K(6272K)->6058K(6272K) NonClass: 5448K(5568K)->5448K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.158Z] [2.742s][info][gc ] GC(5) Pause Young (Normal) (G1 Evacuation Pause) 25M->25M(128M) 1.865ms [2025-09-04T06:15:28.158Z] [2.742s][info][gc,cpu ] GC(5) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.158Z] [2.749s][info][gc,start ] GC(6) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.749s][info][gc,task ] GC(6) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.750s][info][gc,phases ] GC(6) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.158Z] [2.750s][info][gc,phases ] GC(6) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.158Z] [2.750s][info][gc,phases ] GC(6) Evacuate Collection Set: 1.43ms [2025-09-04T06:15:28.158Z] [2.750s][info][gc,phases ] GC(6) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.158Z] [2.750s][info][gc,phases ] GC(6) Other: 0.04ms [2025-09-04T06:15:28.158Z] [2.750s][info][gc,heap ] GC(6) Eden regions: 8->0(8) [2025-09-04T06:15:28.158Z] [2.750s][info][gc,heap ] GC(6) Survivor regions: 2->2(2) [2025-09-04T06:15:28.158Z] [2.750s][info][gc,heap ] GC(6) Old regions: 24->32 [2025-09-04T06:15:28.158Z] [2.750s][info][gc,heap ] GC(6) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.751s][info][gc,metaspace] GC(6) Metaspace: 6058K(6272K)->6058K(6272K) NonClass: 5448K(5568K)->5448K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.158Z] [2.751s][info][gc ] GC(6) Pause Young (Normal) (G1 Evacuation Pause) 33M->33M(128M) 1.797ms [2025-09-04T06:15:28.158Z] [2.751s][info][gc,cpu ] GC(6) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.158Z] [2.761s][info][gc,start ] GC(7) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.761s][info][gc,task ] GC(7) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.762s][info][gc,phases ] GC(7) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.158Z] [2.762s][info][gc,phases ] GC(7) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.158Z] [2.763s][info][gc,phases ] GC(7) Evacuate Collection Set: 1.58ms [2025-09-04T06:15:28.158Z] [2.763s][info][gc,phases ] GC(7) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.158Z] [2.763s][info][gc,phases ] GC(7) Other: 0.03ms [2025-09-04T06:15:28.158Z] [2.763s][info][gc,heap ] GC(7) Eden regions: 8->0(8) [2025-09-04T06:15:28.158Z] [2.763s][info][gc,heap ] GC(7) Survivor regions: 2->2(2) [2025-09-04T06:15:28.158Z] [2.763s][info][gc,heap ] GC(7) Old regions: 32->40 [2025-09-04T06:15:28.158Z] [2.763s][info][gc,heap ] GC(7) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.763s][info][gc,metaspace] GC(7) Metaspace: 6058K(6272K)->6058K(6272K) NonClass: 5448K(5568K)->5448K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.158Z] [2.763s][info][gc ] GC(7) Pause Young (Normal) (G1 Evacuation Pause) 41M->41M(128M) 1.927ms [2025-09-04T06:15:28.158Z] [2.763s][info][gc,cpu ] GC(7) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.158Z] [2.769s][info][gc,start ] GC(8) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.769s][info][gc,task ] GC(8) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.771s][info][gc,phases ] GC(8) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.158Z] [2.771s][info][gc,phases ] GC(8) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.158Z] [2.771s][info][gc,phases ] GC(8) Evacuate Collection Set: 1.76ms [2025-09-04T06:15:28.158Z] [2.771s][info][gc,phases ] GC(8) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.158Z] [2.771s][info][gc,phases ] GC(8) Other: 0.04ms [2025-09-04T06:15:28.158Z] [2.771s][info][gc,heap ] GC(8) Eden regions: 8->0(8) [2025-09-04T06:15:28.158Z] [2.771s][info][gc,heap ] GC(8) Survivor regions: 2->2(2) [2025-09-04T06:15:28.158Z] [2.771s][info][gc,heap ] GC(8) Old regions: 40->48 [2025-09-04T06:15:28.158Z] [2.771s][info][gc,heap ] GC(8) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.771s][info][gc,metaspace] GC(8) Metaspace: 6058K(6272K)->6058K(6272K) NonClass: 5448K(5568K)->5448K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.158Z] [2.771s][info][gc ] GC(8) Pause Young (Normal) (G1 Evacuation Pause) 49M->49M(128M) 2.151ms [2025-09-04T06:15:28.158Z] [2.771s][info][gc,cpu ] GC(8) User=0.02s Sys=0.02s Real=0.00s [2025-09-04T06:15:28.158Z] [2.777s][info][gc,start ] GC(9) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.777s][info][gc,task ] GC(9) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.158Z] [2.778s][info][gc,phases ] GC(9) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.158Z] [2.778s][info][gc,phases ] GC(9) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.158Z] [2.778s][info][gc,phases ] GC(9) Evacuate Collection Set: 1.37ms [2025-09-04T06:15:28.158Z] [2.778s][info][gc,phases ] GC(9) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.158Z] [2.778s][info][gc,phases ] GC(9) Other: 0.04ms [2025-09-04T06:15:28.158Z] [2.778s][info][gc,heap ] GC(9) Eden regions: 8->0(8) [2025-09-04T06:15:28.158Z] [2.778s][info][gc,heap ] GC(9) Survivor regions: 2->2(2) [2025-09-04T06:15:28.158Z] [2.778s][info][gc,heap ] GC(9) Old regions: 48->56 [2025-09-04T06:15:28.158Z] [2.778s][info][gc,heap ] GC(9) Humongous regions: 0->0 [2025-09-04T06:15:28.158Z] [2.778s][info][gc,metaspace] GC(9) Metaspace: 6058K(6272K)->6058K(6272K) NonClass: 5448K(5568K)->5448K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.158Z] [2.778s][info][gc ] GC(9) Pause Young (Normal) (G1 Evacuation Pause) 57M->58M(128M) 1.726ms [2025-09-04T06:15:28.158Z] [2.778s][info][gc,cpu ] GC(9) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.158Z] [2.783s][info][gc,start ] GC(10) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.158Z] [2.783s][info][gc,task ] GC(10) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [2.785s][info][gc,phases ] GC(10) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.159Z] [2.785s][info][gc,phases ] GC(10) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.159Z] [2.785s][info][gc,phases ] GC(10) Evacuate Collection Set: 1.35ms [2025-09-04T06:15:28.159Z] [2.785s][info][gc,phases ] GC(10) Post Evacuate Collection Set: 0.12ms [2025-09-04T06:15:28.159Z] [2.785s][info][gc,phases ] GC(10) Other: 0.04ms [2025-09-04T06:15:28.159Z] [2.785s][info][gc,heap ] GC(10) Eden regions: 8->0(8) [2025-09-04T06:15:28.159Z] [2.785s][info][gc,heap ] GC(10) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [2.785s][info][gc,heap ] GC(10) Old regions: 56->65 [2025-09-04T06:15:28.159Z] [2.785s][info][gc,heap ] GC(10) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [2.785s][info][gc,metaspace] GC(10) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [2.785s][info][gc ] GC(10) Pause Young (Normal) (G1 Evacuation Pause) 66M->66M(128M) 1.706ms [2025-09-04T06:15:28.159Z] [2.785s][info][gc,cpu ] GC(10) User=0.02s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.824s][info][gc,start ] GC(11) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [2.824s][info][gc,task ] GC(11) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [2.827s][info][gc,phases ] GC(11) Pre Evacuate Collection Set: 0.10ms [2025-09-04T06:15:28.159Z] [2.827s][info][gc,phases ] GC(11) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.159Z] [2.827s][info][gc,phases ] GC(11) Evacuate Collection Set: 2.12ms [2025-09-04T06:15:28.159Z] [2.827s][info][gc,phases ] GC(11) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.159Z] [2.827s][info][gc,phases ] GC(11) Other: 0.06ms [2025-09-04T06:15:28.159Z] [2.827s][info][gc,heap ] GC(11) Eden regions: 8->0(8) [2025-09-04T06:15:28.159Z] [2.827s][info][gc,heap ] GC(11) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [2.827s][info][gc,heap ] GC(11) Old regions: 65->73 [2025-09-04T06:15:28.159Z] [2.827s][info][gc,heap ] GC(11) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [2.827s][info][gc,metaspace] GC(11) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [2.827s][info][gc ] GC(11) Pause Young (Concurrent Start) (G1 Evacuation Pause) 74M->74M(128M) 2.579ms [2025-09-04T06:15:28.159Z] [2.827s][info][gc,cpu ] GC(11) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.827s][info][gc ] GC(12) Concurrent Mark Cycle [2025-09-04T06:15:28.159Z] [2.827s][info][gc,marking ] GC(12) Concurrent Scan Root Regions [2025-09-04T06:15:28.159Z] [2.828s][info][gc,marking ] GC(12) Concurrent Scan Root Regions 1.300ms [2025-09-04T06:15:28.159Z] [2.828s][info][gc,marking ] GC(12) Concurrent Mark [2025-09-04T06:15:28.159Z] [2.828s][info][gc,marking ] GC(12) Concurrent Mark From Roots [2025-09-04T06:15:28.159Z] [2.828s][info][gc,task ] GC(12) Using 1 workers of 1 for marking [2025-09-04T06:15:28.159Z] [2.836s][info][gc,marking ] GC(12) Concurrent Mark From Roots 7.212ms [2025-09-04T06:15:28.159Z] [2.836s][info][gc,marking ] GC(12) Concurrent Preclean [2025-09-04T06:15:28.159Z] [2.836s][info][gc,marking ] GC(12) Concurrent Preclean 0.020ms [2025-09-04T06:15:28.159Z] [2.836s][info][gc,start ] GC(12) Pause Remark [2025-09-04T06:15:28.159Z] [2.838s][info][gc ] GC(12) Pause Remark 74M->27M(94M) 2.545ms [2025-09-04T06:15:28.159Z] [2.838s][info][gc,cpu ] GC(12) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.839s][info][gc,marking ] GC(12) Concurrent Mark 10.989ms [2025-09-04T06:15:28.159Z] [2.839s][info][gc,marking ] GC(12) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.159Z] [2.842s][info][gc,marking ] GC(12) Concurrent Rebuild Remembered Sets and Scrub Regions 2.846ms [2025-09-04T06:15:28.159Z] [2.843s][info][gc,start ] GC(12) Pause Cleanup [2025-09-04T06:15:28.159Z] [2.843s][info][gc ] GC(12) Pause Cleanup 27M->27M(94M) 0.055ms [2025-09-04T06:15:28.159Z] [2.843s][info][gc,cpu ] GC(12) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.843s][info][gc,marking ] GC(12) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.159Z] [2.843s][info][gc,marking ] GC(12) Concurrent Clear Claimed Marks 0.012ms [2025-09-04T06:15:28.159Z] [2.843s][info][gc,marking ] GC(12) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.159Z] [2.843s][info][gc,marking ] GC(12) Concurrent Cleanup for Next Mark 0.208ms [2025-09-04T06:15:28.159Z] [2.843s][info][gc ] GC(12) Concurrent Mark Cycle 15.960ms [2025-09-04T06:15:28.159Z] [2.850s][info][gc,start ] GC(13) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [2.850s][info][gc,task ] GC(13) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [2.851s][info][gc,phases ] GC(13) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.159Z] [2.851s][info][gc,phases ] GC(13) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.159Z] [2.851s][info][gc,phases ] GC(13) Evacuate Collection Set: 1.17ms [2025-09-04T06:15:28.159Z] [2.851s][info][gc,phases ] GC(13) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.159Z] [2.851s][info][gc,phases ] GC(13) Other: 0.04ms [2025-09-04T06:15:28.159Z] [2.851s][info][gc,heap ] GC(13) Eden regions: 8->0(8) [2025-09-04T06:15:28.159Z] [2.851s][info][gc,heap ] GC(13) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [2.851s][info][gc,heap ] GC(13) Old regions: 26->34 [2025-09-04T06:15:28.159Z] [2.851s][info][gc,heap ] GC(13) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [2.851s][info][gc,metaspace] GC(13) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [2.851s][info][gc ] GC(13) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 35M->35M(94M) 1.532ms [2025-09-04T06:15:28.159Z] [2.851s][info][gc,cpu ] GC(13) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.874s][info][gc,start ] GC(14) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [2.874s][info][gc,task ] GC(14) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [2.876s][info][gc,phases ] GC(14) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.159Z] [2.876s][info][gc,phases ] GC(14) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.159Z] [2.876s][info][gc,phases ] GC(14) Evacuate Collection Set: 1.12ms [2025-09-04T06:15:28.159Z] [2.876s][info][gc,phases ] GC(14) Post Evacuate Collection Set: 0.16ms [2025-09-04T06:15:28.159Z] [2.876s][info][gc,phases ] GC(14) Other: 0.05ms [2025-09-04T06:15:28.159Z] [2.876s][info][gc,heap ] GC(14) Eden regions: 8->0(8) [2025-09-04T06:15:28.159Z] [2.876s][info][gc,heap ] GC(14) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [2.876s][info][gc,heap ] GC(14) Old regions: 34->38 [2025-09-04T06:15:28.159Z] [2.876s][info][gc,heap ] GC(14) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [2.876s][info][gc,metaspace] GC(14) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [2.876s][info][gc ] GC(14) Pause Young (Mixed) (G1 Evacuation Pause) 43M->39M(94M) 1.539ms [2025-09-04T06:15:28.159Z] [2.876s][info][gc,cpu ] GC(14) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.880s][info][gc,start ] GC(15) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [2.881s][info][gc,task ] GC(15) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [2.882s][info][gc,phases ] GC(15) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.159Z] [2.882s][info][gc,phases ] GC(15) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.159Z] [2.882s][info][gc,phases ] GC(15) Evacuate Collection Set: 1.09ms [2025-09-04T06:15:28.159Z] [2.882s][info][gc,phases ] GC(15) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.159Z] [2.882s][info][gc,phases ] GC(15) Other: 0.04ms [2025-09-04T06:15:28.159Z] [2.882s][info][gc,heap ] GC(15) Eden regions: 8->0(8) [2025-09-04T06:15:28.159Z] [2.882s][info][gc,heap ] GC(15) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [2.882s][info][gc,heap ] GC(15) Old regions: 38->46 [2025-09-04T06:15:28.159Z] [2.882s][info][gc,heap ] GC(15) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [2.882s][info][gc,metaspace] GC(15) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [2.882s][info][gc ] GC(15) Pause Young (Normal) (G1 Evacuation Pause) 47M->47M(94M) 1.443ms [2025-09-04T06:15:28.159Z] [2.882s][info][gc,cpu ] GC(15) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.984s][info][gc,start ] GC(16) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [2.984s][info][gc,task ] GC(16) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [2.985s][info][gc,phases ] GC(16) Pre Evacuate Collection Set: 0.08ms [2025-09-04T06:15:28.159Z] [2.985s][info][gc,phases ] GC(16) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.159Z] [2.985s][info][gc,phases ] GC(16) Evacuate Collection Set: 1.11ms [2025-09-04T06:15:28.159Z] [2.985s][info][gc,phases ] GC(16) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.159Z] [2.985s][info][gc,phases ] GC(16) Other: 0.06ms [2025-09-04T06:15:28.159Z] [2.985s][info][gc,heap ] GC(16) Eden regions: 8->0(8) [2025-09-04T06:15:28.159Z] [2.985s][info][gc,heap ] GC(16) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [2.985s][info][gc,heap ] GC(16) Old regions: 46->54 [2025-09-04T06:15:28.159Z] [2.985s][info][gc,heap ] GC(16) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [2.985s][info][gc,metaspace] GC(16) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [2.985s][info][gc ] GC(16) Pause Young (Concurrent Start) (G1 Evacuation Pause) 55M->55M(94M) 1.564ms [2025-09-04T06:15:28.159Z] [2.985s][info][gc,cpu ] GC(16) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.985s][info][gc ] GC(17) Concurrent Mark Cycle [2025-09-04T06:15:28.159Z] [2.985s][info][gc,marking ] GC(17) Concurrent Scan Root Regions [2025-09-04T06:15:28.159Z] [2.986s][info][gc,marking ] GC(17) Concurrent Scan Root Regions 0.234ms [2025-09-04T06:15:28.159Z] [2.986s][info][gc,marking ] GC(17) Concurrent Mark [2025-09-04T06:15:28.159Z] [2.986s][info][gc,marking ] GC(17) Concurrent Mark From Roots [2025-09-04T06:15:28.159Z] [2.986s][info][gc,task ] GC(17) Using 1 workers of 1 for marking [2025-09-04T06:15:28.159Z] [2.992s][info][gc,marking ] GC(17) Concurrent Mark From Roots 6.847ms [2025-09-04T06:15:28.159Z] [2.992s][info][gc,marking ] GC(17) Concurrent Preclean [2025-09-04T06:15:28.159Z] [2.992s][info][gc,marking ] GC(17) Concurrent Preclean 0.014ms [2025-09-04T06:15:28.159Z] [2.993s][info][gc,start ] GC(17) Pause Remark [2025-09-04T06:15:28.159Z] [2.996s][info][gc ] GC(17) Pause Remark 55M->55M(94M) 3.289ms [2025-09-04T06:15:28.159Z] [2.996s][info][gc,cpu ] GC(17) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.996s][info][gc,marking ] GC(17) Concurrent Mark 10.786ms [2025-09-04T06:15:28.159Z] [2.996s][info][gc,marking ] GC(17) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.159Z] [2.999s][info][gc,marking ] GC(17) Concurrent Rebuild Remembered Sets and Scrub Regions 2.905ms [2025-09-04T06:15:28.159Z] [2.999s][info][gc,start ] GC(17) Pause Cleanup [2025-09-04T06:15:28.159Z] [2.999s][info][gc ] GC(17) Pause Cleanup 56M->56M(94M) 0.053ms [2025-09-04T06:15:28.159Z] [2.999s][info][gc,cpu ] GC(17) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [2.999s][info][gc,marking ] GC(17) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.159Z] [2.999s][info][gc,marking ] GC(17) Concurrent Clear Claimed Marks 0.011ms [2025-09-04T06:15:28.159Z] [2.999s][info][gc,marking ] GC(17) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.159Z] [3.000s][info][gc,marking ] GC(17) Concurrent Cleanup for Next Mark 0.080ms [2025-09-04T06:15:28.159Z] [3.000s][info][gc ] GC(17) Concurrent Mark Cycle 14.234ms [2025-09-04T06:15:28.159Z] [3.001s][info][gc,start ] GC(18) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [3.001s][info][gc,task ] GC(18) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [3.002s][info][gc,phases ] GC(18) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.159Z] [3.002s][info][gc,phases ] GC(18) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.159Z] [3.002s][info][gc,phases ] GC(18) Evacuate Collection Set: 0.96ms [2025-09-04T06:15:28.159Z] [3.002s][info][gc,phases ] GC(18) Post Evacuate Collection Set: 0.16ms [2025-09-04T06:15:28.159Z] [3.002s][info][gc,phases ] GC(18) Other: 0.05ms [2025-09-04T06:15:28.159Z] [3.002s][info][gc,heap ] GC(18) Eden regions: 8->0(8) [2025-09-04T06:15:28.159Z] [3.002s][info][gc,heap ] GC(18) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [3.002s][info][gc,heap ] GC(18) Old regions: 54->62 [2025-09-04T06:15:28.159Z] [3.002s][info][gc,heap ] GC(18) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [3.002s][info][gc,metaspace] GC(18) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [3.002s][info][gc ] GC(18) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 63M->63M(94M) 1.370ms [2025-09-04T06:15:28.159Z] [3.002s][info][gc,cpu ] GC(18) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [3.024s][info][gc,start ] GC(19) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [3.024s][info][gc,task ] GC(19) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [3.025s][info][gc,phases ] GC(19) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.159Z] [3.025s][info][gc,phases ] GC(19) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.159Z] [3.025s][info][gc,phases ] GC(19) Evacuate Collection Set: 1.06ms [2025-09-04T06:15:28.159Z] [3.025s][info][gc,phases ] GC(19) Post Evacuate Collection Set: 0.16ms [2025-09-04T06:15:28.159Z] [3.025s][info][gc,phases ] GC(19) Other: 0.04ms [2025-09-04T06:15:28.159Z] [3.025s][info][gc,heap ] GC(19) Eden regions: 8->0(6) [2025-09-04T06:15:28.159Z] [3.025s][info][gc,heap ] GC(19) Survivor regions: 2->2(2) [2025-09-04T06:15:28.159Z] [3.025s][info][gc,heap ] GC(19) Old regions: 62->69 [2025-09-04T06:15:28.159Z] [3.025s][info][gc,heap ] GC(19) Humongous regions: 0->0 [2025-09-04T06:15:28.159Z] [3.025s][info][gc,metaspace] GC(19) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.159Z] [3.025s][info][gc ] GC(19) Pause Young (Mixed) (G1 Evacuation Pause) 71M->70M(94M) 1.476ms [2025-09-04T06:15:28.159Z] [3.025s][info][gc,cpu ] GC(19) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.159Z] [3.027s][info][gc,start ] GC(20) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.159Z] [3.027s][info][gc,task ] GC(20) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.159Z] [3.028s][info][gc,phases ] GC(20) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.159Z] [3.028s][info][gc,phases ] GC(20) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.159Z] [3.028s][info][gc,phases ] GC(20) Evacuate Collection Set: 0.91ms [2025-09-04T06:15:28.159Z] [3.028s][info][gc,phases ] GC(20) Post Evacuate Collection Set: 0.12ms [2025-09-04T06:15:28.159Z] [3.028s][info][gc,phases ] GC(20) Other: 0.05ms [2025-09-04T06:15:28.159Z] [3.028s][info][gc,heap ] GC(20) Eden regions: 6->0(4) [2025-09-04T06:15:28.159Z] [3.028s][info][gc,heap ] GC(20) Survivor regions: 2->1(1) [2025-09-04T06:15:28.160Z] [3.028s][info][gc,heap ] GC(20) Old regions: 69->76 [2025-09-04T06:15:28.160Z] [3.028s][info][gc,heap ] GC(20) Humongous regions: 0->0 [2025-09-04T06:15:28.160Z] [3.028s][info][gc,metaspace] GC(20) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.160Z] [3.028s][info][gc ] GC(20) Pause Young (Concurrent Start) (G1 Evacuation Pause) 76M->77M(94M) 1.276ms [2025-09-04T06:15:28.160Z] [3.028s][info][gc,cpu ] GC(20) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.160Z] [3.028s][info][gc ] GC(21) Concurrent Mark Cycle [2025-09-04T06:15:28.160Z] [3.028s][info][gc,marking ] GC(21) Concurrent Scan Root Regions [2025-09-04T06:15:28.160Z] [3.028s][info][gc,marking ] GC(21) Concurrent Scan Root Regions 0.119ms [2025-09-04T06:15:28.160Z] [3.028s][info][gc,marking ] GC(21) Concurrent Mark [2025-09-04T06:15:28.160Z] [3.028s][info][gc,marking ] GC(21) Concurrent Mark From Roots [2025-09-04T06:15:28.160Z] [3.028s][info][gc,task ] GC(21) Using 1 workers of 1 for marking [2025-09-04T06:15:28.160Z] [3.035s][info][gc,marking ] GC(21) Concurrent Mark From Roots 6.828ms [2025-09-04T06:15:28.160Z] [3.035s][info][gc,marking ] GC(21) Concurrent Preclean [2025-09-04T06:15:28.160Z] [3.035s][info][gc,marking ] GC(21) Concurrent Preclean 0.018ms [2025-09-04T06:15:28.160Z] [3.035s][info][gc,start ] GC(21) Pause Remark [2025-09-04T06:15:28.160Z] [3.036s][info][gc ] GC(21) Pause Remark 77M->35M(94M) 0.792ms [2025-09-04T06:15:28.160Z] [3.036s][info][gc,cpu ] GC(21) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.160Z] [3.036s][info][gc,marking ] GC(21) Concurrent Mark 7.855ms [2025-09-04T06:15:28.160Z] [3.036s][info][gc,marking ] GC(21) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.160Z] [3.037s][info][gc,start ] GC(22) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.160Z] [3.037s][info][gc,task ] GC(22) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.160Z] [3.038s][info][gc,phases ] GC(22) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.160Z] [3.038s][info][gc,phases ] GC(22) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.160Z] [3.038s][info][gc,phases ] GC(22) Evacuate Collection Set: 0.39ms [2025-09-04T06:15:28.160Z] [3.038s][info][gc,phases ] GC(22) Post Evacuate Collection Set: 0.22ms [2025-09-04T06:15:28.160Z] [3.038s][info][gc,phases ] GC(22) Other: 0.05ms [2025-09-04T06:15:28.160Z] [3.038s][info][gc,heap ] GC(22) Eden regions: 4->0(9) [2025-09-04T06:15:28.160Z] [3.038s][info][gc,heap ] GC(22) Survivor regions: 1->1(1) [2025-09-04T06:15:28.160Z] [3.038s][info][gc,heap ] GC(22) Old regions: 34->39 [2025-09-04T06:15:28.160Z] [3.038s][info][gc,heap ] GC(22) Humongous regions: 0->0 [2025-09-04T06:15:28.160Z] [3.038s][info][gc,metaspace] GC(22) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.160Z] [3.038s][info][gc ] GC(22) Pause Young (Normal) (G1 Evacuation Pause) 39M->39M(103M) 0.861ms [2025-09-04T06:15:28.160Z] [3.038s][info][gc,cpu ] GC(22) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.160Z] [3.040s][info][gc,marking ] GC(21) Concurrent Rebuild Remembered Sets and Scrub Regions 3.719ms [2025-09-04T06:15:28.160Z] [3.040s][info][gc,start ] GC(21) Pause Cleanup [2025-09-04T06:15:28.160Z] [3.040s][info][gc ] GC(21) Pause Cleanup 39M->39M(103M) 0.052ms [2025-09-04T06:15:28.160Z] [3.040s][info][gc,cpu ] GC(21) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.160Z] [3.040s][info][gc,marking ] GC(21) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.160Z] [3.040s][info][gc,marking ] GC(21) Concurrent Clear Claimed Marks 0.010ms [2025-09-04T06:15:28.160Z] [3.040s][info][gc,marking ] GC(21) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.160Z] [3.040s][info][gc,marking ] GC(21) Concurrent Cleanup for Next Mark 0.117ms [2025-09-04T06:15:28.160Z] [3.040s][info][gc ] GC(21) Concurrent Mark Cycle 12.055ms [2025-09-04T06:15:28.160Z] [3.043s][info][gc,start ] GC(23) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.160Z] [3.043s][info][gc,task ] GC(23) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.160Z] [3.044s][info][gc,phases ] GC(23) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.160Z] [3.044s][info][gc,phases ] GC(23) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.160Z] [3.044s][info][gc,phases ] GC(23) Evacuate Collection Set: 1.09ms [2025-09-04T06:15:28.160Z] [3.044s][info][gc,phases ] GC(23) Post Evacuate Collection Set: 0.11ms [2025-09-04T06:15:28.160Z] [3.044s][info][gc,phases ] GC(23) Other: 0.04ms [2025-09-04T06:15:28.160Z] [3.044s][info][gc,heap ] GC(23) Eden regions: 9->0(8) [2025-09-04T06:15:28.160Z] [3.044s][info][gc,heap ] GC(23) Survivor regions: 1->2(2) [2025-09-04T06:15:28.160Z] [3.044s][info][gc,heap ] GC(23) Old regions: 39->47 [2025-09-04T06:15:28.160Z] [3.044s][info][gc,heap ] GC(23) Humongous regions: 0->0 [2025-09-04T06:15:28.160Z] [3.044s][info][gc,metaspace] GC(23) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.160Z] [3.044s][info][gc ] GC(23) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 48M->49M(103M) 1.435ms [2025-09-04T06:15:28.160Z] [3.044s][info][gc,cpu ] GC(23) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.160Z] [3.046s][info][gc,start ] GC(24) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.160Z] [3.046s][info][gc,task ] GC(24) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.160Z] [3.047s][info][gc,phases ] GC(24) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.160Z] [3.047s][info][gc,phases ] GC(24) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.160Z] [3.047s][info][gc,phases ] GC(24) Evacuate Collection Set: 0.82ms [2025-09-04T06:15:28.160Z] [3.047s][info][gc,phases ] GC(24) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.160Z] [3.047s][info][gc,phases ] GC(24) Other: 0.04ms [2025-09-04T06:15:28.160Z] [3.047s][info][gc,heap ] GC(24) Eden regions: 8->0(8) [2025-09-04T06:15:28.160Z] [3.047s][info][gc,heap ] GC(24) Survivor regions: 2->2(2) [2025-09-04T06:15:28.160Z] [3.047s][info][gc,heap ] GC(24) Old regions: 47->48 [2025-09-04T06:15:28.160Z] [3.047s][info][gc,heap ] GC(24) Humongous regions: 0->0 [2025-09-04T06:15:28.160Z] [3.047s][info][gc,metaspace] GC(24) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.160Z] [3.047s][info][gc ] GC(24) Pause Young (Mixed) (G1 Evacuation Pause) 56M->50M(103M) 1.170ms [2025-09-04T06:15:28.160Z] [3.047s][info][gc,cpu ] GC(24) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.160Z] [3.048s][info][gc,start ] GC(25) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.160Z] [3.048s][info][gc,task ] GC(25) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.160Z] [3.049s][info][gc,phases ] GC(25) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.160Z] [3.049s][info][gc,phases ] GC(25) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.160Z] [3.049s][info][gc,phases ] GC(25) Evacuate Collection Set: 0.68ms [2025-09-04T06:15:28.162Z] [3.049s][info][gc,phases ] GC(25) Post Evacuate Collection Set: 0.11ms [2025-09-04T06:15:28.162Z] [3.049s][info][gc,phases ] GC(25) Other: 0.05ms [2025-09-04T06:15:28.162Z] [3.049s][info][gc,heap ] GC(25) Eden regions: 8->0(8) [2025-09-04T06:15:28.162Z] [3.049s][info][gc,heap ] GC(25) Survivor regions: 2->2(2) [2025-09-04T06:15:28.162Z] [3.049s][info][gc,heap ] GC(25) Old regions: 48->56 [2025-09-04T06:15:28.162Z] [3.049s][info][gc,heap ] GC(25) Humongous regions: 0->0 [2025-09-04T06:15:28.162Z] [3.049s][info][gc,metaspace] GC(25) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.162Z] [3.049s][info][gc ] GC(25) Pause Young (Concurrent Start) (G1 Evacuation Pause) 57M->58M(103M) 1.019ms [2025-09-04T06:15:28.162Z] [3.049s][info][gc,cpu ] GC(25) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.162Z] [3.049s][info][gc ] GC(26) Concurrent Mark Cycle [2025-09-04T06:15:28.162Z] [3.049s][info][gc,marking ] GC(26) Concurrent Scan Root Regions [2025-09-04T06:15:28.162Z] [3.049s][info][gc,marking ] GC(26) Concurrent Scan Root Regions 0.226ms [2025-09-04T06:15:28.162Z] [3.049s][info][gc,marking ] GC(26) Concurrent Mark [2025-09-04T06:15:28.162Z] [3.049s][info][gc,marking ] GC(26) Concurrent Mark From Roots [2025-09-04T06:15:28.162Z] [3.049s][info][gc,task ] GC(26) Using 1 workers of 1 for marking [2025-09-04T06:15:28.162Z] [3.056s][info][gc,marking ] GC(26) Concurrent Mark From Roots 6.769ms [2025-09-04T06:15:28.162Z] [3.056s][info][gc,marking ] GC(26) Concurrent Preclean [2025-09-04T06:15:28.162Z] [3.056s][info][gc,marking ] GC(26) Concurrent Preclean 0.013ms [2025-09-04T06:15:28.162Z] [3.056s][info][gc,start ] GC(26) Pause Remark [2025-09-04T06:15:28.162Z] [3.057s][info][gc ] GC(26) Pause Remark 58M->58M(103M) 0.726ms [2025-09-04T06:15:28.162Z] [3.057s][info][gc,cpu ] GC(26) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.162Z] [3.057s][info][gc,marking ] GC(26) Concurrent Mark 7.642ms [2025-09-04T06:15:28.162Z] [3.057s][info][gc,marking ] GC(26) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.162Z] [3.059s][info][gc,start ] GC(27) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.162Z] [3.059s][info][gc,task ] GC(27) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.162Z] [3.059s][info][gc,phases ] GC(27) Pre Evacuate Collection Set: 0.04ms [2025-09-04T06:15:28.162Z] [3.059s][info][gc,phases ] GC(27) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.162Z] [3.059s][info][gc,phases ] GC(27) Evacuate Collection Set: 0.60ms [2025-09-04T06:15:28.162Z] [3.059s][info][gc,phases ] GC(27) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.162Z] [3.059s][info][gc,phases ] GC(27) Other: 0.03ms [2025-09-04T06:15:28.162Z] [3.059s][info][gc,heap ] GC(27) Eden regions: 8->0(8) [2025-09-04T06:15:28.162Z] [3.059s][info][gc,heap ] GC(27) Survivor regions: 2->2(2) [2025-09-04T06:15:28.162Z] [3.059s][info][gc,heap ] GC(27) Old regions: 56->65 [2025-09-04T06:15:28.162Z] [3.059s][info][gc,heap ] GC(27) Humongous regions: 0->0 [2025-09-04T06:15:28.163Z] [3.059s][info][gc,metaspace] GC(27) Metaspace: 6061K(6272K)->6061K(6272K) NonClass: 5451K(5568K)->5451K(5568K) Class: 609K(704K)->609K(704K) [2025-09-04T06:15:28.163Z] [3.059s][info][gc ] GC(27) Pause Young (Normal) (G1 Evacuation Pause) 65M->66M(103M) 0.938ms [2025-09-04T06:15:28.163Z] [3.059s][info][gc,cpu ] GC(27) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [3.061s][info][gc,marking ] GC(26) Concurrent Rebuild Remembered Sets and Scrub Regions 3.888ms [2025-09-04T06:15:28.163Z] [3.061s][info][gc,start ] GC(26) Pause Cleanup [2025-09-04T06:15:28.163Z] [3.061s][info][gc ] GC(26) Pause Cleanup 66M->66M(103M) 0.133ms [2025-09-04T06:15:28.163Z] [3.061s][info][gc,cpu ] GC(26) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [3.061s][info][gc,marking ] GC(26) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.163Z] [3.061s][info][gc,marking ] GC(26) Concurrent Clear Claimed Marks 0.011ms [2025-09-04T06:15:28.163Z] [3.061s][info][gc,marking ] GC(26) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.163Z] [3.061s][info][gc,marking ] GC(26) Concurrent Cleanup for Next Mark 0.097ms [2025-09-04T06:15:28.163Z] [3.061s][info][gc ] GC(26) Concurrent Mark Cycle 12.164ms [2025-09-04T06:15:28.163Z] [3.063s][info][gc,start ] GC(28) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.163Z] [3.063s][info][gc,task ] GC(28) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.163Z] [3.065s][info][gc,phases ] GC(28) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.163Z] [3.065s][info][gc,phases ] GC(28) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.163Z] [3.065s][info][gc,phases ] GC(28) Evacuate Collection Set: 0.92ms [2025-09-04T06:15:28.163Z] [3.065s][info][gc,phases ] GC(28) Post Evacuate Collection Set: 0.23ms [2025-09-04T06:15:28.163Z] [3.065s][info][gc,phases ] GC(28) Other: 0.07ms [2025-09-04T06:15:28.163Z] [3.065s][info][gc,heap ] GC(28) Eden regions: 8->0(8) [2025-09-04T06:15:28.163Z] [3.065s][info][gc,heap ] GC(28) Survivor regions: 2->2(2) [2025-09-04T06:15:28.163Z] [3.065s][info][gc,heap ] GC(28) Old regions: 65->73 [2025-09-04T06:15:28.163Z] [3.065s][info][g [2025-09-04T06:15:28.163Z] [2025-09-04T06:15:28.163Z] ... [2025-09-04T06:15:28.163Z] Output overflow: [2025-09-04T06:15:28.163Z] JT Harness has limited the test output to the text [2025-09-04T06:15:28.163Z] at the beginning and the end, so that you can see how the [2025-09-04T06:15:28.163Z] test began, and how it completed. [2025-09-04T06:15:28.163Z] [2025-09-04T06:15:28.163Z] If you need to see more of the output from the test, [2025-09-04T06:15:28.163Z] set the system property javatest.maxOutputSize to a higher [2025-09-04T06:15:28.163Z] value. The current value is 100000 [2025-09-04T06:15:28.163Z] ... [2025-09-04T06:15:28.163Z] [2025-09-04T06:15:28.163Z] t Start) (G1 Evacuation Pause) 72M->73M(90M) 0.890ms [2025-09-04T06:15:28.163Z] [961.999s][info][gc,cpu ] GC(144454) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [961.999s][info][gc ] GC(144455) Concurrent Mark Cycle [2025-09-04T06:15:28.163Z] [961.999s][info][gc,marking ] GC(144455) Concurrent Scan Root Regions [2025-09-04T06:15:28.163Z] [961.999s][info][gc,marking ] GC(144455) Concurrent Scan Root Regions 0.093ms [2025-09-04T06:15:28.163Z] [961.999s][info][gc,marking ] GC(144455) Concurrent Mark [2025-09-04T06:15:28.163Z] [961.999s][info][gc,marking ] GC(144455) Concurrent Mark From Roots [2025-09-04T06:15:28.163Z] [961.999s][info][gc,task ] GC(144455) Using 1 workers of 1 for marking [2025-09-04T06:15:28.163Z] [962.006s][info][gc,marking ] GC(144455) Concurrent Mark From Roots 6.365ms [2025-09-04T06:15:28.163Z] [962.006s][info][gc,marking ] GC(144455) Concurrent Preclean [2025-09-04T06:15:28.163Z] [962.006s][info][gc,marking ] GC(144455) Concurrent Preclean 0.023ms [2025-09-04T06:15:28.163Z] [962.006s][info][gc,start ] GC(144455) Pause Remark [2025-09-04T06:15:28.163Z] [962.006s][info][gc ] GC(144455) Pause Remark 73M->24M(80M) 0.399ms [2025-09-04T06:15:28.163Z] [962.006s][info][gc,cpu ] GC(144455) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.006s][info][gc,marking ] GC(144455) Concurrent Mark 6.950ms [2025-09-04T06:15:28.163Z] [962.006s][info][gc,marking ] GC(144455) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.163Z] [962.007s][info][gc,start ] GC(144456) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.163Z] [962.007s][info][gc,task ] GC(144456) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.163Z] [962.008s][info][gc,phases ] GC(144456) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.163Z] [962.008s][info][gc,phases ] GC(144456) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.163Z] [962.008s][info][gc,phases ] GC(144456) Evacuate Collection Set: 0.43ms [2025-09-04T06:15:28.163Z] [962.008s][info][gc,phases ] GC(144456) Post Evacuate Collection Set: 0.12ms [2025-09-04T06:15:28.163Z] [962.008s][info][gc,phases ] GC(144456) Other: 0.05ms [2025-09-04T06:15:28.163Z] [962.008s][info][gc,heap ] GC(144456) Eden regions: 4->0(9) [2025-09-04T06:15:28.163Z] [962.008s][info][gc,heap ] GC(144456) Survivor regions: 1->1(1) [2025-09-04T06:15:28.163Z] [962.008s][info][gc,heap ] GC(144456) Old regions: 23->27 [2025-09-04T06:15:28.163Z] [962.008s][info][gc,heap ] GC(144456) Humongous regions: 0->0 [2025-09-04T06:15:28.163Z] [962.008s][info][gc,metaspace] GC(144456) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.163Z] [962.008s][info][gc ] GC(144456) Pause Young (Normal) (G1 Evacuation Pause) 28M->28M(80M) 0.789ms [2025-09-04T06:15:28.163Z] [962.008s][info][gc,cpu ] GC(144456) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.014s][info][gc,marking ] GC(144455) Concurrent Rebuild Remembered Sets and Scrub Regions 7.553ms [2025-09-04T06:15:28.163Z] [962.015s][info][gc,start ] GC(144455) Pause Cleanup [2025-09-04T06:15:28.163Z] [962.015s][info][gc ] GC(144455) Pause Cleanup 28M->28M(80M) 0.057ms [2025-09-04T06:15:28.163Z] [962.015s][info][gc,cpu ] GC(144455) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.015s][info][gc,marking ] GC(144455) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.163Z] [962.015s][info][gc,marking ] GC(144455) Concurrent Clear Claimed Marks 0.008ms [2025-09-04T06:15:28.163Z] [962.015s][info][gc,marking ] GC(144455) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.163Z] [962.015s][info][gc,marking ] GC(144455) Concurrent Cleanup for Next Mark 0.083ms [2025-09-04T06:15:28.163Z] [962.015s][info][gc ] GC(144455) Concurrent Mark Cycle 15.483ms [2025-09-04T06:15:28.163Z] [962.016s][info][gc,start ] GC(144457) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.163Z] [962.016s][info][gc,task ] GC(144457) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.163Z] [962.017s][info][gc,phases ] GC(144457) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.163Z] [962.017s][info][gc,phases ] GC(144457) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.163Z] [962.017s][info][gc,phases ] GC(144457) Evacuate Collection Set: 0.90ms [2025-09-04T06:15:28.163Z] [962.017s][info][gc,phases ] GC(144457) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.163Z] [962.017s][info][gc,phases ] GC(144457) Other: 0.04ms [2025-09-04T06:15:28.163Z] [962.017s][info][gc,heap ] GC(144457) Eden regions: 9->0(8) [2025-09-04T06:15:28.163Z] [962.017s][info][gc,heap ] GC(144457) Survivor regions: 1->2(2) [2025-09-04T06:15:28.163Z] [962.017s][info][gc,heap ] GC(144457) Old regions: 27->36 [2025-09-04T06:15:28.163Z] [962.017s][info][gc,heap ] GC(144457) Humongous regions: 0->0 [2025-09-04T06:15:28.163Z] [962.017s][info][gc,metaspace] GC(144457) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.163Z] [962.017s][info][gc ] GC(144457) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 36M->37M(80M) 1.246ms [2025-09-04T06:15:28.163Z] [962.017s][info][gc,cpu ] GC(144457) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.021s][info][gc,start ] GC(144458) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.163Z] [962.021s][info][gc,task ] GC(144458) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.163Z] [962.022s][info][gc,phases ] GC(144458) Pre Evacuate Collection Set: 0.04ms [2025-09-04T06:15:28.163Z] [962.022s][info][gc,phases ] GC(144458) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.163Z] [962.022s][info][gc,phases ] GC(144458) Evacuate Collection Set: 0.99ms [2025-09-04T06:15:28.163Z] [962.022s][info][gc,phases ] GC(144458) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.163Z] [962.022s][info][gc,phases ] GC(144458) Other: 0.03ms [2025-09-04T06:15:28.163Z] [962.022s][info][gc,heap ] GC(144458) Eden regions: 8->0(8) [2025-09-04T06:15:28.163Z] [962.022s][info][gc,heap ] GC(144458) Survivor regions: 2->2(2) [2025-09-04T06:15:28.163Z] [962.022s][info][gc,heap ] GC(144458) Old regions: 36->41 [2025-09-04T06:15:28.163Z] [962.022s][info][gc,heap ] GC(144458) Humongous regions: 0->0 [2025-09-04T06:15:28.163Z] [962.022s][info][gc,metaspace] GC(144458) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.163Z] [962.022s][info][gc ] GC(144458) Pause Young (Mixed) (G1 Evacuation Pause) 45M->42M(80M) 1.320ms [2025-09-04T06:15:28.163Z] [962.022s][info][gc,cpu ] GC(144458) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.037s][info][gc,start ] GC(144459) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.163Z] [962.037s][info][gc,task ] GC(144459) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.163Z] [962.038s][info][gc,phases ] GC(144459) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.163Z] [962.038s][info][gc,phases ] GC(144459) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.163Z] [962.038s][info][gc,phases ] GC(144459) Evacuate Collection Set: 1.29ms [2025-09-04T06:15:28.163Z] [962.038s][info][gc,phases ] GC(144459) Post Evacuate Collection Set: 0.29ms [2025-09-04T06:15:28.163Z] [962.038s][info][gc,phases ] GC(144459) Other: 0.06ms [2025-09-04T06:15:28.163Z] [962.038s][info][gc,heap ] GC(144459) Eden regions: 8->0(8) [2025-09-04T06:15:28.163Z] [962.038s][info][gc,heap ] GC(144459) Survivor regions: 2->2(2) [2025-09-04T06:15:28.163Z] [962.038s][info][gc,heap ] GC(144459) Old regions: 41->49 [2025-09-04T06:15:28.163Z] [962.038s][info][gc,heap ] GC(144459) Humongous regions: 0->0 [2025-09-04T06:15:28.163Z] [962.038s][info][gc,metaspace] GC(144459) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.163Z] [962.038s][info][gc ] GC(144459) Pause Young (Concurrent Start) (G1 Evacuation Pause) 50M->50M(98M) 1.870ms [2025-09-04T06:15:28.163Z] [962.038s][info][gc,cpu ] GC(144459) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.039s][info][gc ] GC(144460) Concurrent Mark Cycle [2025-09-04T06:15:28.163Z] [962.039s][info][gc,marking ] GC(144460) Concurrent Scan Root Regions [2025-09-04T06:15:28.163Z] [962.039s][info][gc,marking ] GC(144460) Concurrent Scan Root Regions 0.214ms [2025-09-04T06:15:28.163Z] [962.039s][info][gc,marking ] GC(144460) Concurrent Mark [2025-09-04T06:15:28.163Z] [962.039s][info][gc,marking ] GC(144460) Concurrent Mark From Roots [2025-09-04T06:15:28.163Z] [962.039s][info][gc,task ] GC(144460) Using 1 workers of 1 for marking [2025-09-04T06:15:28.163Z] [962.045s][info][gc,marking ] GC(144460) Concurrent Mark From Roots 6.368ms [2025-09-04T06:15:28.163Z] [962.045s][info][gc,marking ] GC(144460) Concurrent Preclean [2025-09-04T06:15:28.163Z] [962.045s][info][gc,marking ] GC(144460) Concurrent Preclean 0.019ms [2025-09-04T06:15:28.163Z] [962.046s][info][gc,start ] GC(144460) Pause Remark [2025-09-04T06:15:28.163Z] [962.046s][info][gc ] GC(144460) Pause Remark 50M->50M(98M) 0.361ms [2025-09-04T06:15:28.163Z] [962.046s][info][gc,cpu ] GC(144460) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.046s][info][gc,marking ] GC(144460) Concurrent Mark 7.265ms [2025-09-04T06:15:28.163Z] [962.046s][info][gc,marking ] GC(144460) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.163Z] [962.049s][info][gc,marking ] GC(144460) Concurrent Rebuild Remembered Sets and Scrub Regions 2.716ms [2025-09-04T06:15:28.163Z] [962.049s][info][gc,start ] GC(144460) Pause Cleanup [2025-09-04T06:15:28.163Z] [962.049s][info][gc ] GC(144460) Pause Cleanup 56M->56M(98M) 0.069ms [2025-09-04T06:15:28.163Z] [962.049s][info][gc,cpu ] GC(144460) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.049s][info][gc,marking ] GC(144460) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.163Z] [962.049s][info][gc,marking ] GC(144460) Concurrent Clear Claimed Marks 0.024ms [2025-09-04T06:15:28.163Z] [962.049s][info][gc,marking ] GC(144460) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.163Z] [962.050s][info][gc,marking ] GC(144460) Concurrent Cleanup for Next Mark 0.182ms [2025-09-04T06:15:28.163Z] [962.050s][info][gc ] GC(144460) Concurrent Mark Cycle 10.902ms [2025-09-04T06:15:28.163Z] [962.050s][info][gc,start ] GC(144461) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.163Z] [962.050s][info][gc,task ] GC(144461) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.163Z] [962.052s][info][gc,phases ] GC(144461) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.163Z] [962.052s][info][gc,phases ] GC(144461) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.163Z] [962.052s][info][gc,phases ] GC(144461) Evacuate Collection Set: 1.12ms [2025-09-04T06:15:28.163Z] [962.052s][info][gc,phases ] GC(144461) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.163Z] [962.052s][info][gc,phases ] GC(144461) Other: 0.04ms [2025-09-04T06:15:28.163Z] [962.052s][info][gc,heap ] GC(144461) Eden regions: 8->0(8) [2025-09-04T06:15:28.163Z] [962.052s][info][gc,heap ] GC(144461) Survivor regions: 2->2(2) [2025-09-04T06:15:28.163Z] [962.052s][info][gc,heap ] GC(144461) Old regions: 49->57 [2025-09-04T06:15:28.163Z] [962.052s][info][gc,heap ] GC(144461) Humongous regions: 0->0 [2025-09-04T06:15:28.163Z] [962.052s][info][gc,metaspace] GC(144461) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.163Z] [962.052s][info][gc ] GC(144461) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 58M->58M(98M) 1.496ms [2025-09-04T06:15:28.163Z] [962.052s][info][gc,cpu ] GC(144461) User=0.03s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.163Z] [962.053s][info][gc,start ] GC(144462) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.163Z] [962.053s][info][gc,task ] GC(144462) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.163Z] [962.054s][info][gc,phases ] GC(144462) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.163Z] [962.054s][info][gc,phases ] GC(144462) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.163Z] [962.054s][info][gc,phases ] GC(144462) Evacuate Collection Set: 1.11ms [2025-09-04T06:15:28.163Z] [962.054s][info][gc,phases ] GC(144462) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.163Z] [962.054s][info][gc,phases ] GC(144462) Other: 0.04ms [2025-09-04T06:15:28.163Z] [962.054s][info][gc,heap ] GC(144462) Eden regions: 8->0(8) [2025-09-04T06:15:28.163Z] [962.054s][info][gc,heap ] GC(144462) Survivor regions: 2->2(2) [2025-09-04T06:15:28.163Z] [962.054s][info][gc,heap ] GC(144462) Old regions: 57->63 [2025-09-04T06:15:28.163Z] [962.054s][info][gc,heap ] GC(144462) Humongous regions: 0->0 [2025-09-04T06:15:28.163Z] [962.054s][info][gc,metaspace] GC(144462) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.163Z] [962.054s][info][gc ] GC(144462) Pause Young (Mixed) (G1 Evacuation Pause) 66M->65M(98M) 1.473ms [2025-09-04T06:15:28.164Z] [962.054s][info][gc,cpu ] GC(144462) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.056s][info][gc,start ] GC(144463) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.164Z] [962.056s][info][gc,task ] GC(144463) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.164Z] [962.058s][info][gc,phases ] GC(144463) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.164Z] [962.058s][info][gc,phases ] GC(144463) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.164Z] [962.058s][info][gc,phases ] GC(144463) Evacuate Collection Set: 1.17ms [2025-09-04T06:15:28.164Z] [962.058s][info][gc,phases ] GC(144463) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.164Z] [962.058s][info][gc,phases ] GC(144463) Other: 0.04ms [2025-09-04T06:15:28.164Z] [962.058s][info][gc,heap ] GC(144463) Eden regions: 8->0(7) [2025-09-04T06:15:28.164Z] [962.058s][info][gc,heap ] GC(144463) Survivor regions: 2->2(2) [2025-09-04T06:15:28.164Z] [962.058s][info][gc,heap ] GC(144463) Old regions: 63->71 [2025-09-04T06:15:28.164Z] [962.058s][info][gc,heap ] GC(144463) Humongous regions: 0->0 [2025-09-04T06:15:28.164Z] [962.058s][info][gc,metaspace] GC(144463) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.164Z] [962.058s][info][gc ] GC(144463) Pause Young (Concurrent Start) (G1 Evacuation Pause) 72M->73M(98M) 1.527ms [2025-09-04T06:15:28.164Z] [962.058s][info][gc,cpu ] GC(144463) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.060s][info][gc ] GC(144464) Concurrent Mark Cycle [2025-09-04T06:15:28.164Z] [962.060s][info][gc,marking ] GC(144464) Concurrent Scan Root Regions [2025-09-04T06:15:28.164Z] [962.060s][info][gc,marking ] GC(144464) Concurrent Scan Root Regions 0.108ms [2025-09-04T06:15:28.164Z] [962.060s][info][gc,marking ] GC(144464) Concurrent Mark [2025-09-04T06:15:28.164Z] [962.060s][info][gc,marking ] GC(144464) Concurrent Mark From Roots [2025-09-04T06:15:28.164Z] [962.060s][info][gc,task ] GC(144464) Using 1 workers of 1 for marking [2025-09-04T06:15:28.164Z] [962.066s][info][gc,marking ] GC(144464) Concurrent Mark From Roots 6.357ms [2025-09-04T06:15:28.164Z] [962.066s][info][gc,marking ] GC(144464) Concurrent Preclean [2025-09-04T06:15:28.164Z] [962.066s][info][gc,marking ] GC(144464) Concurrent Preclean 0.015ms [2025-09-04T06:15:28.164Z] [962.081s][info][gc,start ] GC(144464) Pause Remark [2025-09-04T06:15:28.164Z] [962.082s][info][gc ] GC(144464) Pause Remark 73M->25M(84M) 0.633ms [2025-09-04T06:15:28.164Z] [962.082s][info][gc,cpu ] GC(144464) User=0.02s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.082s][info][gc,marking ] GC(144464) Concurrent Mark 22.164ms [2025-09-04T06:15:28.164Z] [962.082s][info][gc,marking ] GC(144464) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.164Z] [962.085s][info][gc,marking ] GC(144464) Concurrent Rebuild Remembered Sets and Scrub Regions 2.781ms [2025-09-04T06:15:28.164Z] [962.085s][info][gc,start ] GC(144464) Pause Cleanup [2025-09-04T06:15:28.164Z] [962.085s][info][gc ] GC(144464) Pause Cleanup 25M->25M(84M) 0.053ms [2025-09-04T06:15:28.164Z] [962.085s][info][gc,cpu ] GC(144464) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.085s][info][gc,marking ] GC(144464) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.164Z] [962.085s][info][gc,marking ] GC(144464) Concurrent Clear Claimed Marks 0.010ms [2025-09-04T06:15:28.164Z] [962.085s][info][gc,marking ] GC(144464) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.164Z] [962.085s][info][gc,marking ] GC(144464) Concurrent Cleanup for Next Mark 0.077ms [2025-09-04T06:15:28.164Z] [962.085s][info][gc ] GC(144464) Concurrent Mark Cycle 25.438ms [2025-09-04T06:15:28.164Z] [962.088s][info][gc,start ] GC(144465) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.164Z] [962.088s][info][gc,task ] GC(144465) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.164Z] [962.089s][info][gc,phases ] GC(144465) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.164Z] [962.089s][info][gc,phases ] GC(144465) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.164Z] [962.089s][info][gc,phases ] GC(144465) Evacuate Collection Set: 0.78ms [2025-09-04T06:15:28.164Z] [962.089s][info][gc,phases ] GC(144465) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.164Z] [962.089s][info][gc,phases ] GC(144465) Other: 0.05ms [2025-09-04T06:15:28.164Z] [962.089s][info][gc,heap ] GC(144465) Eden regions: 7->0(8) [2025-09-04T06:15:28.164Z] [962.089s][info][gc,heap ] GC(144465) Survivor regions: 2->2(2) [2025-09-04T06:15:28.164Z] [962.089s][info][gc,heap ] GC(144465) Old regions: 23->30 [2025-09-04T06:15:28.164Z] [962.089s][info][gc,heap ] GC(144465) Humongous regions: 0->0 [2025-09-04T06:15:28.164Z] [962.089s][info][gc,metaspace] GC(144465) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.164Z] [962.089s][info][gc ] GC(144465) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 31M->32M(84M) 1.197ms [2025-09-04T06:15:28.164Z] [962.089s][info][gc,cpu ] GC(144465) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.090s][info][gc,start ] GC(144466) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.164Z] [962.090s][info][gc,task ] GC(144466) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.164Z] [962.091s][info][gc,phases ] GC(144466) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.164Z] [962.091s][info][gc,phases ] GC(144466) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.164Z] [962.091s][info][gc,phases ] GC(144466) Evacuate Collection Set: 0.87ms [2025-09-04T06:15:28.164Z] [962.091s][info][gc,phases ] GC(144466) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.164Z] [962.091s][info][gc,phases ] GC(144466) Other: 0.04ms [2025-09-04T06:15:28.164Z] [962.091s][info][gc,heap ] GC(144466) Eden regions: 8->0(8) [2025-09-04T06:15:28.164Z] [962.091s][info][gc,heap ] GC(144466) Survivor regions: 2->2(2) [2025-09-04T06:15:28.164Z] [962.091s][info][gc,heap ] GC(144466) Old regions: 30->37 [2025-09-04T06:15:28.164Z] [962.091s][info][gc,heap ] GC(144466) Humongous regions: 0->0 [2025-09-04T06:15:28.164Z] [962.091s][info][gc,metaspace] GC(144466) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.164Z] [962.091s][info][gc ] GC(144466) Pause Young (Mixed) (G1 Evacuation Pause) 39M->38M(84M) 1.262ms [2025-09-04T06:15:28.164Z] [962.091s][info][gc,cpu ] GC(144466) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.093s][info][gc,start ] GC(144467) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.164Z] [962.093s][info][gc,task ] GC(144467) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.164Z] [962.095s][info][gc,phases ] GC(144467) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.164Z] [962.095s][info][gc,phases ] GC(144467) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.164Z] [962.095s][info][gc,phases ] GC(144467) Evacuate Collection Set: 0.86ms [2025-09-04T06:15:28.164Z] [962.095s][info][gc,phases ] GC(144467) Post Evacuate Collection Set: 0.20ms [2025-09-04T06:15:28.164Z] [962.095s][info][gc,phases ] GC(144467) Other: 0.05ms [2025-09-04T06:15:28.164Z] [962.095s][info][gc,heap ] GC(144467) Eden regions: 8->0(8) [2025-09-04T06:15:28.164Z] [962.095s][info][gc,heap ] GC(144467) Survivor regions: 2->2(2) [2025-09-04T06:15:28.164Z] [962.095s][info][gc,heap ] GC(144467) Old regions: 37->45 [2025-09-04T06:15:28.164Z] [962.095s][info][gc,heap ] GC(144467) Humongous regions: 0->0 [2025-09-04T06:15:28.164Z] [962.095s][info][gc,metaspace] GC(144467) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.164Z] [962.095s][info][gc ] GC(144467) Pause Young (Concurrent Start) (G1 Evacuation Pause) 46M->46M(102M) 1.291ms [2025-09-04T06:15:28.164Z] [962.095s][info][gc,cpu ] GC(144467) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.095s][info][gc ] GC(144468) Concurrent Mark Cycle [2025-09-04T06:15:28.164Z] [962.095s][info][gc,marking ] GC(144468) Concurrent Scan Root Regions [2025-09-04T06:15:28.164Z] [962.095s][info][gc,marking ] GC(144468) Concurrent Scan Root Regions 0.190ms [2025-09-04T06:15:28.164Z] [962.095s][info][gc,marking ] GC(144468) Concurrent Mark [2025-09-04T06:15:28.164Z] [962.095s][info][gc,marking ] GC(144468) Concurrent Mark From Roots [2025-09-04T06:15:28.164Z] [962.095s][info][gc,task ] GC(144468) Using 1 workers of 1 for marking [2025-09-04T06:15:28.164Z] [962.102s][info][gc,marking ] GC(144468) Concurrent Mark From Roots 6.731ms [2025-09-04T06:15:28.164Z] [962.102s][info][gc,marking ] GC(144468) Concurrent Preclean [2025-09-04T06:15:28.164Z] [962.102s][info][gc,marking ] GC(144468) Concurrent Preclean 0.016ms [2025-09-04T06:15:28.164Z] [962.103s][info][gc,start ] GC(144468) Pause Remark [2025-09-04T06:15:28.164Z] [962.103s][info][gc ] GC(144468) Pause Remark 46M->46M(102M) 0.483ms [2025-09-04T06:15:28.164Z] [962.103s][info][gc,cpu ] GC(144468) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.103s][info][gc,marking ] GC(144468) Concurrent Mark 8.224ms [2025-09-04T06:15:28.164Z] [962.103s][info][gc,marking ] GC(144468) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.164Z] [962.106s][info][gc,marking ] GC(144468) Concurrent Rebuild Remembered Sets and Scrub Regions 2.766ms [2025-09-04T06:15:28.164Z] [962.106s][info][gc,start ] GC(144468) Pause Cleanup [2025-09-04T06:15:28.164Z] [962.106s][info][gc ] GC(144468) Pause Cleanup 46M->46M(102M) 0.065ms [2025-09-04T06:15:28.164Z] [962.106s][info][gc,cpu ] GC(144468) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.106s][info][gc,marking ] GC(144468) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.164Z] [962.106s][info][gc,marking ] GC(144468) Concurrent Clear Claimed Marks 0.012ms [2025-09-04T06:15:28.164Z] [962.106s][info][gc,marking ] GC(144468) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.164Z] [962.106s][info][gc,marking ] GC(144468) Concurrent Cleanup for Next Mark 0.144ms [2025-09-04T06:15:28.164Z] [962.106s][info][gc ] GC(144468) Concurrent Mark Cycle 11.614ms [2025-09-04T06:15:28.164Z] [962.109s][info][gc,start ] GC(144469) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.164Z] [962.109s][info][gc,task ] GC(144469) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.164Z] [962.111s][info][gc,phases ] GC(144469) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.164Z] [962.111s][info][gc,phases ] GC(144469) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.164Z] [962.111s][info][gc,phases ] GC(144469) Evacuate Collection Set: 0.98ms [2025-09-04T06:15:28.164Z] [962.111s][info][gc,phases ] GC(144469) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.164Z] [962.111s][info][gc,phases ] GC(144469) Other: 0.05ms [2025-09-04T06:15:28.164Z] [962.111s][info][gc,heap ] GC(144469) Eden regions: 8->0(8) [2025-09-04T06:15:28.164Z] [962.111s][info][gc,heap ] GC(144469) Survivor regions: 2->2(2) [2025-09-04T06:15:28.164Z] [962.111s][info][gc,heap ] GC(144469) Old regions: 45->53 [2025-09-04T06:15:28.164Z] [962.111s][info][gc,heap ] GC(144469) Humongous regions: 0->0 [2025-09-04T06:15:28.164Z] [962.111s][info][gc,metaspace] GC(144469) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.164Z] [962.111s][info][gc ] GC(144469) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 54M->55M(102M) 1.401ms [2025-09-04T06:15:28.164Z] [962.111s][info][gc,cpu ] GC(144469) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.112s][info][gc,start ] GC(144470) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.164Z] [962.112s][info][gc,task ] GC(144470) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.164Z] [962.113s][info][gc,phases ] GC(144470) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.164Z] [962.113s][info][gc,phases ] GC(144470) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.164Z] [962.113s][info][gc,phases ] GC(144470) Evacuate Collection Set: 1.22ms [2025-09-04T06:15:28.164Z] [962.113s][info][gc,phases ] GC(144470) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.164Z] [962.113s][info][gc,phases ] GC(144470) Other: 0.03ms [2025-09-04T06:15:28.164Z] [962.113s][info][gc,heap ] GC(144470) Eden regions: 8->0(8) [2025-09-04T06:15:28.164Z] [962.113s][info][gc,heap ] GC(144470) Survivor regions: 2->2(2) [2025-09-04T06:15:28.164Z] [962.113s][info][gc,heap ] GC(144470) Old regions: 53->60 [2025-09-04T06:15:28.164Z] [962.113s][info][gc,heap ] GC(144470) Humongous regions: 0->0 [2025-09-04T06:15:28.164Z] [962.113s][info][gc,metaspace] GC(144470) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.164Z] [962.113s][info][gc ] GC(144470) Pause Young (Mixed) (G1 Evacuation Pause) 63M->61M(102M) 1.562ms [2025-09-04T06:15:28.164Z] [962.113s][info][gc,cpu ] GC(144470) User=0.02s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.162s][info][gc,start ] GC(144471) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.164Z] [962.162s][info][gc,task ] GC(144471) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.164Z] [962.163s][info][gc,phases ] GC(144471) Pre Evacuate Collection Set: 0.08ms [2025-09-04T06:15:28.164Z] [962.163s][info][gc,phases ] GC(144471) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.164Z] [962.163s][info][gc,phases ] GC(144471) Evacuate Collection Set: 0.83ms [2025-09-04T06:15:28.164Z] [962.163s][info][gc,phases ] GC(144471) Post Evacuate Collection Set: 0.12ms [2025-09-04T06:15:28.164Z] [962.163s][info][gc,phases ] GC(144471) Other: 0.07ms [2025-09-04T06:15:28.164Z] [962.163s][info][gc,heap ] GC(144471) Eden regions: 8->0(8) [2025-09-04T06:15:28.164Z] [962.163s][info][gc,heap ] GC(144471) Survivor regions: 2->2(2) [2025-09-04T06:15:28.164Z] [962.163s][info][gc,heap ] GC(144471) Old regions: 60->68 [2025-09-04T06:15:28.164Z] [962.163s][info][gc,heap ] GC(144471) Humongous regions: 0->0 [2025-09-04T06:15:28.164Z] [962.163s][info][gc,metaspace] GC(144471) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.164Z] [962.163s][info][gc ] GC(144471) Pause Young (Concurrent Start) (G1 Evacuation Pause) 69M->70M(102M) 1.270ms [2025-09-04T06:15:28.164Z] [962.164s][info][gc,cpu ] GC(144471) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.164s][info][gc ] GC(144472) Concurrent Mark Cycle [2025-09-04T06:15:28.164Z] [962.164s][info][gc,marking ] GC(144472) Concurrent Scan Root Regions [2025-09-04T06:15:28.164Z] [962.164s][info][gc,marking ] GC(144472) Concurrent Scan Root Regions 0.109ms [2025-09-04T06:15:28.164Z] [962.164s][info][gc,marking ] GC(144472) Concurrent Mark [2025-09-04T06:15:28.164Z] [962.164s][info][gc,marking ] GC(144472) Concurrent Mark From Roots [2025-09-04T06:15:28.164Z] [962.164s][info][gc,task ] GC(144472) Using 1 workers of 1 for marking [2025-09-04T06:15:28.164Z] [962.170s][info][gc,marking ] GC(144472) Concurrent Mark From Roots 6.285ms [2025-09-04T06:15:28.164Z] [962.170s][info][gc,marking ] GC(144472) Concurrent Preclean [2025-09-04T06:15:28.164Z] [962.170s][info][gc,marking ] GC(144472) Concurrent Preclean 0.015ms [2025-09-04T06:15:28.164Z] [962.170s][info][gc,start ] GC(144472) Pause Remark [2025-09-04T06:15:28.164Z] [962.170s][info][gc ] GC(144472) Pause Remark 70M->25M(84M) 0.375ms [2025-09-04T06:15:28.164Z] [962.170s][info][gc,cpu ] GC(144472) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.164Z] [962.170s][info][gc,marking ] GC(144472) Concurrent Mark 6.800ms [2025-09-04T06:15:28.164Z] [962.170s][info][gc,marking ] GC(144472) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.165Z] [962.172s][info][gc,start ] GC(144473) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.172s][info][gc,task ] GC(144473) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.173s][info][gc,phases ] GC(144473) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.165Z] [962.173s][info][gc,phases ] GC(144473) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.165Z] [962.173s][info][gc,phases ] GC(144473) Evacuate Collection Set: 0.79ms [2025-09-04T06:15:28.165Z] [962.173s][info][gc,phases ] GC(144473) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.165Z] [962.173s][info][gc,phases ] GC(144473) Other: 0.04ms [2025-09-04T06:15:28.165Z] [962.173s][info][gc,heap ] GC(144473) Eden regions: 8->0(8) [2025-09-04T06:15:28.165Z] [962.173s][info][gc,heap ] GC(144473) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.173s][info][gc,heap ] GC(144473) Old regions: 23->31 [2025-09-04T06:15:28.165Z] [962.173s][info][gc,heap ] GC(144473) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.173s][info][gc,metaspace] GC(144473) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.173s][info][gc ] GC(144473) Pause Young (Normal) (G1 Evacuation Pause) 32M->33M(84M) 1.161ms [2025-09-04T06:15:28.165Z] [962.173s][info][gc,cpu ] GC(144473) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.174s][info][gc,marking ] GC(144472) Concurrent Rebuild Remembered Sets and Scrub Regions 3.844ms [2025-09-04T06:15:28.165Z] [962.175s][info][gc,start ] GC(144472) Pause Cleanup [2025-09-04T06:15:28.165Z] [962.175s][info][gc ] GC(144472) Pause Cleanup 33M->33M(84M) 0.068ms [2025-09-04T06:15:28.165Z] [962.175s][info][gc,cpu ] GC(144472) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.175s][info][gc,marking ] GC(144472) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.165Z] [962.175s][info][gc,marking ] GC(144472) Concurrent Clear Claimed Marks 0.013ms [2025-09-04T06:15:28.165Z] [962.175s][info][gc,marking ] GC(144472) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.165Z] [962.176s][info][gc,marking ] GC(144472) Concurrent Cleanup for Next Mark 0.097ms [2025-09-04T06:15:28.165Z] [962.176s][info][gc ] GC(144472) Concurrent Mark Cycle 12.072ms [2025-09-04T06:15:28.165Z] [962.177s][info][gc,start ] GC(144474) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.177s][info][gc,task ] GC(144474) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.178s][info][gc,phases ] GC(144474) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.165Z] [962.178s][info][gc,phases ] GC(144474) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.165Z] [962.178s][info][gc,phases ] GC(144474) Evacuate Collection Set: 1.19ms [2025-09-04T06:15:28.165Z] [962.178s][info][gc,phases ] GC(144474) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.165Z] [962.178s][info][gc,phases ] GC(144474) Other: 0.04ms [2025-09-04T06:15:28.165Z] [962.178s][info][gc,heap ] GC(144474) Eden regions: 8->0(8) [2025-09-04T06:15:28.165Z] [962.178s][info][gc,heap ] GC(144474) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.178s][info][gc,heap ] GC(144474) Old regions: 31->39 [2025-09-04T06:15:28.165Z] [962.178s][info][gc,heap ] GC(144474) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.178s][info][gc,metaspace] GC(144474) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.178s][info][gc ] GC(144474) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 40M->41M(84M) 1.579ms [2025-09-04T06:15:28.165Z] [962.178s][info][gc,cpu ] GC(144474) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.180s][info][gc,start ] GC(144475) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.180s][info][gc,task ] GC(144475) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.181s][info][gc,phases ] GC(144475) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.165Z] [962.181s][info][gc,phases ] GC(144475) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.165Z] [962.181s][info][gc,phases ] GC(144475) Evacuate Collection Set: 0.76ms [2025-09-04T06:15:28.165Z] [962.181s][info][gc,phases ] GC(144475) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.165Z] [962.181s][info][gc,phases ] GC(144475) Other: 0.03ms [2025-09-04T06:15:28.165Z] [962.181s][info][gc,heap ] GC(144475) Eden regions: 8->0(8) [2025-09-04T06:15:28.165Z] [962.181s][info][gc,heap ] GC(144475) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.181s][info][gc,heap ] GC(144475) Old regions: 39->44 [2025-09-04T06:15:28.165Z] [962.181s][info][gc,heap ] GC(144475) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.181s][info][gc,metaspace] GC(144475) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.181s][info][gc ] GC(144475) Pause Young (Mixed) (G1 Evacuation Pause) 48M->46M(84M) 1.105ms [2025-09-04T06:15:28.165Z] [962.181s][info][gc,cpu ] GC(144475) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.191s][info][gc,start ] GC(144476) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.191s][info][gc,task ] GC(144476) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.192s][info][gc,phases ] GC(144476) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.165Z] [962.192s][info][gc,phases ] GC(144476) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.165Z] [962.192s][info][gc,phases ] GC(144476) Evacuate Collection Set: 0.79ms [2025-09-04T06:15:28.165Z] [962.192s][info][gc,phases ] GC(144476) Post Evacuate Collection Set: 0.17ms [2025-09-04T06:15:28.165Z] [962.192s][info][gc,phases ] GC(144476) Other: 0.06ms [2025-09-04T06:15:28.165Z] [962.192s][info][gc,heap ] GC(144476) Eden regions: 8->0(8) [2025-09-04T06:15:28.165Z] [962.192s][info][gc,heap ] GC(144476) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.192s][info][gc,heap ] GC(144476) Old regions: 44->52 [2025-09-04T06:15:28.165Z] [962.192s][info][gc,heap ] GC(144476) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.192s][info][gc,metaspace] GC(144476) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.192s][info][gc ] GC(144476) Pause Young (Concurrent Start) (G1 Evacuation Pause) 53M->54M(102M) 1.232ms [2025-09-04T06:15:28.165Z] [962.192s][info][gc,cpu ] GC(144476) User=0.03s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.192s][info][gc ] GC(144477) Concurrent Mark Cycle [2025-09-04T06:15:28.165Z] [962.192s][info][gc,marking ] GC(144477) Concurrent Scan Root Regions [2025-09-04T06:15:28.165Z] [962.192s][info][gc,marking ] GC(144477) Concurrent Scan Root Regions 0.223ms [2025-09-04T06:15:28.165Z] [962.192s][info][gc,marking ] GC(144477) Concurrent Mark [2025-09-04T06:15:28.165Z] [962.192s][info][gc,marking ] GC(144477) Concurrent Mark From Roots [2025-09-04T06:15:28.165Z] [962.192s][info][gc,task ] GC(144477) Using 1 workers of 1 for marking [2025-09-04T06:15:28.165Z] [962.199s][info][gc,marking ] GC(144477) Concurrent Mark From Roots 6.417ms [2025-09-04T06:15:28.165Z] [962.199s][info][gc,marking ] GC(144477) Concurrent Preclean [2025-09-04T06:15:28.165Z] [962.199s][info][gc,marking ] GC(144477) Concurrent Preclean 0.015ms [2025-09-04T06:15:28.165Z] [962.199s][info][gc,start ] GC(144477) Pause Remark [2025-09-04T06:15:28.165Z] [962.200s][info][gc ] GC(144477) Pause Remark 54M->52M(102M) 0.425ms [2025-09-04T06:15:28.165Z] [962.200s][info][gc,cpu ] GC(144477) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.200s][info][gc,marking ] GC(144477) Concurrent Mark 7.787ms [2025-09-04T06:15:28.165Z] [962.200s][info][gc,marking ] GC(144477) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.165Z] [962.202s][info][gc,start ] GC(144478) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.202s][info][gc,task ] GC(144478) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.203s][info][gc,phases ] GC(144478) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.165Z] [962.203s][info][gc,phases ] GC(144478) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.165Z] [962.203s][info][gc,phases ] GC(144478) Evacuate Collection Set: 0.73ms [2025-09-04T06:15:28.165Z] [962.203s][info][gc,phases ] GC(144478) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.165Z] [962.203s][info][gc,phases ] GC(144478) Other: 0.04ms [2025-09-04T06:15:28.165Z] [962.203s][info][gc,heap ] GC(144478) Eden regions: 8->0(8) [2025-09-04T06:15:28.165Z] [962.203s][info][gc,heap ] GC(144478) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.203s][info][gc,heap ] GC(144478) Old regions: 50->58 [2025-09-04T06:15:28.165Z] [962.203s][info][gc,heap ] GC(144478) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.203s][info][gc,metaspace] GC(144478) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.203s][info][gc ] GC(144478) Pause Young (Normal) (G1 Evacuation Pause) 59M->60M(102M) 1.099ms [2025-09-04T06:15:28.165Z] [962.203s][info][gc,cpu ] GC(144478) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.204s][info][gc,marking ] GC(144477) Concurrent Rebuild Remembered Sets and Scrub Regions 3.919ms [2025-09-04T06:15:28.165Z] [962.205s][info][gc,start ] GC(144477) Pause Cleanup [2025-09-04T06:15:28.165Z] [962.205s][info][gc ] GC(144477) Pause Cleanup 60M->60M(102M) 0.087ms [2025-09-04T06:15:28.165Z] [962.205s][info][gc,cpu ] GC(144477) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.205s][info][gc,marking ] GC(144477) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.165Z] [962.205s][info][gc,marking ] GC(144477) Concurrent Clear Claimed Marks 0.014ms [2025-09-04T06:15:28.165Z] [962.205s][info][gc,marking ] GC(144477) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.165Z] [962.205s][info][gc,marking ] GC(144477) Concurrent Cleanup for Next Mark 0.151ms [2025-09-04T06:15:28.165Z] [962.205s][info][gc ] GC(144477) Concurrent Mark Cycle 13.320ms [2025-09-04T06:15:28.165Z] [962.206s][info][gc,start ] GC(144479) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.207s][info][gc,task ] GC(144479) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.208s][info][gc,phases ] GC(144479) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.165Z] [962.208s][info][gc,phases ] GC(144479) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.165Z] [962.208s][info][gc,phases ] GC(144479) Evacuate Collection Set: 0.97ms [2025-09-04T06:15:28.165Z] [962.208s][info][gc,phases ] GC(144479) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.165Z] [962.208s][info][gc,phases ] GC(144479) Other: 0.06ms [2025-09-04T06:15:28.165Z] [962.208s][info][gc,heap ] GC(144479) Eden regions: 8->0(8) [2025-09-04T06:15:28.165Z] [962.208s][info][gc,heap ] GC(144479) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.208s][info][gc,heap ] GC(144479) Old regions: 58->66 [2025-09-04T06:15:28.165Z] [962.208s][info][gc,heap ] GC(144479) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.208s][info][gc,metaspace] GC(144479) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.208s][info][gc ] GC(144479) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 67M->68M(102M) 1.380ms [2025-09-04T06:15:28.165Z] [962.208s][info][gc,cpu ] GC(144479) User=0.00s Sys=0.02s Real=0.00s [2025-09-04T06:15:28.165Z] [962.211s][info][gc,start ] GC(144480) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.211s][info][gc,task ] GC(144480) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.212s][info][gc,phases ] GC(144480) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.165Z] [962.212s][info][gc,phases ] GC(144480) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.165Z] [962.212s][info][gc,phases ] GC(144480) Evacuate Collection Set: 0.76ms [2025-09-04T06:15:28.165Z] [962.212s][info][gc,phases ] GC(144480) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.165Z] [962.212s][info][gc,phases ] GC(144480) Other: 0.04ms [2025-09-04T06:15:28.165Z] [962.212s][info][gc,heap ] GC(144480) Eden regions: 8->0(7) [2025-09-04T06:15:28.165Z] [962.212s][info][gc,heap ] GC(144480) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.212s][info][gc,heap ] GC(144480) Old regions: 66->73 [2025-09-04T06:15:28.165Z] [962.212s][info][gc,heap ] GC(144480) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.212s][info][gc,metaspace] GC(144480) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.212s][info][gc ] GC(144480) Pause Young (Mixed) (G1 Evacuation Pause) 75M->74M(102M) 1.110ms [2025-09-04T06:15:28.165Z] [962.212s][info][gc,cpu ] GC(144480) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.213s][info][gc,start ] GC(144481) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.165Z] [962.213s][info][gc,task ] GC(144481) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.165Z] [962.214s][info][gc,phases ] GC(144481) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.165Z] [962.214s][info][gc,phases ] GC(144481) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.165Z] [962.214s][info][gc,phases ] GC(144481) Evacuate Collection Set: 0.82ms [2025-09-04T06:15:28.165Z] [962.214s][info][gc,phases ] GC(144481) Post Evacuate Collection Set: 0.13ms [2025-09-04T06:15:28.165Z] [962.214s][info][gc,phases ] GC(144481) Other: 0.04ms [2025-09-04T06:15:28.165Z] [962.214s][info][gc,heap ] GC(144481) Eden regions: 7->0(5) [2025-09-04T06:15:28.165Z] [962.214s][info][gc,heap ] GC(144481) Survivor regions: 2->2(2) [2025-09-04T06:15:28.165Z] [962.214s][info][gc,heap ] GC(144481) Old regions: 73->80 [2025-09-04T06:15:28.165Z] [962.214s][info][gc,heap ] GC(144481) Humongous regions: 0->0 [2025-09-04T06:15:28.165Z] [962.214s][info][gc,metaspace] GC(144481) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.165Z] [962.214s][info][gc ] GC(144481) Pause Young (Concurrent Start) (G1 Evacuation Pause) 81M->82M(102M) 1.181ms [2025-09-04T06:15:28.165Z] [962.214s][info][gc,cpu ] GC(144481) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.214s][info][gc ] GC(144482) Concurrent Mark Cycle [2025-09-04T06:15:28.165Z] [962.214s][info][gc,marking ] GC(144482) Concurrent Scan Root Regions [2025-09-04T06:15:28.165Z] [962.214s][info][gc,marking ] GC(144482) Concurrent Scan Root Regions 0.143ms [2025-09-04T06:15:28.165Z] [962.214s][info][gc,marking ] GC(144482) Concurrent Mark [2025-09-04T06:15:28.165Z] [962.214s][info][gc,marking ] GC(144482) Concurrent Mark From Roots [2025-09-04T06:15:28.165Z] [962.214s][info][gc,task ] GC(144482) Using 1 workers of 1 for marking [2025-09-04T06:15:28.165Z] [962.220s][info][gc,marking ] GC(144482) Concurrent Mark From Roots 6.339ms [2025-09-04T06:15:28.165Z] [962.220s][info][gc,marking ] GC(144482) Concurrent Preclean [2025-09-04T06:15:28.165Z] [962.220s][info][gc,marking ] GC(144482) Concurrent Preclean 0.016ms [2025-09-04T06:15:28.165Z] [962.221s][info][gc,start ] GC(144482) Pause Remark [2025-09-04T06:15:28.165Z] [962.221s][info][gc ] GC(144482) Pause Remark 82M->35M(102M) 0.344ms [2025-09-04T06:15:28.165Z] [962.221s][info][gc,cpu ] GC(144482) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.165Z] [962.221s][info][gc,marking ] GC(144482) Concurrent Mark 6.948ms [2025-09-04T06:15:28.165Z] [962.221s][info][gc,marking ] GC(144482) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.165Z] [962.223s][info][gc,start ] GC(144483) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.166Z] [962.223s][info][gc,task ] GC(144483) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.166Z] [962.224s][info][gc,phases ] GC(144483) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.166Z] [962.224s][info][gc,phases ] GC(144483) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.166Z] [962.224s][info][gc,phases ] GC(144483) Evacuate Collection Set: 0.56ms [2025-09-04T06:15:28.166Z] [962.224s][info][gc,phases ] GC(144483) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.166Z] [962.224s][info][gc,phases ] GC(144483) Other: 0.04ms [2025-09-04T06:15:28.166Z] [962.224s][info][gc,heap ] GC(144483) Eden regions: 5->0(9) [2025-09-04T06:15:28.166Z] [962.224s][info][gc,heap ] GC(144483) Survivor regions: 2->1(1) [2025-09-04T06:15:28.166Z] [962.224s][info][gc,heap ] GC(144483) Old regions: 33->39 [2025-09-04T06:15:28.166Z] [962.224s][info][gc,heap ] GC(144483) Humongous regions: 0->0 [2025-09-04T06:15:28.166Z] [962.224s][info][gc,metaspace] GC(144483) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.166Z] [962.224s][info][gc ] GC(144483) Pause Young (Normal) (G1 Evacuation Pause) 39M->40M(102M) 0.918ms [2025-09-04T06:15:28.166Z] [962.224s][info][gc,cpu ] GC(144483) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.225s][info][gc,marking ] GC(144482) Concurrent Rebuild Remembered Sets and Scrub Regions 3.677ms [2025-09-04T06:15:28.166Z] [962.241s][info][gc,start ] GC(144482) Pause Cleanup [2025-09-04T06:15:28.166Z] [962.241s][info][gc ] GC(144482) Pause Cleanup 40M->40M(102M) 0.071ms [2025-09-04T06:15:28.166Z] [962.241s][info][gc,cpu ] GC(144482) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.241s][info][gc,marking ] GC(144482) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.166Z] [962.241s][info][gc,marking ] GC(144482) Concurrent Clear Claimed Marks 0.012ms [2025-09-04T06:15:28.166Z] [962.241s][info][gc,marking ] GC(144482) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.166Z] [962.241s][info][gc,marking ] GC(144482) Concurrent Cleanup for Next Mark 0.113ms [2025-09-04T06:15:28.166Z] [962.241s][info][gc ] GC(144482) Concurrent Mark Cycle 26.966ms [2025-09-04T06:15:28.166Z] [962.242s][info][gc,start ] GC(144484) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.166Z] [962.242s][info][gc,task ] GC(144484) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.166Z] [962.244s][info][gc,phases ] GC(144484) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.166Z] [962.244s][info][gc,phases ] GC(144484) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.166Z] [962.244s][info][gc,phases ] GC(144484) Evacuate Collection Set: 1.43ms [2025-09-04T06:15:28.166Z] [962.244s][info][gc,phases ] GC(144484) Post Evacuate Collection Set: 0.17ms [2025-09-04T06:15:28.166Z] [962.244s][info][gc,phases ] GC(144484) Other: 0.04ms [2025-09-04T06:15:28.166Z] [962.244s][info][gc,heap ] GC(144484) Eden regions: 9->0(8) [2025-09-04T06:15:28.166Z] [962.244s][info][gc,heap ] GC(144484) Survivor regions: 1->2(2) [2025-09-04T06:15:28.166Z] [962.244s][info][gc,heap ] GC(144484) Old regions: 39->47 [2025-09-04T06:15:28.166Z] [962.244s][info][gc,heap ] GC(144484) Humongous regions: 0->0 [2025-09-04T06:15:28.166Z] [962.244s][info][gc,metaspace] GC(144484) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.166Z] [962.244s][info][gc ] GC(144484) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 48M->49M(102M) 1.823ms [2025-09-04T06:15:28.166Z] [962.244s][info][gc,cpu ] GC(144484) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.274s][info][gc,start ] GC(144485) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.166Z] [962.274s][info][gc,task ] GC(144485) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.166Z] [962.275s][info][gc,phases ] GC(144485) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.166Z] [962.275s][info][gc,phases ] GC(144485) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.166Z] [962.275s][info][gc,phases ] GC(144485) Evacuate Collection Set: 0.97ms [2025-09-04T06:15:28.166Z] [962.275s][info][gc,phases ] GC(144485) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.166Z] [962.275s][info][gc,phases ] GC(144485) Other: 0.05ms [2025-09-04T06:15:28.166Z] [962.275s][info][gc,heap ] GC(144485) Eden regions: 8->0(8) [2025-09-04T06:15:28.166Z] [962.275s][info][gc,heap ] GC(144485) Survivor regions: 2->2(2) [2025-09-04T06:15:28.166Z] [962.275s][info][gc,heap ] GC(144485) Old regions: 47->53 [2025-09-04T06:15:28.166Z] [962.275s][info][gc,heap ] GC(144485) Humongous regions: 0->0 [2025-09-04T06:15:28.166Z] [962.275s][info][gc,metaspace] GC(144485) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.166Z] [962.275s][info][gc ] GC(144485) Pause Young (Mixed) (G1 Evacuation Pause) 56M->55M(102M) 1.389ms [2025-09-04T06:15:28.166Z] [962.275s][info][gc,cpu ] GC(144485) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.280s][info][gc,start ] GC(144486) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.166Z] [962.280s][info][gc,task ] GC(144486) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.166Z] [962.281s][info][gc,phases ] GC(144486) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.166Z] [962.281s][info][gc,phases ] GC(144486) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.166Z] [962.281s][info][gc,phases ] GC(144486) Evacuate Collection Set: 0.82ms [2025-09-04T06:15:28.166Z] [962.281s][info][gc,phases ] GC(144486) Post Evacuate Collection Set: 0.14ms [2025-09-04T06:15:28.166Z] [962.281s][info][gc,phases ] GC(144486) Other: 0.06ms [2025-09-04T06:15:28.166Z] [962.282s][info][gc,heap ] GC(144486) Eden regions: 8->0(8) [2025-09-04T06:15:28.166Z] [962.282s][info][gc,heap ] GC(144486) Survivor regions: 2->2(2) [2025-09-04T06:15:28.166Z] [962.282s][info][gc,heap ] GC(144486) Old regions: 53->61 [2025-09-04T06:15:28.166Z] [962.282s][info][gc,heap ] GC(144486) Humongous regions: 0->0 [2025-09-04T06:15:28.166Z] [962.282s][info][gc,metaspace] GC(144486) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.166Z] [962.282s][info][gc ] GC(144486) Pause Young (Concurrent Start) (G1 Evacuation Pause) 62M->63M(102M) 1.216ms [2025-09-04T06:15:28.166Z] [962.282s][info][gc,cpu ] GC(144486) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.282s][info][gc ] GC(144487) Concurrent Mark Cycle [2025-09-04T06:15:28.166Z] [962.282s][info][gc,marking ] GC(144487) Concurrent Scan Root Regions [2025-09-04T06:15:28.166Z] [962.282s][info][gc,marking ] GC(144487) Concurrent Scan Root Regions 0.259ms [2025-09-04T06:15:28.166Z] [962.282s][info][gc,marking ] GC(144487) Concurrent Mark [2025-09-04T06:15:28.166Z] [962.282s][info][gc,marking ] GC(144487) Concurrent Mark From Roots [2025-09-04T06:15:28.166Z] [962.282s][info][gc,task ] GC(144487) Using 1 workers of 1 for marking [2025-09-04T06:15:28.166Z] [962.288s][info][gc,marking ] GC(144487) Concurrent Mark From Roots 6.464ms [2025-09-04T06:15:28.166Z] [962.288s][info][gc,marking ] GC(144487) Concurrent Preclean [2025-09-04T06:15:28.166Z] [962.288s][info][gc,marking ] GC(144487) Concurrent Preclean 0.021ms [2025-09-04T06:15:28.166Z] [962.288s][info][gc,start ] GC(144487) Pause Remark [2025-09-04T06:15:28.166Z] [962.289s][info][gc ] GC(144487) Pause Remark 63M->63M(105M) 0.402ms [2025-09-04T06:15:28.166Z] [962.289s][info][gc,cpu ] GC(144487) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.289s][info][gc,marking ] GC(144487) Concurrent Mark 7.015ms [2025-09-04T06:15:28.166Z] [962.289s][info][gc,marking ] GC(144487) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.166Z] [962.292s][info][gc,marking ] GC(144487) Concurrent Rebuild Remembered Sets and Scrub Regions 2.728ms [2025-09-04T06:15:28.166Z] [962.305s][info][gc,start ] GC(144487) Pause Cleanup [2025-09-04T06:15:28.166Z] [962.305s][info][gc ] GC(144487) Pause Cleanup 66M->66M(105M) 0.089ms [2025-09-04T06:15:28.166Z] [962.305s][info][gc,cpu ] GC(144487) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.305s][info][gc,marking ] GC(144487) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.166Z] [962.305s][info][gc,marking ] GC(144487) Concurrent Clear Claimed Marks 0.014ms [2025-09-04T06:15:28.166Z] [962.305s][info][gc,marking ] GC(144487) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.166Z] [962.305s][info][gc,marking ] GC(144487) Concurrent Cleanup for Next Mark 0.144ms [2025-09-04T06:15:28.166Z] [962.305s][info][gc ] GC(144487) Concurrent Mark Cycle 23.747ms [2025-09-04T06:15:28.166Z] [962.306s][info][gc,start ] GC(144488) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.166Z] [962.306s][info][gc,task ] GC(144488) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.166Z] [962.308s][info][gc,phases ] GC(144488) Pre Evacuate Collection Set: 0.07ms [2025-09-04T06:15:28.166Z] [962.308s][info][gc,phases ] GC(144488) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.166Z] [962.308s][info][gc,phases ] GC(144488) Evacuate Collection Set: 1.00ms [2025-09-04T06:15:28.166Z] [962.308s][info][gc,phases ] GC(144488) Post Evacuate Collection Set: 0.16ms [2025-09-04T06:15:28.166Z] [962.308s][info][gc,phases ] GC(144488) Other: 0.05ms [2025-09-04T06:15:28.166Z] [962.308s][info][gc,heap ] GC(144488) Eden regions: 8->0(8) [2025-09-04T06:15:28.166Z] [962.308s][info][gc,heap ] GC(144488) Survivor regions: 2->2(2) [2025-09-04T06:15:28.166Z] [962.308s][info][gc,heap ] GC(144488) Old regions: 61->69 [2025-09-04T06:15:28.166Z] [962.308s][info][gc,heap ] GC(144488) Humongous regions: 0->0 [2025-09-04T06:15:28.166Z] [962.308s][info][gc,metaspace] GC(144488) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.166Z] [962.308s][info][gc ] GC(144488) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 70M->70M(105M) 1.418ms [2025-09-04T06:15:28.166Z] [962.308s][info][gc,cpu ] GC(144488) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.309s][info][gc,start ] GC(144489) Pause Young (Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.166Z] [962.309s][info][gc,task ] GC(144489) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.166Z] [962.310s][info][gc,phases ] GC(144489) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.166Z] [962.310s][info][gc,phases ] GC(144489) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.166Z] [962.310s][info][gc,phases ] GC(144489) Evacuate Collection Set: 0.77ms [2025-09-04T06:15:28.166Z] [962.310s][info][gc,phases ] GC(144489) Post Evacuate Collection Set: 0.21ms [2025-09-04T06:15:28.166Z] [962.310s][info][gc,phases ] GC(144489) Other: 0.04ms [2025-09-04T06:15:28.166Z] [962.311s][info][gc,heap ] GC(144489) Eden regions: 8->0(8) [2025-09-04T06:15:28.166Z] [962.311s][info][gc,heap ] GC(144489) Survivor regions: 2->2(2) [2025-09-04T06:15:28.166Z] [962.311s][info][gc,heap ] GC(144489) Old regions: 69->75 [2025-09-04T06:15:28.166Z] [962.311s][info][gc,heap ] GC(144489) Humongous regions: 0->0 [2025-09-04T06:15:28.166Z] [962.311s][info][gc,metaspace] GC(144489) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.166Z] [962.311s][info][gc ] GC(144489) Pause Young (Mixed) (G1 Evacuation Pause) 78M->76M(115M) 1.224ms [2025-09-04T06:15:28.166Z] [962.311s][info][gc,cpu ] GC(144489) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.343s][info][gc,start ] GC(144490) Pause Young (Concurrent Start) (G1 Evacuation Pause) [2025-09-04T06:15:28.166Z] [962.343s][info][gc,task ] GC(144490) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.166Z] [962.345s][info][gc,phases ] GC(144490) Pre Evacuate Collection Set: 0.09ms [2025-09-04T06:15:28.166Z] [962.345s][info][gc,phases ] GC(144490) Merge Heap Roots: 0.01ms [2025-09-04T06:15:28.166Z] [962.345s][info][gc,phases ] GC(144490) Evacuate Collection Set: 1.80ms [2025-09-04T06:15:28.166Z] [962.345s][info][gc,phases ] GC(144490) Post Evacuate Collection Set: 0.17ms [2025-09-04T06:15:28.166Z] [962.345s][info][gc,phases ] GC(144490) Other: 0.07ms [2025-09-04T06:15:28.166Z] [962.345s][info][gc,heap ] GC(144490) Eden regions: 8->0(8) [2025-09-04T06:15:28.166Z] [962.345s][info][gc,heap ] GC(144490) Survivor regions: 2->2(2) [2025-09-04T06:15:28.166Z] [962.345s][info][gc,heap ] GC(144490) Old regions: 75->83 [2025-09-04T06:15:28.166Z] [962.345s][info][gc,heap ] GC(144490) Humongous regions: 0->0 [2025-09-04T06:15:28.166Z] [962.345s][info][gc,metaspace] GC(144490) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.166Z] [962.345s][info][gc ] GC(144490) Pause Young (Concurrent Start) (G1 Evacuation Pause) 84M->85M(115M) 2.278ms [2025-09-04T06:15:28.166Z] [962.345s][info][gc,cpu ] GC(144490) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.166Z] [962.345s][info][gc ] GC(144491) Concurrent Mark Cycle [2025-09-04T06:15:28.167Z] [962.345s][info][gc,marking ] GC(144491) Concurrent Scan Root Regions [2025-09-04T06:15:28.167Z] [962.345s][info][gc,marking ] GC(144491) Concurrent Scan Root Regions 0.157ms [2025-09-04T06:15:28.167Z] [962.345s][info][gc,marking ] GC(144491) Concurrent Mark [2025-09-04T06:15:28.167Z] [962.345s][info][gc,marking ] GC(144491) Concurrent Mark From Roots [2025-09-04T06:15:28.167Z] [962.345s][info][gc,task ] GC(144491) Using 1 workers of 1 for marking [2025-09-04T06:15:28.167Z] [962.352s][info][gc,marking ] GC(144491) Concurrent Mark From Roots 6.392ms [2025-09-04T06:15:28.167Z] [962.352s][info][gc,marking ] GC(144491) Concurrent Preclean [2025-09-04T06:15:28.167Z] [962.352s][info][gc,marking ] GC(144491) Concurrent Preclean 0.016ms [2025-09-04T06:15:28.167Z] [962.369s][info][gc,start ] GC(144491) Pause Remark [2025-09-04T06:15:28.167Z] [962.369s][info][gc ] GC(144491) Pause Remark 85M->39M(115M) 0.533ms [2025-09-04T06:15:28.167Z] [962.369s][info][gc,cpu ] GC(144491) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.167Z] [962.371s][info][gc,marking ] GC(144491) Concurrent Mark 25.761ms [2025-09-04T06:15:28.167Z] [962.371s][info][gc,marking ] GC(144491) Concurrent Rebuild Remembered Sets and Scrub Regions [2025-09-04T06:15:28.167Z] [962.372s][info][gc,start ] GC(144492) Pause Young (Normal) (G1 Evacuation Pause) [2025-09-04T06:15:28.167Z] [962.373s][info][gc,task ] GC(144492) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.167Z] [962.374s][info][gc,phases ] GC(144492) Pre Evacuate Collection Set: 0.06ms [2025-09-04T06:15:28.167Z] [962.374s][info][gc,phases ] GC(144492) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.167Z] [962.374s][info][gc,phases ] GC(144492) Evacuate Collection Set: 1.12ms [2025-09-04T06:15:28.167Z] [962.374s][info][gc,phases ] GC(144492) Post Evacuate Collection Set: 0.15ms [2025-09-04T06:15:28.167Z] [962.374s][info][gc,phases ] GC(144492) Other: 0.05ms [2025-09-04T06:15:28.167Z] [962.374s][info][gc,heap ] GC(144492) Eden regions: 8->0(8) [2025-09-04T06:15:28.167Z] [962.374s][info][gc,heap ] GC(144492) Survivor regions: 2->2(2) [2025-09-04T06:15:28.167Z] [962.374s][info][gc,heap ] GC(144492) Old regions: 37->45 [2025-09-04T06:15:28.167Z] [962.374s][info][gc,heap ] GC(144492) Humongous regions: 0->0 [2025-09-04T06:15:28.167Z] [962.374s][info][gc,metaspace] GC(144492) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.167Z] [962.374s][info][gc ] GC(144492) Pause Young (Normal) (G1 Evacuation Pause) 46M->47M(115M) 1.532ms [2025-09-04T06:15:28.167Z] [962.374s][info][gc,cpu ] GC(144492) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.167Z] [962.376s][info][gc,marking ] GC(144491) Concurrent Rebuild Remembered Sets and Scrub Regions 4.335ms [2025-09-04T06:15:28.167Z] [962.376s][info][gc,start ] GC(144491) Pause Cleanup [2025-09-04T06:15:28.167Z] [962.376s][info][gc ] GC(144491) Pause Cleanup 47M->47M(115M) 0.068ms [2025-09-04T06:15:28.167Z] [962.376s][info][gc,cpu ] GC(144491) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.167Z] [962.376s][info][gc,marking ] GC(144491) Concurrent Clear Claimed Marks [2025-09-04T06:15:28.167Z] [962.376s][info][gc,marking ] GC(144491) Concurrent Clear Claimed Marks 0.014ms [2025-09-04T06:15:28.167Z] [962.376s][info][gc,marking ] GC(144491) Concurrent Cleanup for Next Mark [2025-09-04T06:15:28.167Z] [962.376s][info][gc,marking ] GC(144491) Concurrent Cleanup for Next Mark 0.175ms [2025-09-04T06:15:28.167Z] [962.376s][info][gc ] GC(144491) Concurrent Mark Cycle 30.709ms [2025-09-04T06:15:28.167Z] [962.377s][info][gc,start ] GC(144493) Pause Young (Prepare Mixed) (G1 Evacuation Pause) [2025-09-04T06:15:28.167Z] [962.377s][info][gc,task ] GC(144493) Using 2 workers of 2 for evacuation [2025-09-04T06:15:28.167Z] [962.378s][info][gc,phases ] GC(144493) Pre Evacuate Collection Set: 0.05ms [2025-09-04T06:15:28.167Z] [962.378s][info][gc,phases ] GC(144493) Merge Heap Roots: 0.02ms [2025-09-04T06:15:28.167Z] [962.378s][info][gc,phases ] GC(144493) Evacuate Collection Set: 0.87ms [2025-09-04T06:15:28.167Z] [962.378s][info][gc,phases ] GC(144493) Post Evacuate Collection Set: 0.12ms [2025-09-04T06:15:28.167Z] [962.378s][info][gc,phases ] GC(144493) Other: 0.04ms [2025-09-04T06:15:28.167Z] [962.378s][info][gc,heap ] GC(144493) Eden regions: 8->0(8) [2025-09-04T06:15:28.167Z] [962.378s][info][gc,heap ] GC(144493) Survivor regions: 2->2(2) [2025-09-04T06:15:28.167Z] [962.378s][info][gc,heap ] GC(144493) Old regions: 45->53 [2025-09-04T06:15:28.167Z] [962.378s][info][gc,heap ] GC(144493) Humongous regions: 0->0 [2025-09-04T06:15:28.167Z] [962.378s][info][gc,metaspace] GC(144493) Metaspace: 6072K(6336K)->6072K(6336K) NonClass: 5476K(5632K)->5476K(5632K) Class: 596K(704K)->596K(704K) [2025-09-04T06:15:28.167Z] [962.378s][info][gc ] GC(144493) Pause Young (Prepare Mixed) (G1 Evacuation Pause) 54M->55M(115M) 1.218ms [2025-09-04T06:15:28.167Z] [962.378s][info][gc,cpu ] GC(144493) User=0.00s Sys=0.00s Real=0.00s [2025-09-04T06:15:28.167Z] STDERR: [2025-09-04T06:15:28.167Z] rerun: [2025-09-04T06:15:28.167Z] cd 'C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\scratch\0' && \ [2025-09-04T06:15:28.167Z] PATH='C:\cygwin64\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0;C:\Windows\System32\OpenSSH;C:\Users\adoptopenjdk\AppData\Local\Microsoft\WindowsApps;C:\Strawberry\perl\bin;C:\Program Files\Git\cmd;C:\openjdk\jdk-8\bin;C:\apache-ant\apache-ant-1.10.15\bin;C:\Program Files (x86)\Windows Kits\10\Windows Performance Toolkit;C:\Program Files (x86)\Incredibuild;C:\rust\bin;C:\Program Files\IcedTeaWEB\bin;C:\Program Files\dotnet;C:\Users\jenkins\AppData\Local\Microsoft\WindowsApps' \ [2025-09-04T06:15:28.167Z] SystemDrive=C: \ [2025-09-04T06:15:28.167Z] SystemRoot='C:\Windows' \ [2025-09-04T06:15:28.167Z] TEMP='C:\Users\jenkins\AppData\Local\Temp' \ [2025-09-04T06:15:28.167Z] TMP='C:\Users\jenkins\AppData\Local\Temp' \ [2025-09-04T06:15:28.167Z] windir='C:\Windows' \ [2025-09-04T06:15:28.167Z] CLASSPATH='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\jdk;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jvmtest\openjdk\jtreg\lib\javatest.jar;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jvmtest\openjdk\jtreg\lib\jtreg.jar' \ [2025-09-04T06:15:28.167Z] 'c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image\bin\java' \ [2025-09-04T06:15:28.167Z] -Dtest.vm.opts='-ea -esa -Xmx768m -XX:+UseCompressedOops' \ [2025-09-04T06:15:28.167Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx768m -J-XX:+UseCompressedOops' \ [2025-09-04T06:15:28.167Z] -Dtest.compiler.opts= \ [2025-09-04T06:15:28.167Z] -Dtest.java.opts= \ [2025-09-04T06:15:28.167Z] -Dtest.jdk='c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image' \ [2025-09-04T06:15:28.167Z] -Dcompile.jdk='c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image' \ [2025-09-04T06:15:28.167Z] -Dtest.timeout.factor=8.0 \ [2025-09-04T06:15:28.167Z] -Dtest.nativepath='c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\openjdk-test-image\jdk\jtreg\native' \ [2025-09-04T06:15:28.167Z] -Dtest.root='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk' \ [2025-09-04T06:15:28.167Z] -Dtest.name=jdk/jfr/event/gc/stacktrace/TestG1OldAllocationPendingStackTrace.java \ [2025-09-04T06:15:28.167Z] -Dtest.file='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.java' \ [2025-09-04T06:15:28.167Z] -Dtest.src='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace' \ [2025-09-04T06:15:28.167Z] -Dtest.src.path='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk' \ [2025-09-04T06:15:28.167Z] -Dtest.classes='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d' \ [2025-09-04T06:15:28.167Z] -Dtest.class.path='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\jdk' \ [2025-09-04T06:15:28.167Z] -Dtest.class.path.prefix='C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\openjdk\openjdk-jdk\test\jdk\jdk\jfr\event\gc\stacktrace;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\lib;C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\classes\1\test\jdk' \ [2025-09-04T06:15:28.167Z] -Dtest.modules='jdk.jfr java.management jdk.management' \ [2025-09-04T06:15:28.167Z] --add-modules jdk.jfr,java.management,jdk.management \ [2025-09-04T06:15:28.167Z] -ea \ [2025-09-04T06:15:28.167Z] -esa \ [2025-09-04T06:15:28.167Z] -Xmx768m \ [2025-09-04T06:15:28.167Z] -XX:+UseCompressedOops \ [2025-09-04T06:15:28.167Z] '-Djava.library.path=c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\openjdk-test-image\jdk\jtreg\native' \ [2025-09-04T06:15:28.167Z] -XX:MaxNewSize=10M \ [2025-09-04T06:15:28.167Z] -Xmx128M \ [2025-09-04T06:15:28.167Z] -XX:+UseG1GC \ [2025-09-04T06:15:28.167Z] -Xlog:gc* \ [2025-09-04T06:15:28.167Z] com.sun.javatest.regtest.agent.MainWrapper 'C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work\jdk\jfr\event\gc\stacktrace\TestG1OldAllocationPendingStackTrace.d\main.0.jta' [2025-09-04T06:15:28.167Z] [2025-09-04T06:15:28.167Z] TEST RESULT: Error. Program `c:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\jdkbinary\j2sdk-image\bin\java' timed out (timeout set to 960000ms, elapsed time including timeout handling was 962465ms). [2025-09-04T06:15:28.167Z] -------------------------------------------------- [2025-09-04T06:24:08.741Z] Test results: passed: 582; error: 1 [2025-09-04T06:24:17.590Z] Report written to C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\report\html\report.html [2025-09-04T06:24:17.590Z] Results written to C:\jenkins\workspace\Test_openjdk21_hs_extended.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_17569536838139\jdk_jfr_0\work [2025-09-04T06:24:17.590Z] Error: Some tests failed or other problems occurred. [2025-09-04T06:24:17.590Z] ----------------------------------- [2025-09-04T06:24:17.590Z] jdk_jfr_0_FAILED [2025-09-04T06:24:17.590Z] ----------------------------------- [2025-09-04T06:24:17.590Z] [2025-09-04T06:24:17.590Z] TEST TEARDOWN: [2025-09-04T06:24:17.590Z] Nothing to be done for teardown. [2025-09-04T06:24:17.590Z] jdk_jfr_0 Finish Time: Thu Sep 4 06:24:17 2025 Epoch Time (ms): 1756967057190