https://openj9-jenkins.osuosl.org/job/Test_openjdk19_j9_sanity.openjdk_aarch64_linux_Nightly/111/
jdk_lang_0
java/lang/Thread/virtual/stress/Skynet.java
https://openj9-artifactory.osuosl.org/artifactory/ci-openj9/Test/Test_openjdk19_j9_sanity.openjdk_aarch64_linux_Nightly/111/openjdk_test_output.tar.gz
21:55:35 ACTION: main -- Error. Program `/home/jenkins/workspace/Test_openjdk19_j9_sanity.openjdk_aarch64_linux_Nightly/openjdkbinary/j2sdk-image/bin/java' timed out (timeout set to 2400000ms, elapsed time including timeout handling was 2404113ms).
21:55:35 REASON: User specified action: run main/othervm/timeout=300 --enable-preview Skynet
21:55:35 TIME: 2404.116 seconds
21:55:35 messages:
21:55:35 command: main --enable-preview Skynet
21:55:35 reason: User specified action: run main/othervm/timeout=300 --enable-preview Skynet
21:55:35 Mode: othervm [/othervm specified]
21:55:35 Timeout information:
21:55:35 Running jcmd on process 2529589
21:55:35 Dump written to /home/jenkins/workspace/Test_openjdk19_j9_sanity.openjdk_aarch64_linux_Nightly/aqa-tests/TKG/output_1676426825596/jdk_lang_0/work/scratch/2/core.20230214.215530.2529589.0001.dmp
21:55:35 Dump written to /home/jenkins/workspace/Test_openjdk19_j9_sanity.openjdk_aarch64_linux_Nightly/aqa-tests/TKG/output_1676426825596/jdk_lang_0/work/scratch/2/javacore.20230214.215531.2529589.0002.txt
21:55:35 Running jstack on process 2529589
21:55:35 2023-02-14T21:55:32.813679073
21:55:35 Virtual machine: 2529589 JVM information:
21:55:35 JRE 19 Linux aarch64-64-Bit Compressed References 20230215_180 (JIT enabled, AOT enabled)
21:55:35 OpenJ9 - 711ca6c2adb
21:55:35 OMR - 6adea0343aa
21:55:35 JCL - 47925e78c4e based on jdk-19.0.2+7
21:55:35
21:55:35 "main" prio=5 Id=2 WAITING
21:55:35 at java.base@19.0.2-internal/java.lang.Object.waitImpl(Native Method)
21:55:35 at java.base@19.0.2-internal/java.lang.Object.wait(Object.java:255)
21:55:35 at java.base@19.0.2-internal/java.lang.Object.wait(Object.java:221)
21:55:35 at java.base@19.0.2-internal/java.lang.Thread.join(Thread.java:2151)
21:55:35 at java.base@19.0.2-internal/java.lang.Thread.join(Thread.java:2227)
21:55:35 at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:74)
21:55:35
21:55:35 "JIT Compilation Thread-000" prio=10 Id=4 RUNNABLE
21:55:35
21:55:35 "JIT Compilation Thread-001 Suspended" prio=10 Id=5 RUNNABLE
21:55:35
21:55:35 "JIT Compilation Thread-002 Suspended" prio=10 Id=6 RUNNABLE
21:55:35
21:55:35 "JIT Compilation Thread-003 Suspended" prio=10 Id=7 RUNNABLE
21:55:35
21:55:35 "JIT Compilation Thread-004 Suspended" prio=10 Id=8 RUNNABLE
21:55:35
21:55:35 "JIT Compilation Thread-005 Suspended" prio=10 Id=9 RUNNABLE
21:55:35
21:55:35 "JIT Compilation Thread-006 Suspended" prio=10 Id=10 RUNNABLE
21:55:35
21:55:35 "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=11 RUNNABLE
21:55:35
21:55:35 "JIT-SamplerThread" prio=10 Id=12 TIMED_WAITING
21:55:35
21:55:35 "IProfiler" prio=5 Id=13 RUNNABLE
21:55:35
21:55:35 "Common-Cleaner" prio=8 Id=3 TIMED_WAITING
21:55:35 at java.base@19.0.2-internal/java.lang.Object.waitImpl(Native Method)
21:55:35 at java.base@19.0.2-internal/java.lang.Object.wait(Object.java:255)
21:55:35 at java.base@19.0.2-internal/java.lang.Object.wait(Object.java:221)
21:55:35 at java.base@19.0.2-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
21:55:35 at java.base@19.0.2-internal/jdk.internal.ref.CleanerImpl.run(CleanerImpl.java:140)
21:55:35 at java.base@19.0.2-internal/java.lang.Thread.run(Thread.java:1573)
21:55:35 at java.base@19.0.2-internal/jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:186)
21:55:35
21:55:35 "Concurrent Mark Helper" prio=1 Id=14 RUNNABLE
21:55:35
21:55:35 "GC Worker" prio=5 Id=15 RUNNABLE
21:55:35
21:55:35 "GC Worker" prio=5 Id=16 RUNNABLE
21:55:35
21:55:35 "GC Worker" prio=5 Id=17 RUNNABLE
21:55:35
21:55:35 "GC Worker" prio=5 Id=18 RUNNABLE
21:55:35
21:55:35 "GC Worker" prio=5 Id=19 RUNNABLE
21:55:35
21:55:35 "GC Worker" prio=5 Id=20 RUNNABLE
21:55:35
21:55:35 "GC Worker" prio=5 Id=21 RUNNABLE
21:55:35
21:55:35 "Attach API wait loop" prio=10 Id=24 RUNNABLE
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
21:55:35
21:55:35 "Finalizer thread" prio=5 Id=25 RUNNABLE
21:55:35
21:55:35 "MainThread" prio=5 Id=27 WAITING
21:55:35 at java.base@19.0.2-internal/jdk.internal.misc.Unsafe.park(Native Method)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:371)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.SynchronousQueue$TransferStack$SNode.block(SynchronousQueue.java:288)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.unmanagedBlock(ForkJoinPool.java:3745)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.managedBlock(ForkJoinPool.java:3690)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:397)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.SynchronousQueue.take(SynchronousQueue.java:886)
21:55:35 at app//Skynet$Channel.receive(Skynet.java:110)
21:55:35 at app//Skynet.skynet(Skynet.java:60)
21:55:35 at app//Skynet.main(Skynet.java:50)
21:55:35 at java.base@19.0.2-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
21:55:35 at java.base@19.0.2-internal/java.lang.reflect.Method.invoke(Method.java:578)
21:55:35 at app//com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
21:55:35 at java.base@19.0.2-internal/java.lang.Thread.run(Thread.java:1573)
21:55:35
21:55:35 "ForkJoinPool-1-worker-2" prio=5 Id=31 RUNNABLE
21:55:35 at java.base@19.0.2-internal/jdk.internal.vm.Continuation.enterImpl(Native Method)
21:55:35 at java.base@19.0.2-internal/jdk.internal.vm.Continuation.run(Continuation.java:198)
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.runContinuation(VirtualThread.java:218)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask$RunnableExecuteAction.exec(ForkJoinTask.java:1423)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:387)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1311)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1841)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1806)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)
21:55:35
21:55:35 "ForkJoinPool-1-worker-3" prio=5 Id=41 RUNNABLE
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.notifyJvmtiUnmountEnd(Native Method)
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.afterYield(VirtualThread.java:396)
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.runContinuation(VirtualThread.java:223)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask$AdaptedRunnableAction.exec(ForkJoinTask.java:1403)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:387)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1311)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1841)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1806)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)
21:55:35
21:55:35 "ForkJoinPool-1-worker-6" prio=5 Id=47 RUNNABLE
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.notifyJvmtiUnmountEnd(Native Method)
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.afterTerminate(VirtualThread.java:424)
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.runContinuation(VirtualThread.java:221)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask$RunnableExecuteAction.exec(ForkJoinTask.java:1423)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:387)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1311)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1841)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1806)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)
21:55:35
21:55:35 "ForkJoinPool-1-worker-7" prio=5 Id=48 RUNNABLE
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.notifyJvmtiMountBegin(Native Method)
21:55:35 at java.base@19.0.2-internal/java.lang.VirtualThread.runContinuation(VirtualThread.java:215)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask$RunnableExecuteAction.exec(ForkJoinTask.java:1423)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:387)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1311)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1841)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1806)
21:55:35 at java.base@19.0.2-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)
21:55:35
21:55:35 "file lock watchdog" prio=10 Id=10700077 TIMED_WAITING
21:55:35 at java.base@19.0.2-internal/java.lang.Object.waitImpl(Native Method)
21:55:35 at java.base@19.0.2-internal/java.lang.Object.wait(Object.java:255)
21:55:35 at java.base@19.0.2-internal/java.lang.Object.wait(Object.java:221)
21:55:35 at java.base@19.0.2-internal/java.util.TimerThread.mainLoop(Timer.java:569)
21:55:35 at java.base@19.0.2-internal/java.util.TimerThread.run(Timer.java:522)
21:55:35
21:55:35 "Attachment portNumber: 40951" prio=10 Id=10708739 RUNNABLE
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.DiagnosticUtils.dumpAllThreadsImpl(Native Method)
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.DiagnosticUtils.getThreadInfo(DiagnosticUtils.java:245)
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.DiagnosticUtils.executeDiagnosticCommand(DiagnosticUtils.java:181)
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.Attachment.doCommand(Attachment.java:248)
21:55:35 at java.base@19.0.2-internal/openj9.internal.tools.attach.target.Attachment.run(Attachment.java:159)
21:55:35
21:55:35
21:55:35 --- Timeout information end.
21:55:35 elapsed time (seconds): 2404.116
21:55:35 configuration:
21:55:35 STDOUT:
21:55:35 Result: 499999500000 in 396129 ms
21:55:35 Result: 499999500000 in 141690 ms
21:55:35 Result: 499999500000 in 344331 ms
21:55:35 Result: 499999500000 in 326083 ms
21:55:35 Result: 499999500000 in 300962 ms
21:55:35 Result: 499999500000 in 379486 ms
21:55:35 Result: 499999500000 in 222160 ms
21:55:35 Result: 499999500000 in 194157 ms
21:55:35 Result: 499999500000 in 50598 ms
21:55:35 Timeout refired 2400 times
https://openj9-jenkins.osuosl.org/job/Test_openjdk19_j9_sanity.openjdk_aarch64_linux_Nightly/111/
jdk_lang_0
java/lang/Thread/virtual/stress/Skynet.java
https://openj9-artifactory.osuosl.org/artifactory/ci-openj9/Test/Test_openjdk19_j9_sanity.openjdk_aarch64_linux_Nightly/111/openjdk_test_output.tar.gz