Test Results Summary Service

jdk_nio_2

[2023-07-25T11:37:11.788Z] Running test jdk_nio_2 ... [2023-07-25T11:37:11.788Z] =============================================== [2023-07-25T11:37:11.788Z] jdk_nio_2 Start Time: Tue Jul 25 11:37:11 2023 Epoch Time (ms): 1690285031419 [2023-07-25T11:37:11.788Z] variation: Mode1000 [2023-07-25T11:37:11.788Z] JVM_OPTIONS: [2023-07-25T11:37:11.788Z] { \ [2023-07-25T11:37:11.788Z] echo ""; echo "TEST SETUP:"; \ [2023-07-25T11:37:11.788Z] echo "Nothing to be done for setup."; \ [2023-07-25T11:37:11.788Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_16902820676409/jdk_nio_2"; \ [2023-07-25T11:37:11.788Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_16902820676409/jdk_nio_2"; \ [2023-07-25T11:37:11.788Z] echo ""; echo "TESTING:"; \ [2023-07-25T11:37:11.788Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/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" \ [2023-07-25T11:37:11.788Z] -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-07-25T11:37:11.788Z] -w ""/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_16902820676409/jdk_nio_2"/work" \ [2023-07-25T11:37:11.788Z] -r ""/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_16902820676409/jdk_nio_2"/report" \ [2023-07-25T11:37:11.788Z] -jdk:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image" \ [2023-07-25T11:37:11.788Z] -exclude:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/jdk/test/ProblemList.txt" \ [2023-07-25T11:37:11.788Z] -exclude:"/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk8.txt" \ [2023-07-25T11:37:11.788Z] \ [2023-07-25T11:37:11.788Z] \ [2023-07-25T11:37:11.788Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/jdk/test:jdk_nio"; \ [2023-07-25T11:37:11.788Z] 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; \ [2023-07-25T11:37:11.788Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-07-25T11:37:11.788Z] echo "Nothing to be done for teardown."; \ [2023-07-25T11:37:11.788Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_16902820676409/TestTargetResult"; [2023-07-25T11:37:11.788Z] [2023-07-25T11:37:11.788Z] TEST SETUP: [2023-07-25T11:37:11.788Z] Nothing to be done for setup. [2023-07-25T11:37:11.788Z] [2023-07-25T11:37:11.788Z] TESTING: [2023-07-25T11:37:12.551Z] Directory "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_16902820676409/jdk_nio_2/work" not found: creating [2023-07-25T11:37:12.551Z] Directory "/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/../TKG/output_16902820676409/jdk_nio_2/report" not found: creating [2023-07-25T11:37:12.551Z] XML output with verification to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work [2023-07-25T11:54:18.249Z] -------------------------------------------------- [2023-07-25T11:54:18.249Z] TEST: java/nio/channels/FileChannel/ClosedByInterrupt.java [2023-07-25T11:54:18.249Z] TEST JDK: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image [2023-07-25T11:54:18.249Z] [2023-07-25T11:54:18.249Z] ACTION: build -- Passed. Build successful [2023-07-25T11:54:18.249Z] REASON: Named class compiled on demand [2023-07-25T11:54:18.249Z] TIME: 0.074 seconds [2023-07-25T11:54:18.249Z] messages: [2023-07-25T11:54:18.249Z] command: build ClosedByInterrupt [2023-07-25T11:54:18.249Z] reason: Named class compiled on demand [2023-07-25T11:54:18.249Z] Test directory: [2023-07-25T11:54:18.249Z] compile: ClosedByInterrupt [2023-07-25T11:54:18.249Z] elapsed time (seconds): 0.074 [2023-07-25T11:54:18.249Z] [2023-07-25T11:54:18.249Z] ACTION: compile -- Passed. Compilation successful [2023-07-25T11:54:18.249Z] REASON: .class file out of date or does not exist [2023-07-25T11:54:18.249Z] TIME: 0.074 seconds [2023-07-25T11:54:18.249Z] messages: [2023-07-25T11:54:18.249Z] 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/ClosedByInterrupt.java [2023-07-25T11:54:18.249Z] reason: .class file out of date or does not exist [2023-07-25T11:54:18.249Z] Mode: agentvm [2023-07-25T11:54:18.249Z] Agent id: 1 [2023-07-25T11:54:18.249Z] elapsed time (seconds): 0.074 [2023-07-25T11:54:18.249Z] configuration: [2023-07-25T11:54:18.249Z] Boot Layer (javac runtime environment) [2023-07-25T11:54:18.249Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar [2023-07-25T11:54:18.250Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2023-07-25T11:54:18.250Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2023-07-25T11:54:18.250Z] [2023-07-25T11:54:18.250Z] javac compilation environment [2023-07-25T11:54:18.250Z] 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 [2023-07-25T11:54:18.250Z] 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 [2023-07-25T11:54:18.250Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel [2023-07-25T11:54:18.250Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar [2023-07-25T11:54:18.250Z] [2023-07-25T11:54:18.250Z] rerun: [2023-07-25T11:54:18.250Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/scratch/3 && \ [2023-07-25T11:54:18.250Z] DISPLAY=:0 \ [2023-07-25T11:54:18.250Z] HOME=/home/jenkins \ [2023-07-25T11:54:18.250Z] PATH=/bin:/usr/bin:/usr/sbin \ [2023-07-25T11:54:18.250Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/bin/javac \ [2023-07-25T11:54:18.250Z] -J-ea \ [2023-07-25T11:54:18.250Z] -J-esa \ [2023-07-25T11:54:18.250Z] -J-Xmx512m \ [2023-07-25T11:54:18.250Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m' \ [2023-07-25T11:54:18.250Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2023-07-25T11:54:18.250Z] -J-Dtest.compiler.opts= \ [2023-07-25T11:54:18.250Z] -J-Dtest.java.opts= \ [2023-07-25T11:54:18.250Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.250Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.250Z] -J-Dtest.timeout.factor=8.0 \ [2023-07-25T11:54:18.250Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2023-07-25T11:54:18.250Z] -J-Dtest.name=java/nio/channels/FileChannel/ClosedByInterrupt.java \ [2023-07-25T11:54:18.250Z] -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/ClosedByInterrupt.java \ [2023-07-25T11:54:18.250Z] -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 \ [2023-07-25T11:54:18.250Z] -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 \ [2023-07-25T11:54:18.250Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.250Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.250Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/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 \ [2023-07-25T11:54:18.250Z] -d /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.250Z] -sourcepath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.250Z] -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_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar \ [2023-07-25T11:54:18.250Z] -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/ClosedByInterrupt.java [2023-07-25T11:54:18.250Z] [2023-07-25T11:54:18.250Z] ACTION: main -- Error. Agent error: java.lang.Exception: Agent 8 timed out with a timeout of 960 seconds; check console log for any additional details [2023-07-25T11:54:18.250Z] REASON: Assumed action based on file name: run main ClosedByInterrupt [2023-07-25T11:54:18.250Z] TIME: 960.357 seconds [2023-07-25T11:54:18.250Z] messages: [2023-07-25T11:54:18.250Z] command: main ClosedByInterrupt [2023-07-25T11:54:18.250Z] reason: Assumed action based on file name: run main ClosedByInterrupt [2023-07-25T11:54:18.250Z] Mode: agentvm [2023-07-25T11:54:18.250Z] Agent id: 8 [2023-07-25T11:54:18.250Z] Timeout refired 960 times [2023-07-25T11:54:18.250Z] Timeout information: [2023-07-25T11:54:18.250Z] Running jstack on process 82587 [2023-07-25T11:54:18.250Z] 2023-07-25 11:54:07 [2023-07-25T11:54:18.250Z] Full thread dump OpenJDK Client VM (25.382-b05 mixed mode): [2023-07-25T11:54:18.250Z] [2023-07-25T11:54:18.250Z] "Attach Listener" #1471 daemon prio=9 os_prio=0 tid=0xd2c00800 nid=0x15cb7 waiting on condition [0x00000000] [2023-07-25T11:54:18.250Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.250Z] [2023-07-25T11:54:18.250Z] "Thread-996" #1466 prio=5 os_prio=0 tid=0xd1f55400 nid=0x14dca waiting for monitor entry [0xd04fe000] [2023-07-25T11:54:18.250Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-07-25T11:54:18.250Z] at java.lang.Thread.blockedOn(Thread.java:241) [2023-07-25T11:54:18.250Z] - waiting to lock <0xd3a71f68> (a java.lang.Object) [2023-07-25T11:54:18.250Z] at java.lang.System$2.blockedOn(System.java:1267) [2023-07-25T11:54:18.250Z] at java.nio.channels.spi.AbstractInterruptibleChannel.blockedOn(AbstractInterruptibleChannel.java:211) [2023-07-25T11:54:18.250Z] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:198) [2023-07-25T11:54:18.250Z] at sun.nio.ch.FileChannelImpl.writeInternal(FileChannelImpl.java:777) [2023-07-25T11:54:18.250Z] at sun.nio.ch.FileChannelImpl.write(FileChannelImpl.java:758) [2023-07-25T11:54:18.250Z] at ClosedByInterrupt$ReaderWriter.run(ClosedByInterrupt.java:130) [2023-07-25T11:54:18.250Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.250Z] [2023-07-25T11:54:18.250Z] "AgentVMThread" #1455 prio=5 os_prio=0 tid=0xd24afc00 nid=0x14db0 in Object.wait() [0xd2284000] [2023-07-25T11:54:18.250Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2023-07-25T11:54:18.250Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.250Z] at sun.nio.ch.NativeThreadSet.signalAndWait(NativeThreadSet.java:101) [2023-07-25T11:54:18.250Z] - locked <0xd3a71d78> (a sun.nio.ch.NativeThreadSet) [2023-07-25T11:54:18.250Z] at sun.nio.ch.FileChannelImpl.implCloseChannel(FileChannelImpl.java:130) [2023-07-25T11:54:18.250Z] at java.nio.channels.spi.AbstractInterruptibleChannel$1.interrupt(AbstractInterruptibleChannel.java:165) [2023-07-25T11:54:18.250Z] - locked <0xd3a71d70> (a java.lang.Object) [2023-07-25T11:54:18.250Z] at java.lang.Thread.interrupt(Thread.java:927) [2023-07-25T11:54:18.250Z] - locked <0xd3a71f68> (a java.lang.Object) [2023-07-25T11:54:18.250Z] at ClosedByInterrupt.test(ClosedByInterrupt.java:92) [2023-07-25T11:54:18.250Z] at ClosedByInterrupt.main(ClosedByInterrupt.java:59) [2023-07-25T11:54:18.250Z] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2023-07-25T11:54:18.250Z] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2023-07-25T11:54:18.250Z] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2023-07-25T11:54:18.251Z] at java.lang.reflect.Method.invoke(Method.java:498) [2023-07-25T11:54:18.251Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:298) [2023-07-25T11:54:18.251Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "InnocuousThread-425" #1421 daemon prio=5 os_prio=0 tid=0xd1f38000 nid=0x14baf waiting on condition [0xd1dae000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.251Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.251Z] - parking to wait for <0xde44d108> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.251Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.251Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.251Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.251Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "InnocuousThread-424" #1420 daemon prio=5 os_prio=0 tid=0xd1f3f000 nid=0x14bae runnable [0xd1d5e000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.251Z] at sun.nio.ch.EPoll.epollWait(Native Method) [2023-07-25T11:54:18.251Z] at sun.nio.ch.EPollPort$EventHandlerTask.poll(EPollPort.java:194) [2023-07-25T11:54:18.251Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:268) [2023-07-25T11:54:18.251Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.251Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.251Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "InnocuousThread-423" #1419 daemon prio=5 os_prio=0 tid=0xd1f39c00 nid=0x14bad waiting on condition [0xd19ae000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.251Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.251Z] - parking to wait for <0xde44d108> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.251Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.251Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.251Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.251Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "InnocuousThread-422" #1418 daemon prio=5 os_prio=0 tid=0xd1f35400 nid=0x14bac waiting on condition [0xd195e000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.251Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.251Z] - parking to wait for <0xde44d108> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.251Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.251Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.251Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.251Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "InnocuousThread-421" #1417 daemon prio=5 os_prio=0 tid=0xd1f36800 nid=0x14bab waiting on condition [0xd15ae000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.251Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.251Z] - parking to wait for <0xde44d108> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.251Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.251Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.251Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "pool-1-thread-1" #7 daemon prio=5 os_prio=0 tid=0xd2478400 nid=0x142c0 waiting on condition [0xd25fe000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: TIMED_WAITING (parking) [2023-07-25T11:54:18.251Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.251Z] - parking to wait for <0xde38f718> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [2023-07-25T11:54:18.251Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) [2023-07-25T11:54:18.251Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.251Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "Service Thread" #6 daemon prio=9 os_prio=0 tid=0xf5a88c00 nid=0x142ac runnable [0x00000000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "C1 CompilerThread0" #5 daemon prio=9 os_prio=0 tid=0xf5a85400 nid=0x142ab waiting on condition [0x00000000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "Signal Dispatcher" #4 daemon prio=9 os_prio=0 tid=0xf5a81800 nid=0x142aa runnable [0x00000000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.251Z] [2023-07-25T11:54:18.251Z] "Finalizer" #3 daemon prio=8 os_prio=0 tid=0xf5a67c00 nid=0x142a7 in Object.wait() [0xd2eae000] [2023-07-25T11:54:18.251Z] java.lang.Thread.State: WAITING (on object monitor) [2023-07-25T11:54:18.251Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.251Z] - waiting on <0xde38fe28> (a java.lang.ref.ReferenceQueue$Lock) [2023-07-25T11:54:18.251Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144) [2023-07-25T11:54:18.252Z] - locked <0xde38fe28> (a java.lang.ref.ReferenceQueue$Lock) [2023-07-25T11:54:18.252Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165) [2023-07-25T11:54:18.252Z] at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:188) [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] "Reference Handler" #2 daemon prio=10 os_prio=0 tid=0xf5a65000 nid=0x142a5 in Object.wait() [0xd2efe000] [2023-07-25T11:54:18.252Z] java.lang.Thread.State: WAITING (on object monitor) [2023-07-25T11:54:18.252Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.252Z] - waiting on <0xde38ffc8> (a java.lang.ref.Reference$Lock) [2023-07-25T11:54:18.252Z] at java.lang.Object.wait(Object.java:502) [2023-07-25T11:54:18.252Z] at java.lang.ref.Reference.tryHandlePending(Reference.java:191) [2023-07-25T11:54:18.252Z] - locked <0xde38ffc8> (a java.lang.ref.Reference$Lock) [2023-07-25T11:54:18.252Z] at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153) [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] "main" #1 prio=5 os_prio=0 tid=0xf5a08c00 nid=0x1429e in Object.wait() [0xf5b87000] [2023-07-25T11:54:18.252Z] java.lang.Thread.State: WAITING (on object monitor) [2023-07-25T11:54:18.252Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.252Z] - waiting on <0xd3952628> (a java.lang.Thread) [2023-07-25T11:54:18.252Z] at java.lang.Thread.join(Thread.java:1257) [2023-07-25T11:54:18.252Z] - locked <0xd3952628> (a java.lang.Thread) [2023-07-25T11:54:18.252Z] at java.lang.Thread.join(Thread.java:1331) [2023-07-25T11:54:18.252Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:184) [2023-07-25T11:54:18.252Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:301) [2023-07-25T11:54:18.252Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:232) [2023-07-25T11:54:18.252Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:69) [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] "VM Thread" os_prio=0 tid=0xf5a5f400 nid=0x142a4 runnable [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] "VM Periodic Task Thread" os_prio=0 tid=0xf5a8a800 nid=0x142ad waiting on condition [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] JNI global references: 219 [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] --- Timeout information end. [2023-07-25T11:54:18.252Z] elapsed time (seconds): 960.357 [2023-07-25T11:54:18.252Z] configuration: [2023-07-25T11:54:18.252Z] Boot Layer [2023-07-25T11:54:18.252Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2023-07-25T11:54:18.252Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2023-07-25T11:54:18.252Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar [2023-07-25T11:54:18.252Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/junit.jar [2023-07-25T11:54:18.252Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/testng.jar [2023-07-25T11:54:18.252Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jcommander.jar [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] Test Layer [2023-07-25T11:54:18.252Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel [2023-07-25T11:54:18.252Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] rerun: [2023-07-25T11:54:18.252Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/scratch/3 && \ [2023-07-25T11:54:18.252Z] DISPLAY=:0 \ [2023-07-25T11:54:18.252Z] HOME=/home/jenkins \ [2023-07-25T11:54:18.252Z] PATH=/bin:/usr/bin:/usr/sbin \ [2023-07-25T11:54:18.252Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/bin/java \ [2023-07-25T11:54:18.252Z] -Dtest.vm.opts='-ea -esa -Xmx512m' \ [2023-07-25T11:54:18.252Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2023-07-25T11:54:18.252Z] -Dtest.compiler.opts= \ [2023-07-25T11:54:18.252Z] -Dtest.java.opts= \ [2023-07-25T11:54:18.252Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.252Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.252Z] -Dtest.timeout.factor=8.0 \ [2023-07-25T11:54:18.252Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2023-07-25T11:54:18.252Z] -Dtest.name=java/nio/channels/FileChannel/ClosedByInterrupt.java \ [2023-07-25T11:54:18.252Z] -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/ClosedByInterrupt.java \ [2023-07-25T11:54:18.252Z] -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 \ [2023-07-25T11:54:18.252Z] -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 \ [2023-07-25T11:54:18.252Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.252Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.252Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/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 \ [2023-07-25T11:54:18.252Z] -classpath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/3/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/openjdkbinary/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 \ [2023-07-25T11:54:18.252Z] ClosedByInterrupt [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] TEST RESULT: Error. Agent error: java.lang.Exception: Agent 8 timed out with a timeout of 960 seconds; check console log for any additional details [2023-07-25T11:54:18.252Z] -------------------------------------------------- [2023-07-25T11:54:18.252Z] TEST: java/nio/channels/FileChannel/InterruptDeadlock.java [2023-07-25T11:54:18.252Z] TEST JDK: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] ACTION: build -- Passed. Build successful [2023-07-25T11:54:18.252Z] REASON: Named class compiled on demand [2023-07-25T11:54:18.252Z] TIME: 0.031 seconds [2023-07-25T11:54:18.252Z] messages: [2023-07-25T11:54:18.252Z] command: build InterruptDeadlock [2023-07-25T11:54:18.252Z] reason: Named class compiled on demand [2023-07-25T11:54:18.252Z] Test directory: [2023-07-25T11:54:18.252Z] compile: InterruptDeadlock [2023-07-25T11:54:18.252Z] elapsed time (seconds): 0.031 [2023-07-25T11:54:18.252Z] [2023-07-25T11:54:18.252Z] ACTION: compile -- Passed. Compilation successful [2023-07-25T11:54:18.252Z] REASON: .class file out of date or does not exist [2023-07-25T11:54:18.252Z] TIME: 0.031 seconds [2023-07-25T11:54:18.252Z] messages: [2023-07-25T11:54:18.253Z] 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 [2023-07-25T11:54:18.253Z] reason: .class file out of date or does not exist [2023-07-25T11:54:18.253Z] Mode: agentvm [2023-07-25T11:54:18.253Z] Agent id: 4 [2023-07-25T11:54:18.253Z] elapsed time (seconds): 0.031 [2023-07-25T11:54:18.253Z] configuration: [2023-07-25T11:54:18.253Z] Boot Layer (javac runtime environment) [2023-07-25T11:54:18.253Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar [2023-07-25T11:54:18.253Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2023-07-25T11:54:18.253Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] javac compilation environment [2023-07-25T11:54:18.253Z] 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 [2023-07-25T11:54:18.253Z] 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 [2023-07-25T11:54:18.253Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel [2023-07-25T11:54:18.253Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] rerun: [2023-07-25T11:54:18.253Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/scratch/2 && \ [2023-07-25T11:54:18.253Z] DISPLAY=:0 \ [2023-07-25T11:54:18.253Z] HOME=/home/jenkins \ [2023-07-25T11:54:18.253Z] PATH=/bin:/usr/bin:/usr/sbin \ [2023-07-25T11:54:18.253Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/bin/javac \ [2023-07-25T11:54:18.253Z] -J-ea \ [2023-07-25T11:54:18.253Z] -J-esa \ [2023-07-25T11:54:18.253Z] -J-Xmx512m \ [2023-07-25T11:54:18.253Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m' \ [2023-07-25T11:54:18.253Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2023-07-25T11:54:18.253Z] -J-Dtest.compiler.opts= \ [2023-07-25T11:54:18.253Z] -J-Dtest.java.opts= \ [2023-07-25T11:54:18.253Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.253Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.253Z] -J-Dtest.timeout.factor=8.0 \ [2023-07-25T11:54:18.253Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2023-07-25T11:54:18.253Z] -J-Dtest.name=java/nio/channels/FileChannel/InterruptDeadlock.java \ [2023-07-25T11:54:18.253Z] -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 \ [2023-07-25T11:54:18.253Z] -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 \ [2023-07-25T11:54:18.253Z] -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 \ [2023-07-25T11:54:18.253Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.253Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.253Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/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 \ [2023-07-25T11:54:18.253Z] -d /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.253Z] -sourcepath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.253Z] -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_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel:/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar \ [2023-07-25T11:54:18.253Z] -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 [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] ACTION: main -- Error. Agent error: java.lang.Exception: Agent 7 timed out with a timeout of 960 seconds; check console log for any additional details [2023-07-25T11:54:18.253Z] REASON: Assumed action based on file name: run main InterruptDeadlock [2023-07-25T11:54:18.253Z] TIME: 960.356 seconds [2023-07-25T11:54:18.253Z] messages: [2023-07-25T11:54:18.253Z] command: main InterruptDeadlock [2023-07-25T11:54:18.253Z] reason: Assumed action based on file name: run main InterruptDeadlock [2023-07-25T11:54:18.253Z] Mode: agentvm [2023-07-25T11:54:18.253Z] Agent id: 7 [2023-07-25T11:54:18.253Z] Timeout refired 960 times [2023-07-25T11:54:18.253Z] Timeout information: [2023-07-25T11:54:18.253Z] Running jstack on process 82554 [2023-07-25T11:54:18.253Z] 2023-07-25 11:54:13 [2023-07-25T11:54:18.253Z] Full thread dump OpenJDK Client VM (25.382-b05 mixed mode): [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] "Attach Listener" #376 daemon prio=9 os_prio=0 tid=0xd2a00800 nid=0x15cc6 waiting on condition [0x00000000] [2023-07-25T11:54:18.253Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] "Thread-87" #375 prio=5 os_prio=0 tid=0xbc207c00 nid=0x14e30 waiting for monitor entry [0xbc45e000] [2023-07-25T11:54:18.253Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-07-25T11:54:18.253Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2023-07-25T11:54:18.253Z] - waiting to lock <0xd3a80a70> (a java.lang.Object) [2023-07-25T11:54:18.253Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] "Thread-86" #374 prio=5 os_prio=0 tid=0xbc207000 nid=0x14e2f waiting for monitor entry [0xd1d5e000] [2023-07-25T11:54:18.253Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-07-25T11:54:18.253Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2023-07-25T11:54:18.253Z] - waiting to lock <0xd3a80a70> (a java.lang.Object) [2023-07-25T11:54:18.253Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] "Thread-85" #373 prio=5 os_prio=0 tid=0xbc206c00 nid=0x14e2e waiting for monitor entry [0xbc0fe000] [2023-07-25T11:54:18.253Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-07-25T11:54:18.253Z] at java.lang.Thread.blockedOn(Thread.java:241) [2023-07-25T11:54:18.253Z] - waiting to lock <0xd3a80e88> (a java.lang.Object) [2023-07-25T11:54:18.253Z] at java.lang.System$2.blockedOn(System.java:1267) [2023-07-25T11:54:18.253Z] at java.nio.channels.spi.AbstractInterruptibleChannel.blockedOn(AbstractInterruptibleChannel.java:211) [2023-07-25T11:54:18.253Z] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:198) [2023-07-25T11:54:18.253Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:315) [2023-07-25T11:54:18.253Z] - locked <0xd3a80a70> (a java.lang.Object) [2023-07-25T11:54:18.253Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-07-25T11:54:18.253Z] [2023-07-25T11:54:18.253Z] "Thread-84" #372 prio=5 os_prio=0 tid=0xbc206400 nid=0x14e2d waiting for monitor entry [0xd1dfe000] [2023-07-25T11:54:18.253Z] java.lang.Thread.State: BLOCKED (on object monitor) [2023-07-25T11:54:18.253Z] at sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:301) [2023-07-25T11:54:18.254Z] - waiting to lock <0xd3a80a70> (a java.lang.Object) [2023-07-25T11:54:18.254Z] at InterruptDeadlock$Reader.run(InterruptDeadlock.java:61) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.254Z] "AgentVMThread" #295 prio=5 os_prio=0 tid=0xd2684c00 nid=0x14dde in Object.wait() [0xbc4ae000] [2023-07-25T11:54:18.254Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2023-07-25T11:54:18.254Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.254Z] at sun.nio.ch.NativeThreadSet.signalAndWait(NativeThreadSet.java:101) [2023-07-25T11:54:18.254Z] - locked <0xd3a80a38> (a sun.nio.ch.NativeThreadSet) [2023-07-25T11:54:18.254Z] at sun.nio.ch.FileChannelImpl.implCloseChannel(FileChannelImpl.java:130) [2023-07-25T11:54:18.254Z] at java.nio.channels.spi.AbstractInterruptibleChannel$1.interrupt(AbstractInterruptibleChannel.java:165) [2023-07-25T11:54:18.254Z] - locked <0xd3a80a30> (a java.lang.Object) [2023-07-25T11:54:18.254Z] at java.lang.Thread.interrupt(Thread.java:927) [2023-07-25T11:54:18.254Z] - locked <0xd3a80e88> (a java.lang.Object) [2023-07-25T11:54:18.254Z] at InterruptDeadlock.main(InterruptDeadlock.java:110) [2023-07-25T11:54:18.254Z] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2023-07-25T11:54:18.254Z] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2023-07-25T11:54:18.254Z] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2023-07-25T11:54:18.254Z] at java.lang.reflect.Method.invoke(Method.java:498) [2023-07-25T11:54:18.254Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:298) [2023-07-25T11:54:18.254Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.254Z] "InnocuousThread-5" #17 daemon prio=5 os_prio=0 tid=0xd1c0bc00 nid=0x14a4c waiting on condition [0xd15fe000] [2023-07-25T11:54:18.254Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.254Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.254Z] - parking to wait for <0xde523f90> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.254Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.254Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.254Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.254Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.254Z] "InnocuousThread-4" #16 daemon prio=5 os_prio=0 tid=0xd1c0a400 nid=0x14a4b runnable [0xd195e000] [2023-07-25T11:54:18.254Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.254Z] at sun.nio.ch.EPoll.epollWait(Native Method) [2023-07-25T11:54:18.254Z] at sun.nio.ch.EPollPort$EventHandlerTask.poll(EPollPort.java:194) [2023-07-25T11:54:18.254Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:268) [2023-07-25T11:54:18.254Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.254Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.254Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.254Z] "InnocuousThread-3" #15 daemon prio=5 os_prio=0 tid=0xd1c09000 nid=0x14a4a waiting on condition [0xd19ae000] [2023-07-25T11:54:18.254Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.254Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.254Z] - parking to wait for <0xde523f90> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.254Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.254Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.254Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.254Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.254Z] "InnocuousThread-2" #14 daemon prio=5 os_prio=0 tid=0xd1c08000 nid=0x14a49 waiting on condition [0xd19fe000] [2023-07-25T11:54:18.254Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.254Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.254Z] - parking to wait for <0xde523f90> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.254Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.254Z] at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.254Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.254Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.254Z] "InnocuousThread-1" #13 daemon prio=5 os_prio=0 tid=0xd1c07800 nid=0x14a48 waiting on condition [0xd2284000] [2023-07-25T11:54:18.254Z] java.lang.Thread.State: WAITING (parking) [2023-07-25T11:54:18.254Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.254Z] - parking to wait for <0xde523f90> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403) [2023-07-25T11:54:18.254Z] at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:262) [2023-07-25T11:54:18.254Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.254Z] at sun.misc.InnocuousThread.run(InnocuousThread.java:112) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.254Z] "pool-1-thread-1" #7 daemon prio=5 os_prio=0 tid=0xd2681000 nid=0x14287 waiting on condition [0xd24fe000] [2023-07-25T11:54:18.254Z] java.lang.Thread.State: TIMED_WAITING (parking) [2023-07-25T11:54:18.254Z] at sun.misc.Unsafe.park(Native Method) [2023-07-25T11:54:18.254Z] - parking to wait for <0xde3c9ee0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [2023-07-25T11:54:18.254Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) [2023-07-25T11:54:18.254Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [2023-07-25T11:54:18.254Z] at java.lang.Thread.run(Thread.java:750) [2023-07-25T11:54:18.254Z] [2023-07-25T11:54:18.255Z] "Service Thread" #6 daemon prio=9 os_prio=0 tid=0xf5a88800 nid=0x14285 runnable [0x00000000] [2023-07-25T11:54:18.255Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] "C1 CompilerThread0" #5 daemon prio=9 os_prio=0 tid=0xf5a85400 nid=0x14284 waiting on condition [0x00000000] [2023-07-25T11:54:18.255Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] "Signal Dispatcher" #4 daemon prio=9 os_prio=0 tid=0xf5a81800 nid=0x14283 runnable [0x00000000] [2023-07-25T11:54:18.255Z] java.lang.Thread.State: RUNNABLE [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] "Finalizer" #3 daemon prio=8 os_prio=0 tid=0xf5a67c00 nid=0x14281 in Object.wait() [0xd2f65000] [2023-07-25T11:54:18.255Z] java.lang.Thread.State: WAITING (on object monitor) [2023-07-25T11:54:18.255Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.255Z] - waiting on <0xde3ca5f0> (a java.lang.ref.ReferenceQueue$Lock) [2023-07-25T11:54:18.255Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144) [2023-07-25T11:54:18.255Z] - locked <0xde3ca5f0> (a java.lang.ref.ReferenceQueue$Lock) [2023-07-25T11:54:18.255Z] at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165) [2023-07-25T11:54:18.255Z] at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:188) [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] "Reference Handler" #2 daemon prio=10 os_prio=0 tid=0xf5a65000 nid=0x14280 in Object.wait() [0xd2fb5000] [2023-07-25T11:54:18.255Z] java.lang.Thread.State: WAITING (on object monitor) [2023-07-25T11:54:18.255Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.255Z] - waiting on <0xde3ca790> (a java.lang.ref.Reference$Lock) [2023-07-25T11:54:18.255Z] at java.lang.Object.wait(Object.java:502) [2023-07-25T11:54:18.255Z] at java.lang.ref.Reference.tryHandlePending(Reference.java:191) [2023-07-25T11:54:18.255Z] - locked <0xde3ca790> (a java.lang.ref.Reference$Lock) [2023-07-25T11:54:18.255Z] at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153) [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] "main" #1 prio=5 os_prio=0 tid=0xf5a08c00 nid=0x1427e in Object.wait() [0xf5b66000] [2023-07-25T11:54:18.255Z] java.lang.Thread.State: WAITING (on object monitor) [2023-07-25T11:54:18.255Z] at java.lang.Object.wait(Native Method) [2023-07-25T11:54:18.255Z] - waiting on <0xd39c2140> (a java.lang.Thread) [2023-07-25T11:54:18.255Z] at java.lang.Thread.join(Thread.java:1257) [2023-07-25T11:54:18.255Z] - locked <0xd39c2140> (a java.lang.Thread) [2023-07-25T11:54:18.255Z] at java.lang.Thread.join(Thread.java:1331) [2023-07-25T11:54:18.255Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:184) [2023-07-25T11:54:18.255Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:301) [2023-07-25T11:54:18.255Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:232) [2023-07-25T11:54:18.255Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:69) [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] "VM Thread" os_prio=0 tid=0xf5a5f400 nid=0x1427f runnable [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] "VM Periodic Task Thread" os_prio=0 tid=0xf5a8a400 nid=0x14286 waiting on condition [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] JNI global references: 251 [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] --- Timeout information end. [2023-07-25T11:54:18.255Z] elapsed time (seconds): 960.356 [2023-07-25T11:54:18.255Z] configuration: [2023-07-25T11:54:18.255Z] Boot Layer [2023-07-25T11:54:18.255Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2023-07-25T11:54:18.255Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2023-07-25T11:54:18.255Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/lib/tools.jar [2023-07-25T11:54:18.255Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/junit.jar [2023-07-25T11:54:18.255Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/testng.jar [2023-07-25T11:54:18.255Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/jvmtest/openjdk/jtreg/lib/jcommander.jar [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] Test Layer [2023-07-25T11:54:18.255Z] class path: /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel [2023-07-25T11:54:18.255Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test/java/nio/channels/FileChannel [2023-07-25T11:54:18.255Z] [2023-07-25T11:54:18.255Z] rerun: [2023-07-25T11:54:18.255Z] cd /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/scratch/2 && \ [2023-07-25T11:54:18.255Z] DISPLAY=:0 \ [2023-07-25T11:54:18.255Z] HOME=/home/jenkins \ [2023-07-25T11:54:18.255Z] PATH=/bin:/usr/bin:/usr/sbin \ [2023-07-25T11:54:18.255Z] /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image/bin/java \ [2023-07-25T11:54:18.255Z] -Dtest.vm.opts='-ea -esa -Xmx512m' \ [2023-07-25T11:54:18.255Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2023-07-25T11:54:18.255Z] -Dtest.compiler.opts= \ [2023-07-25T11:54:18.255Z] -Dtest.java.opts= \ [2023-07-25T11:54:18.255Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.255Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/openjdkbinary/j2sdk-image \ [2023-07-25T11:54:18.255Z] -Dtest.timeout.factor=8.0 \ [2023-07-25T11:54:18.255Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/jdk/test \ [2023-07-25T11:54:18.255Z] -Dtest.name=java/nio/channels/FileChannel/InterruptDeadlock.java \ [2023-07-25T11:54:18.255Z] -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 \ [2023-07-25T11:54:18.255Z] -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 \ [2023-07-25T11:54:18.255Z] -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 \ [2023-07-25T11:54:18.255Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.255Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/java/nio/channels/FileChannel \ [2023-07-25T11:54:18.255Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/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 \ [2023-07-25T11:54:18.256Z] -classpath /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work/classes/0/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/openjdkbinary/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 \ [2023-07-25T11:54:18.256Z] InterruptDeadlock [2023-07-25T11:54:18.256Z] STDOUT: [2023-07-25T11:54:18.256Z] Iteration: 1 [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] Iteration: 2 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 3 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedChannelException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 4 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 5 [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] Iteration: 6 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 7 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedChannelException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] Iteration: 8 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 9 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 10 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 11 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] Iteration: 12 [2023-07-25T11:54:18.256Z] class java.nio.channels.ClosedByInterruptException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class java.nio.channels.AsynchronousCloseException (expected) [2023-07-25T11:54:18.256Z] class j [2023-07-25T11:54:18.256Z] TEST RESULT: Error. Agent error: java.lang.Exception: Agent 7 timed out with a timeout of 960 seconds; check console log for any additional details [2023-07-25T11:54:18.256Z] -------------------------------------------------- [2023-07-25T11:54:18.256Z] Test results: passed: 344; error: 2 [2023-07-25T11:54:23.809Z] Report written to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/report/html/report.html [2023-07-25T11:54:23.809Z] Results written to /home/jenkins/workspace/Test_openjdk8_hs_extended.openjdk_arm_linux_testList_1/aqa-tests/TKG/output_16902820676409/jdk_nio_2/work [2023-07-25T11:54:23.809Z] Error: Some tests failed or other problems occurred. [2023-07-25T11:54:23.809Z] ----------------------------------- [2023-07-25T11:54:23.809Z] jdk_nio_2_FAILED [2023-07-25T11:54:23.809Z] ----------------------------------- [2023-07-25T11:54:23.809Z] [2023-07-25T11:54:23.809Z] TEST TEARDOWN: [2023-07-25T11:54:23.809Z] Nothing to be done for teardown. [2023-07-25T11:54:23.809Z] jdk_nio_2 Finish Time: Tue Jul 25 11:54:23 2023 Epoch Time (ms): 1690286063309