[2025-05-31T21:30:00.654Z] Running test jdk_nio_2 ... [2025-05-31T21:30:00.654Z] =============================================== [2025-05-31T21:30:00.654Z] jdk_nio_2 Start Time: Sat May 31 21:30:00 2025 Epoch Time (ms): 1748727000469 [2025-05-31T21:30:00.654Z] variation: Mode1000 [2025-05-31T21:30:00.654Z] JVM_OPTIONS: [2025-05-31T21:30:00.654Z] { \ [2025-05-31T21:30:00.654Z] echo ""; echo "TEST SETUP:"; \ [2025-05-31T21:30:00.654Z] echo "Nothing to be done for setup."; \ [2025-05-31T21:30:00.654Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_17487259942664/jdk_nio_2"; \ [2025-05-31T21:30:00.654Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_17487259942664/jdk_nio_2"; \ [2025-05-31T21:30:00.654Z] echo ""; echo "TESTING:"; \ [2025-05-31T21:30:00.654Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-05-31T21:30:00.654Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:3 -vmoptions:"-Xmx512m " \ [2025-05-31T21:30:00.654Z] -w ""/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_17487259942664/jdk_nio_2"/work" \ [2025-05-31T21:30:00.654Z] -r ""/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_17487259942664/jdk_nio_2"/report" \ [2025-05-31T21:30:00.654Z] -jdk:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image" \ [2025-05-31T21:30:00.654Z] -exclude:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/jdk/test/ProblemList.txt" \ [2025-05-31T21:30:00.654Z] -exclude:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk8.txt" \ [2025-05-31T21:30:00.654Z] \ [2025-05-31T21:30:00.654Z] \ [2025-05-31T21:30:00.654Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/jdk/test:jdk_nio"; \ [2025-05-31T21:30:00.654Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_nio_2""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_nio_2""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-31T21:30:00.654Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-31T21:30:00.654Z] echo "Nothing to be done for teardown."; \ [2025-05-31T21:30:00.654Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_17487259942664/TestTargetResult"; [2025-05-31T21:30:00.654Z] [2025-05-31T21:30:00.654Z] TEST SETUP: [2025-05-31T21:30:00.654Z] Nothing to be done for setup. [2025-05-31T21:30:00.654Z] [2025-05-31T21:30:00.654Z] TESTING: [2025-05-31T21:30:01.424Z] Directory "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_17487259942664/jdk_nio_2/work" not found: creating [2025-05-31T21:30:01.424Z] Directory "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_17487259942664/jdk_nio_2/report" not found: creating [2025-05-31T21:30:01.424Z] XML output with verification to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work [2025-05-31T21:47:37.560Z] -------------------------------------------------- [2025-05-31T21:47:37.560Z] TEST: java/nio/channels/FileChannel/InterruptDeadlock.java [2025-05-31T21:47:37.560Z] TEST JDK: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image [2025-05-31T21:47:37.560Z] [2025-05-31T21:47:37.560Z] ACTION: build -- Passed. Build successful [2025-05-31T21:47:37.560Z] REASON: Named class compiled on demand [2025-05-31T21:47:37.560Z] TIME: 0.088 seconds [2025-05-31T21:47:37.560Z] messages: [2025-05-31T21:47:37.560Z] command: build InterruptDeadlock [2025-05-31T21:47:37.560Z] reason: Named class compiled on demand [2025-05-31T21:47:37.560Z] Test directory: [2025-05-31T21:47:37.560Z] compile: InterruptDeadlock [2025-05-31T21:47:37.560Z] elapsed time (seconds): 0.088 [2025-05-31T21:47:37.560Z] [2025-05-31T21:47:37.560Z] ACTION: compile -- Passed. Compilation successful [2025-05-31T21:47:37.560Z] REASON: .class file out of date or does not exist [2025-05-31T21:47:37.560Z] TIME: 0.088 seconds [2025-05-31T21:47:37.560Z] messages: [2025-05-31T21:47:37.560Z] command: compile -XDignore.symbol.file=true /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java [2025-05-31T21:47:37.560Z] reason: .class file out of date or does not exist [2025-05-31T21:47:37.560Z] Mode: agentvm [2025-05-31T21:47:37.560Z] Agent id: 3 [2025-05-31T21:47:37.560Z] elapsed time (seconds): 0.088 [2025-05-31T21:47:37.560Z] configuration: [2025-05-31T21:47:37.560Z] Boot Layer (javac runtime environment) [2025-05-31T21:47:37.560Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/lib/tools.jar [2025-05-31T21:47:37.560Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-31T21:47:37.560Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-31T21:47:37.560Z] [2025-05-31T21:47:37.560Z] javac compilation environment [2025-05-31T21:47:37.560Z] source path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2025-05-31T21:47:37.560Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2025-05-31T21:47:37.560Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel [2025-05-31T21:47:37.560Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/lib/tools.jar [2025-05-31T21:47:37.560Z] [2025-05-31T21:47:37.560Z] rerun: [2025-05-31T21:47:37.560Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/scratch/1 && \ [2025-05-31T21:47:37.560Z] DISPLAY=:0 \ [2025-05-31T21:47:37.560Z] HOME=/home/jenkins \ [2025-05-31T21:47:37.560Z] LANG=C.UTF-8 \ [2025-05-31T21:47:37.560Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-31T21:47:37.560Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/bin/javac \ [2025-05-31T21:47:37.560Z] -J-ea \ [2025-05-31T21:47:37.560Z] -J-esa \ [2025-05-31T21:47:37.560Z] -J-Xmx512m \ [2025-05-31T21:47:37.560Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m' \ [2025-05-31T21:47:37.560Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2025-05-31T21:47:37.560Z] -J-Dtest.compiler.opts= \ [2025-05-31T21:47:37.560Z] -J-Dtest.java.opts= \ [2025-05-31T21:47:37.560Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image \ [2025-05-31T21:47:37.560Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image \ [2025-05-31T21:47:37.560Z] -J-Dtest.timeout.factor=8.0 \ [2025-05-31T21:47:37.560Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2025-05-31T21:47:37.560Z] -J-Dtest.name=java/nio/channels/FileChannel/InterruptDeadlock.java \ [2025-05-31T21:47:37.560Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java \ [2025-05-31T21:47:37.560Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.560Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.560Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.560Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.560Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.560Z] -d /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.560Z] -sourcepath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.560Z] -classpath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/lib/tools.jar \ [2025-05-31T21:47:37.560Z] -XDignore.symbol.file=true /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java [2025-05-31T21:47:37.560Z] [2025-05-31T21:47:37.560Z] ACTION: main -- Error. Agent error: java.lang.Exception: Agent 5 timed out with a timeout of 960 seconds; check console log for any additional details [2025-05-31T21:47:37.560Z] REASON: Assumed action based on file name: run main InterruptDeadlock [2025-05-31T21:47:37.560Z] TIME: 960.425 seconds [2025-05-31T21:47:37.560Z] messages: [2025-05-31T21:47:37.560Z] command: main InterruptDeadlock [2025-05-31T21:47:37.560Z] reason: Assumed action based on file name: run main InterruptDeadlock [2025-05-31T21:47:37.560Z] Mode: agentvm [2025-05-31T21:47:37.560Z] Agent id: 5 [2025-05-31T21:47:37.560Z] Timeout refired 960 times [2025-05-31T21:47:37.560Z] Timeout information: [2025-05-31T21:47:37.560Z] Running jstack on process 41570 [2025-05-31T21:47:37.560Z] 2025-05-31 21:47:32 [2025-05-31T21:47:37.560Z] Full thread dump OpenJDK Client VM (25.462-b04 mixed mode): [2025-05-31T21:47:37.560Z] [2025-05-31T21:47:37.561Z] "Attach Listener" #1756 daemon prio=9 os_prio=0 tid=0xd2a00c00 nid=0xbd2d waiting on condition [0x00000000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: RUNNABLE [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "Thread-1293" #1755 prio=5 os_prio=0 tid=0xccd08800 nid=0xae35 waiting for monitor entry [0xcf0ae000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: BLOCKED (on object monitor) [2025-05-31T21:47:37.561Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2025-05-31T21:47:37.561Z] - waiting to lock <0xd4271a70> (a java.lang.Object) [2025-05-31T21:47:37.561Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "Thread-1292" #1754 prio=5 os_prio=0 tid=0xccd08000 nid=0xae34 waiting for monitor entry [0xce65e000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: BLOCKED (on object monitor) [2025-05-31T21:47:37.561Z] at java.nio.channels.spi.AbstractInterruptibleChannel$1.interrupt(AbstractInterruptibleChannel.java:160) [2025-05-31T21:47:37.561Z] - waiting to lock <0xd4271a30> (a java.lang.Object) [2025-05-31T21:47:37.561Z] at java.nio.channels.spi.AbstractInterruptibleChannel.begin(AbstractInterruptibleChannel.java:173) [2025-05-31T21:47:37.561Z] at sun.nio.ch.FileChannelImpl.readInternal(FileChannelImpl.java:730) [2025-05-31T21:47:37.561Z] at sun.nio.ch.FileChannelImpl.read(FileChannelImpl.java:721) [2025-05-31T21:47:37.561Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:57) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "Thread-1291" #1753 prio=5 os_prio=0 tid=0xccd07400 nid=0xae33 waiting for monitor entry [0xd2284000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: BLOCKED (on object monitor) [2025-05-31T21:47:37.561Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2025-05-31T21:47:37.561Z] - waiting to lock <0xd4271a70> (a java.lang.Object) [2025-05-31T21:47:37.561Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "Thread-1290" #1752 prio=5 os_prio=0 tid=0xccd06c00 nid=0xae32 in Object.wait() [0xcd95e000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-05-31T21:47:37.561Z] at java.lang.Object.wait(Native Method) [2025-05-31T21:47:37.561Z] at sun.nio.ch.NativeThreadSet.signalAndWait(NativeThreadSet.java:101) [2025-05-31T21:47:37.561Z] - locked <0xd4271a38> (a sun.nio.ch.NativeThreadSet) [2025-05-31T21:47:37.561Z] at sun.nio.ch.FileChannelImpl.implCloseChannel(FileChannelImpl.java:130) [2025-05-31T21:47:37.561Z] at java.nio.channels.spi.AbstractInterruptibleChannel$1.interrupt(AbstractInterruptibleChannel.java:165) [2025-05-31T21:47:37.561Z] - locked <0xd4271a30> (a java.lang.Object) [2025-05-31T21:47:37.561Z] at java.nio.channels.spi.AbstractInterruptibleChannel.begin(AbstractInterruptibleChannel.java:173) [2025-05-31T21:47:37.561Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:305) [2025-05-31T21:47:37.561Z] - locked <0xd4271a70> (a java.lang.Object) [2025-05-31T21:47:37.561Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "AgentVMThread" #1751 prio=5 os_prio=0 tid=0xd2630800 nid=0xae31 waiting for monitor entry [0xcd1ae000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: BLOCKED (on object monitor) [2025-05-31T21:47:37.561Z] at java.nio.channels.spi.AbstractInterruptibleChannel.close(AbstractInterruptibleChannel.java:112) [2025-05-31T21:47:37.561Z] - waiting to lock <0xd4271a30> (a java.lang.Object) [2025-05-31T21:47:37.561Z] at InterruptDeadlock.main(InterruptDeadlock.java:134) [2025-05-31T21:47:37.561Z] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2025-05-31T21:47:37.561Z] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2025-05-31T21:47:37.561Z] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2025-05-31T21:47:37.561Z] at java.lang.reflect.Method.invoke(Method.java:498) [2025-05-31T21:47:37.561Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:298) [2025-05-31T21:47:37.561Z] at java.lang.Thread.run(Thread.java:750) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "InnocuousThread-425" #1446 daemon prio=5 os_prio=0 tid=0xd1f7e400 nid=0xaba1 waiting on condition [0xce8fe000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: WAITING (parking) [2025-05-31T21:47:37.561Z] at sun.misc.Unsafe.park(Native Method) [2025-05-31T21:47:37.561Z] - parking to wait for <0xde5cc4f8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2025-05-31T21:47:37.561Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2025-05-31T21:47:37.561Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2025-05-31T21:47:37.561Z] at java.lang.Thread.run(Thread.java:750) [2025-05-31T21:47:37.561Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "InnocuousThread-424" #1445 daemon prio=5 os_prio=0 tid=0xd1f42c00 nid=0xaba0 runnable [0xcdcfe000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: RUNNABLE [2025-05-31T21:47:37.561Z] at sun.nio.ch.EPoll.epollWait(Native Method) [2025-05-31T21:47:37.561Z] at sun.nio.ch.EPollPort$EventHandlerTask.poll(EPollPort.java:194) [2025-05-31T21:47:37.561Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:268) [2025-05-31T21:47:37.561Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2025-05-31T21:47:37.561Z] at java.lang.Thread.run(Thread.java:750) [2025-05-31T21:47:37.561Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "InnocuousThread-423" #1444 daemon prio=5 os_prio=0 tid=0xd1f3e800 nid=0xab9f waiting on condition [0xcf5ae000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: WAITING (parking) [2025-05-31T21:47:37.561Z] at sun.misc.Unsafe.park(Native Method) [2025-05-31T21:47:37.561Z] - parking to wait for <0xde5cc4f8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2025-05-31T21:47:37.561Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2025-05-31T21:47:37.561Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2025-05-31T21:47:37.561Z] at java.lang.Thread.run(Thread.java:750) [2025-05-31T21:47:37.561Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "InnocuousThread-422" #1443 daemon prio=5 os_prio=0 tid=0xd1f75400 nid=0xab9e waiting on condition [0xce85e000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: WAITING (parking) [2025-05-31T21:47:37.561Z] at sun.misc.Unsafe.park(Native Method) [2025-05-31T21:47:37.561Z] - parking to wait for <0xde5cc4f8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2025-05-31T21:47:37.561Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2025-05-31T21:47:37.561Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2025-05-31T21:47:37.561Z] at java.lang.Thread.run(Thread.java:750) [2025-05-31T21:47:37.561Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "InnocuousThread-421" #1442 daemon prio=5 os_prio=0 tid=0xd1f29000 nid=0xab9d waiting on condition [0xcdc5e000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: WAITING (parking) [2025-05-31T21:47:37.561Z] at sun.misc.Unsafe.park(Native Method) [2025-05-31T21:47:37.561Z] - parking to wait for <0xde5cc4f8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2025-05-31T21:47:37.561Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2025-05-31T21:47:37.561Z] at java.lang.Thread.run(Thread.java:750) [2025-05-31T21:47:37.561Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "pool-1-thread-1" #7 daemon prio=5 os_prio=0 tid=0xd2605400 nid=0xa273 waiting on condition [0xd24fe000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-05-31T21:47:37.561Z] at sun.misc.Unsafe.park(Native Method) [2025-05-31T21:47:37.561Z] - parking to wait for <0xde52c960> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [2025-05-31T21:47:37.561Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) [2025-05-31T21:47:37.561Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2025-05-31T21:47:37.561Z] at java.lang.Thread.run(Thread.java:750) [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.561Z] "Service Thread" #6 daemon prio=9 os_prio=0 tid=0xf5c8d800 nid=0xa26c runnable [0x00000000] [2025-05-31T21:47:37.561Z] java.lang.Thread.State: RUNNABLE [2025-05-31T21:47:37.561Z] [2025-05-31T21:47:37.562Z] "C1 CompilerThread0" #5 daemon prio=9 os_prio=0 tid=0xf5c8a400 nid=0xa26b waiting on condition [0x00000000] [2025-05-31T21:47:37.562Z] java.lang.Thread.State: RUNNABLE [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] "Signal Dispatcher" #4 daemon prio=9 os_prio=0 tid=0xf5c87400 nid=0xa26a runnable [0x00000000] [2025-05-31T21:47:37.562Z] java.lang.Thread.State: RUNNABLE [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] "Finalizer" #3 daemon prio=8 os_prio=0 tid=0xf5c6b800 nid=0xa269 in Object.wait() [0xd30fe000] [2025-05-31T21:47:37.562Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-31T21:47:37.562Z] at java.lang.Object.wait(Native Method) [2025-05-31T21:47:37.562Z] - waiting on <0xde52d070> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-31T21:47:37.562Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144) [2025-05-31T21:47:37.562Z] - locked <0xde52d070> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-31T21:47:37.562Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165) [2025-05-31T21:47:37.562Z] at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:188) [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] "Reference Handler" #2 daemon prio=10 os_prio=0 tid=0xf5c65000 nid=0xa268 in Object.wait() [0xd3259000] [2025-05-31T21:47:37.562Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-31T21:47:37.562Z] at java.lang.Object.wait(Native Method) [2025-05-31T21:47:37.562Z] - waiting on <0xde52d210> (a java.lang.ref.Reference$Lock) [2025-05-31T21:47:37.562Z] at java.lang.Object.wait(Object.java:502) [2025-05-31T21:47:37.562Z] at java.lang.ref.Reference.tryHandlePending(Reference.java:191) [2025-05-31T21:47:37.562Z] - locked <0xde52d210> (a java.lang.ref.Reference$Lock) [2025-05-31T21:47:37.562Z] at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153) [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] "main" #1 prio=5 os_prio=0 tid=0xf5c08c00 nid=0xa264 in Object.wait() [0xf5dbc000] [2025-05-31T21:47:37.562Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-31T21:47:37.562Z] at java.lang.Object.wait(Native Method) [2025-05-31T21:47:37.562Z] - waiting on <0xd4269c10> (a java.lang.Thread) [2025-05-31T21:47:37.562Z] at java.lang.Thread.join(Thread.java:1257) [2025-05-31T21:47:37.562Z] - locked <0xd4269c10> (a java.lang.Thread) [2025-05-31T21:47:37.562Z] at java.lang.Thread.join(Thread.java:1331) [2025-05-31T21:47:37.562Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:184) [2025-05-31T21:47:37.562Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:301) [2025-05-31T21:47:37.562Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:232) [2025-05-31T21:47:37.562Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:69) [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] "VM Thread" os_prio=0 tid=0xf5c5f800 nid=0xa267 runnable [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] "VM Periodic Task Thread" os_prio=0 tid=0xf5c8fc00 nid=0xa26d waiting on condition [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] JNI global references: 213 [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] --- Timeout information end. [2025-05-31T21:47:37.562Z] elapsed time (seconds): 960.425 [2025-05-31T21:47:37.562Z] configuration: [2025-05-31T21:47:37.562Z] Boot Layer [2025-05-31T21:47:37.562Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-31T21:47:37.562Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-31T21:47:37.562Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/lib/tools.jar [2025-05-31T21:47:37.562Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/junit.jar [2025-05-31T21:47:37.562Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/testng.jar [2025-05-31T21:47:37.562Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jcommander.jar [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] Test Layer [2025-05-31T21:47:37.562Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel [2025-05-31T21:47:37.562Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] rerun: [2025-05-31T21:47:37.562Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/scratch/1 && \ [2025-05-31T21:47:37.562Z] DISPLAY=:0 \ [2025-05-31T21:47:37.562Z] HOME=/home/jenkins \ [2025-05-31T21:47:37.562Z] LANG=C.UTF-8 \ [2025-05-31T21:47:37.562Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-31T21:47:37.562Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/bin/java \ [2025-05-31T21:47:37.562Z] -Dtest.vm.opts='-ea -esa -Xmx512m' \ [2025-05-31T21:47:37.562Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2025-05-31T21:47:37.562Z] -Dtest.compiler.opts= \ [2025-05-31T21:47:37.562Z] -Dtest.java.opts= \ [2025-05-31T21:47:37.562Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image \ [2025-05-31T21:47:37.562Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image \ [2025-05-31T21:47:37.562Z] -Dtest.timeout.factor=8.0 \ [2025-05-31T21:47:37.562Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2025-05-31T21:47:37.562Z] -Dtest.name=java/nio/channels/FileChannel/InterruptDeadlock.java \ [2025-05-31T21:47:37.562Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java \ [2025-05-31T21:47:37.562Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.562Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.562Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.562Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.562Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2025-05-31T21:47:37.562Z] -classpath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work/classes/2/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jdkbinary/j2sdk-image/lib/tools.jar:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-05-31T21:47:37.562Z] InterruptDeadlock [2025-05-31T21:47:37.562Z] [2025-05-31T21:47:37.562Z] TEST RESULT: Error. Agent error: java.lang.Exception: Agent 5 timed out with a timeout of 960 seconds; check console log for any additional details [2025-05-31T21:47:37.562Z] -------------------------------------------------- [2025-05-31T21:47:37.562Z] Test results: passed: 346; error: 1 [2025-05-31T21:47:40.963Z] Report written to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/report/html/report.html [2025-05-31T21:47:40.963Z] Results written to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_17487259942664/jdk_nio_2/work [2025-05-31T21:47:40.963Z] Error: Some tests failed or other problems occurred. [2025-05-31T21:47:40.963Z] ----------------------------------- [2025-05-31T21:47:40.963Z] jdk_nio_2_FAILED [2025-05-31T21:47:40.963Z] ----------------------------------- [2025-05-31T21:47:40.963Z] [2025-05-31T21:47:40.963Z] TEST TEARDOWN: [2025-05-31T21:47:40.963Z] Nothing to be done for teardown. [2025-05-31T21:47:40.963Z] jdk_nio_2 Finish Time: Sat May 31 21:47:40 2025 Epoch Time (ms): 1748728060487