[2025-03-26T22:18:02.253Z] Running test hotspot_gc_0 ... [2025-03-26T22:18:02.253Z] =============================================== [2025-03-26T22:18:02.253Z] hotspot_gc_0 Start Time: Wed Mar 26 22:18:00 2025 Epoch Time (ms): 1743027480590 [2025-03-26T22:18:02.253Z] variation: NoOptions [2025-03-26T22:18:02.253Z] JVM_OPTIONS: [2025-03-26T22:18:02.253Z] { \ [2025-03-26T22:18:02.253Z] echo ""; echo "TEST SETUP:"; \ [2025-03-26T22:18:02.253Z] echo "Nothing to be done for setup."; \ [2025-03-26T22:18:02.253Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17430274792006/hotspot_gc_0"; \ [2025-03-26T22:18:02.253Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17430274792006/hotspot_gc_0"; \ [2025-03-26T22:18:02.253Z] echo ""; echo "TESTING:"; \ [2025-03-26T22:18:02.253Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-03-26T22:18:02.253Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/openjdk-test-image/hotspot/jtreg/native" -vmoptions:"-Xmx512m " \ [2025-03-26T22:18:02.253Z] -w ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17430274792006/hotspot_gc_0"/work" \ [2025-03-26T22:18:02.253Z] -r ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17430274792006/hotspot_gc_0"/report" \ [2025-03-26T22:18:02.253Z] -jdk:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image" \ [2025-03-26T22:18:02.253Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../openjdk/openjdk-jdk/test/hotspot/jtreg/ProblemList.txt" \ [2025-03-26T22:18:02.253Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk21.txt" \ [2025-03-26T22:18:02.253Z] \ [2025-03-26T22:18:02.253Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../openjdk/excludes/vendors/eclipse/ProblemList_openjdk21.txt" \ [2025-03-26T22:18:02.253Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../openjdk/openjdk-jdk/test/hotspot/jtreg:hotspot_gc"; \ [2025-03-26T22:18:02.253Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "hotspot_gc_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "hotspot_gc_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-26T22:18:02.253Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-26T22:18:02.253Z] echo "Nothing to be done for teardown."; \ [2025-03-26T22:18:02.253Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17430274792006/TestTargetResult"; [2025-03-26T22:18:02.253Z] [2025-03-26T22:18:02.253Z] TEST SETUP: [2025-03-26T22:18:02.253Z] Nothing to be done for setup. [2025-03-26T22:18:02.253Z] [2025-03-26T22:18:02.253Z] TESTING: [2025-03-26T22:18:05.205Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17430274792006/hotspot_gc_0/work" not found: creating [2025-03-26T22:18:05.205Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17430274792006/hotspot_gc_0/report" not found: creating [2025-03-26T22:19:03.231Z] XML output with verification to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work [2025-03-27T02:42:12.470Z] -------------------------------------------------- [2025-03-27T02:42:12.470Z] TEST: gc/x/TestHighUsage.java [2025-03-27T02:42:12.470Z] TEST JDK: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image [2025-03-27T02:42:12.470Z] [2025-03-27T02:42:12.470Z] ACTION: build -- Passed. Build successful [2025-03-27T02:42:12.470Z] REASON: Named class compiled on demand [2025-03-27T02:42:12.470Z] TIME: 1.743 seconds [2025-03-27T02:42:12.470Z] messages: [2025-03-27T02:42:12.470Z] command: build gc.x.TestHighUsage [2025-03-27T02:42:12.470Z] reason: Named class compiled on demand [2025-03-27T02:42:12.470Z] started: Thu Mar 27 02:40:22 UTC 2025 [2025-03-27T02:42:12.470Z] Test directory: [2025-03-27T02:42:12.470Z] compile: gc.x.TestHighUsage [2025-03-27T02:42:12.470Z] finished: Thu Mar 27 02:40:24 UTC 2025 [2025-03-27T02:42:12.470Z] elapsed time (seconds): 1.743 [2025-03-27T02:42:12.470Z] [2025-03-27T02:42:12.470Z] ACTION: compile -- Passed. Compilation successful [2025-03-27T02:42:12.470Z] REASON: .class file out of date or does not exist [2025-03-27T02:42:12.470Z] TIME: 1.742 seconds [2025-03-27T02:42:12.470Z] messages: [2025-03-27T02:42:12.470Z] command: compile /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x/TestHighUsage.java [2025-03-27T02:42:12.470Z] reason: .class file out of date or does not exist [2025-03-27T02:42:12.470Z] started: Thu Mar 27 02:40:22 UTC 2025 [2025-03-27T02:42:12.470Z] Mode: agentvm [2025-03-27T02:42:12.470Z] Agent id: 3 [2025-03-27T02:42:12.470Z] finished: Thu Mar 27 02:40:24 UTC 2025 [2025-03-27T02:42:12.470Z] elapsed time (seconds): 1.742 [2025-03-27T02:42:12.470Z] configuration: [2025-03-27T02:42:12.470Z] Boot Layer (javac runtime environment) [2025-03-27T02:42:12.470Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-03-27T02:42:12.470Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-03-27T02:42:12.470Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/patches/java.base [2025-03-27T02:42:12.470Z] [2025-03-27T02:42:12.470Z] javac compilation environment [2025-03-27T02:42:12.470Z] source path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x [2025-03-27T02:42:12.470Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/lib [2025-03-27T02:42:12.470Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x [2025-03-27T02:42:12.470Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d [2025-03-27T02:42:12.470Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib [2025-03-27T02:42:12.470Z] [2025-03-27T02:42:12.470Z] rerun: [2025-03-27T02:42:12.470Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/scratch/2 && \ [2025-03-27T02:42:12.470Z] DISPLAY=:0 \ [2025-03-27T02:42:12.470Z] HOME=/home/jenkins \ [2025-03-27T02:42:12.470Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-03-27T02:42:12.470Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/javac \ [2025-03-27T02:42:12.470Z] -J-ea \ [2025-03-27T02:42:12.470Z] -J-esa \ [2025-03-27T02:42:12.470Z] -J-Xmx512m \ [2025-03-27T02:42:12.470Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m' \ [2025-03-27T02:42:12.470Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2025-03-27T02:42:12.470Z] -J-Dtest.compiler.opts= \ [2025-03-27T02:42:12.470Z] -J-Dtest.java.opts= \ [2025-03-27T02:42:12.470Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image \ [2025-03-27T02:42:12.470Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image \ [2025-03-27T02:42:12.470Z] -J-Dtest.timeout.factor=8.0 \ [2025-03-27T02:42:12.470Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-03-27T02:42:12.470Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg \ [2025-03-27T02:42:12.470Z] -J-Dtest.name=gc/x/TestHighUsage.java \ [2025-03-27T02:42:12.470Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x/TestHighUsage.java \ [2025-03-27T02:42:12.470Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x \ [2025-03-27T02:42:12.470Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-03-27T02:42:12.470Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d \ [2025-03-27T02:42:12.470Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib \ [2025-03-27T02:42:12.471Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib \ [2025-03-27T02:42:12.471Z] -d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d \ [2025-03-27T02:42:12.471Z] -sourcepath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-03-27T02:42:12.471Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x/TestHighUsage.java [2025-03-27T02:42:12.471Z] direct: [2025-03-27T02:42:12.471Z] Note: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/lib/jdk/test/lib/Asserts.java uses unchecked or unsafe operations. [2025-03-27T02:42:12.471Z] Note: Recompile with -Xlint:unchecked for details. [2025-03-27T02:42:12.471Z] [2025-03-27T02:42:12.471Z] ACTION: main -- Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: 'High Usage' missing from stdout/stderr [2025-03-27T02:42:12.471Z] REASON: User specified action: run main/othervm gc.x.TestHighUsage [2025-03-27T02:42:12.471Z] TIME: 100.443 seconds [2025-03-27T02:42:12.471Z] messages: [2025-03-27T02:42:12.471Z] command: main gc.x.TestHighUsage [2025-03-27T02:42:12.471Z] reason: User specified action: run main/othervm gc.x.TestHighUsage [2025-03-27T02:42:12.471Z] started: Thu Mar 27 02:40:24 UTC 2025 [2025-03-27T02:42:12.471Z] Mode: othervm [/othervm specified] [2025-03-27T02:42:12.471Z] finished: Thu Mar 27 02:42:04 UTC 2025 [2025-03-27T02:42:12.471Z] elapsed time (seconds): 100.443 [2025-03-27T02:42:12.471Z] configuration: [2025-03-27T02:42:12.471Z] STDOUT: [2025-03-27T02:42:12.471Z] Command line: [/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java -cp /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jvmtest/openjdk/jtreg/lib/jtreg.jar -ea -esa -Xmx512m -XX:+UseZGC -XX:-ZGenerational -XX:-ZProactive -Xms128M -Xmx128M -XX:ParallelGCThreads=1 -XX:ConcGCThreads=1 -Xlog:gc,gc+start gc.x.TestHighUsage$Test ] [2025-03-27T02:42:12.471Z] [2025-03-27T02:40:25.944152060Z] Gathering output for process 1864624 [2025-03-27T02:42:12.471Z] [2025-03-27T02:40:26.377307294Z] Waiting for completion for process 1864624 [2025-03-27T02:42:12.471Z] [2025-03-27T02:42:04.109784697Z] Waiting for completion finished for process 1864624 [2025-03-27T02:42:12.471Z] Output and diagnostic info for process 1864624 was saved into 'pid-1864624-output.log' [2025-03-27T02:42:12.471Z] STDERR: [2025-03-27T02:42:12.471Z] stdout: [[0.194s][info][gc] Using The Z Garbage Collector [2025-03-27T02:42:12.471Z] Max capacity: 128M [2025-03-27T02:42:12.471Z] High usage threshold: 6M [2025-03-27T02:42:12.471Z] Allocating live-set [2025-03-27T02:42:12.471Z] [1.225s][info][gc,start] GC(0) Garbage Collection (System.gc()) [2025-03-27T02:42:12.471Z] [2.069s][info][gc ] GC(0) Garbage Collection (System.gc()) 112M(88%)->112M(88%) [2025-03-27T02:42:12.471Z] [2.164s][info][gc,start] GC(1) Garbage Collection (Warmup) [2025-03-27T02:42:12.471Z] [2.907s][info][gc ] GC(1) Garbage Collection (Warmup) 112M(88%)->110M(86%) [2025-03-27T02:42:12.471Z] [2.948s][info][gc,start] GC(2) Garbage Collection (Warmup) [2025-03-27T02:42:12.471Z] [3.732s][info][gc ] GC(2) Garbage Collection (Warmup) 110M(86%)->110M(86%) [2025-03-27T02:42:12.471Z] [3.752s][info][gc,start] GC(3) Garbage Collection (Warmup) [2025-03-27T02:42:12.471Z] [4.620s][info][gc ] GC(3) Garbage Collection (Warmup) 110M(86%)->112M(88%) [2025-03-27T02:42:12.471Z] [4.620s][info][gc,start] GC(4) Garbage Collection (System.gc()) [2025-03-27T02:42:12.471Z] [5.724s][info][gc ] GC(4) Garbage Collection (System.gc()) 112M(88%)->110M(86%) [2025-03-27T02:42:12.471Z] [5.756s][info][gc,start] GC(5) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] [6.575s][info][gc ] GC(5) Garbage Collection (Allocation Rate) 110M(86%)->110M(86%) [2025-03-27T02:42:12.471Z] [7.734s][info][gc,start] GC(6) Garbage Collection (System.gc()) [2025-03-27T02:42:12.471Z] [8.621s][info][gc ] GC(6) Garbage Collection (System.gc()) 112M(88%)->110M(86%) [2025-03-27T02:42:12.471Z] [10.628s][info][gc,start] GC(7) Garbage Collection (System.gc()) [2025-03-27T02:42:12.471Z] [11.334s][info][gc ] GC(7) Garbage Collection (System.gc()) 112M(88%)->110M(86%) [2025-03-27T02:42:12.471Z] [13.352s][info][gc,start] GC(8) Garbage Collection (System.gc()) [2025-03-27T02:42:12.471Z] [14.168s][info][gc ] GC(8) Garbage Collection (System.gc()) 112M(88%)->110M(86%) [2025-03-27T02:42:12.471Z] [16.173s][info][gc,start] GC(9) Garbage Collection (System.gc()) [2025-03-27T02:42:12.471Z] [16.733s][info][gc ] GC(9) Garbage Collection (System.gc()) 112M(88%)->110M(86%) [2025-03-27T02:42:12.471Z] [16.745s][info][gc,start] GC(10) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] [17.391s][info][gc ] GC(10) Garbage Collection (Allocation Rate) 110M(86%)->110M(86%) [2025-03-27T02:42:12.471Z] [18.745s][info][gc,start] GC(11) Garbage Collection (System.gc()) [2025-03-27T02:42:12.471Z] [19.552s][info][gc ] GC(11) Garbage Collection (System.gc()) 112M(88%)->112M(88%) [2025-03-27T02:42:12.471Z] [20.249s][info][gc,start] GC(12) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] [21.196s][info][gc ] GC(12) Garbage Collection (Allocation Rate) 112M(88%)->112M(88%) [2025-03-27T02:42:12.471Z] Allocating garbage slowly [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] [21.642s][info][gc,start] GC(13) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [22.628s][info][gc ] GC(13) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] [22.642s][info][gc,start] GC(14) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [23.604s][info][gc ] GC(14) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] [23.944s][info][gc,start] GC(15) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [24.734s][info][gc ] GC(15) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] [24.748s][info][gc,start] GC(16) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [25.657s][info][gc ] GC(16) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] [25.744s][info][gc,start] GC(17) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [26.593s][info][gc ] GC(17) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] [27.246s][info][gc,start] GC(18) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [27.989s][info][gc ] GC(18) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] [28.043s][info][gc,start] GC(19) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [28.592s][info][gc ] GC(19) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] [29.443s][info][gc,start] GC(20) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [30.112s][info][gc ] GC(20) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] [30.143s][info][gc,start] GC(21) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] Free: 12M (Allocating) [2025-03-27T02:42:12.471Z] [30.817s][info][gc ] GC(21) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.471Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [31.856s][info][gc,start] GC(22) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [32.586s][info][gc ] GC(22) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [32.643s][info][gc,start] GC(23) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [33.409s][info][gc ] GC(23) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [34.352s][info][gc,start] GC(24) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [35.095s][info][gc ] GC(24) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [35.960s][info][gc,start] GC(25) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [36.832s][info][gc ] GC(25) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [36.852s][info][gc,start] GC(26) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [37.734s][info][gc ] GC(26) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [37.748s][info][gc,start] GC(27) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [38.688s][info][gc ] GC(27) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [39.148s][info][gc,start] GC(28) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [40.156s][info][gc ] GC(28) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [40.344s][info][gc,start] GC(29) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [41.114s][info][gc ] GC(29) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [41.156s][info][gc,start] GC(30) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [41.515s][info][gc ] GC(30) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [41.543s][info][gc,start] GC(31) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [42.000s][info][gc ] GC(31) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [42.060s][info][gc,start] GC(32) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [42.860s][info][gc ] GC(32) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [42.984s][info][gc,start] GC(33) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [43.744s][info][gc ] GC(33) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [44.160s][info][gc,start] GC(34) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [45.012s][info][gc ] GC(34) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [45.043s][info][gc,start] GC(35) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [46.096s][info][gc ] GC(35) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [46.160s][info][gc,start] GC(36) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [47.134s][info][gc ] GC(36) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [47.443s][info][gc,start] GC(37) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [48.408s][info][gc ] GC(37) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [48.848s][info][gc,start] GC(38) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [49.732s][info][gc ] GC(38) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [50.152s][info][gc,start] GC(39) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [51.074s][info][gc ] GC(39) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [51.143s][info][gc,start] GC(40) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [51.973s][info][gc ] GC(40) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [52.448s][info][gc,start] GC(41) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [53.188s][info][gc ] GC(41) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [53.248s][info][gc,start] GC(42) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [53.959s][info][gc ] GC(42) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [54.443s][info][gc,start] GC(43) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [55.444s][info][gc ] GC(43) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [55.648s][info][gc,start] GC(44) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [56.423s][info][gc ] GC(44) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [56.446s][info][gc,start] GC(45) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [57.108s][info][gc ] GC(45) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [57.748s][info][gc,start] GC(46) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [58.696s][info][gc ] GC(46) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [58.951s][info][gc,start] GC(47) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [59.826s][info][gc ] GC(47) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] [59.844s][info][gc,start] GC(48) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.472Z] [60.672s][info][gc ] GC(48) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] Free: 14M (Allocating) [2025-03-27T02:42:12.472Z] [61.344s][info][gc,start] GC(49) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.472Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [62.226s][info][gc ] GC(49) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [62.260s][info][gc,start] GC(50) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [63.180s][info][gc ] GC(50) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [63.660s][info][gc,start] GC(51) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [64.494s][info][gc ] GC(51) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [64.560s][info][gc,start] GC(52) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [65.408s][info][gc ] GC(52) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [65.643s][info][gc,start] GC(53) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [66.327s][info][gc ] GC(53) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [66.944s][info][gc,start] GC(54) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [67.910s][info][gc ] GC(54) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [67.954s][info][gc,start] GC(55) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [68.789s][info][gc ] GC(55) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [69.452s][info][gc,start] GC(56) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [70.220s][info][gc ] GC(56) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [70.244s][info][gc,start] GC(57) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [71.110s][info][gc ] GC(57) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [71.360s][info][gc,start] GC(58) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [72.014s][info][gc ] GC(58) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [72.144s][info][gc,start] GC(59) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [73.252s][info][gc ] GC(59) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [73.344s][info][gc,start] GC(60) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [74.149s][info][gc ] GC(60) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [74.244s][info][gc,start] GC(61) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [75.188s][info][gc ] GC(61) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [75.244s][info][gc,start] GC(62) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [76.177s][info][gc ] GC(62) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [76.548s][info][gc,start] GC(63) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [77.436s][info][gc ] GC(63) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [77.844s][info][gc,start] GC(64) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [78.823s][info][gc ] GC(64) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [79.143s][info][gc,start] GC(65) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [79.744s][info][gc ] GC(65) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [79.843s][info][gc,start] GC(66) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [80.469s][info][gc ] GC(66) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [80.548s][info][gc,start] GC(67) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [81.184s][info][gc ] GC(67) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [82.162s][info][gc,start] GC(68) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [82.999s][info][gc ] GC(68) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [83.348s][info][gc,start] GC(69) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [84.036s][info][gc ] GC(69) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [84.052s][info][gc,start] GC(70) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [84.852s][info][gc ] GC(70) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [85.552s][info][gc,start] GC(71) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [86.272s][info][gc ] GC(71) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [86.343s][info][gc,start] GC(72) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [87.191s][info][gc ] GC(72) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [87.747s][info][gc,start] GC(73) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [88.540s][info][gc ] GC(73) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] [88.546s][info][gc,start] GC(74) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [89.216s][info][gc ] GC(74) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [89.244s][info][gc,start] GC(75) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] [89.804s][info][gc ] GC(75) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] Free: 14M (Allocating) [2025-03-27T02:42:12.473Z] [90.945s][info][gc,start] GC(76) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.473Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] [91.668s][info][gc ] GC(76) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.474Z] [91.742s][info][gc,start] GC(77) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] [92.603s][info][gc ] GC(77) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.474Z] [92.652s][info][gc,start] GC(78) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] [93.303s][info][gc ] GC(78) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.474Z] Free: 14M (Allocating) [2025-03-27T02:42:12.474Z] Free: 14M (Allocating) [2025-03-27T02:42:12.474Z] Free: 14M (Allocating) [2025-03-27T02:42:12.474Z] [94.044s][info][gc,start] GC(79) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] [94.904s][info][gc ] GC(79) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.474Z] [94.948s][info][gc,start] GC(80) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] [95.774s][info][gc ] GC(80) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.474Z] Free: 14M (Allocating) [2025-03-27T02:42:12.474Z] Free: 14M (Allocating) [2025-03-27T02:42:12.474Z] Free: 14M (Allocating) [2025-03-27T02:42:12.474Z] [96.448s][info][gc,start] GC(81) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] [97.329s][info][gc ] GC(81) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.474Z] [97.342s][info][gc,start] GC(82) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] Free: 12M (Allocating) [2025-03-27T02:42:12.474Z] [97.838s][info][gc ] GC(82) Garbage Collection (Allocation Rate) 114M(89%)->114M(89%) [2025-03-27T02:42:12.474Z] [97.843s][info][gc,start] GC(83) Garbage Collection (Allocation Rate) [2025-03-27T02:42:12.474Z] Done [2025-03-27T02:42:12.474Z] [98.280s][info][gc ] GC(83) Garbage Collection (Allocation Rate) Aborted [2025-03-27T02:42:12.474Z] ]; [2025-03-27T02:42:12.474Z] stderr: [] [2025-03-27T02:42:12.474Z] exitValue = 0 [2025-03-27T02:42:12.474Z] [2025-03-27T02:42:12.474Z] java.lang.RuntimeException: 'High Usage' missing from stdout/stderr [2025-03-27T02:42:12.474Z] at jdk.test.lib.process.OutputAnalyzer.shouldContain(OutputAnalyzer.java:231) [2025-03-27T02:42:12.474Z] at gc.x.TestHighUsage.main(TestHighUsage.java:98) [2025-03-27T02:42:12.474Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-03-27T02:42:12.474Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-03-27T02:42:12.474Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-03-27T02:42:12.474Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-03-27T02:42:12.474Z] [2025-03-27T02:42:12.474Z] JavaTest Message: Test threw exception: java.lang.RuntimeException: 'High Usage' missing from stdout/stderr [2025-03-27T02:42:12.474Z] JavaTest Message: shutting down test [2025-03-27T02:42:12.474Z] [2025-03-27T02:42:12.474Z] STATUS:Failed.`main' threw exception: java.lang.RuntimeException: 'High Usage' missing from stdout/stderr [2025-03-27T02:42:12.474Z] rerun: [2025-03-27T02:42:12.474Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/scratch/2 && \ [2025-03-27T02:42:12.474Z] DISPLAY=:0 \ [2025-03-27T02:42:12.474Z] HOME=/home/jenkins \ [2025-03-27T02:42:12.474Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-03-27T02:42:12.474Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-03-27T02:42:12.474Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java \ [2025-03-27T02:42:12.474Z] -Dtest.vm.opts='-ea -esa -Xmx512m' \ [2025-03-27T02:42:12.474Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2025-03-27T02:42:12.474Z] -Dtest.compiler.opts= \ [2025-03-27T02:42:12.474Z] -Dtest.java.opts= \ [2025-03-27T02:42:12.474Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image \ [2025-03-27T02:42:12.474Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/j2sdk-image \ [2025-03-27T02:42:12.474Z] -Dtest.timeout.factor=8.0 \ [2025-03-27T02:42:12.474Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-03-27T02:42:12.474Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg \ [2025-03-27T02:42:12.474Z] -Dtest.name=gc/x/TestHighUsage.java \ [2025-03-27T02:42:12.474Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x/TestHighUsage.java \ [2025-03-27T02:42:12.474Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x \ [2025-03-27T02:42:12.474Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-03-27T02:42:12.474Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d \ [2025-03-27T02:42:12.474Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib \ [2025-03-27T02:42:12.474Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/gc/x/TestHighUsage.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/gc/x:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/classes/0/test/lib \ [2025-03-27T02:42:12.474Z] -ea \ [2025-03-27T02:42:12.474Z] -esa \ [2025-03-27T02:42:12.474Z] -Xmx512m \ [2025-03-27T02:42:12.474Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-03-27T02:42:12.474Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work/gc/x/TestHighUsage.d/main.0.jta [2025-03-27T02:42:12.474Z] [2025-03-27T02:42:12.474Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: 'High Usage' missing from stdout/stderr [2025-03-27T02:42:12.474Z] -------------------------------------------------- [2025-03-27T02:53:24.159Z] Test results: passed: 544; failed: 1 [2025-03-27T02:55:32.344Z] Report written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/report/html/report.html [2025-03-27T02:55:32.344Z] Results written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_ppc64le_linux_testList_0/aqa-tests/TKG/output_17430274792006/hotspot_gc_0/work [2025-03-27T02:55:32.344Z] Error: Some tests failed or other problems occurred. [2025-03-27T02:55:32.344Z] ----------------------------------- [2025-03-27T02:55:32.344Z] hotspot_gc_0_FAILED [2025-03-27T02:55:32.344Z] ----------------------------------- [2025-03-27T02:55:32.344Z] [2025-03-27T02:55:32.344Z] TEST TEARDOWN: [2025-03-27T02:55:32.344Z] Nothing to be done for teardown. [2025-03-27T02:55:32.344Z] hotspot_gc_0 Finish Time: Thu Mar 27 02:55:22 2025 Epoch Time (ms): 1743044122396