[2025-03-28T11:30:43.060Z] Running test jdk_util_1 ... [2025-03-28T11:30:43.060Z] =============================================== [2025-03-28T11:30:43.060Z] jdk_util_1 Start Time: Fri Mar 28 11:30:39 2025 Epoch Time (ms): 1743161439717 [2025-03-28T11:30:43.060Z] variation: Mode650 [2025-03-28T11:30:43.060Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-03-28T11:30:43.060Z] { \ [2025-03-28T11:30:43.060Z] echo ""; echo "TEST SETUP:"; \ [2025-03-28T11:30:43.060Z] echo "Nothing to be done for setup."; \ [2025-03-28T11:30:43.060Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../TKG/output_17431160867651/jdk_util_1"; \ [2025-03-28T11:30:43.060Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../TKG/output_17431160867651/jdk_util_1"; \ [2025-03-28T11:30:43.060Z] echo ""; echo "TESTING:"; \ [2025-03-28T11:30:43.060Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-03-28T11:30:43.060Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx1540m -XX:-UseCompressedOops " \ [2025-03-28T11:30:43.060Z] \ [2025-03-28T11:30:43.060Z] -w ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../TKG/output_17431160867651/jdk_util_1"/work" \ [2025-03-28T11:30:43.060Z] -r ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../TKG/output_17431160867651/jdk_util_1"/report" \ [2025-03-28T11:30:43.060Z] -jdk:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image" \ [2025-03-28T11:30:43.060Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2025-03-28T11:30:43.060Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk25.txt" \ [2025-03-28T11:30:43.060Z] \ [2025-03-28T11:30:43.060Z] \ [2025-03-28T11:30:43.060Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_util"; \ [2025-03-28T11:30:43.060Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_util_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_util_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-28T11:30:43.060Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-28T11:30:43.060Z] echo "Nothing to be done for teardown."; \ [2025-03-28T11:30:43.060Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../TKG/output_17431160867651/TestTargetResult"; [2025-03-28T11:30:43.060Z] [2025-03-28T11:30:43.060Z] TEST SETUP: [2025-03-28T11:30:43.060Z] Nothing to be done for setup. [2025-03-28T11:30:43.060Z] [2025-03-28T11:30:43.060Z] TESTING: [2025-03-28T11:30:43.060Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../TKG/output_17431160867651/jdk_util_1/work" not found: creating [2025-03-28T11:30:43.060Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/../TKG/output_17431160867651/jdk_util_1/report" not found: creating [2025-03-28T11:31:09.189Z] XML output with verification to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work [2025-03-28T11:55:48.815Z] -------------------------------------------------- [2025-03-28T11:55:48.815Z] TEST: java/util/concurrent/forkjoin/Starvation.java [2025-03-28T11:55:48.815Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image [2025-03-28T11:55:48.815Z] [2025-03-28T11:55:48.815Z] ACTION: build -- Passed. Build successful [2025-03-28T11:55:48.815Z] REASON: Named class compiled on demand [2025-03-28T11:55:48.815Z] TIME: 0.231 seconds [2025-03-28T11:55:48.815Z] messages: [2025-03-28T11:55:48.815Z] command: build Starvation [2025-03-28T11:55:48.815Z] reason: Named class compiled on demand [2025-03-28T11:55:48.815Z] started: Fri Mar 28 11:39:37 UTC 2025 [2025-03-28T11:55:48.815Z] Test directory: [2025-03-28T11:55:48.815Z] compile: Starvation [2025-03-28T11:55:48.815Z] finished: Fri Mar 28 11:39:37 UTC 2025 [2025-03-28T11:55:48.815Z] elapsed time (seconds): 0.231 [2025-03-28T11:55:48.815Z] [2025-03-28T11:55:48.815Z] ACTION: compile -- Passed. Compilation successful [2025-03-28T11:55:48.815Z] REASON: .class file out of date or does not exist [2025-03-28T11:55:48.815Z] TIME: 0.205 seconds [2025-03-28T11:55:48.815Z] messages: [2025-03-28T11:55:48.815Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin/Starvation.java [2025-03-28T11:55:48.815Z] reason: .class file out of date or does not exist [2025-03-28T11:55:48.815Z] started: Fri Mar 28 11:39:37 UTC 2025 [2025-03-28T11:55:48.815Z] Mode: agentvm [2025-03-28T11:55:48.815Z] Agent id: 1 [2025-03-28T11:55:48.815Z] Process id: 3717000 [2025-03-28T11:55:48.815Z] finished: Fri Mar 28 11:39:37 UTC 2025 [2025-03-28T11:55:48.815Z] elapsed time (seconds): 0.205 [2025-03-28T11:55:48.815Z] configuration: [2025-03-28T11:55:48.815Z] Boot Layer (javac runtime environment) [2025-03-28T11:55:48.815Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-03-28T11:55:48.815Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-03-28T11:55:48.815Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/patches/java.base [2025-03-28T11:55:48.815Z] [2025-03-28T11:55:48.815Z] javac compilation environment [2025-03-28T11:55:48.815Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin [2025-03-28T11:55:48.815Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin [2025-03-28T11:55:48.815Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d [2025-03-28T11:55:48.815Z] [2025-03-28T11:55:48.815Z] rerun: [2025-03-28T11:55:48.815Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/scratch/0 && \ [2025-03-28T11:55:48.815Z] DISPLAY=:0 \ [2025-03-28T11:55:48.815Z] HOME=/home/jenkins \ [2025-03-28T11:55:48.815Z] LANG=C.UTF-8 \ [2025-03-28T11:55:48.815Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-03-28T11:55:48.815Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image/bin/javac \ [2025-03-28T11:55:48.815Z] -J-ea \ [2025-03-28T11:55:48.815Z] -J-esa \ [2025-03-28T11:55:48.815Z] -J-Xmx1540m \ [2025-03-28T11:55:48.815Z] -J-XX:-UseCompressedOops \ [2025-03-28T11:55:48.815Z] -J-Dtest.vm.opts='-ea -esa -Xmx1540m -XX:-UseCompressedOops' \ [2025-03-28T11:55:48.815Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx1540m -J-XX:-UseCompressedOops' \ [2025-03-28T11:55:48.815Z] -J-Dtest.compiler.opts= \ [2025-03-28T11:55:48.815Z] -J-Dtest.java.opts= \ [2025-03-28T11:55:48.815Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image \ [2025-03-28T11:55:48.815Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image \ [2025-03-28T11:55:48.815Z] -J-Dtest.timeout.factor=8.0 \ [2025-03-28T11:55:48.815Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-03-28T11:55:48.815Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-03-28T11:55:48.815Z] -J-Dtest.name=java/util/concurrent/forkjoin/Starvation.java \ [2025-03-28T11:55:48.815Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-03-28T11:55:48.815Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin/Starvation.java \ [2025-03-28T11:55:48.815Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin \ [2025-03-28T11:55:48.815Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin \ [2025-03-28T11:55:48.815Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d \ [2025-03-28T11:55:48.815Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d \ [2025-03-28T11:55:48.815Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin \ [2025-03-28T11:55:48.816Z] -d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d \ [2025-03-28T11:55:48.816Z] -sourcepath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin \ [2025-03-28T11:55:48.816Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin/Starvation.java [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] ACTION: main -- Error. "main" action timed out with a timeout of 960 seconds on agent 11 [2025-03-28T11:55:48.816Z] REASON: Assumed action based on file name: run main Starvation [2025-03-28T11:55:48.816Z] TIME: 963.932 seconds [2025-03-28T11:55:48.816Z] messages: [2025-03-28T11:55:48.816Z] command: main Starvation [2025-03-28T11:55:48.816Z] reason: Assumed action based on file name: run main Starvation [2025-03-28T11:55:48.816Z] started: Fri Mar 28 11:39:37 UTC 2025 [2025-03-28T11:55:48.816Z] Mode: agentvm [2025-03-28T11:55:48.816Z] Agent id: 11 [2025-03-28T11:55:48.816Z] Process id: 3718385 [2025-03-28T11:55:48.816Z] Timeout signalled after 960 seconds [2025-03-28T11:55:48.816Z] Timeout information: [2025-03-28T11:55:48.816Z] Running jstack on process 3718385 [2025-03-28T11:55:48.816Z] 2025-03-28 11:55:40 [2025-03-28T11:55:48.816Z] Full thread dump OpenJDK 64-Bit Server VM (25-beta+16-ea mixed mode): [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] Threads class SMR info: [2025-03-28T11:55:48.816Z] _java_thread_list=0x000075ad60001b70, length=14, elements={ [2025-03-28T11:55:48.816Z] 0x000075ae1c02aa00, 0x000075ae1c12db00, 0x000075ae1c12f0a0, 0x000075ae1c1308d0, [2025-03-28T11:55:48.816Z] 0x000075ae1c131f10, 0x000075ae1c1334b0, 0x000075ae1c134fd0, 0x000075ae1c1366e0, [2025-03-28T11:55:48.816Z] 0x000075ae1c1861f0, 0x000075ae1c21a850, 0x000075ae1c241480, 0x000075ad301dbcb0, [2025-03-28T11:55:48.816Z] 0x000075ad14007db0, 0x000075ad60000f30 [2025-03-28T11:55:48.816Z] } [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "main" #3 [3718388] prio=5 os_prio=0 cpu=656.29ms elapsed=1153.80s tid=0x000075ae1c02aa00 nid=3718388 runnable [0x000075ae227f6000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] at sun.nio.ch.Net.poll(java.base@25-beta/Native Method) [2025-03-28T11:55:48.816Z] at sun.nio.ch.NioSocketImpl.park(java.base@25-beta/NioSocketImpl.java:190) [2025-03-28T11:55:48.816Z] at sun.nio.ch.NioSocketImpl.timedRead(java.base@25-beta/NioSocketImpl.java:279) [2025-03-28T11:55:48.816Z] at sun.nio.ch.NioSocketImpl.implRead(java.base@25-beta/NioSocketImpl.java:303) [2025-03-28T11:55:48.816Z] at sun.nio.ch.NioSocketImpl.read(java.base@25-beta/NioSocketImpl.java:345) [2025-03-28T11:55:48.816Z] at sun.nio.ch.NioSocketImpl$1.read(java.base@25-beta/NioSocketImpl.java:790) [2025-03-28T11:55:48.816Z] at java.net.Socket$SocketInputStream.implRead(java.base@25-beta/Socket.java:983) [2025-03-28T11:55:48.816Z] at java.net.Socket$SocketInputStream.read(java.base@25-beta/Socket.java:970) [2025-03-28T11:55:48.816Z] at java.io.BufferedInputStream.fill(java.base@25-beta/BufferedInputStream.java:289) [2025-03-28T11:55:48.816Z] at java.io.BufferedInputStream.read(java.base@25-beta/BufferedInputStream.java:308) [2025-03-28T11:55:48.816Z] - locked <0x000075ada4471a70> (a java.io.BufferedInputStream) [2025-03-28T11:55:48.816Z] at java.io.FilterInputStream.read(java.base@25-beta/FilterInputStream.java:71) [2025-03-28T11:55:48.816Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:238) [2025-03-28T11:55:48.816Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71) [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "Reference Handler" #11 [3718396] daemon prio=10 os_prio=0 cpu=2.07ms elapsed=1153.27s tid=0x000075ae1c12db00 nid=3718396 waiting on condition [0x000075ae20ab0000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@25-beta/Native Method) [2025-03-28T11:55:48.816Z] at java.lang.ref.Reference.processPendingReferences(java.base@25-beta/Reference.java:246) [2025-03-28T11:55:48.816Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@25-beta/Reference.java:208) [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "Finalizer" #12 [3718397] daemon prio=8 os_prio=0 cpu=0.29ms elapsed=1153.24s tid=0x000075ae1c12f0a0 nid=3718397 in Object.wait() [0x000075ae209af000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: WAITING (on object monitor) [2025-03-28T11:55:48.816Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-03-28T11:55:48.816Z] - waiting on <0x000075ada41688d8> (a java.lang.ref.ReferenceQueue$Lock) [2025-03-28T11:55:48.816Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-03-28T11:55:48.816Z] at java.lang.Object.wait(java.base@25-beta/Object.java:351) [2025-03-28T11:55:48.816Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:138) [2025-03-28T11:55:48.816Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:229) [2025-03-28T11:55:48.816Z] - locked <0x000075ada41688d8> (a java.lang.ref.ReferenceQueue$Lock) [2025-03-28T11:55:48.816Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@25-beta/Finalizer.java:165) [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "Signal Dispatcher" #13 [3718398] daemon prio=9 os_prio=0 cpu=0.96ms elapsed=1153.23s tid=0x000075ae1c1308d0 nid=3718398 waiting on condition [0x0000000000000000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "Service Thread" #14 [3718399] daemon prio=9 os_prio=0 cpu=40.25ms elapsed=1153.20s tid=0x000075ae1c131f10 nid=3718399 runnable [0x0000000000000000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "Monitor Deflation Thread" #15 [3718400] daemon prio=9 os_prio=0 cpu=89.15ms elapsed=1153.19s tid=0x000075ae1c1334b0 nid=3718400 runnable [0x0000000000000000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "C2 CompilerThread0" #16 [3718401] daemon prio=9 os_prio=0 cpu=7677.72ms elapsed=1153.19s tid=0x000075ae1c134fd0 nid=3718401 waiting on condition [0x0000000000000000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] No compile task [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "C1 CompilerThread0" #18 [3718402] daemon prio=9 os_prio=0 cpu=2050.31ms elapsed=1153.19s tid=0x000075ae1c1366e0 nid=3718402 waiting on condition [0x0000000000000000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] No compile task [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "Common-Cleaner" #19 [3718403] daemon prio=8 os_prio=0 cpu=1.84ms elapsed=1152.75s tid=0x000075ae1c1861f0 nid=3718403 in Object.wait() [0x000075ae20299000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-03-28T11:55:48.816Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-03-28T11:55:48.816Z] - waiting on <no object reference available> [2025-03-28T11:55:48.816Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-03-28T11:55:48.816Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:124) [2025-03-28T11:55:48.816Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:215) [2025-03-28T11:55:48.816Z] - locked <0x000075ada41cfcf8> (a java.lang.ref.ReferenceQueue$Lock) [2025-03-28T11:55:48.816Z] at jdk.internal.ref.CleanerImpl.run(java.base@25-beta/CleanerImpl.java:146) [2025-03-28T11:55:48.816Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-03-28T11:55:48.816Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-03-28T11:55:48.816Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "Notification Thread" #20 [3718404] daemon prio=9 os_prio=0 cpu=0.08ms elapsed=1152.33s tid=0x000075ae1c21a850 nid=3718404 runnable [0x0000000000000000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "pool-1-thread-1" #21 [3718408] daemon prio=5 os_prio=0 cpu=19.07ms elapsed=1151.46s tid=0x000075ae1c241480 nid=3718408 waiting on condition [0x000075ae13572000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-03-28T11:55:48.816Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-03-28T11:55:48.816Z] - parking to wait for <0x000075ada4257410> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-03-28T11:55:48.816Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@25-beta/LockSupport.java:271) [2025-03-28T11:55:48.816Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@25-beta/AbstractQueuedSynchronizer.java:1802) [2025-03-28T11:55:48.816Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:1166) [2025-03-28T11:55:48.816Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:883) [2025-03-28T11:55:48.816Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@25-beta/ThreadPoolExecutor.java:1016) [2025-03-28T11:55:48.816Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1076) [2025-03-28T11:55:48.816Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-03-28T11:55:48.816Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-03-28T11:55:48.816Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-03-28T11:55:48.816Z] [2025-03-28T11:55:48.816Z] "VirtualThread-unblocker" #714 [3720977] daemon prio=5 os_prio=0 cpu=0.13ms elapsed=977.52s tid=0x000075ad301dbcb0 nid=3720977 runnable [0x000075ad9b6f5000] [2025-03-28T11:55:48.816Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.816Z] at java.lang.VirtualThread.takeVirtualThreadListToUnblock(java.base@25-beta/Native Method) [2025-03-28T11:55:48.816Z] at java.lang.VirtualThread.unblockVirtualThreads(java.base@25-beta/VirtualThread.java:1489) [2025-03-28T11:55:48.817Z] at java.lang.VirtualThread$$Lambda/0x00000000851e5880.run(java.base@25-beta/Unknown Source) [2025-03-28T11:55:48.817Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-03-28T11:55:48.817Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-03-28T11:55:48.817Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "VirtualThread-unparker" #717 [3720979] daemon prio=5 os_prio=0 cpu=0.35ms elapsed=977.52s tid=0x000075ad14007db0 nid=3720979 waiting on condition [0x000075ad9befd000] [2025-03-28T11:55:48.817Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-03-28T11:55:48.817Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-03-28T11:55:48.817Z] - parking to wait for <0x000075adb050e338> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-03-28T11:55:48.817Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@25-beta/LockSupport.java:271) [2025-03-28T11:55:48.817Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@25-beta/AbstractQueuedSynchronizer.java:1802) [2025-03-28T11:55:48.817Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:1166) [2025-03-28T11:55:48.817Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:883) [2025-03-28T11:55:48.817Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@25-beta/ThreadPoolExecutor.java:1016) [2025-03-28T11:55:48.817Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1076) [2025-03-28T11:55:48.817Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-03-28T11:55:48.817Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-03-28T11:55:48.817Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-03-28T11:55:48.817Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "Attach Listener" #763 [3797838] daemon prio=9 os_prio=0 cpu=1.07ms elapsed=0.24s tid=0x000075ad60000f30 nid=3797838 waiting on condition [0x0000000000000000] [2025-03-28T11:55:48.817Z] java.lang.Thread.State: RUNNABLE [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "GC Thread#3" os_prio=0 cpu=184.60ms elapsed=1136.51s tid=0x000075ad74008460 nid=3718523 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "GC Thread#2" os_prio=0 cpu=181.42ms elapsed=1136.51s tid=0x000075ad74007930 nid=3718522 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "GC Thread#1" os_prio=0 cpu=190.09ms elapsed=1136.51s tid=0x000075ad74006e00 nid=3718521 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "VM Thread" os_prio=0 cpu=44.26ms elapsed=1153.46s tid=0x000075ae1c0e5c60 nid=3718395 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "VM Periodic Task Thread" os_prio=0 cpu=475.73ms elapsed=1153.72s tid=0x000075ae1c0c4090 nid=3718394 waiting on condition [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "G1 Service" os_prio=0 cpu=34.74ms elapsed=1153.72s tid=0x000075ae1c0b4f10 nid=3718393 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "G1 Refine#0" os_prio=0 cpu=1590.96ms elapsed=1153.75s tid=0x000075ae1c0b3f30 nid=3718392 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "G1 Conc#0" os_prio=0 cpu=83.04ms elapsed=1153.77s tid=0x000075ae1c08ac90 nid=3718391 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "G1 Main Marker" os_prio=0 cpu=0.40ms elapsed=1153.78s tid=0x000075ae1c089cd0 nid=3718390 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] "GC Thread#0" os_prio=0 cpu=203.27ms elapsed=1153.79s tid=0x000075ae1c0765a0 nid=3718389 runnable [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] JNI global refs: 17, weak refs: 0 [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] --- Timeout information end. [2025-03-28T11:55:48.817Z] finished: Fri Mar 28 11:55:41 UTC 2025 [2025-03-28T11:55:48.817Z] elapsed time (seconds): 963.932 [2025-03-28T11:55:48.817Z] configuration: [2025-03-28T11:55:48.817Z] Boot Layer [2025-03-28T11:55:48.817Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-03-28T11:55:48.817Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-03-28T11:55:48.817Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar [2025-03-28T11:55:48.817Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-03-28T11:55:48.817Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-03-28T11:55:48.817Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-03-28T11:55:48.817Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/patches/java.base [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] Test Layer [2025-03-28T11:55:48.817Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d [2025-03-28T11:55:48.817Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] rerun: [2025-03-28T11:55:48.817Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/scratch/0 && \ [2025-03-28T11:55:48.817Z] DISPLAY=:0 \ [2025-03-28T11:55:48.817Z] HOME=/home/jenkins \ [2025-03-28T11:55:48.817Z] LANG=C.UTF-8 \ [2025-03-28T11:55:48.817Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-03-28T11:55:48.817Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image/bin/java \ [2025-03-28T11:55:48.817Z] -Dtest.vm.opts='-ea -esa -Xmx1540m -XX:-UseCompressedOops' \ [2025-03-28T11:55:48.817Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx1540m -J-XX:-UseCompressedOops' \ [2025-03-28T11:55:48.817Z] -Dtest.compiler.opts= \ [2025-03-28T11:55:48.817Z] -Dtest.java.opts= \ [2025-03-28T11:55:48.817Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image \ [2025-03-28T11:55:48.817Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/j2sdk-image \ [2025-03-28T11:55:48.817Z] -Dtest.timeout.factor=8.0 \ [2025-03-28T11:55:48.817Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-03-28T11:55:48.817Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-03-28T11:55:48.817Z] -Dtest.name=java/util/concurrent/forkjoin/Starvation.java \ [2025-03-28T11:55:48.817Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-03-28T11:55:48.817Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin/Starvation.java \ [2025-03-28T11:55:48.817Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin \ [2025-03-28T11:55:48.817Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin \ [2025-03-28T11:55:48.817Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d \ [2025-03-28T11:55:48.817Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d \ [2025-03-28T11:55:48.817Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin \ [2025-03-28T11:55:48.817Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work/classes/0/java/util/concurrent/forkjoin/Starvation.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/concurrent/forkjoin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-03-28T11:55:48.817Z] Starvation [2025-03-28T11:55:48.817Z] STDERR: [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] JavaTest Message: Test complete. [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] [2025-03-28T11:55:48.817Z] TEST RESULT: Error. "main" action timed out with a timeout of 960 seconds on agent 11 [2025-03-28T11:55:48.817Z] -------------------------------------------------- [2025-03-28T12:31:36.560Z] Test results: passed: 983; error: 1; excluded: 1; did not match keywords: 8; did not meet platform requirements: 3 [2025-03-28T12:32:06.843Z] Report written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/report/html/report.html [2025-03-28T12:32:06.843Z] Results written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_x86-64_linux/aqa-tests/TKG/output_17431160867651/jdk_util_1/work [2025-03-28T12:32:06.843Z] Error: Some tests failed or other problems occurred. [2025-03-28T12:32:06.843Z] ----------------------------------- [2025-03-28T12:32:06.843Z] jdk_util_1_FAILED [2025-03-28T12:32:06.843Z] ----------------------------------- [2025-03-28T12:32:06.843Z] [2025-03-28T12:32:06.843Z] TEST TEARDOWN: [2025-03-28T12:32:06.843Z] Nothing to be done for teardown. [2025-03-28T12:32:06.843Z] jdk_util_1 Finish Time: Fri Mar 28 12:32:06 2025 Epoch Time (ms): 1743165126654