[2025-05-30T02:42:18.690Z] Running test jdk_nio_1 ... [2025-05-30T02:42:18.690Z] =============================================== [2025-05-30T02:42:18.690Z] jdk_nio_1 Start Time: Fri May 30 02:42:18 2025 Epoch Time (ms): 1748572938284 [2025-05-30T02:42:18.691Z] variation: Mode650 [2025-05-30T02:42:18.691Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-05-30T02:42:18.691Z] { \ [2025-05-30T02:42:18.691Z] echo ""; echo "TEST SETUP:"; \ [2025-05-30T02:42:18.691Z] echo "Nothing to be done for setup."; \ [2025-05-30T02:42:18.691Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485631864458/jdk_nio_1"; \ [2025-05-30T02:42:18.691Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485631864458/jdk_nio_1"; \ [2025-05-30T02:42:18.691Z] echo ""; echo "TESTING:"; \ [2025-05-30T02:42:18.691Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-05-30T02:42:18.691Z] -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_extended.openjdk_s390x_linux_testList_2/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx512m -XX:-UseCompressedOops " \ [2025-05-30T02:42:18.691Z] -w ""/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485631864458/jdk_nio_1"/work" \ [2025-05-30T02:42:18.691Z] -r ""/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485631864458/jdk_nio_1"/report" \ [2025-05-30T02:42:18.691Z] -jdk:"/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image" \ [2025-05-30T02:42:18.691Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2025-05-30T02:42:18.691Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk25.txt" \ [2025-05-30T02:42:18.691Z] \ [2025-05-30T02:42:18.691Z] \ [2025-05-30T02:42:18.691Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_nio"; \ [2025-05-30T02:42:18.691Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_nio_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_nio_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-30T02:42:18.691Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-30T02:42:18.691Z] echo "Nothing to be done for teardown."; \ [2025-05-30T02:42:18.691Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485631864458/TestTargetResult"; [2025-05-30T02:42:18.691Z] [2025-05-30T02:42:18.691Z] TEST SETUP: [2025-05-30T02:42:18.691Z] Nothing to be done for setup. [2025-05-30T02:42:18.691Z] [2025-05-30T02:42:18.691Z] TESTING: [2025-05-30T02:42:20.912Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485631864458/jdk_nio_1/work" not found: creating [2025-05-30T02:42:20.912Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485631864458/jdk_nio_1/report" not found: creating [2025-05-30T02:42:50.224Z] XML output with verification to /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work [2025-05-30T03:00:44.039Z] -------------------------------------------------- [2025-05-30T03:00:44.039Z] TEST: java/nio/channels/AsynchronousFileChannel/LotsOfWrites.java [2025-05-30T03:00:44.039Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image [2025-05-30T03:00:44.039Z] [2025-05-30T03:00:44.039Z] ACTION: build -- Passed. Build successful [2025-05-30T03:00:44.039Z] REASON: Named class compiled on demand [2025-05-30T03:00:44.039Z] TIME: 0.545 seconds [2025-05-30T03:00:44.039Z] messages: [2025-05-30T03:00:44.039Z] command: build LotsOfWrites [2025-05-30T03:00:44.039Z] reason: Named class compiled on demand [2025-05-30T03:00:44.039Z] started: Fri May 30 02:44:30 UTC 2025 [2025-05-30T03:00:44.039Z] Test directory: [2025-05-30T03:00:44.039Z] compile: LotsOfWrites [2025-05-30T03:00:44.039Z] finished: Fri May 30 02:44:31 UTC 2025 [2025-05-30T03:00:44.039Z] elapsed time (seconds): 0.545 [2025-05-30T03:00:44.039Z] [2025-05-30T03:00:44.039Z] ACTION: compile -- Passed. Compilation successful [2025-05-30T03:00:44.039Z] REASON: .class file out of date or does not exist [2025-05-30T03:00:44.039Z] TIME: 0.544 seconds [2025-05-30T03:00:44.039Z] messages: [2025-05-30T03:00:44.039Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.java [2025-05-30T03:00:44.039Z] reason: .class file out of date or does not exist [2025-05-30T03:00:44.039Z] started: Fri May 30 02:44:30 UTC 2025 [2025-05-30T03:00:44.039Z] Mode: agentvm [2025-05-30T03:00:44.039Z] Agent id: 3 [2025-05-30T03:00:44.039Z] Process id: 870310 [2025-05-30T03:00:44.039Z] finished: Fri May 30 02:44:31 UTC 2025 [2025-05-30T03:00:44.039Z] elapsed time (seconds): 0.544 [2025-05-30T03:00:44.039Z] configuration: [2025-05-30T03:00:44.039Z] Boot Layer (javac runtime environment) [2025-05-30T03:00:44.039Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-30T03:00:44.039Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-30T03:00:44.039Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/patches/java.base [2025-05-30T03:00:44.039Z] [2025-05-30T03:00:44.039Z] javac compilation environment [2025-05-30T03:00:44.039Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel [2025-05-30T03:00:44.039Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel [2025-05-30T03:00:44.039Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d [2025-05-30T03:00:44.039Z] [2025-05-30T03:00:44.039Z] rerun: [2025-05-30T03:00:44.039Z] cd /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/scratch/2 && \ [2025-05-30T03:00:44.039Z] DISPLAY=:0 \ [2025-05-30T03:00:44.039Z] HOME=/home/jenkins \ [2025-05-30T03:00:44.039Z] LANG=C.UTF-8 \ [2025-05-30T03:00:44.039Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-30T03:00:44.039Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/javac \ [2025-05-30T03:00:44.039Z] -J-ea \ [2025-05-30T03:00:44.039Z] -J-esa \ [2025-05-30T03:00:44.039Z] -J-Xmx512m \ [2025-05-30T03:00:44.039Z] -J-XX:-UseCompressedOops \ [2025-05-30T03:00:44.039Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops' \ [2025-05-30T03:00:44.039Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops' \ [2025-05-30T03:00:44.039Z] -J-Dtest.compiler.opts= \ [2025-05-30T03:00:44.039Z] -J-Dtest.java.opts= \ [2025-05-30T03:00:44.039Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:44.039Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:44.039Z] -J-Dtest.timeout.factor=8.0 \ [2025-05-30T03:00:44.039Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-30T03:00:44.039Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-30T03:00:44.039Z] -J-Dtest.name=java/nio/channels/AsynchronousFileChannel/LotsOfWrites.java \ [2025-05-30T03:00:44.039Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-30T03:00:44.039Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.java \ [2025-05-30T03:00:44.039Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel \ [2025-05-30T03:00:44.039Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel \ [2025-05-30T03:00:44.039Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d \ [2025-05-30T03:00:44.039Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d \ [2025-05-30T03:00:44.039Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel \ [2025-05-30T03:00:44.040Z] -d /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d \ [2025-05-30T03:00:44.040Z] -sourcepath /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel \ [2025-05-30T03:00:44.040Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.java [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] ACTION: main -- Error. "main" action timed out with a timeout of 960 seconds on agent 6 [2025-05-30T03:00:44.040Z] REASON: Assumed action based on file name: run main LotsOfWrites [2025-05-30T03:00:44.040Z] TIME: 963.223 seconds [2025-05-30T03:00:44.040Z] messages: [2025-05-30T03:00:44.040Z] command: main LotsOfWrites [2025-05-30T03:00:44.040Z] reason: Assumed action based on file name: run main LotsOfWrites [2025-05-30T03:00:44.040Z] started: Fri May 30 02:44:31 UTC 2025 [2025-05-30T03:00:44.040Z] Mode: agentvm [2025-05-30T03:00:44.040Z] Agent id: 6 [2025-05-30T03:00:44.040Z] Process id: 870581 [2025-05-30T03:00:44.040Z] Timeout signalled after 960 seconds [2025-05-30T03:00:44.040Z] Timeout information: [2025-05-30T03:00:44.040Z] Running jstack on process 870581 [2025-05-30T03:00:44.040Z] 2025-05-30 03:00:33 [2025-05-30T03:00:44.040Z] Full thread dump OpenJDK 64-Bit Server VM (25-beta+25-ea mixed mode): [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] Threads class SMR info: [2025-05-30T03:00:44.040Z] _java_thread_list=0x000003ff180019e0, length=18, elements={ [2025-05-30T03:00:44.040Z] 0x000003ff9002c630, 0x000003ff901050e0, 0x000003ff90106810, 0x000003ff901081d0, [2025-05-30T03:00:44.040Z] 0x000003ff901099a0, 0x000003ff9010b0d0, 0x000003ff9010cd80, 0x000003ff9010e620, [2025-05-30T03:00:44.040Z] 0x000003ff9019cdc0, 0x000003ff901ff300, 0x000003ff90252190, 0x000003fee449cf60, [2025-05-30T03:00:44.040Z] 0x000003fee4484a90, 0x000003fee44852c0, 0x000003fee449e940, 0x000003fee449f170, [2025-05-30T03:00:44.040Z] 0x000003ff901736c0, 0x000003ff18000df0 [2025-05-30T03:00:44.040Z] } [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "main" #3 [870584] prio=5 os_prio=0 cpu=988.46ms elapsed=1008.43s tid=0x000003ff9002c630 nid=870584 in Object.wait() [0x000003ff973fe000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-30T03:00:44.040Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-30T03:00:44.040Z] - waiting on <0x000003ff62026b20> (a java.lang.Thread) [2025-05-30T03:00:44.040Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-30T03:00:44.040Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1860) [2025-05-30T03:00:44.040Z] - locked <0x000003ff62026b20> (a java.lang.Thread) [2025-05-30T03:00:44.040Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1936) [2025-05-30T03:00:44.040Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219) [2025-05-30T03:00:44.040Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:319) [2025-05-30T03:00:44.040Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:244) [2025-05-30T03:00:44.040Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71) [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "Reference Handler" #11 [870592] daemon prio=10 os_prio=0 cpu=128.90ms elapsed=1008.34s tid=0x000003ff901050e0 nid=870592 waiting on condition [0x000003ff946fe000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@25-beta/Native Method) [2025-05-30T03:00:44.040Z] at java.lang.ref.Reference.processPendingReferences(java.base@25-beta/Reference.java:246) [2025-05-30T03:00:44.040Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@25-beta/Reference.java:208) [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "Finalizer" #12 [870593] daemon prio=8 os_prio=0 cpu=0.10ms elapsed=1008.35s tid=0x000003ff90106810 nid=870593 in Object.wait() [0x000003ff945fe000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-30T03:00:44.040Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-30T03:00:44.040Z] - waiting on <0x000003ff58c31d70> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-30T03:00:44.040Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-30T03:00:44.040Z] at java.lang.Object.wait(java.base@25-beta/Object.java:351) [2025-05-30T03:00:44.040Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:137) [2025-05-30T03:00:44.040Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:215) [2025-05-30T03:00:44.040Z] - locked <0x000003ff58c31d70> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-30T03:00:44.040Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@25-beta/Finalizer.java:165) [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "Signal Dispatcher" #13 [870594] daemon prio=9 os_prio=0 cpu=2.94ms elapsed=1008.35s tid=0x000003ff901081d0 nid=870594 waiting on condition [0x0000000000000000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "Service Thread" #14 [870595] daemon prio=9 os_prio=0 cpu=65.69ms elapsed=1008.35s tid=0x000003ff901099a0 nid=870595 runnable [0x0000000000000000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "Monitor Deflation Thread" #15 [870596] daemon prio=9 os_prio=0 cpu=121.81ms elapsed=1008.35s tid=0x000003ff9010b0d0 nid=870596 runnable [0x0000000000000000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "C2 CompilerThread0" #16 [870597] daemon prio=9 os_prio=0 cpu=7900.05ms elapsed=1008.35s tid=0x000003ff9010cd80 nid=870597 runnable [0x0000000000000000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] No compile task [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "C1 CompilerThread0" #18 [870598] daemon prio=9 os_prio=0 cpu=1226.37ms elapsed=1008.35s tid=0x000003ff9010e620 nid=870598 waiting on condition [0x0000000000000000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] No compile task [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "Common-Cleaner" #19 [870599] daemon prio=8 os_prio=0 cpu=21.41ms elapsed=1007.93s tid=0x000003ff9019cdc0 nid=870599 in Object.wait() [0x000003ff941fe000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-05-30T03:00:44.040Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-30T03:00:44.040Z] - waiting on <0x000003ff58a7af80> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-30T03:00:44.040Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-30T03:00:44.040Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:123) [2025-05-30T03:00:44.040Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:201) [2025-05-30T03:00:44.040Z] - locked <0x000003ff58a7af80> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-30T03:00:44.040Z] at jdk.internal.ref.CleanerImpl.run(java.base@25-beta/CleanerImpl.java:146) [2025-05-30T03:00:44.040Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.040Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.040Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "Notification Thread" #20 [870600] daemon prio=9 os_prio=0 cpu=0.15ms elapsed=1007.37s tid=0x000003ff901ff300 nid=870600 runnable [0x0000000000000000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "pool-1-thread-1" #21 [870605] daemon prio=5 os_prio=0 cpu=44.17ms elapsed=1006.77s tid=0x000003ff90252190 nid=870605 waiting on condition [0x000003ff581fe000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-05-30T03:00:44.040Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:44.040Z] - parking to wait for <0x000003ff58c2dda8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:44.040Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@25-beta/LockSupport.java:271) [2025-05-30T03:00:44.040Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@25-beta/AbstractQueuedSynchronizer.java:1802) [2025-05-30T03:00:44.040Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:1166) [2025-05-30T03:00:44.040Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:883) [2025-05-30T03:00:44.040Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@25-beta/ThreadPoolExecutor.java:1016) [2025-05-30T03:00:44.040Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1076) [2025-05-30T03:00:44.040Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:44.040Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.040Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.040Z] [2025-05-30T03:00:44.040Z] "InnocuousThread-1" #27 [871891] daemon prio=5 os_prio=0 cpu=104.58ms elapsed=972.18s tid=0x000003fee449cf60 nid=871891 runnable [0x000003ff584fe000] [2025-05-30T03:00:44.040Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.040Z] at sun.nio.ch.EPoll.wait(java.base@25-beta/Native Method) [2025-05-30T03:00:44.040Z] at sun.nio.ch.EPollPort$EventHandlerTask.poll(java.base@25-beta/EPollPort.java:199) [2025-05-30T03:00:44.040Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:280) [2025-05-30T03:00:44.040Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.041Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "InnocuousThread-2" #28 [871896] daemon prio=5 os_prio=0 cpu=11.67ms elapsed=972.13s tid=0x000003fee4484a90 nid=871896 waiting on condition [0x000003ff518fe000] [2025-05-30T03:00:44.041Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:44.041Z] - parking to wait for <0x000003ff5c81ff70> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:44.041Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:44.041Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:44.041Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.041Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "InnocuousThread-3" #29 [871898] daemon prio=5 os_prio=0 cpu=14.36ms elapsed=972.13s tid=0x000003fee44852c0 nid=871898 waiting on condition [0x000003ff517fe000] [2025-05-30T03:00:44.041Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:44.041Z] - parking to wait for <0x000003ff5c81ff70> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:44.041Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:44.041Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:44.041Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.041Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "InnocuousThread-4" #30 [871904] daemon prio=5 os_prio=0 cpu=9.73ms elapsed=972.12s tid=0x000003fee449e940 nid=871904 waiting on condition [0x000003ff516fe000] [2025-05-30T03:00:44.041Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:44.041Z] - parking to wait for <0x000003ff5c81ff70> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:44.041Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:44.041Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:44.041Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.041Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "InnocuousThread-5" #31 [871905] daemon prio=5 os_prio=0 cpu=12.54ms elapsed=972.12s tid=0x000003fee449f170 nid=871905 waiting on condition [0x000003ff515fe000] [2025-05-30T03:00:44.041Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:44.041Z] - parking to wait for <0x000003ff5c81ff70> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:44.041Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:44.041Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:44.041Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:44.041Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.041Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "AgentVMThread" #311 [873129] prio=5 os_prio=0 cpu=15.15ms elapsed=962.84s tid=0x000003ff901736c0 nid=873129 waiting on condition [0x000003ff51ffd000] [2025-05-30T03:00:44.041Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:44.041Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:44.041Z] - parking to wait for <0x000003ff62086518> (a java.util.concurrent.CountDownLatch$Sync) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:223) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(java.base@25-beta/AbstractQueuedSynchronizer.java:789) [2025-05-30T03:00:44.041Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(java.base@25-beta/AbstractQueuedSynchronizer.java:1138) [2025-05-30T03:00:44.041Z] at java.util.concurrent.CountDownLatch.await(java.base@25-beta/CountDownLatch.java:230) [2025-05-30T03:00:44.041Z] at LotsOfWrites.main(LotsOfWrites.java:136) [2025-05-30T03:00:44.041Z] at java.lang.invoke.LambdaForm$DMH/0x000000007f081400.invokeStatic(java.base@25-beta/LambdaForm$DMH) [2025-05-30T03:00:44.041Z] at java.lang.invoke.LambdaForm$MH/0x000000007f193400.invoke(java.base@25-beta/LambdaForm$MH) [2025-05-30T03:00:44.041Z] at java.lang.invoke.Invokers$Holder.invokeExact_MT(java.base@25-beta/Invokers$Holder) [2025-05-30T03:00:44.041Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@25-beta/DirectMethodHandleAccessor.java:155) [2025-05-30T03:00:44.041Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@25-beta/DirectMethodHandleAccessor.java:104) [2025-05-30T03:00:44.041Z] at java.lang.reflect.Method.invoke(java.base@25-beta/Method.java:565) [2025-05-30T03:00:44.041Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:335) [2025-05-30T03:00:44.041Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:44.041Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "Attach Listener" #332 [877315] daemon prio=9 os_prio=0 cpu=2.11ms elapsed=1.11s tid=0x000003ff18000df0 nid=877315 waiting on condition [0x0000000000000000] [2025-05-30T03:00:44.041Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "GC Thread#3" os_prio=0 cpu=143.67ms elapsed=1002.74s tid=0x000003ff2c008790 nid=870665 runnable [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "GC Thread#2" os_prio=0 cpu=362.78ms elapsed=1002.74s tid=0x000003ff2c007a80 nid=870664 runnable [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "GC Thread#1" os_prio=0 cpu=134.73ms elapsed=1002.75s tid=0x000003ff2c006de0 nid=870663 runnable [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.041Z] "VM Thread" os_prio=0 cpu=26.51ms elapsed=1008.59s tid=0x000003ff900bd720 nid=870591 runnable [2025-05-30T03:00:44.041Z] [2025-05-30T03:00:44.042Z] "G1 Main Marker" os_prio=0 cpu=0.14ms elapsed=1008.67s tid=0x000003ff90061c10 nid=870586 runnable [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] "VM Periodic Task Thread" os_prio=0 cpu=760.45ms elapsed=1008.63s tid=0x000003ff90099400 nid=870590 waiting on condition [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] "G1 Service" os_prio=0 cpu=107.23ms elapsed=1008.63s tid=0x000003ff9008ddf0 nid=870589 runnable [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] "G1 Refine#0" os_prio=0 cpu=0.06ms elapsed=1008.63s tid=0x000003ff9008cc30 nid=870588 runnable [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] "G1 Conc#0" os_prio=0 cpu=0.04ms elapsed=1008.64s tid=0x000003ff90062db0 nid=870587 runnable [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] "GC Thread#0" os_prio=0 cpu=151.02ms elapsed=1008.67s tid=0x000003ff90059c40 nid=870585 runnable [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] JNI global refs: 16, weak refs: 0 [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] --- Timeout information end. [2025-05-30T03:00:44.042Z] finished: Fri May 30 03:00:34 UTC 2025 [2025-05-30T03:00:44.042Z] elapsed time (seconds): 963.223 [2025-05-30T03:00:44.042Z] configuration: [2025-05-30T03:00:44.042Z] Boot Layer [2025-05-30T03:00:44.042Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-30T03:00:44.042Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-30T03:00:44.042Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar [2025-05-30T03:00:44.042Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-05-30T03:00:44.042Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-05-30T03:00:44.042Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-05-30T03:00:44.042Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/patches/java.base [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] Test Layer [2025-05-30T03:00:44.042Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d [2025-05-30T03:00:44.042Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] rerun: [2025-05-30T03:00:44.042Z] cd /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/scratch/2 && \ [2025-05-30T03:00:44.042Z] DISPLAY=:0 \ [2025-05-30T03:00:44.042Z] HOME=/home/jenkins \ [2025-05-30T03:00:44.042Z] LANG=C.UTF-8 \ [2025-05-30T03:00:44.042Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-30T03:00:44.042Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java \ [2025-05-30T03:00:44.042Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops' \ [2025-05-30T03:00:44.042Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops' \ [2025-05-30T03:00:44.042Z] -Dtest.compiler.opts= \ [2025-05-30T03:00:44.042Z] -Dtest.java.opts= \ [2025-05-30T03:00:44.042Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:44.042Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:44.042Z] -Dtest.timeout.factor=8.0 \ [2025-05-30T03:00:44.042Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-30T03:00:44.042Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-30T03:00:44.042Z] -Dtest.name=java/nio/channels/AsynchronousFileChannel/LotsOfWrites.java \ [2025-05-30T03:00:44.042Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-30T03:00:44.042Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.java \ [2025-05-30T03:00:44.042Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel \ [2025-05-30T03:00:44.042Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel \ [2025-05-30T03:00:44.042Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d \ [2025-05-30T03:00:44.042Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d \ [2025-05-30T03:00:44.042Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel \ [2025-05-30T03:00:44.042Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/2/java/nio/channels/AsynchronousFileChannel/LotsOfWrites.d:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousFileChannel:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-05-30T03:00:44.042Z] LotsOfWrites [2025-05-30T03:00:44.042Z] [2025-05-30T03:00:44.042Z] TEST RESULT: Error. "main" action timed out with a timeout of 960 seconds on agent 6 [2025-05-30T03:00:44.042Z] -------------------------------------------------- [2025-05-30T03:00:59.641Z] TEST: java/nio/channels/AsynchronousSocketChannel/StressLoopback.java [2025-05-30T03:00:59.641Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image [2025-05-30T03:00:59.641Z] [2025-05-30T03:00:59.641Z] ACTION: build -- Passed. Build successful [2025-05-30T03:00:59.641Z] REASON: Named class compiled on demand [2025-05-30T03:00:59.641Z] TIME: 0.715 seconds [2025-05-30T03:00:59.641Z] messages: [2025-05-30T03:00:59.641Z] command: build StressLoopback [2025-05-30T03:00:59.641Z] reason: Named class compiled on demand [2025-05-30T03:00:59.641Z] started: Fri May 30 02:44:52 UTC 2025 [2025-05-30T03:00:59.641Z] Test directory: [2025-05-30T03:00:59.641Z] compile: StressLoopback [2025-05-30T03:00:59.641Z] finished: Fri May 30 02:44:53 UTC 2025 [2025-05-30T03:00:59.641Z] elapsed time (seconds): 0.715 [2025-05-30T03:00:59.641Z] [2025-05-30T03:00:59.641Z] ACTION: compile -- Passed. Compilation successful [2025-05-30T03:00:59.641Z] REASON: .class file out of date or does not exist [2025-05-30T03:00:59.641Z] TIME: 0.715 seconds [2025-05-30T03:00:59.641Z] messages: [2025-05-30T03:00:59.641Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel/StressLoopback.java [2025-05-30T03:00:59.641Z] reason: .class file out of date or does not exist [2025-05-30T03:00:59.641Z] started: Fri May 30 02:44:52 UTC 2025 [2025-05-30T03:00:59.641Z] Mode: agentvm [2025-05-30T03:00:59.641Z] Agent id: 1 [2025-05-30T03:00:59.641Z] Process id: 870263 [2025-05-30T03:00:59.641Z] finished: Fri May 30 02:44:53 UTC 2025 [2025-05-30T03:00:59.641Z] elapsed time (seconds): 0.715 [2025-05-30T03:00:59.641Z] configuration: [2025-05-30T03:00:59.641Z] Boot Layer (javac runtime environment) [2025-05-30T03:00:59.641Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-30T03:00:59.641Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-30T03:00:59.641Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/patches/java.base [2025-05-30T03:00:59.641Z] [2025-05-30T03:00:59.641Z] javac compilation environment [2025-05-30T03:00:59.641Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel [2025-05-30T03:00:59.641Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel [2025-05-30T03:00:59.641Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d [2025-05-30T03:00:59.641Z] [2025-05-30T03:00:59.641Z] rerun: [2025-05-30T03:00:59.641Z] cd /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/scratch/0 && \ [2025-05-30T03:00:59.641Z] DISPLAY=:0 \ [2025-05-30T03:00:59.641Z] HOME=/home/jenkins \ [2025-05-30T03:00:59.641Z] LANG=C.UTF-8 \ [2025-05-30T03:00:59.641Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-30T03:00:59.641Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/javac \ [2025-05-30T03:00:59.641Z] -J-ea \ [2025-05-30T03:00:59.641Z] -J-esa \ [2025-05-30T03:00:59.641Z] -J-Xmx512m \ [2025-05-30T03:00:59.641Z] -J-XX:-UseCompressedOops \ [2025-05-30T03:00:59.641Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops' \ [2025-05-30T03:00:59.641Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops' \ [2025-05-30T03:00:59.641Z] -J-Dtest.compiler.opts= \ [2025-05-30T03:00:59.641Z] -J-Dtest.java.opts= \ [2025-05-30T03:00:59.641Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:59.641Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:59.641Z] -J-Dtest.timeout.factor=8.0 \ [2025-05-30T03:00:59.641Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-30T03:00:59.641Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-30T03:00:59.641Z] -J-Dtest.name=java/nio/channels/AsynchronousSocketChannel/StressLoopback.java \ [2025-05-30T03:00:59.641Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-30T03:00:59.641Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel/StressLoopback.java \ [2025-05-30T03:00:59.642Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel \ [2025-05-30T03:00:59.642Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel \ [2025-05-30T03:00:59.642Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d \ [2025-05-30T03:00:59.642Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d \ [2025-05-30T03:00:59.642Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel \ [2025-05-30T03:00:59.642Z] -d /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d \ [2025-05-30T03:00:59.642Z] -sourcepath /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel \ [2025-05-30T03:00:59.642Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel/StressLoopback.java [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] ACTION: main -- Error. "main" action timed out with a timeout of 960 seconds on agent 4 [2025-05-30T03:00:59.642Z] REASON: User specified action: run main StressLoopback [2025-05-30T03:00:59.642Z] TIME: 963.633 seconds [2025-05-30T03:00:59.642Z] messages: [2025-05-30T03:00:59.642Z] command: main StressLoopback [2025-05-30T03:00:59.642Z] reason: User specified action: run main StressLoopback [2025-05-30T03:00:59.642Z] started: Fri May 30 02:44:53 UTC 2025 [2025-05-30T03:00:59.642Z] Mode: agentvm [2025-05-30T03:00:59.642Z] Agent id: 4 [2025-05-30T03:00:59.642Z] Process id: 870339 [2025-05-30T03:00:59.642Z] Timeout signalled after 960 seconds [2025-05-30T03:00:59.642Z] Timeout information: [2025-05-30T03:00:59.642Z] Running jstack on process 870339 [2025-05-30T03:00:59.642Z] 2025-05-30 03:00:56 [2025-05-30T03:00:59.642Z] Full thread dump OpenJDK 64-Bit Server VM (25-beta+25-ea mixed mode): [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] Threads class SMR info: [2025-05-30T03:00:59.642Z] _java_thread_list=0x000003ff040021f0, length=18, elements={ [2025-05-30T03:00:59.642Z] 0x000003ff7c02c630, 0x000003ff7c1050e0, 0x000003ff7c106810, 0x000003ff7c1081d0, [2025-05-30T03:00:59.642Z] 0x000003ff7c1099a0, 0x000003ff7c10b0d0, 0x000003ff7c10cd80, 0x000003ff7c10e620, [2025-05-30T03:00:59.642Z] 0x000003ff7c15c3d0, 0x000003ff7c1cefa0, 0x000003ff7c222a70, 0x000003fe800039b0, [2025-05-30T03:00:59.642Z] 0x000003fe80004ca0, 0x000003fe80005c70, 0x000003fe80007050, 0x000003fe80008030, [2025-05-30T03:00:59.642Z] 0x000003ff7c16f6a0, 0x000003ff04000f20 [2025-05-30T03:00:59.642Z] } [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "main" #3 [870342] prio=5 os_prio=0 cpu=1425.82ms elapsed=1075.19s tid=0x000003ff7c02c630 nid=870342 in Object.wait() [0x000003ff835fe000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-30T03:00:59.642Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-30T03:00:59.642Z] - waiting on <no object reference available> [2025-05-30T03:00:59.642Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-30T03:00:59.642Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1860) [2025-05-30T03:00:59.642Z] - locked <0x000003ff45300000> (a java.lang.Thread) [2025-05-30T03:00:59.642Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1936) [2025-05-30T03:00:59.642Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219) [2025-05-30T03:00:59.642Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:319) [2025-05-30T03:00:59.642Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:244) [2025-05-30T03:00:59.642Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71) [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "Reference Handler" #11 [870352] daemon prio=10 os_prio=0 cpu=37.54ms elapsed=1075.46s tid=0x000003ff7c1050e0 nid=870352 waiting on condition [0x000003ff808fe000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.642Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@25-beta/Native Method) [2025-05-30T03:00:59.642Z] at java.lang.ref.Reference.processPendingReferences(java.base@25-beta/Reference.java:246) [2025-05-30T03:00:59.642Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@25-beta/Reference.java:208) [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "Finalizer" #12 [870353] daemon prio=8 os_prio=0 cpu=0.11ms elapsed=1075.62s tid=0x000003ff7c106810 nid=870353 in Object.wait() [0x000003ff807fe000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-30T03:00:59.642Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-30T03:00:59.642Z] - waiting on <0x000003ff44b2de28> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-30T03:00:59.642Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-30T03:00:59.642Z] at java.lang.Object.wait(java.base@25-beta/Object.java:351) [2025-05-30T03:00:59.642Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:137) [2025-05-30T03:00:59.642Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:215) [2025-05-30T03:00:59.642Z] - locked <0x000003ff44b2de28> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-30T03:00:59.642Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@25-beta/Finalizer.java:165) [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "Signal Dispatcher" #13 [870354] daemon prio=9 os_prio=0 cpu=2.07ms elapsed=1075.68s tid=0x000003ff7c1081d0 nid=870354 waiting on condition [0x0000000000000000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "Service Thread" #14 [870355] daemon prio=9 os_prio=0 cpu=46.24ms elapsed=1075.68s tid=0x000003ff7c1099a0 nid=870355 runnable [0x0000000000000000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "Monitor Deflation Thread" #15 [870356] daemon prio=9 os_prio=0 cpu=110.75ms elapsed=1075.68s tid=0x000003ff7c10b0d0 nid=870356 runnable [0x0000000000000000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "C2 CompilerThread0" #16 [870357] daemon prio=9 os_prio=0 cpu=2136.50ms elapsed=1075.68s tid=0x000003ff7c10cd80 nid=870357 waiting on condition [0x0000000000000000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.642Z] No compile task [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "C1 CompilerThread0" #18 [870358] daemon prio=9 os_prio=0 cpu=1379.07ms elapsed=1075.67s tid=0x000003ff7c10e620 nid=870358 waiting on condition [0x0000000000000000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.642Z] No compile task [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "Common-Cleaner" #19 [870362] daemon prio=8 os_prio=0 cpu=2.61ms elapsed=1075.14s tid=0x000003ff7c15c3d0 nid=870362 in Object.wait() [0x000003ff447fe000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-05-30T03:00:59.642Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-30T03:00:59.642Z] - waiting on <no object reference available> [2025-05-30T03:00:59.642Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-30T03:00:59.642Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:123) [2025-05-30T03:00:59.642Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:201) [2025-05-30T03:00:59.642Z] - locked <0x000003ff44b2e528> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-30T03:00:59.642Z] at jdk.internal.ref.CleanerImpl.run(java.base@25-beta/CleanerImpl.java:146) [2025-05-30T03:00:59.642Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.642Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.642Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "Notification Thread" #20 [870363] daemon prio=9 os_prio=0 cpu=0.09ms elapsed=1073.45s tid=0x000003ff7c1cefa0 nid=870363 runnable [0x0000000000000000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.642Z] [2025-05-30T03:00:59.642Z] "pool-1-thread-1" #21 [870371] daemon prio=5 os_prio=0 cpu=39.13ms elapsed=1072.18s tid=0x000003ff7c222a70 nid=870371 waiting on condition [0x000003ff445fe000] [2025-05-30T03:00:59.642Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-05-30T03:00:59.642Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:59.642Z] - parking to wait for <0x000003ff44b2ea08> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:59.642Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@25-beta/LockSupport.java:271) [2025-05-30T03:00:59.642Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@25-beta/AbstractQueuedSynchronizer.java:1802) [2025-05-30T03:00:59.642Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:1166) [2025-05-30T03:00:59.642Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:883) [2025-05-30T03:00:59.642Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@25-beta/ThreadPoolExecutor.java:1016) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1076) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:59.643Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.643Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "InnocuousThread-3" #58 [871545] daemon prio=5 os_prio=0 cpu=25.09ms elapsed=999.08s tid=0x000003fe800039b0 nid=871545 waiting on condition [0x000003ff3d5fe000] [2025-05-30T03:00:59.643Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:59.643Z] - parking to wait for <0x000003ff44dbbf88> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:59.643Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:59.643Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.643Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "InnocuousThread-4" #59 [871548] daemon prio=5 os_prio=0 cpu=45.43ms elapsed=999.12s tid=0x000003fe80004ca0 nid=871548 waiting on condition [0x000003ff3d6fe000] [2025-05-30T03:00:59.643Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:59.643Z] - parking to wait for <0x000003ff44dbbf88> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:59.643Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:59.643Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:59.643Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.643Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "InnocuousThread-5" #60 [871549] daemon prio=5 os_prio=0 cpu=86.38ms elapsed=999.17s tid=0x000003fe80005c70 nid=871549 runnable [0x000003ff3d4fe000] [2025-05-30T03:00:59.643Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.643Z] at sun.nio.ch.EPoll.wait(java.base@25-beta/Native Method) [2025-05-30T03:00:59.643Z] at sun.nio.ch.EPollPort$EventHandlerTask.poll(java.base@25-beta/EPollPort.java:199) [2025-05-30T03:00:59.643Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:280) [2025-05-30T03:00:59.643Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:59.643Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.643Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "InnocuousThread-6" #61 [871551] daemon prio=5 os_prio=0 cpu=33.67ms elapsed=999.16s tid=0x000003fe80007050 nid=871551 waiting on condition [0x000003ff3d1fe000] [2025-05-30T03:00:59.643Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:59.643Z] - parking to wait for <0x000003ff44dbbf88> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:59.643Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:59.643Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:59.643Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.643Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "InnocuousThread-7" #62 [871552] daemon prio=5 os_prio=0 cpu=29.40ms elapsed=999.16s tid=0x000003fe80008030 nid=871552 waiting on condition [0x000003ff3d3fe000] [2025-05-30T03:00:59.643Z] java.lang.Thread.State: WAITING (parking) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-30T03:00:59.643Z] - parking to wait for <0x000003ff44dbbf88> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:369) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionNode.block(java.base@25-beta/AbstractQueuedSynchronizer.java:519) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.unmanagedBlock(java.base@25-beta/ForkJoinPool.java:4364) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ForkJoinPool.managedBlock(java.base@25-beta/ForkJoinPool.java:4310) [2025-05-30T03:00:59.643Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@25-beta/AbstractQueuedSynchronizer.java:1751) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ArrayBlockingQueue.take(java.base@25-beta/ArrayBlockingQueue.java:421) [2025-05-30T03:00:59.643Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(java.base@25-beta/EPollPort.java:274) [2025-05-30T03:00:59.643Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(java.base@25-beta/AsynchronousChannelGroupImpl.java:108) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1090) [2025-05-30T03:00:59.643Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-30T03:00:59.643Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.643Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.643Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "AgentVMThread" #697 [873509] prio=5 os_prio=0 cpu=916.39ms elapsed=963.21s tid=0x000003ff7c16f6a0 nid=873509 sleeping [0x000003ff338fd000] [2025-05-30T03:00:59.643Z] java.lang.Thread.State: TIMED_WAITING (sleeping) [2025-05-30T03:00:59.643Z] at java.lang.Thread.sleepNanos0(java.base@25-beta/Native Method) [2025-05-30T03:00:59.643Z] at java.lang.Thread.sleepNanos(java.base@25-beta/Thread.java:482) [2025-05-30T03:00:59.643Z] at java.lang.Thread.sleep(java.base@25-beta/Thread.java:513) [2025-05-30T03:00:59.643Z] at StressLoopback.waitUntilClosed(StressLoopback.java:172) [2025-05-30T03:00:59.643Z] at StressLoopback$Source.finish(StressLoopback.java:125) [2025-05-30T03:00:59.643Z] at StressLoopback.main(StressLoopback.java:73) [2025-05-30T03:00:59.643Z] at java.lang.invoke.LambdaForm$DMH/0x0000000086081400.invokeStatic(java.base@25-beta/LambdaForm$DMH) [2025-05-30T03:00:59.643Z] at java.lang.invoke.LambdaForm$MH/0x000000008608a800.invoke(java.base@25-beta/LambdaForm$MH) [2025-05-30T03:00:59.643Z] at java.lang.invoke.Invokers$Holder.invokeExact_MT(java.base@25-beta/Invokers$Holder) [2025-05-30T03:00:59.643Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@25-beta/DirectMethodHandleAccessor.java:155) [2025-05-30T03:00:59.643Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@25-beta/DirectMethodHandleAccessor.java:104) [2025-05-30T03:00:59.643Z] at java.lang.reflect.Method.invoke(java.base@25-beta/Method.java:565) [2025-05-30T03:00:59.643Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:335) [2025-05-30T03:00:59.643Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-30T03:00:59.643Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "Attach Listener" #714 [877712] daemon prio=9 os_prio=0 cpu=1.32ms elapsed=1.51s tid=0x000003ff04000f20 nid=877712 waiting on condition [0x0000000000000000] [2025-05-30T03:00:59.643Z] java.lang.Thread.State: RUNNABLE [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.643Z] "GC Thread#3" os_prio=0 cpu=148.90ms elapsed=1052.92s tid=0x000003ff180081d0 nid=870472 runnable [2025-05-30T03:00:59.643Z] [2025-05-30T03:00:59.644Z] "GC Thread#2" os_prio=0 cpu=100.48ms elapsed=1052.93s tid=0x000003ff18007670 nid=870471 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "GC Thread#1" os_prio=0 cpu=47.89ms elapsed=1052.93s tid=0x000003ff18006dc0 nid=870470 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "VM Thread" os_prio=0 cpu=39.53ms elapsed=1076.01s tid=0x000003ff7c0bd720 nid=870351 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "VM Periodic Task Thread" os_prio=0 cpu=816.76ms elapsed=1076.10s tid=0x000003ff7c099400 nid=870350 waiting on condition [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "G1 Service" os_prio=0 cpu=55.80ms elapsed=1076.10s tid=0x000003ff7c08ddf0 nid=870349 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "G1 Refine#0" os_prio=0 cpu=575.26ms elapsed=1076.10s tid=0x000003ff7c08cc30 nid=870348 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "G1 Conc#0" os_prio=0 cpu=0.06ms elapsed=1076.10s tid=0x000003ff7c062db0 nid=870347 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "G1 Main Marker" os_prio=0 cpu=0.07ms elapsed=1076.11s tid=0x000003ff7c061c10 nid=870346 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] "GC Thread#0" os_prio=0 cpu=187.46ms elapsed=1076.11s tid=0x000003ff7c059c40 nid=870345 runnable [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] JNI global refs: 16, weak refs: 0 [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] --- Timeout information end. [2025-05-30T03:00:59.644Z] finished: Fri May 30 03:00:57 UTC 2025 [2025-05-30T03:00:59.644Z] elapsed time (seconds): 963.633 [2025-05-30T03:00:59.644Z] configuration: [2025-05-30T03:00:59.644Z] Boot Layer [2025-05-30T03:00:59.644Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-30T03:00:59.644Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-30T03:00:59.644Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar [2025-05-30T03:00:59.644Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-05-30T03:00:59.644Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-05-30T03:00:59.644Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-05-30T03:00:59.644Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/patches/java.base [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] Test Layer [2025-05-30T03:00:59.644Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d [2025-05-30T03:00:59.644Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] rerun: [2025-05-30T03:00:59.644Z] cd /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/scratch/0 && \ [2025-05-30T03:00:59.644Z] DISPLAY=:0 \ [2025-05-30T03:00:59.644Z] HOME=/home/jenkins \ [2025-05-30T03:00:59.644Z] LANG=C.UTF-8 \ [2025-05-30T03:00:59.644Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-30T03:00:59.644Z] /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java \ [2025-05-30T03:00:59.644Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops' \ [2025-05-30T03:00:59.644Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops' \ [2025-05-30T03:00:59.644Z] -Dtest.compiler.opts= \ [2025-05-30T03:00:59.644Z] -Dtest.java.opts= \ [2025-05-30T03:00:59.644Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:59.644Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/j2sdk-image \ [2025-05-30T03:00:59.644Z] -Dtest.timeout.factor=8.0 \ [2025-05-30T03:00:59.644Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-30T03:00:59.644Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-30T03:00:59.644Z] -Dtest.name=java/nio/channels/AsynchronousSocketChannel/StressLoopback.java \ [2025-05-30T03:00:59.644Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-30T03:00:59.644Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel/StressLoopback.java \ [2025-05-30T03:00:59.644Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel \ [2025-05-30T03:00:59.644Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel \ [2025-05-30T03:00:59.644Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d \ [2025-05-30T03:00:59.644Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d \ [2025-05-30T03:00:59.644Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel \ [2025-05-30T03:00:59.644Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work/classes/0/java/nio/channels/AsynchronousSocketChannel/StressLoopback.d:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/nio/channels/AsynchronousSocketChannel:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-05-30T03:00:59.644Z] StressLoopback [2025-05-30T03:00:59.644Z] [2025-05-30T03:00:59.644Z] TEST RESULT: Error. "main" action timed out with a timeout of 960 seconds on agent 4 [2025-05-30T03:00:59.644Z] -------------------------------------------------- [2025-05-30T03:11:22.259Z] Test results: passed: 472; error: 2; skipped: 1; excluded: 12; did not match keywords: 4; did not meet platform requirements: 20 [2025-05-30T03:14:31.838Z] Report written to /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/report/html/report.html [2025-05-30T03:14:31.838Z] Results written to /home/jenkins/workspace/Test_openjdk25_hs_extended.openjdk_s390x_linux_testList_2/aqa-tests/TKG/output_17485631864458/jdk_nio_1/work [2025-05-30T03:14:31.838Z] Error: Some tests failed or other problems occurred. [2025-05-30T03:14:31.838Z] ----------------------------------- [2025-05-30T03:14:31.838Z] jdk_nio_1_FAILED [2025-05-30T03:14:31.838Z] ----------------------------------- [2025-05-30T03:14:31.838Z] [2025-05-30T03:14:31.838Z] TEST TEARDOWN: [2025-05-30T03:14:31.838Z] Nothing to be done for teardown. [2025-05-30T03:14:31.838Z] jdk_nio_1 Finish Time: Fri May 30 03:14:23 2025 Epoch Time (ms): 1748574863334