[2025-06-19T14:23:48.578Z] Running test UtilLoadTest_5m_1 ... [2025-06-19T14:23:48.578Z] =============================================== [2025-06-19T14:23:48.578Z] UtilLoadTest_5m_1 Start Time: Thu Jun 19 14:23:48 2025 Epoch Time (ms): 1750343028295 [2025-06-19T14:23:48.578Z] variation: Mode650 [2025-06-19T14:23:48.578Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-06-19T14:23:48.578Z] { \ [2025-06-19T14:23:48.578Z] echo ""; echo "TEST SETUP:"; \ [2025-06-19T14:23:48.578Z] echo "Nothing to be done for setup."; \ [2025-06-19T14:23:48.578Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1"; \ [2025-06-19T14:23:48.578Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1"; \ [2025-06-19T14:23:48.578Z] echo ""; echo "TESTING:"; \ [2025-06-19T14:23:48.578Z] perl /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/otherLoadTest/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/otherLoadTest/..//STF;/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/otherLoadTest/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1" -test=UtilLoadTest -test-args="timeLimit=5m"; \ [2025-06-19T14:23:48.578Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "UtilLoadTest_5m_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1"; else echo "-----------------------------------"; echo "UtilLoadTest_5m_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-19T14:23:48.578Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-19T14:23:48.578Z] echo "Nothing to be done for teardown."; \ [2025-06-19T14:23:48.578Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/TestTargetResult"; [2025-06-19T14:23:48.578Z] [2025-06-19T14:23:48.578Z] TEST SETUP: [2025-06-19T14:23:48.578Z] Nothing to be done for setup. [2025-06-19T14:23:48.578Z] [2025-06-19T14:23:48.578Z] TESTING: [2025-06-19T14:23:48.904Z] STF 14:23:48.572 - ========================= S T F ========================= [2025-06-19T14:23:48.904Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1 [2025-06-19T14:23:48.904Z] There is 51173 Mb free [2025-06-19T14:23:48.904Z] STF 14:23:48.592 - ================== G E N E R A T I O N ================== [2025-06-19T14:23:48.904Z] STF 14:23:48.597 - Checking JVM: /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jdkbinary/j2sdk-image [2025-06-19T14:23:48.904Z] STF 14:23:48.597 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest" [2025-06-19T14:23:48.904Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-06-19T14:23:48.904Z] GEN [0.017s][warning][cds] Archived non-system classes are disabled because the java.system.class.loader property is specified (value = "net.adoptopenjdk.stf.runner.StfClassLoader"). To use archived non-system classes, this property must not be set [2025-06-19T14:23:53.633Z] GEN 14:23:53.219 - Found test. Project: 'openjdk.test.load' class: 'UtilLoadTest.class' Dir: '/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.load/bin' [2025-06-19T14:23:53.633Z] GEN 14:23:53.289 - Found test. Project: 'openjdk.test.load' class: 'net.adoptopenjdk.stf.UtilLoadTest' [2025-06-19T14:23:53.959Z] GEN Classpath directories used by project 'openjdk.test.load': [2025-06-19T14:23:53.959Z] GEN /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.load/bin [2025-06-19T14:23:53.959Z] GEN /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.core/bin [2025-06-19T14:23:53.959Z] GEN /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.load/bin [2025-06-19T14:23:53.959Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-06-19T14:23:53.959Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-06-19T14:23:53.959Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2025-06-19T14:23:53.959Z] GEN /home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar [2025-06-19T14:23:54.283Z] GEN 14:23:54.000 - Using Mode NoOptions. Values = '' [2025-06-19T14:23:54.614Z] GEN 14:23:54.425 - [2025-06-19T14:23:54.614Z] GEN 14:23:54.425 - Test command summary: [2025-06-19T14:23:54.614Z] GEN 14:23:54.427 - Step Stage Command Description [2025-06-19T14:23:54.614Z] GEN 14:23:54.428 - -----+--------+-----------------+------------ [2025-06-19T14:23:54.614Z] GEN 14:23:54.429 - 1 execute Run java Run util load tests [2025-06-19T14:23:54.614Z] STF 14:23:54.567 - [2025-06-19T14:23:54.614Z] STF 14:23:54.567 - Script generation completed [2025-06-19T14:23:54.614Z] STF 14:23:54.568 - [2025-06-19T14:23:54.614Z] STF 14:23:54.569 - [2025-06-19T14:23:54.614Z] STF 14:23:54.569 - ======================= S E T U P ======================= [2025-06-19T14:23:54.614Z] STF 14:23:54.569 - Running setup: perl /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/setUp.pl [2025-06-19T14:23:54.938Z] STF 14:23:54.798 - SETUP stage completed [2025-06-19T14:23:54.938Z] STF 14:23:54.806 - [2025-06-19T14:23:54.938Z] STF 14:23:54.806 - ==================== E X E C U T E - ==================== [2025-06-19T14:23:54.938Z] STF 14:23:54.807 - Running execute: perl /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/execute.pl [2025-06-19T14:23:55.264Z] STF 14:23:55.038 - [2025-06-19T14:23:55.264Z] STF 14:23:55.038 - Java version [2025-06-19T14:23:55.264Z] STF 14:23:55.038 - Running: /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jdkbinary/j2sdk-image/bin/java -version [2025-06-19T14:23:55.264Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-06-19T14:23:55.264Z] openjdk version "21.0.8-beta" 2025-07-15 [2025-06-19T14:23:55.264Z] OpenJDK Runtime Environment Temurin-21.0.8+7-202506181959 (build 21.0.8-beta+7-ea) [2025-06-19T14:23:55.593Z] OpenJDK 64-Bit Server VM Temurin-21.0.8+7-202506181959 (build 21.0.8-beta+7-ea, mixed mode, sharing) [2025-06-19T14:23:55.593Z] STF 14:23:55.278 - [2025-06-19T14:23:55.593Z] STF 14:23:55.278 - +------ Step 1 - Run util load tests [2025-06-19T14:23:55.593Z] STF 14:23:55.278 - | Run foreground process [2025-06-19T14:23:55.593Z] STF 14:23:55.278 - | Program: /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jdkbinary/j2sdk-image/bin/java [2025-06-19T14:23:55.593Z] STF 14:23:55.278 - | Mnemonic: ULT [2025-06-19T14:23:55.593Z] STF 14:23:55.279 - | Echo: ECHO_ON [2025-06-19T14:23:55.593Z] STF 14:23:55.279 - | Expectation: CLEAN_RUN within 1h [2025-06-19T14:23:55.593Z] STF 14:23:55.279 - | [2025-06-19T14:23:55.593Z] STF 14:23:55.280 - Running command: /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/asm/asm.jar:/home/jenkins/testDependency/system_lib/asm/asm-commons.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results -resultsPrefix 1.ULT. -timeLimit 5m -abortIfOutOfMemory false -reportFailureLimit 1 -abortAtFailureLimit 10 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.util.threadCount 3 -suite.util.inventoryFile /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.inventory/openjdk.test.load/config/inventories/util/util.xml -suite.util.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.util.selection random -suite.util.seed -1 -suite.util.repeatCount 1 -suite.util.thinkingTime 0ms..0ms [2025-06-19T14:23:55.593Z] STF 14:23:55.281 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.stderr [2025-06-19T14:23:55.593Z] STF 14:23:55.281 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.stdout [2025-06-19T14:23:55.593Z] STF 14:23:55.318 - Monitoring processes: ULT [2025-06-19T14:23:55.593Z] ULT stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-06-19T14:24:03.584Z] ULT 14:24:02.443 - Load test parameters [2025-06-19T14:24:03.584Z] ULT 14:24:02.466 - Time limited = true [2025-06-19T14:24:03.584Z] ULT 14:24:02.468 - Time limit = 5m [2025-06-19T14:24:03.584Z] ULT 14:24:02.469 - abortIfOutOfMemory = false [2025-06-19T14:24:03.584Z] ULT 14:24:02.471 - reportFailureLimit = 1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.472 - abortAtFailureLimit = 10 [2025-06-19T14:24:03.584Z] ULT 14:24:02.495 - maxTotalLogFileSpace = 209715200 [2025-06-19T14:24:03.584Z] ULT 14:24:02.497 - maxSingleLogSize = 8388608 [2025-06-19T14:24:03.584Z] ULT 14:24:02.499 - Parameters for suite 0 [2025-06-19T14:24:03.584Z] ULT 14:24:02.500 - Suite name = util [2025-06-19T14:24:03.584Z] ULT 14:24:02.502 - Number threads = 3 [2025-06-19T14:24:03.584Z] ULT 14:24:02.504 - Supplied seed = -1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.505 - Inventory file = /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.inventory/openjdk.test.load/config/inventories/util/util.xml [2025-06-19T14:24:03.584Z] ULT 14:24:02.506 - Exclude file = /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml [2025-06-19T14:24:03.584Z] ULT 14:24:02.508 - Number tests = -1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.510 - Repeat count = 1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.512 - Thinking time = 0ms..0ms [2025-06-19T14:24:03.584Z] ULT 14:24:02.513 - Selection mode = random [2025-06-19T14:24:03.584Z] ULT 14:24:02.518 - Actual seed = 1750339288381 [2025-06-19T14:24:03.584Z] ULT 14:24:02.592 - Parsing inventory file. Root=/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.inventory File=openjdk.test.load/config/inventories/util/util.xml [2025-06-19T14:24:03.584Z] ULT 14:24:02.646 - Reading exclusion file. File=openjdk.test.load/config/inventories/util/util_exclude.xml [2025-06-19T14:24:03.584Z] ULT 14:24:02.647 - Parsing inventory file. Root=/home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.inventory File=openjdk.test.load/config/inventories/util/util_exclude.xml [2025-06-19T14:24:03.584Z] ULT 14:24:02.660 - Final test list: [2025-06-19T14:24:03.584Z] ULT 14:24:02.711 - 0 ArbitraryJava[net.adoptopenjdk.test.util.calendars.CalendarTest run] Weighting=1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.712 - 1 ArbitraryJava[net.adoptopenjdk.test.util.hashmap.Hog run] Weighting=1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.715 - 2 JUnit[net.adoptopenjdk.test.util.lilac.TestArrays] Weighting=1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.716 - 4 JUnit[net.adoptopenjdk.test.util.treemap.TreeMapAPITest] Weighting=1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.717 - 5 JUnit[net.adoptopenjdk.test.util.treemap.TreeMapTest] Weighting=1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.840 - Starting thread. Suite=0 thread=0 [2025-06-19T14:24:03.584Z] ULT 14:24:02.861 - Starting thread. Suite=0 thread=1 [2025-06-19T14:24:03.584Z] ULT 14:24:02.873 - Starting thread. Suite=0 thread=2 [2025-06-19T14:24:26.654Z] ULT 14:24:22.999 - Completed 6.7%. Number of tests started=1340 [2025-06-19T14:24:46.022Z] ULT 14:24:42.846 - Completed 13.4%. Number of tests started=3916 (+2576) [2025-06-19T14:25:05.108Z] ULT 14:25:02.783 - Completed 20.0%. Number of tests started=7464 (+3548) [2025-06-19T14:25:24.374Z] ULT 14:25:22.819 - Completed 26.7%. Number of tests started=10944 (+3480) [2025-06-19T14:25:43.461Z] ULT 14:25:42.857 - Completed 33.4%. Number of tests started=14546 (+3602) [2025-06-19T14:26:06.562Z] ULT 14:26:02.794 - Completed 40.1%. Number of tests started=18063 (+3517) [2025-06-19T14:26:25.636Z] ULT 14:26:22.851 - Completed 46.8%. Number of tests started=21645 (+3582) [2025-06-19T14:26:44.713Z] ULT 14:26:42.781 - Completed 53.4%. Number of tests started=25336 (+3691) [2025-06-19T14:27:03.863Z] ULT 14:27:02.811 - Completed 60.1%. Number of tests started=29039 (+3703) [2025-06-19T14:27:26.969Z] ULT 14:27:22.849 - Completed 66.8%. Number of tests started=32665 (+3626) [2025-06-19T14:27:46.101Z] ULT 14:27:42.776 - Completed 73.4%. Number of tests started=34122 (+1457) [2025-06-19T14:28:05.170Z] ULT 14:28:02.803 - Completed 80.1%. Number of tests started=35504 (+1382) [2025-06-19T14:28:24.268Z] ULT 14:28:22.830 - Completed 86.8%. Number of tests started=36732 (+1228) [2025-06-19T14:28:47.358Z] ULT 14:28:42.857 - Completed 93.5%. Number of tests started=38038 (+1306) [2025-06-19T14:28:56.193Z] STF 14:28:55.344 - Heartbeat: Process ULT is still running [2025-06-19T14:29:03.426Z] ULT 14:29:02.437 - Thread completed. Suite=0 thread=0 [2025-06-19T14:29:03.426Z] ULT 14:29:02.786 - Completed 100.0%. Number of tests started=39332 (+1294) [2025-06-19T14:29:26.736Z] ULT 14:29:22.847 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:29:46.119Z] ULT 14:29:42.808 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:30:05.627Z] ULT 14:30:02.769 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:30:25.093Z] ULT 14:30:22.826 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:30:44.687Z] ULT 14:30:42.787 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:31:04.093Z] ULT 14:31:02.848 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:31:23.621Z] ULT 14:31:22.808 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:31:44.135Z] ULT 14:31:42.768 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:32:03.533Z] ULT 14:32:02.829 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:32:26.946Z] ULT 14:32:22.789 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:32:46.495Z] ULT 14:32:42.851 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:33:05.921Z] ULT 14:33:02.811 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:33:25.381Z] ULT 14:33:22.777 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:33:44.780Z] ULT 14:33:42.840 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:33:55.869Z] STF 14:33:55.153 - Heartbeat: Process ULT is still running [2025-06-19T14:34:04.935Z] ULT 14:34:02.800 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:34:24.381Z] ULT 14:34:22.860 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:34:43.839Z] ULT 14:34:42.820 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:35:03.261Z] ULT 14:35:02.778 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:35:26.599Z] ULT 14:35:22.837 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:35:45.960Z] ULT 14:35:42.798 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:36:05.350Z] ULT 14:36:02.859 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:36:24.764Z] ULT 14:36:22.819 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:36:44.120Z] ULT 14:36:42.776 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:37:03.576Z] ULT 14:37:02.837 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:37:24.158Z] ULT 14:37:22.793 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:37:43.557Z] ULT 14:37:42.854 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:38:03.272Z] ULT 14:38:02.814 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:38:26.638Z] ULT 14:38:22.776 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:38:46.024Z] ULT 14:38:42.834 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:38:57.069Z] STF 14:38:55.115 - Heartbeat: Process ULT is still running [2025-06-19T14:39:04.505Z] ULT 14:39:02.794 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:39:24.083Z] ULT 14:39:22.851 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:39:43.467Z] ULT 14:39:42.813 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:40:06.788Z] ULT 14:40:02.771 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:40:26.174Z] ULT 14:40:22.830 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:40:45.854Z] ULT 14:40:42.789 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:41:05.353Z] ULT 14:41:02.852 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:41:24.838Z] ULT 14:41:22.809 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:41:44.258Z] ULT 14:41:42.766 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:42:03.879Z] ULT 14:42:02.826 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:42:23.352Z] ULT 14:42:22.793 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:42:46.763Z] ULT 14:42:42.851 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:43:06.249Z] ULT 14:43:02.810 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:43:25.794Z] ULT 14:43:22.768 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:43:45.271Z] ULT 14:43:42.826 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:43:56.342Z] STF 14:43:55.076 - Heartbeat: Process ULT is still running [2025-06-19T14:44:03.798Z] ULT 14:44:02.584 - **POSSIBLE HANG DETECTED** [2025-06-19T14:44:03.798Z] STF 14:44:02.662 - **FAILED** Process ULT has hung [2025-06-19T14:44:03.798Z] STF 14:44:02.663 - Collecting dumps for: ULT [2025-06-19T14:44:03.798Z] STF 14:44:02.663 - Sending SIG 3 to the java process to generate a javacore [2025-06-19T14:44:03.798Z] STF 14:44:02.666 - Running command: kill -3 3946761 [2025-06-19T14:44:03.798Z] STF 14:44:02.666 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_3.stderr [2025-06-19T14:44:03.798Z] STF 14:44:02.667 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_3.stdout [2025-06-19T14:44:03.798Z] STF 14:44:02.679 - Pausing for 30 seconds [2025-06-19T14:44:37.535Z] STF 14:44:32.680 - Sending SIG 3 to the java process to generate a javacore [2025-06-19T14:44:37.535Z] STF 14:44:32.687 - Running command: kill -3 3946761 [2025-06-19T14:44:37.535Z] STF 14:44:32.688 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_3.stderr [2025-06-19T14:44:37.535Z] STF 14:44:32.688 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_3.stdout [2025-06-19T14:44:37.535Z] STF 14:44:32.706 - Pausing for 30 seconds [2025-06-19T14:45:05.607Z] STF 14:45:02.708 - Sending SIG 3 to the java process to generate a javacore [2025-06-19T14:45:05.607Z] STF 14:45:02.715 - Running command: kill -3 3946761 [2025-06-19T14:45:05.607Z] STF 14:45:02.715 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_3.stderr [2025-06-19T14:45:05.607Z] STF 14:45:02.716 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_3.stdout [2025-06-19T14:45:05.607Z] STF 14:45:02.728 - Pausing for 30 seconds [2025-06-19T14:45:33.670Z] STF 14:45:32.729 - Sending SIGABRT (kill -6) to the java process to generate a core [2025-06-19T14:45:33.670Z] STF 14:45:32.731 - Running command: kill -6 3946761 [2025-06-19T14:45:33.670Z] STF 14:45:32.731 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_6.stderr [2025-06-19T14:45:33.670Z] STF 14:45:32.731 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_6.stdout [2025-06-19T14:45:33.670Z] STF 14:45:32.744 - Pausing for 30 seconds [2025-06-19T14:46:07.406Z] STF 14:46:02.744 - Sending SIGXCPU (kill -24) to the java process to generate an OS dump [2025-06-19T14:46:07.406Z] STF 14:46:02.749 - Running command: kill -24 3946761 [2025-06-19T14:46:07.406Z] STF 14:46:02.749 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_24.stderr [2025-06-19T14:46:07.406Z] STF 14:46:02.749 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/results/1.ULT.kill_24.stdout [2025-06-19T14:46:07.406Z] ULT 2025-06-19 14:44:02 [2025-06-19T14:46:07.406Z] ULT Full thread dump OpenJDK 64-Bit Server VM (21.0.8-beta+7-ea mixed mode, sharing): [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT Threads class SMR info: [2025-06-19T14:46:07.406Z] ULT _java_thread_list=0x0000003e48048d00, length=12, elements={ [2025-06-19T14:46:07.406Z] ULT 0x0000003fc402d540, 0x0000003fc4132d90, 0x0000003fc41342f0, 0x0000003fc4135a80, [2025-06-19T14:46:07.406Z] ULT 0x0000003fc41370b0, 0x0000003fc4138640, 0x0000003fc413a170, 0x0000003fc413b820, [2025-06-19T14:46:07.406Z] ULT 0x0000003fc419c430, 0x0000003fc422ddd0, 0x0000003fc4895390, 0x0000003fc4896b00 [2025-06-19T14:46:07.406Z] ULT } [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT "main" #1 [3946762] prio=5 os_prio=0 cpu=8990.19ms elapsed=1207.35s tid=0x0000003fc402d540 nid=3946762 waiting on condition [0x0000003fc86c9000] [2025-06-19T14:46:07.406Z] ULT java.lang.Thread.State: TIMED_WAITING (sleeping) [2025-06-19T14:46:07.406Z] ULT at java.lang.Thread.sleep0(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.406Z] ULT at java.lang.Thread.sleep(java.base@21.0.8-beta/Thread.java:509) [2025-06-19T14:46:07.406Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner.run(LoadTestRunner.java:332) [2025-06-19T14:46:07.406Z] ULT at net.adoptopenjdk.loadTest.LoadTest.runLoadTest(LoadTest.java:136) [2025-06-19T14:46:07.406Z] ULT at net.adoptopenjdk.loadTest.LoadTest.main(LoadTest.java:114) [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT "Reference Handler" #9 [3946772] daemon prio=10 os_prio=0 cpu=6.39ms elapsed=1207.17s tid=0x0000003fc4132d90 nid=3946772 waiting on condition [0x0000003eb0264000] [2025-06-19T14:46:07.406Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.406Z] ULT at java.lang.ref.Reference.waitForReferencePendingList(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.406Z] ULT at java.lang.ref.Reference.processPendingReferences(java.base@21.0.8-beta/Reference.java:246) [2025-06-19T14:46:07.406Z] ULT at java.lang.ref.Reference$ReferenceHandler.run(java.base@21.0.8-beta/Reference.java:208) [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT "Finalizer" #10 [3946773] daemon prio=8 os_prio=0 cpu=0.73ms elapsed=1207.17s tid=0x0000003fc41342f0 nid=3946773 in Object.wait() [0x0000003ea1ffe000] [2025-06-19T14:46:07.406Z] ULT java.lang.Thread.State: WAITING (on object monitor) [2025-06-19T14:46:07.406Z] ULT at java.lang.Object.wait0(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.406Z] ULT - waiting on <0x0000003eb6a008c0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-06-19T14:46:07.406Z] ULT at java.lang.Object.wait(java.base@21.0.8-beta/Object.java:366) [2025-06-19T14:46:07.406Z] ULT at java.lang.Object.wait(java.base@21.0.8-beta/Object.java:339) [2025-06-19T14:46:07.406Z] ULT at java.lang.ref.NativeReferenceQueue.await(java.base@21.0.8-beta/NativeReferenceQueue.java:48) [2025-06-19T14:46:07.406Z] ULT at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.8-beta/ReferenceQueue.java:158) [2025-06-19T14:46:07.406Z] ULT at java.lang.ref.NativeReferenceQueue.remove(java.base@21.0.8-beta/NativeReferenceQueue.java:89) [2025-06-19T14:46:07.406Z] ULT - locked <0x0000003eb6a008c0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-06-19T14:46:07.406Z] ULT at java.lang.ref.Finalizer$FinalizerThread.run(java.base@21.0.8-beta/Finalizer.java:173) [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT "Signal Dispatcher" #11 [3946774] daemon prio=9 os_prio=0 cpu=0.37ms elapsed=1207.17s tid=0x0000003fc4135a80 nid=3946774 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.406Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT "Service Thread" #12 [3946775] daemon prio=9 os_prio=0 cpu=5.18ms elapsed=1207.17s tid=0x0000003fc41370b0 nid=3946775 runnable [0x0000000000000000] [2025-06-19T14:46:07.406Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT "Monitor Deflation Thread" #13 [3946776] daemon prio=9 os_prio=0 cpu=475.06ms elapsed=1207.17s tid=0x0000003fc4138640 nid=3946776 runnable [0x0000000000000000] [2025-06-19T14:46:07.406Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.406Z] ULT [2025-06-19T14:46:07.406Z] ULT "C2 CompilerThread0" #14 [3946777] daemon prio=9 os_prio=0 cpu=41482.20ms elapsed=1207.17s tid=0x0000003fc413a170 nid=3946777 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.407Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.407Z] ULT No compile task [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "C1 CompilerThread0" #16 [3946778] daemon prio=9 os_prio=0 cpu=7530.57ms elapsed=1207.17s tid=0x0000003fc413b820 nid=3946778 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.407Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.407Z] ULT No compile task [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "Common-Cleaner" #17 [3946779] daemon prio=8 os_prio=0 cpu=14.33ms elapsed=1207.04s tid=0x0000003fc419c430 nid=3946779 waiting on condition [0x0000003ea13fd000] [2025-06-19T14:46:07.407Z] ULT java.lang.Thread.State: TIMED_WAITING (parking) [2025-06-19T14:46:07.407Z] ULT at jdk.internal.misc.Unsafe.park(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.407Z] ULT - parking to wait for <0x0000003eb6a00160> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-06-19T14:46:07.407Z] ULT at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.8-beta/LockSupport.java:269) [2025-06-19T14:46:07.407Z] ULT at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@21.0.8-beta/AbstractQueuedSynchronizer.java:1852) [2025-06-19T14:46:07.407Z] ULT at java.lang.ref.ReferenceQueue.await(java.base@21.0.8-beta/ReferenceQueue.java:71) [2025-06-19T14:46:07.407Z] ULT at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.8-beta/ReferenceQueue.java:143) [2025-06-19T14:46:07.407Z] ULT at java.lang.ref.ReferenceQueue.remove(java.base@21.0.8-beta/ReferenceQueue.java:218) [2025-06-19T14:46:07.407Z] ULT at jdk.internal.ref.CleanerImpl.run(java.base@21.0.8-beta/CleanerImpl.java:140) [2025-06-19T14:46:07.407Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.407Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.407Z] ULT at jdk.internal.misc.InnocuousThread.run(java.base@21.0.8-beta/InnocuousThread.java:186) [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "Notification Thread" #18 [3946780] daemon prio=9 os_prio=0 cpu=0.32ms elapsed=1206.75s tid=0x0000003fc422ddd0 nid=3946780 runnable [0x0000000000000000] [2025-06-19T14:46:07.407Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "load-1" #26 [3946791] prio=5 os_prio=0 cpu=189545.50ms elapsed=1199.82s tid=0x0000003fc4895390 nid=3946791 waiting for monitor entry [0x0000003ea04aa000] [2025-06-19T14:46:07.407Z] ULT java.lang.Thread.State: BLOCKED (on object monitor) [2025-06-19T14:46:07.407Z] ULT at java.io.PrintStream.println(java.base@21.0.8-beta/PrintStream.java:1170) [2025-06-19T14:46:07.407Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:108) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.407Z] ULT - locked <0x0000003eb7379b78> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.407Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.407Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.407Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.407Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.407Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.407Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "load-2" #27 [3946792] prio=5 os_prio=0 cpu=189845.12ms elapsed=1199.81s tid=0x0000003fc4896b00 nid=3946792 waiting for monitor entry [0x0000003ea02aa000] [2025-06-19T14:46:07.407Z] ULT java.lang.Thread.State: BLOCKED (on object monitor) [2025-06-19T14:46:07.407Z] ULT at java.io.PrintStream.flush(java.base@21.0.8-beta/PrintStream.java:456) [2025-06-19T14:46:07.407Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.reporting.OutputFilter.flush(OutputFilter.java:80) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:106) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.407Z] ULT - locked <0x0000003eb737a388> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.407Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.407Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.407Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.407Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.407Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.407Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.407Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.407Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.407Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.407Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "GC Thread#3" os_prio=0 cpu=2577.76ms elapsed=1205.59s tid=0x0000003e480080d0 nid=3946784 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "GC Thread#2" os_prio=0 cpu=2388.06ms elapsed=1205.59s tid=0x0000003e480075c0 nid=3946783 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "GC Thread#1" os_prio=0 cpu=2481.21ms elapsed=1205.60s tid=0x0000003e48006b20 nid=3946782 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "VM Thread" os_prio=0 cpu=346.93ms elapsed=1207.21s tid=0x0000003fc41299d0 nid=3946771 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "VM Periodic Task Thread" os_prio=0 cpu=2506.06ms elapsed=1207.24s tid=0x0000003fc4117b10 nid=3946770 waiting on condition [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "G1 Service" os_prio=0 cpu=156.77ms elapsed=1207.34s tid=0x0000003fc4106cb0 nid=3946769 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "G1 Refine#0" os_prio=0 cpu=1251.79ms elapsed=1207.34s tid=0x0000003fc4105d00 nid=3946768 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "G1 Conc#0" os_prio=0 cpu=0.17ms elapsed=1207.35s tid=0x0000003fc40a3bd0 nid=3946767 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "G1 Main Marker" os_prio=0 cpu=0.30ms elapsed=1207.35s tid=0x0000003fc40a2c30 nid=3946766 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT "GC Thread#0" os_prio=0 cpu=2214.43ms elapsed=1207.35s tid=0x0000003fc4091e10 nid=3946765 runnable [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT JNI global refs: 20, weak refs: 0 [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT [2025-06-19T14:46:07.407Z] ULT Found one Java-level deadlock: [2025-06-19T14:46:07.407Z] ULT ============================= [2025-06-19T14:46:07.407Z] ULT "load-1": [2025-06-19T14:46:07.408Z] ULT waiting to lock monitor 0x0000003e0c015790 (object 0x0000003eb6c00000, a net.adoptopenjdk.loadTest.reporting.OutputFilter), [2025-06-19T14:46:07.408Z] ULT which is held by UNKNOWN_owner_addr=0x0000003fc4894660 [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT Java stack information for the threads listed above: [2025-06-19T14:46:07.408Z] ULT =================================================== [2025-06-19T14:46:07.408Z] ULT "load-1": [2025-06-19T14:46:07.408Z] ULT at java.io.PrintStream.println(java.base@21.0.8-beta/PrintStream.java:1170) [2025-06-19T14:46:07.408Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:108) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.408Z] ULT - locked <0x0000003eb7379b78> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.408Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.408Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.408Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.408Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.408Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.408Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT Found one Java-level deadlock: [2025-06-19T14:46:07.408Z] ULT ============================= [2025-06-19T14:46:07.408Z] ULT "load-2": [2025-06-19T14:46:07.408Z] ULT waiting to lock monitor 0x0000003e0c015790 (object 0x0000003eb6c00000, a net.adoptopenjdk.loadTest.reporting.OutputFilter), [2025-06-19T14:46:07.408Z] ULT which is held by UNKNOWN_owner_addr=0x0000003fc4894660 [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT Java stack information for the threads listed above: [2025-06-19T14:46:07.408Z] ULT =================================================== [2025-06-19T14:46:07.408Z] ULT "load-2": [2025-06-19T14:46:07.408Z] ULT at java.io.PrintStream.flush(java.base@21.0.8-beta/PrintStream.java:456) [2025-06-19T14:46:07.408Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.reporting.OutputFilter.flush(OutputFilter.java:80) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:106) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.408Z] ULT - locked <0x0000003eb737a388> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.408Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.408Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.408Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.408Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.408Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.408Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.408Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.408Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.408Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT Found 2 deadlocks. [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT Heap [2025-06-19T14:46:07.408Z] ULT garbage-first heap total 1103872K, used 113145K [0x0000003eb6a00000, 0x0000003fac600000) [2025-06-19T14:46:07.408Z] ULT region size 2048K, 51 young (104448K), 1 survivors (2048K) [2025-06-19T14:46:07.408Z] ULT Metaspace used 12902K, committed 13312K, reserved 1114112K [2025-06-19T14:46:07.408Z] ULT class space used 1385K, committed 1536K, reserved 1048576K [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT 14:44:02.792 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:46:07.408Z] ULT 14:44:07.607 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.408Z] ULT 14:44:12.622 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.408Z] ULT 14:44:17.639 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.408Z] ULT 14:44:22.654 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.408Z] ULT 14:44:22.858 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:46:07.408Z] ULT 14:44:27.673 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.408Z] ULT 14:44:32.689 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.408Z] ULT 2025-06-19 14:44:32 [2025-06-19T14:46:07.408Z] ULT Full thread dump OpenJDK 64-Bit Server VM (21.0.8-beta+7-ea mixed mode, sharing): [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT Threads class SMR info: [2025-06-19T14:46:07.408Z] ULT _java_thread_list=0x0000003e48048d00, length=12, elements={ [2025-06-19T14:46:07.408Z] ULT 0x0000003fc402d540, 0x0000003fc4132d90, 0x0000003fc41342f0, 0x0000003fc4135a80, [2025-06-19T14:46:07.408Z] ULT 0x0000003fc41370b0, 0x0000003fc4138640, 0x0000003fc413a170, 0x0000003fc413b820, [2025-06-19T14:46:07.408Z] ULT 0x0000003fc419c430, 0x0000003fc422ddd0, 0x0000003fc4895390, 0x0000003fc4896b00 [2025-06-19T14:46:07.408Z] ULT } [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT "main" #1 [3946762] prio=5 os_prio=0 cpu=9059.46ms elapsed=1237.37s tid=0x0000003fc402d540 nid=3946762 waiting on condition [0x0000003fc86c9000] [2025-06-19T14:46:07.408Z] ULT java.lang.Thread.State: TIMED_WAITING (sleeping) [2025-06-19T14:46:07.408Z] ULT at java.lang.Thread.sleep0(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.408Z] ULT at java.lang.Thread.sleep(java.base@21.0.8-beta/Thread.java:509) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner.run(LoadTestRunner.java:332) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.LoadTest.runLoadTest(LoadTest.java:136) [2025-06-19T14:46:07.408Z] ULT at net.adoptopenjdk.loadTest.LoadTest.main(LoadTest.java:114) [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT "Reference Handler" #9 [3946772] daemon prio=10 os_prio=0 cpu=6.39ms elapsed=1237.20s tid=0x0000003fc4132d90 nid=3946772 waiting on condition [0x0000003eb0264000] [2025-06-19T14:46:07.408Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.408Z] ULT at java.lang.ref.Reference.waitForReferencePendingList(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.408Z] ULT at java.lang.ref.Reference.processPendingReferences(java.base@21.0.8-beta/Reference.java:246) [2025-06-19T14:46:07.408Z] ULT at java.lang.ref.Reference$ReferenceHandler.run(java.base@21.0.8-beta/Reference.java:208) [2025-06-19T14:46:07.408Z] ULT [2025-06-19T14:46:07.408Z] ULT "Finalizer" #10 [3946773] daemon prio=8 os_prio=0 cpu=0.73ms elapsed=1237.20s tid=0x0000003fc41342f0 nid=3946773 in Object.wait() [0x0000003ea1ffe000] [2025-06-19T14:46:07.408Z] ULT java.lang.Thread.State: WAITING (on object monitor) [2025-06-19T14:46:07.408Z] ULT at java.lang.Object.wait0(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.408Z] ULT - waiting on <0x0000003eb6a008c0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-06-19T14:46:07.408Z] ULT at java.lang.Object.wait(java.base@21.0.8-beta/Object.java:366) [2025-06-19T14:46:07.408Z] ULT at java.lang.Object.wait(java.base@21.0.8-beta/Object.java:339) [2025-06-19T14:46:07.409Z] ULT at java.lang.ref.NativeReferenceQueue.await(java.base@21.0.8-beta/NativeReferenceQueue.java:48) [2025-06-19T14:46:07.409Z] ULT at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.8-beta/ReferenceQueue.java:158) [2025-06-19T14:46:07.409Z] ULT at java.lang.ref.NativeReferenceQueue.remove(java.base@21.0.8-beta/NativeReferenceQueue.java:89) [2025-06-19T14:46:07.409Z] ULT - locked <0x0000003eb6a008c0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-06-19T14:46:07.409Z] ULT at java.lang.ref.Finalizer$FinalizerThread.run(java.base@21.0.8-beta/Finalizer.java:173) [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "Signal Dispatcher" #11 [3946774] daemon prio=9 os_prio=0 cpu=0.79ms elapsed=1237.20s tid=0x0000003fc4135a80 nid=3946774 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "Service Thread" #12 [3946775] daemon prio=9 os_prio=0 cpu=5.22ms elapsed=1237.20s tid=0x0000003fc41370b0 nid=3946775 runnable [0x0000000000000000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "Monitor Deflation Thread" #13 [3946776] daemon prio=9 os_prio=0 cpu=488.59ms elapsed=1237.20s tid=0x0000003fc4138640 nid=3946776 runnable [0x0000000000000000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "C2 CompilerThread0" #14 [3946777] daemon prio=9 os_prio=0 cpu=41483.02ms elapsed=1237.20s tid=0x0000003fc413a170 nid=3946777 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.409Z] ULT No compile task [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "C1 CompilerThread0" #16 [3946778] daemon prio=9 os_prio=0 cpu=7531.37ms elapsed=1237.20s tid=0x0000003fc413b820 nid=3946778 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.409Z] ULT No compile task [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "Common-Cleaner" #17 [3946779] daemon prio=8 os_prio=0 cpu=14.33ms elapsed=1237.06s tid=0x0000003fc419c430 nid=3946779 waiting on condition [0x0000003ea13fd000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: TIMED_WAITING (parking) [2025-06-19T14:46:07.409Z] ULT at jdk.internal.misc.Unsafe.park(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.409Z] ULT - parking to wait for <0x0000003eb6a00160> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-06-19T14:46:07.409Z] ULT at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.8-beta/LockSupport.java:269) [2025-06-19T14:46:07.409Z] ULT at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@21.0.8-beta/AbstractQueuedSynchronizer.java:1852) [2025-06-19T14:46:07.409Z] ULT at java.lang.ref.ReferenceQueue.await(java.base@21.0.8-beta/ReferenceQueue.java:71) [2025-06-19T14:46:07.409Z] ULT at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.8-beta/ReferenceQueue.java:143) [2025-06-19T14:46:07.409Z] ULT at java.lang.ref.ReferenceQueue.remove(java.base@21.0.8-beta/ReferenceQueue.java:218) [2025-06-19T14:46:07.409Z] ULT at jdk.internal.ref.CleanerImpl.run(java.base@21.0.8-beta/CleanerImpl.java:140) [2025-06-19T14:46:07.409Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.409Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.409Z] ULT at jdk.internal.misc.InnocuousThread.run(java.base@21.0.8-beta/InnocuousThread.java:186) [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "Notification Thread" #18 [3946780] daemon prio=9 os_prio=0 cpu=0.32ms elapsed=1236.78s tid=0x0000003fc422ddd0 nid=3946780 runnable [0x0000000000000000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "load-1" #26 [3946791] prio=5 os_prio=0 cpu=189549.89ms elapsed=1229.85s tid=0x0000003fc4895390 nid=3946791 waiting for monitor entry [0x0000003ea04aa000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: BLOCKED (on object monitor) [2025-06-19T14:46:07.409Z] ULT at java.io.PrintStream.println(java.base@21.0.8-beta/PrintStream.java:1170) [2025-06-19T14:46:07.409Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:108) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.409Z] ULT - locked <0x0000003eb7379b78> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.409Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.409Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.409Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.409Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.409Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.409Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "load-2" #27 [3946792] prio=5 os_prio=0 cpu=189845.12ms elapsed=1229.84s tid=0x0000003fc4896b00 nid=3946792 waiting for monitor entry [0x0000003ea02aa000] [2025-06-19T14:46:07.409Z] ULT java.lang.Thread.State: BLOCKED (on object monitor) [2025-06-19T14:46:07.409Z] ULT at java.io.PrintStream.flush(java.base@21.0.8-beta/PrintStream.java:456) [2025-06-19T14:46:07.409Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.reporting.OutputFilter.flush(OutputFilter.java:80) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:106) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.409Z] ULT - locked <0x0000003eb737a388> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.409Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.409Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.409Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.409Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.409Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.409Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.409Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.409Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.409Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.409Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "GC Thread#3" os_prio=0 cpu=2577.76ms elapsed=1235.62s tid=0x0000003e480080d0 nid=3946784 runnable [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "GC Thread#2" os_prio=0 cpu=2388.06ms elapsed=1235.62s tid=0x0000003e480075c0 nid=3946783 runnable [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "GC Thread#1" os_prio=0 cpu=2481.21ms elapsed=1235.62s tid=0x0000003e48006b20 nid=3946782 runnable [2025-06-19T14:46:07.409Z] ULT [2025-06-19T14:46:07.409Z] ULT "VM Thread" os_prio=0 cpu=362.64ms elapsed=1237.24s tid=0x0000003fc41299d0 nid=3946771 runnable [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "VM Periodic Task Thread" os_prio=0 cpu=2577.20ms elapsed=1237.27s tid=0x0000003fc4117b10 nid=3946770 waiting on condition [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "G1 Service" os_prio=0 cpu=161.23ms elapsed=1237.37s tid=0x0000003fc4106cb0 nid=3946769 runnable [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "G1 Refine#0" os_prio=0 cpu=1279.26ms elapsed=1237.37s tid=0x0000003fc4105d00 nid=3946768 runnable [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "G1 Conc#0" os_prio=0 cpu=0.17ms elapsed=1237.38s tid=0x0000003fc40a3bd0 nid=3946767 runnable [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "G1 Main Marker" os_prio=0 cpu=0.30ms elapsed=1237.38s tid=0x0000003fc40a2c30 nid=3946766 runnable [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "GC Thread#0" os_prio=0 cpu=2214.43ms elapsed=1237.38s tid=0x0000003fc4091e10 nid=3946765 runnable [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT JNI global refs: 20, weak refs: 0 [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT Found one Java-level deadlock: [2025-06-19T14:46:07.410Z] ULT ============================= [2025-06-19T14:46:07.410Z] ULT "load-1": [2025-06-19T14:46:07.410Z] ULT waiting to lock monitor 0x0000003e0c015790 (object 0x0000003eb6c00000, a net.adoptopenjdk.loadTest.reporting.OutputFilter), [2025-06-19T14:46:07.410Z] ULT which is held by UNKNOWN_owner_addr=0x0000003fc4894660 [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT Java stack information for the threads listed above: [2025-06-19T14:46:07.410Z] ULT =================================================== [2025-06-19T14:46:07.410Z] ULT "load-1": [2025-06-19T14:46:07.410Z] ULT at java.io.PrintStream.println(java.base@21.0.8-beta/PrintStream.java:1170) [2025-06-19T14:46:07.410Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:108) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.410Z] ULT - locked <0x0000003eb7379b78> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.410Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.410Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.410Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.410Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.410Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.410Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT Found one Java-level deadlock: [2025-06-19T14:46:07.410Z] ULT ============================= [2025-06-19T14:46:07.410Z] ULT "load-2": [2025-06-19T14:46:07.410Z] ULT waiting to lock monitor 0x0000003e0c015790 (object 0x0000003eb6c00000, a net.adoptopenjdk.loadTest.reporting.OutputFilter), [2025-06-19T14:46:07.410Z] ULT which is held by UNKNOWN_owner_addr=0x0000003fc4894660 [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT Java stack information for the threads listed above: [2025-06-19T14:46:07.410Z] ULT =================================================== [2025-06-19T14:46:07.410Z] ULT "load-2": [2025-06-19T14:46:07.410Z] ULT at java.io.PrintStream.flush(java.base@21.0.8-beta/PrintStream.java:456) [2025-06-19T14:46:07.410Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.reporting.OutputFilter.flush(OutputFilter.java:80) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:106) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.410Z] ULT - locked <0x0000003eb737a388> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.410Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.410Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.410Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.410Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.410Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.410Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.410Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.410Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.410Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT Found 2 deadlocks. [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT Heap [2025-06-19T14:46:07.410Z] ULT garbage-first heap total 1103872K, used 113145K [0x0000003eb6a00000, 0x0000003fac600000) [2025-06-19T14:46:07.410Z] ULT region size 2048K, 51 young (104448K), 1 survivors (2048K) [2025-06-19T14:46:07.410Z] ULT Metaspace used 12902K, committed 13312K, reserved 1114112K [2025-06-19T14:46:07.410Z] ULT class space used 1385K, committed 1536K, reserved 1048576K [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT 14:44:37.706 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.410Z] ULT 14:44:42.723 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.410Z] ULT 14:44:42.825 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:46:07.410Z] ULT 14:44:47.741 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.410Z] ULT 14:44:52.757 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.410Z] ULT 14:44:57.773 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.410Z] ULT 2025-06-19 14:45:02 [2025-06-19T14:46:07.410Z] ULT Full thread dump OpenJDK 64-Bit Server VM (21.0.8-beta+7-ea mixed mode, sharing): [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT Threads class SMR info: [2025-06-19T14:46:07.410Z] ULT _java_thread_list=0x0000003e48048d00, length=12, elements={ [2025-06-19T14:46:07.410Z] ULT 0x0000003fc402d540, 0x0000003fc4132d90, 0x0000003fc41342f0, 0x0000003fc4135a80, [2025-06-19T14:46:07.410Z] ULT 0x0000003fc41370b0, 0x0000003fc4138640, 0x0000003fc413a170, 0x0000003fc413b820, [2025-06-19T14:46:07.410Z] ULT 0x0000003fc419c430, 0x0000003fc422ddd0, 0x0000003fc4895390, 0x0000003fc4896b00 [2025-06-19T14:46:07.410Z] ULT } [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "main" #1 [3946762] prio=5 os_prio=0 cpu=9122.18ms elapsed=1267.39s tid=0x0000003fc402d540 nid=3946762 waiting on condition [0x0000003fc86c9000] [2025-06-19T14:46:07.410Z] ULT java.lang.Thread.State: TIMED_WAITING (sleeping) [2025-06-19T14:46:07.410Z] ULT at java.lang.Thread.sleep0(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.410Z] ULT at java.lang.Thread.sleep(java.base@21.0.8-beta/Thread.java:509) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner.run(LoadTestRunner.java:332) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.LoadTest.runLoadTest(LoadTest.java:136) [2025-06-19T14:46:07.410Z] ULT at net.adoptopenjdk.loadTest.LoadTest.main(LoadTest.java:114) [2025-06-19T14:46:07.410Z] ULT [2025-06-19T14:46:07.410Z] ULT "Reference Handler" #9 [3946772] daemon prio=10 os_prio=0 cpu=6.39ms elapsed=1267.22s tid=0x0000003fc4132d90 nid=3946772 waiting on condition [0x0000003eb0264000] [2025-06-19T14:46:07.410Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.Reference.waitForReferencePendingList(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.Reference.processPendingReferences(java.base@21.0.8-beta/Reference.java:246) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.Reference$ReferenceHandler.run(java.base@21.0.8-beta/Reference.java:208) [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "Finalizer" #10 [3946773] daemon prio=8 os_prio=0 cpu=0.73ms elapsed=1267.22s tid=0x0000003fc41342f0 nid=3946773 in Object.wait() [0x0000003ea1ffe000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: WAITING (on object monitor) [2025-06-19T14:46:07.411Z] ULT at java.lang.Object.wait0(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.411Z] ULT - waiting on <0x0000003eb6a008c0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-06-19T14:46:07.411Z] ULT at java.lang.Object.wait(java.base@21.0.8-beta/Object.java:366) [2025-06-19T14:46:07.411Z] ULT at java.lang.Object.wait(java.base@21.0.8-beta/Object.java:339) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.NativeReferenceQueue.await(java.base@21.0.8-beta/NativeReferenceQueue.java:48) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.8-beta/ReferenceQueue.java:158) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.NativeReferenceQueue.remove(java.base@21.0.8-beta/NativeReferenceQueue.java:89) [2025-06-19T14:46:07.411Z] ULT - locked <0x0000003eb6a008c0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.Finalizer$FinalizerThread.run(java.base@21.0.8-beta/Finalizer.java:173) [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "Signal Dispatcher" #11 [3946774] daemon prio=9 os_prio=0 cpu=1.20ms elapsed=1267.22s tid=0x0000003fc4135a80 nid=3946774 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "Service Thread" #12 [3946775] daemon prio=9 os_prio=0 cpu=5.22ms elapsed=1267.22s tid=0x0000003fc41370b0 nid=3946775 runnable [0x0000000000000000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "Monitor Deflation Thread" #13 [3946776] daemon prio=9 os_prio=0 cpu=502.05ms elapsed=1267.22s tid=0x0000003fc4138640 nid=3946776 runnable [0x0000000000000000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "C2 CompilerThread0" #14 [3946777] daemon prio=9 os_prio=0 cpu=41488.13ms elapsed=1267.22s tid=0x0000003fc413a170 nid=3946777 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.411Z] ULT No compile task [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "C1 CompilerThread0" #16 [3946778] daemon prio=9 os_prio=0 cpu=7532.38ms elapsed=1267.22s tid=0x0000003fc413b820 nid=3946778 waiting on condition [0x0000000000000000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.411Z] ULT No compile task [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "Common-Cleaner" #17 [3946779] daemon prio=8 os_prio=0 cpu=14.97ms elapsed=1267.09s tid=0x0000003fc419c430 nid=3946779 waiting on condition [0x0000003ea13fd000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: TIMED_WAITING (parking) [2025-06-19T14:46:07.411Z] ULT at jdk.internal.misc.Unsafe.park(java.base@21.0.8-beta/Native Method) [2025-06-19T14:46:07.411Z] ULT - parking to wait for <0x0000003eb6a00160> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-06-19T14:46:07.411Z] ULT at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.8-beta/LockSupport.java:269) [2025-06-19T14:46:07.411Z] ULT at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@21.0.8-beta/AbstractQueuedSynchronizer.java:1852) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.ReferenceQueue.await(java.base@21.0.8-beta/ReferenceQueue.java:71) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.8-beta/ReferenceQueue.java:143) [2025-06-19T14:46:07.411Z] ULT at java.lang.ref.ReferenceQueue.remove(java.base@21.0.8-beta/ReferenceQueue.java:218) [2025-06-19T14:46:07.411Z] ULT at jdk.internal.ref.CleanerImpl.run(java.base@21.0.8-beta/CleanerImpl.java:140) [2025-06-19T14:46:07.411Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.411Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.411Z] ULT at jdk.internal.misc.InnocuousThread.run(java.base@21.0.8-beta/InnocuousThread.java:186) [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "Notification Thread" #18 [3946780] daemon prio=9 os_prio=0 cpu=0.32ms elapsed=1266.80s tid=0x0000003fc422ddd0 nid=3946780 runnable [0x0000000000000000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: RUNNABLE [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "load-1" #26 [3946791] prio=5 os_prio=0 cpu=189553.95ms elapsed=1259.87s tid=0x0000003fc4895390 nid=3946791 waiting for monitor entry [0x0000003ea04aa000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: BLOCKED (on object monitor) [2025-06-19T14:46:07.411Z] ULT at java.io.PrintStream.println(java.base@21.0.8-beta/PrintStream.java:1170) [2025-06-19T14:46:07.411Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.411Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:108) [2025-06-19T14:46:07.411Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.411Z] ULT - locked <0x0000003eb7379b78> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.411Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.411Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.411Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.411Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.411Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.411Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.411Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.411Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.411Z] ULT [2025-06-19T14:46:07.411Z] ULT "load-2" #27 [3946792] prio=5 os_prio=0 cpu=189845.12ms elapsed=1259.86s tid=0x0000003fc4896b00 nid=3946792 waiting for monitor entry [0x0000003ea02aa000] [2025-06-19T14:46:07.411Z] ULT java.lang.Thread.State: BLOCKED (on object monitor) [2025-06-19T14:46:07.411Z] ULT at java.io.PrintStream.flush(java.base@21.0.8-beta/PrintStream.java:456) [2025-06-19T14:46:07.411Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.411Z] ULT at net.adoptopenjdk.loadTest.reporting.OutputFilter.flush(OutputFilter.java:80) [2025-06-19T14:46:07.411Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:106) [2025-06-19T14:46:07.411Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.411Z] ULT - locked <0x0000003eb737a388> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.411Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.411Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.411Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.411Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.411Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.412Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.412Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.412Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.412Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "GC Thread#3" os_prio=0 cpu=2577.76ms elapsed=1265.64s tid=0x0000003e480080d0 nid=3946784 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "GC Thread#2" os_prio=0 cpu=2388.06ms elapsed=1265.64s tid=0x0000003e480075c0 nid=3946783 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "GC Thread#1" os_prio=0 cpu=2481.21ms elapsed=1265.64s tid=0x0000003e48006b20 nid=3946782 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "VM Thread" os_prio=0 cpu=375.57ms elapsed=1267.26s tid=0x0000003fc41299d0 nid=3946771 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "VM Periodic Task Thread" os_prio=0 cpu=2649.60ms elapsed=1267.29s tid=0x0000003fc4117b10 nid=3946770 waiting on condition [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "G1 Service" os_prio=0 cpu=165.57ms elapsed=1267.39s tid=0x0000003fc4106cb0 nid=3946769 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "G1 Refine#0" os_prio=0 cpu=1306.78ms elapsed=1267.39s tid=0x0000003fc4105d00 nid=3946768 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "G1 Conc#0" os_prio=0 cpu=0.17ms elapsed=1267.40s tid=0x0000003fc40a3bd0 nid=3946767 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "G1 Main Marker" os_prio=0 cpu=0.30ms elapsed=1267.40s tid=0x0000003fc40a2c30 nid=3946766 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT "GC Thread#0" os_prio=0 cpu=2214.43ms elapsed=1267.40s tid=0x0000003fc4091e10 nid=3946765 runnable [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT JNI global refs: 20, weak refs: 0 [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT Found one Java-level deadlock: [2025-06-19T14:46:07.412Z] ULT ============================= [2025-06-19T14:46:07.412Z] ULT "load-1": [2025-06-19T14:46:07.412Z] ULT waiting to lock monitor 0x0000003e0c015790 (object 0x0000003eb6c00000, a net.adoptopenjdk.loadTest.reporting.OutputFilter), [2025-06-19T14:46:07.412Z] ULT which is held by UNKNOWN_owner_addr=0x0000003fc4894660 [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT Java stack information for the threads listed above: [2025-06-19T14:46:07.412Z] ULT =================================================== [2025-06-19T14:46:07.412Z] ULT "load-1": [2025-06-19T14:46:07.412Z] ULT at java.io.PrintStream.println(java.base@21.0.8-beta/PrintStream.java:1170) [2025-06-19T14:46:07.412Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:108) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.412Z] ULT - locked <0x0000003eb7379b78> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.412Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.412Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.412Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.412Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.412Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.412Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT Found one Java-level deadlock: [2025-06-19T14:46:07.412Z] ULT ============================= [2025-06-19T14:46:07.412Z] ULT "load-2": [2025-06-19T14:46:07.412Z] ULT waiting to lock monitor 0x0000003e0c015790 (object 0x0000003eb6c00000, a net.adoptopenjdk.loadTest.reporting.OutputFilter), [2025-06-19T14:46:07.412Z] ULT which is held by UNKNOWN_owner_addr=0x0000003fc4894660 [2025-06-19T14:46:07.412Z] ULT [2025-06-19T14:46:07.412Z] ULT Java stack information for the threads listed above: [2025-06-19T14:46:07.412Z] ULT =================================================== [2025-06-19T14:46:07.412Z] ULT "load-2": [2025-06-19T14:46:07.412Z] ULT at java.io.PrintStream.flush(java.base@21.0.8-beta/PrintStream.java:456) [2025-06-19T14:46:07.412Z] ULT - waiting to lock <0x0000003eb6c00000> (a net.adoptopenjdk.loadTest.reporting.OutputFilter) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.reporting.OutputFilter.flush(OutputFilter.java:80) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.reportProgress(JUnitAdaptor.java:106) [2025-06-19T14:46:07.412Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor$1.testFinished(JUnitAdaptor.java:77) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.SynchronizedRunListener.testFinished(SynchronizedRunListener.java:56) [2025-06-19T14:46:07.412Z] ULT - locked <0x0000003eb737a388> (a org.junit.runner.notification.RunNotifier) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.RunNotifier$7.notifyListener(RunNotifier.java:190) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:72) [2025-06-19T14:46:07.412Z] ULT at org.junit.runner.notification.RunNotifier.fireTestFinished(RunNotifier.java:187) [2025-06-19T14:46:07.412Z] ULT at org.junit.internal.runners.JUnit38ClassRunner$OldTestClassAdaptingListener.endTest(JUnit38ClassRunner.java:33) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestResult.endTest(TestResult.java:82) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestResult.run(TestResult.java:127) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestCase.run(TestCase.java:129) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2025-06-19T14:46:07.412Z] ULT at junit.framework.TestSuite.run(TestSuite.java:247) [2025-06-19T14:46:07.412Z] ULT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.Suite.runChild(Suite.java:128) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.Suite.runChild(Suite.java:27) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2025-06-19T14:46:07.412Z] ULT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2025-06-19T14:46:07.413Z] ULT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2025-06-19T14:46:07.413Z] ULT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2025-06-19T14:46:07.413Z] ULT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2025-06-19T14:46:07.413Z] ULT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2025-06-19T14:46:07.413Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2025-06-19T14:46:07.413Z] ULT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2025-06-19T14:46:07.413Z] ULT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2025-06-19T14:46:07.413Z] ULT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2025-06-19T14:46:07.413Z] ULT at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.8-beta/ThreadPoolExecutor.java:1144) [2025-06-19T14:46:07.413Z] ULT at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.8-beta/ThreadPoolExecutor.java:642) [2025-06-19T14:46:07.413Z] ULT at java.lang.Thread.runWith(java.base@21.0.8-beta/Thread.java:1596) [2025-06-19T14:46:07.413Z] ULT at java.lang.Thread.run(java.base@21.0.8-beta/Thread.java:1583) [2025-06-19T14:46:07.413Z] ULT [2025-06-19T14:46:07.413Z] ULT Found 2 deadlocks. [2025-06-19T14:46:07.413Z] ULT [2025-06-19T14:46:07.413Z] ULT Heap [2025-06-19T14:46:07.413Z] ULT garbage-first heap total 1103872K, used 113145K [0x0000003eb6a00000, 0x0000003fac600000) [2025-06-19T14:46:07.413Z] ULT region size 2048K, 51 young (104448K), 1 survivors (2048K) [2025-06-19T14:46:07.413Z] ULT Metaspace used 12902K, committed 13312K, reserved 1114112K [2025-06-19T14:46:07.413Z] ULT class space used 1385K, committed 1536K, reserved 1048576K [2025-06-19T14:46:07.413Z] ULT [2025-06-19T14:46:07.413Z] ULT 14:45:02.791 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:46:07.413Z] ULT 14:45:02.793 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.413Z] ULT 14:45:07.809 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.413Z] ULT 14:45:12.825 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.413Z] ULT 14:45:17.840 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.413Z] ULT 14:45:22.858 - Completed 100.0%. Number of tests started=39332 (+0) [2025-06-19T14:46:07.413Z] ULT 14:45:22.859 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.413Z] ULT 14:45:27.875 - **POSSIBLE HANG DETECTED** [2025-06-19T14:46:07.413Z] STF 14:46:02.789 - Monitoring Report Summary: [2025-06-19T14:46:07.413Z] STF 14:46:02.790 - o Process ULT has hung [2025-06-19T14:46:07.413Z] STF 14:46:02.791 - Killing processes: ULT [2025-06-19T14:46:07.413Z] STF 14:46:02.793 - o Process ULT pid 3946761 is not running [2025-06-19T14:46:07.413Z] **FAILED** at step 1 (Run util load tests). Expected return value=0 Actual=1 at /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/execute.pl line 94. [2025-06-19T14:46:07.413Z] STF 14:46:03.178 - **FAILED** execute script failed. Expected return value=0 Actual=1 [2025-06-19T14:46:07.413Z] STF 14:46:03.178 - [2025-06-19T14:46:07.413Z] STF 14:46:03.179 - ==================== T E A R D O W N ==================== [2025-06-19T14:46:07.413Z] STF 14:46:03.179 - Running teardown: perl /home/jenkins/workspace/Test_openjdk21_hs_extended.system_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17503423966138/UtilLoadTest_5m_1/20250619-142348-UtilLoadTest/tearDown.pl [2025-06-19T14:46:07.413Z] STF 14:46:03.414 - TEARDOWN stage completed [2025-06-19T14:46:07.413Z] STF 14:46:03.422 - [2025-06-19T14:46:07.413Z] STF 14:46:03.422 - ===================== R E S U L T S ===================== [2025-06-19T14:46:07.413Z] STF 14:46:03.423 - Stage results: [2025-06-19T14:46:07.413Z] STF 14:46:03.423 - setUp: pass [2025-06-19T14:46:07.413Z] STF 14:46:03.423 - execute: *fail* [2025-06-19T14:46:07.413Z] STF 14:46:03.423 - teardown: pass [2025-06-19T14:46:07.413Z] STF 14:46:03.423 - [2025-06-19T14:46:07.413Z] STF 14:46:03.424 - Overall result: **FAILED** [2025-06-19T14:46:07.413Z] ----------------------------------- [2025-06-19T14:46:07.413Z] UtilLoadTest_5m_1_FAILED [2025-06-19T14:46:07.413Z] ----------------------------------- [2025-06-19T14:46:07.413Z] [2025-06-19T14:46:07.413Z] TEST TEARDOWN: [2025-06-19T14:46:07.413Z] Nothing to be done for teardown. [2025-06-19T14:46:07.413Z] UtilLoadTest_5m_1 Finish Time: Thu Jun 19 14:46:03 2025 Epoch Time (ms): 1750344363478