[2023-10-24T17:17:25.248Z] Running test jdk_nio_2 ... [2023-10-24T17:17:25.248Z] =============================================== [2023-10-24T17:17:25.248Z] jdk_nio_2 Start Time: Tue Oct 24 17:17:24 2023 Epoch Time (ms): 1698167844121 [2023-10-24T17:17:25.248Z] variation: Mode1000 [2023-10-24T17:17:25.248Z] JVM_OPTIONS: [2023-10-24T17:17:25.248Z] { \ [2023-10-24T17:17:25.248Z] echo ""; echo "TEST SETUP:"; \ [2023-10-24T17:17:25.248Z] echo "Nothing to be done for setup."; \ [2023-10-24T17:17:25.248Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../TKG/output_16981663829322/jdk_nio_2"; \ [2023-10-24T17:17:25.248Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../TKG/output_16981663829322/jdk_nio_2"; \ [2023-10-24T17:17:25.248Z] echo ""; echo "TESTING:"; \ [2023-10-24T17:17:25.248Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2023-10-24T17:17:25.248Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:4 -vmoptions:"-Xmx512m " \ [2023-10-24T17:17:25.248Z] -w ""/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../TKG/output_16981663829322/jdk_nio_2"/work" \ [2023-10-24T17:17:25.248Z] -r ""/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../TKG/output_16981663829322/jdk_nio_2"/report" \ [2023-10-24T17:17:25.248Z] -jdk:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image" \ [2023-10-24T17:17:25.248Z] -exclude:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../openjdk/openjdk-jdk/jdk/test/ProblemList.txt" \ [2023-10-24T17:17:25.248Z] -exclude:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk8.txt" \ [2023-10-24T17:17:25.248Z] \ [2023-10-24T17:17:25.248Z] \ [2023-10-24T17:17:25.248Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../openjdk/openjdk-jdk/jdk/test:jdk_nio"; \ [2023-10-24T17:17:25.248Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_nio_2""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_nio_2""_FAILED"; echo "-----------------------------------"; fi; \ [2023-10-24T17:17:25.248Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-10-24T17:17:25.248Z] echo "Nothing to be done for teardown."; \ [2023-10-24T17:17:25.248Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../TKG/output_16981663829322/TestTargetResult"; [2023-10-24T17:17:25.248Z] [2023-10-24T17:17:25.248Z] TEST SETUP: [2023-10-24T17:17:25.248Z] Nothing to be done for setup. [2023-10-24T17:17:25.248Z] [2023-10-24T17:17:25.248Z] TESTING: [2023-10-24T17:17:25.248Z] Directory "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../TKG/output_16981663829322/jdk_nio_2/work" not found: creating [2023-10-24T17:17:25.248Z] Directory "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/../TKG/output_16981663829322/jdk_nio_2/report" not found: creating [2023-10-24T17:17:25.248Z] XML output with verification to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work [2023-10-24T17:34:31.475Z] -------------------------------------------------- [2023-10-24T17:34:31.475Z] TEST: java/nio/channels/FileChannel/InterruptDeadlock.java [2023-10-24T17:34:31.475Z] TEST JDK: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] ACTION: build -- Passed. Build successful [2023-10-24T17:34:31.475Z] REASON: Named class compiled on demand [2023-10-24T17:34:31.475Z] TIME: 0.039 seconds [2023-10-24T17:34:31.475Z] messages: [2023-10-24T17:34:31.475Z] command: build InterruptDeadlock [2023-10-24T17:34:31.475Z] reason: Named class compiled on demand [2023-10-24T17:34:31.475Z] Test directory: [2023-10-24T17:34:31.475Z] compile: InterruptDeadlock [2023-10-24T17:34:31.475Z] elapsed time (seconds): 0.039 [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] ACTION: compile -- Passed. Compilation successful [2023-10-24T17:34:31.475Z] REASON: .class file out of date or does not exist [2023-10-24T17:34:31.475Z] TIME: 0.039 seconds [2023-10-24T17:34:31.475Z] messages: [2023-10-24T17:34:31.475Z] command: compile -XDignore.symbol.file=true /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java [2023-10-24T17:34:31.475Z] reason: .class file out of date or does not exist [2023-10-24T17:34:31.475Z] Mode: agentvm [2023-10-24T17:34:31.475Z] Agent id: 2 [2023-10-24T17:34:31.475Z] elapsed time (seconds): 0.039 [2023-10-24T17:34:31.475Z] configuration: [2023-10-24T17:34:31.475Z] Boot Layer (javac runtime environment) [2023-10-24T17:34:31.475Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/lib/tools.jar [2023-10-24T17:34:31.475Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar [2023-10-24T17:34:31.475Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] javac compilation environment [2023-10-24T17:34:31.475Z] source path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2023-10-24T17:34:31.475Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2023-10-24T17:34:31.475Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel [2023-10-24T17:34:31.475Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/lib/tools.jar [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] rerun: [2023-10-24T17:34:31.475Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/scratch/1 && \ [2023-10-24T17:34:31.475Z] DISPLAY=:0 \ [2023-10-24T17:34:31.475Z] HOME=/home/jenkins \ [2023-10-24T17:34:31.475Z] PATH=/bin:/usr/bin:/usr/sbin \ [2023-10-24T17:34:31.475Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/bin/javac \ [2023-10-24T17:34:31.475Z] -J-ea \ [2023-10-24T17:34:31.475Z] -J-esa \ [2023-10-24T17:34:31.475Z] -J-Xmx512m \ [2023-10-24T17:34:31.475Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m' \ [2023-10-24T17:34:31.475Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2023-10-24T17:34:31.475Z] -J-Dtest.compiler.opts= \ [2023-10-24T17:34:31.475Z] -J-Dtest.java.opts= \ [2023-10-24T17:34:31.475Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image \ [2023-10-24T17:34:31.475Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image \ [2023-10-24T17:34:31.475Z] -J-Dtest.timeout.factor=8.0 \ [2023-10-24T17:34:31.475Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2023-10-24T17:34:31.475Z] -J-Dtest.name=java/nio/channels/FileChannel/InterruptDeadlock.java \ [2023-10-24T17:34:31.475Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java \ [2023-10-24T17:34:31.475Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.475Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.475Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.475Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.475Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.475Z] -d /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.475Z] -sourcepath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.475Z] -classpath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/lib/tools.jar \ [2023-10-24T17:34:31.475Z] -XDignore.symbol.file=true /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] ACTION: main -- Error. Agent error: java.lang.Exception: Agent 6 timed out with a timeout of 960 seconds; check console log for any additional details [2023-10-24T17:34:31.475Z] REASON: Assumed action based on file name: run main InterruptDeadlock [2023-10-24T17:34:31.475Z] TIME: 960.36 seconds [2023-10-24T17:34:31.475Z] messages: [2023-10-24T17:34:31.475Z] command: main InterruptDeadlock [2023-10-24T17:34:31.475Z] reason: Assumed action based on file name: run main InterruptDeadlock [2023-10-24T17:34:31.475Z] Mode: agentvm [2023-10-24T17:34:31.475Z] Agent id: 6 [2023-10-24T17:34:31.475Z] Timeout refired 960 times [2023-10-24T17:34:31.475Z] Timeout information: [2023-10-24T17:34:31.475Z] Running jstack on process 2893519 [2023-10-24T17:34:31.475Z] 2023-10-24 17:34:26 [2023-10-24T17:34:31.475Z] Full thread dump OpenJDK Client VM (25.392-b08 mixed mode): [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] "Attach Listener" #665 daemon prio=9 os_prio=0 tid=0xd2d00800 nid=0x2c423f waiting on condition [0x00000000] [2023-10-24T17:34:31.475Z] java.lang.Thread.State: RUNNABLE [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] "Thread-612" #664 prio=5 os_prio=0 tid=0xd0425800 nid=0x2c32de waiting for monitor entry [0xd03fe000] [2023-10-24T17:34:31.475Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-10-24T17:34:31.475Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2023-10-24T17:34:31.475Z] - waiting to lock <0xd3aeb5b0> (a java.lang.Object) [2023-10-24T17:34:31.475Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] "Thread-611" #663 prio=5 os_prio=0 tid=0xd0425000 nid=0x2c32dd waiting for monitor entry [0xcfffe000] [2023-10-24T17:34:31.475Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-10-24T17:34:31.475Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2023-10-24T17:34:31.475Z] - waiting to lock <0xd3aeb5b0> (a java.lang.Object) [2023-10-24T17:34:31.475Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] "Thread-610" #662 prio=5 os_prio=0 tid=0xd0424800 nid=0x2c32dc waiting for monitor entry [0xd2684000] [2023-10-24T17:34:31.475Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-10-24T17:34:31.475Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2023-10-24T17:34:31.475Z] - waiting to lock <0xd3aeb5b0> (a java.lang.Object) [2023-10-24T17:34:31.475Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-10-24T17:34:31.475Z] [2023-10-24T17:34:31.475Z] "Thread-609" #661 prio=5 os_prio=0 tid=0xd0424400 nid=0x2c32db in Object.wait() [0xd0fae000] [2023-10-24T17:34:31.475Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2023-10-24T17:34:31.475Z] at java.lang.Object.wait(Native Method) [2023-10-24T17:34:31.475Z] at sun.nio.ch.NativeThreadSet.signalAndWait(NativeThreadSet.java:101) [2023-10-24T17:34:31.475Z] - locked <0xd3aeb578> (a sun.nio.ch.NativeThreadSet) [2023-10-24T17:34:31.476Z] at sun.nio.ch.FileChannelImpl.implCloseChannel(FileChannelImpl.java:130) [2023-10-24T17:34:31.476Z] at java.nio.channels.spi.AbstractInterruptibleChannel$1.interrupt(AbstractInterruptibleChannel.java:165) [2023-10-24T17:34:31.476Z] - locked <0xd3aeb570> (a java.lang.Object) [2023-10-24T17:34:31.476Z] at java.nio.channels.spi.AbstractInterruptibleChannel.begin(AbstractInterruptibleChannel.java:173) [2023-10-24T17:34:31.476Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:305) [2023-10-24T17:34:31.476Z] - locked <0xd3aeb5b0> (a java.lang.Object) [2023-10-24T17:34:31.476Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "AgentVMThread" #648 prio=5 os_prio=0 tid=0xd2785c00 nid=0x2c32ce waiting for monitor entry [0xd07ae000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-10-24T17:34:31.476Z] at java.nio.channels.spi.AbstractInterruptibleChannel.close(AbstractInterruptibleChannel.java:112) [2023-10-24T17:34:31.476Z] - waiting to lock <0xd3aeb570> (a java.lang.Object) [2023-10-24T17:34:31.476Z] at InterruptDeadlock.main(InterruptDeadlock.java:134) [2023-10-24T17:34:31.476Z] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2023-10-24T17:34:31.476Z] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2023-10-24T17:34:31.476Z] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2023-10-24T17:34:31.476Z] at java.lang.reflect.Method.invoke(Method.java:498) [2023-10-24T17:34:31.476Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:298) [2023-10-24T17:34:31.476Z] at java.lang.Thread.run(Thread.java:750) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "InnocuousThread-5" #18 daemon prio=5 os_prio=0 tid=0xd2229400 nid=0x2c2aef waiting on condition [0xd1dbb000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: WAITING (parking) [2023-10-24T17:34:31.476Z] at sun.misc.Unsafe.park(Native Method) [2023-10-24T17:34:31.476Z] - parking to wait for <0xde5dd3b8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-10-24T17:34:31.476Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-10-24T17:34:31.476Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-10-24T17:34:31.476Z] at java.lang.Thread.run(Thread.java:750) [2023-10-24T17:34:31.476Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "InnocuousThread-4" #17 daemon prio=5 os_prio=0 tid=0xd2227c00 nid=0x2c2aed waiting on condition [0xd1e0b000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: WAITING (parking) [2023-10-24T17:34:31.476Z] at sun.misc.Unsafe.park(Native Method) [2023-10-24T17:34:31.476Z] - parking to wait for <0xde5dd3b8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-10-24T17:34:31.476Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-10-24T17:34:31.476Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-10-24T17:34:31.476Z] at java.lang.Thread.run(Thread.java:750) [2023-10-24T17:34:31.476Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "InnocuousThread-3" #16 daemon prio=5 os_prio=0 tid=0xd2226400 nid=0x2c2aeb waiting on condition [0xd1e5b000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: WAITING (parking) [2023-10-24T17:34:31.476Z] at sun.misc.Unsafe.park(Native Method) [2023-10-24T17:34:31.476Z] - parking to wait for <0xde5dd3b8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-10-24T17:34:31.476Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-10-24T17:34:31.476Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-10-24T17:34:31.476Z] at java.lang.Thread.run(Thread.java:750) [2023-10-24T17:34:31.476Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "InnocuousThread-2" #15 daemon prio=5 os_prio=0 tid=0xd2225000 nid=0x2c2ae8 runnable [0xd1eab000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: RUNNABLE [2023-10-24T17:34:31.476Z] at sun.nio.ch.EPoll.epollWait(Native Method) [2023-10-24T17:34:31.476Z] at sun.nio.ch.EPollPort$EventHandlerTask.poll(EPollPort.java:194) [2023-10-24T17:34:31.476Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:268) [2023-10-24T17:34:31.476Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-10-24T17:34:31.476Z] at java.lang.Thread.run(Thread.java:750) [2023-10-24T17:34:31.476Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "InnocuousThread-1" #14 daemon prio=5 os_prio=0 tid=0xd2224000 nid=0x2c2ae7 waiting on condition [0xd1efb000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: WAITING (parking) [2023-10-24T17:34:31.476Z] at sun.misc.Unsafe.park(Native Method) [2023-10-24T17:34:31.476Z] - parking to wait for <0xde5dd3b8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-10-24T17:34:31.476Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-10-24T17:34:31.476Z] at java.lang.Thread.run(Thread.java:750) [2023-10-24T17:34:31.476Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "pool-1-thread-1" #7 daemon prio=5 os_prio=0 tid=0xd276d000 nid=0x2c26dd waiting on condition [0xd29d7000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: TIMED_WAITING (parking) [2023-10-24T17:34:31.476Z] at sun.misc.Unsafe.park(Native Method) [2023-10-24T17:34:31.476Z] - parking to wait for <0xde574948> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [2023-10-24T17:34:31.476Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) [2023-10-24T17:34:31.476Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-10-24T17:34:31.476Z] at java.lang.Thread.run(Thread.java:750) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "Service Thread" #6 daemon prio=9 os_prio=0 tid=0xf5d88c00 nid=0x2c26db runnable [0x00000000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: RUNNABLE [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "C1 CompilerThread0" #5 daemon prio=9 os_prio=0 tid=0xf5d85400 nid=0x2c26da waiting on condition [0x00000000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: RUNNABLE [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "Signal Dispatcher" #4 daemon prio=9 os_prio=0 tid=0xf5d81800 nid=0x2c26d9 runnable [0x00000000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: RUNNABLE [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "Finalizer" #3 daemon prio=8 os_prio=0 tid=0xf5d67c00 nid=0x2c26d7 in Object.wait() [0xd3266000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: WAITING (on object monitor) [2023-10-24T17:34:31.476Z] at java.lang.Object.wait(Native Method) [2023-10-24T17:34:31.476Z] - waiting on <0xde575058> (a java.lang.ref.ReferenceQueue$Lock) [2023-10-24T17:34:31.476Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144) [2023-10-24T17:34:31.476Z] - locked <0xde575058> (a java.lang.ref.ReferenceQueue$Lock) [2023-10-24T17:34:31.476Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165) [2023-10-24T17:34:31.476Z] at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:188) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "Reference Handler" #2 daemon prio=10 os_prio=0 tid=0xf5d65000 nid=0x2c26d6 in Object.wait() [0xd32b6000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: WAITING (on object monitor) [2023-10-24T17:34:31.476Z] at java.lang.Object.wait(Native Method) [2023-10-24T17:34:31.476Z] - waiting on <0xde5751f8> (a java.lang.ref.Reference$Lock) [2023-10-24T17:34:31.476Z] at java.lang.Object.wait(Object.java:502) [2023-10-24T17:34:31.476Z] at java.lang.ref.Reference.tryHandlePending(Reference.java:191) [2023-10-24T17:34:31.476Z] - locked <0xde5751f8> (a java.lang.ref.Reference$Lock) [2023-10-24T17:34:31.476Z] at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "main" #1 prio=5 os_prio=0 tid=0xf5d08c00 nid=0x2c26d3 in Object.wait() [0xf5e52000] [2023-10-24T17:34:31.476Z] java.lang.Thread.State: WAITING (on object monitor) [2023-10-24T17:34:31.476Z] at java.lang.Object.wait(Native Method) [2023-10-24T17:34:31.476Z] - waiting on <0xd3adcf80> (a java.lang.Thread) [2023-10-24T17:34:31.476Z] at java.lang.Thread.join(Thread.java:1257) [2023-10-24T17:34:31.476Z] - locked <0xd3adcf80> (a java.lang.Thread) [2023-10-24T17:34:31.476Z] at java.lang.Thread.join(Thread.java:1331) [2023-10-24T17:34:31.476Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:184) [2023-10-24T17:34:31.476Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:301) [2023-10-24T17:34:31.476Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:232) [2023-10-24T17:34:31.476Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:69) [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "VM Thread" os_prio=0 tid=0xf5d5f400 nid=0x2c26d5 runnable [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] "VM Periodic Task Thread" os_prio=0 tid=0xf5d8a800 nid=0x2c26dc waiting on condition [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] JNI global references: 231 [2023-10-24T17:34:31.476Z] [2023-10-24T17:34:31.476Z] --- Timeout information end. [2023-10-24T17:34:31.476Z] elapsed time (seconds): 960.36 [2023-10-24T17:34:31.476Z] configuration: [2023-10-24T17:34:31.476Z] Boot Layer [2023-10-24T17:34:31.476Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar [2023-10-24T17:34:31.476Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar [2023-10-24T17:34:31.477Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/lib/tools.jar [2023-10-24T17:34:31.477Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/junit.jar [2023-10-24T17:34:31.477Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/testng.jar [2023-10-24T17:34:31.477Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/jcommander.jar [2023-10-24T17:34:31.477Z] [2023-10-24T17:34:31.477Z] Test Layer [2023-10-24T17:34:31.477Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel [2023-10-24T17:34:31.477Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2023-10-24T17:34:31.477Z] [2023-10-24T17:34:31.477Z] rerun: [2023-10-24T17:34:31.477Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/scratch/1 && \ [2023-10-24T17:34:31.477Z] DISPLAY=:0 \ [2023-10-24T17:34:31.477Z] HOME=/home/jenkins \ [2023-10-24T17:34:31.477Z] PATH=/bin:/usr/bin:/usr/sbin \ [2023-10-24T17:34:31.477Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/bin/java \ [2023-10-24T17:34:31.477Z] -Dtest.vm.opts='-ea -esa -Xmx512m' \ [2023-10-24T17:34:31.477Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2023-10-24T17:34:31.477Z] -Dtest.compiler.opts= \ [2023-10-24T17:34:31.477Z] -Dtest.java.opts= \ [2023-10-24T17:34:31.477Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image \ [2023-10-24T17:34:31.477Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image \ [2023-10-24T17:34:31.477Z] -Dtest.timeout.factor=8.0 \ [2023-10-24T17:34:31.477Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2023-10-24T17:34:31.477Z] -Dtest.name=java/nio/channels/FileChannel/InterruptDeadlock.java \ [2023-10-24T17:34:31.477Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel/InterruptDeadlock.java \ [2023-10-24T17:34:31.477Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.477Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.477Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.477Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.477Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-10-24T17:34:31.477Z] -classpath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work/classes/1/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/openjdkbinary/j2sdk-image/lib/tools.jar:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2023-10-24T17:34:31.477Z] InterruptDeadlock [2023-10-24T17:34:31.477Z] [2023-10-24T17:34:31.477Z] TEST RESULT: Error. Agent error: java.lang.Exception: Agent 6 timed out with a timeout of 960 seconds; check console log for any additional details [2023-10-24T17:34:31.477Z] -------------------------------------------------- [2023-10-24T17:34:31.477Z] Test results: passed: 345; error: 1 [2023-10-24T17:34:35.918Z] Report written to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/report/html/report.html [2023-10-24T17:34:35.918Z] Results written to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_2/aqa-tests/TKG/output_16981663829322/jdk_nio_2/work [2023-10-24T17:34:35.918Z] Error: Some tests failed or other problems occurred. [2023-10-24T17:34:35.918Z] ----------------------------------- [2023-10-24T17:34:35.918Z] jdk_nio_2_FAILED [2023-10-24T17:34:35.918Z] ----------------------------------- [2023-10-24T17:34:35.918Z] [2023-10-24T17:34:35.918Z] TEST TEARDOWN: [2023-10-24T17:34:35.918Z] Nothing to be done for teardown. [2023-10-24T17:34:35.918Z] jdk_nio_2 Finish Time: Tue Oct 24 17:34:35 2023 Epoch Time (ms): 1698168875546