search

eclipse-openj9 / openj9

Eclipse OpenJ9: A Java Virtual Machine for OpenJDK that's optimized for small footprint, fast start-up, and high throughput. Builds on Eclipse OMR (https://github.com/eclipse/omr) and combines with the Extensions for OpenJDK for OpenJ9 repo.
Other
3.27k stars 721 forks source link

JDK19 java/lang/Thread/virtual/stress/TimedGet.java timed out #16050

Closed thallium closed 1 year ago

thallium commented 1 year ago

Timed out with and without JIT.

"main" prio=5 Id=2 WAITING
        at java.base@19-internal/java.lang.Object.wait(Native Method)
        at java.base@19-internal/java.lang.Object.wait(Object.java:219)
        at java.base@19-internal/java.lang.Thread.join(Thread.java:2146)
        at java.base@19-internal/java.lang.Thread.join(Thread.java:2222)
        at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:72)

"Common-Cleaner" prio=8 Id=3 TIMED_WAITING
        at java.base@19-internal/java.lang.Object.wait(Native Method)
        at java.base@19-internal/java.lang.Object.wait(Object.java:219)
        at java.base@19-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
        at java.base@19-internal/jdk.internal.ref.CleanerImpl.run(CleanerImpl.java:140)
        at java.base@19-internal/java.lang.Thread.run(Thread.java:1573)
        at java.base@19-internal/jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:186)

"GC Worker" prio=5 Id=4 RUNNABLE

"GC Worker" prio=5 Id=5 RUNNABLE

"GC Worker" prio=5 Id=6 RUNNABLE

"GC Worker" prio=5 Id=7 RUNNABLE

"GC Worker" prio=5 Id=8 RUNNABLE

"GC Worker" prio=5 Id=9 RUNNABLE

"GC Worker" prio=5 Id=10 RUNNABLE

"Attach API wait loop" prio=10 Id=13 RUNNABLE
        at java.base@19-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
        at java.base@19-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
        at java.base@19-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
        at java.base@19-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)

"MainThread" prio=5 Id=15 RUNNABLE
        at java.base@19-internal/jdk.internal.vm.Continuation.createContinuationImpl(Native Method)
        at java.base@19-internal/jdk.internal.vm.Continuation.<init>(Continuation.java:106)
        at java.base@19-internal/java.lang.VirtualThread$VThreadContinuation.<init>(VirtualThread.java:179)
        at java.base@19-internal/java.lang.VirtualThread.<init>(VirtualThread.java:170)
        at java.base@19-internal/java.lang.ThreadBuilders.newVirtualThread(ThreadBuilders.java:384)
        at java.base@19-internal/java.lang.ThreadBuilders$VirtualThreadBuilder.unstarted(ThreadBuilders.java:227)
        at java.base@19-internal/java.lang.ThreadBuilders$VirtualThreadBuilder.start(ThreadBuilders.java:236)
        at app//TimedGet.main(TimedGet.java:62)
        at java.base@19-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
        at java.base@19-internal/java.lang.reflect.Method.invoke(Method.java:578)
        at app//com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:125)
        at java.base@19-internal/java.lang.Thread.run(Thread.java:1573)

"ForkJoinPool-1-worker-1" prio=5 Id=17 RUNNABLE                                                                                                                                                                                                                                  [115/26518]
        at java.base@19-internal/jdk.internal.misc.Unsafe.unpark(Native Method)
        at java.base@19-internal/java.util.concurrent.locks.LockSupport.unpark(LockSupport.java:181)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.signalWork(ForkJoinPool.java:1715)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1839)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1806)
        at java.base@19-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)

"ForkJoinPool-1-worker-2" prio=5 Id=49 RUNNABLE
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.compareTo(ScheduledThreadPoolExecutor.java:256)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.compareTo(ScheduledThreadPoolExecutor.java:185)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.siftUp(ScheduledThreadPoolExecutor.java:971)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.offer(ScheduledThreadPoolExecutor.java:1110)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.add(ScheduledThreadPoolExecutor.java:1127)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.add(ScheduledThreadPoolExecutor.java:899)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:342)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
        at java.base@19-internal/java.lang.VirtualThread.scheduleUnpark(VirtualThread.java:595)
        at java.base@19-internal/java.lang.VirtualThread.parkNanos(VirtualThread.java:534)
        at java.base@19-internal/java.lang.Access.parkVirtualThread(Access.java:509)
        at java.base@19-internal/jdk.internal.misc.VirtualThreads.park(VirtualThreads.java:67)
        at java.base@19-internal/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:267)
        at java.base@19-internal/java.util.concurrent.CompletableFuture$Signaller.block(CompletableFuture.java:1866)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.unmanagedBlock(ForkJoinPool.java:3744)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.managedBlock(ForkJoinPool.java:3689)
        at java.base@19-internal/java.util.concurrent.CompletableFuture.timedGet(CompletableFuture.java:1939)
        at java.base@19-internal/java.util.concurrent.CompletableFuture.get(CompletableFuture.java:2095)
        at app//TimedGet.lambda$main$0(TimedGet.java:64)
        at java.base@19-internal/java.lang.VirtualThread.run(VirtualThread.java:292)
        at java.base@19-internal/java.lang.VirtualThread$VThreadContinuation.lambda$new$0(VirtualThread.java:179)
        at java.base@19-internal/jdk.internal.vm.Continuation.execute(Continuation.java:171)

"ForkJoinPool-1-worker-3" prio=5 Id=83 RUNNABLE
        at java.base@19-internal/jdk.internal.misc.Unsafe.park(Native Method)
        at java.base@19-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:371)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.awaitWork(ForkJoinPool.java:1890)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1807)
        at java.base@19-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)

"ForkJoinPool-1-worker-4" prio=5 Id=84 RUNNABLE
        at java.base@19-internal/java.lang.VirtualThread.scheduleUnpark(VirtualThread.java:595)
        at java.base@19-internal/java.lang.VirtualThread.parkNanos(VirtualThread.java:534)
        at java.base@19-internal/java.lang.Access.parkVirtualThread(Access.java:509)
        at java.base@19-internal/jdk.internal.misc.VirtualThreads.park(VirtualThreads.java:67)
        at java.base@19-internal/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:267)
        at java.base@19-internal/java.util.concurrent.CompletableFuture$Signaller.block(CompletableFuture.java:1866)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.unmanagedBlock(ForkJoinPool.java:3744)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.managedBlock(ForkJoinPool.java:3689)
        at java.base@19-internal/java.util.concurrent.CompletableFuture.timedGet(CompletableFuture.java:1939)
        at java.base@19-internal/java.util.concurrent.CompletableFuture.get(CompletableFuture.java:2095)
        at app//TimedGet.lambda$main$0(TimedGet.java:64)
        at java.base@19-internal/java.lang.VirtualThread.run(VirtualThread.java:292)
        at java.base@19-internal/java.lang.VirtualThread$VThreadContinuation.lambda$new$0(VirtualThread.java:179)
        at java.base@19-internal/jdk.internal.vm.Continuation.execute(Continuation.java:171)
"ForkJoinPool-1-worker-5" prio=5 Id=112 RUNNABLE
        at java.base@19-internal/java.lang.VirtualThread.notifyJvmtiMountBegin(Native Method)
        at java.base@19-internal/java.lang.VirtualThread.runContinuation(VirtualThread.java:215)
        at java.base@19-internal/java.util.concurrent.ForkJoinTask$RunnableExecuteAction.exec(ForkJoinTask.java:1423)
        at java.base@19-internal/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:387)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1311)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1840)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1806)
        at java.base@19-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)

"ForkJoinPool-1-worker-6" prio=5 Id=123 RUNNABLE
        at java.base@19-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:677)
        at java.base@19-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:938)
        at java.base@19-internal/java.util.concurrent.locks.ReentrantLock$Sync.lock(ReentrantLock.java:153)
        at java.base@19-internal/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:322)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.offer(ScheduledThreadPoolExecutor.java:1100)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.add(ScheduledThreadPoolExecutor.java:1127)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.add(ScheduledThreadPoolExecutor.java:899)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:342)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
        at java.base@19-internal/java.lang.VirtualThread.scheduleUnpark(VirtualThread.java:595)
        at java.base@19-internal/java.lang.VirtualThread.parkNanos(VirtualThread.java:534)
        at java.base@19-internal/java.lang.Access.parkVirtualThread(Access.java:509)
        at java.base@19-internal/jdk.internal.misc.VirtualThreads.park(VirtualThreads.java:67)
        at java.base@19-internal/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:267)
        at java.base@19-internal/java.util.concurrent.CompletableFuture$Signaller.block(CompletableFuture.java:1866)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.unmanagedBlock(ForkJoinPool.java:3744)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.managedBlock(ForkJoinPool.java:3689)
        at java.base@19-internal/java.util.concurrent.CompletableFuture.timedGet(CompletableFuture.java:1939)
        at java.base@19-internal/java.util.concurrent.CompletableFuture.get(CompletableFuture.java:2095)
        at app//TimedGet.lambda$main$0(TimedGet.java:64)
        at java.base@19-internal/java.lang.VirtualThread.run(VirtualThread.java:292)
        at java.base@19-internal/java.lang.VirtualThread$VThreadContinuation.lambda$new$0(VirtualThread.java:179)
        at java.base@19-internal/jdk.internal.vm.Continuation.execute(Continuation.java:171)

"ForkJoinPool-1-worker-7" prio=5 Id=132 RUNNABLE
        at java.base@19-internal/jdk.internal.misc.Unsafe.getAndBitwiseOrInt(Unsafe.java:4558)
        at java.base@19-internal/java.util.concurrent.ForkJoinTask.getAndBitwiseOrStatus(ForkJoinTask.java:283)
        at java.base@19-internal/java.util.concurrent.ForkJoinTask.setDone(ForkJoinTask.java:317)
        at java.base@19-internal/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:393)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1311)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1840)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1806)
        at java.base@19-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)

"ForkJoinPool-1-worker-8" prio=5 Id=144 WAITING
        at java.base@19-internal/jdk.internal.misc.Unsafe.park(Native Method)
        at java.base@19-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:371)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.awaitWork(ForkJoinPool.java:1890)
        at java.base@19-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1807)
        at java.base@19-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177)

"VirtualThread-unparker" prio=5 Id=959 TIMED_WAITING
        at java.base@19-internal/jdk.internal.misc.Unsafe.park(Native Method)
        at java.base@19-internal/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:269)
        at java.base@19-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:1674)
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182) 
        at java.base@19-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
        at java.base@19-internal/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1070)
        at java.base@19-internal/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at java.base@19-internal/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
        at java.base@19-internal/java.lang.Thread.run(Thread.java:1573) 
        at java.base@19-internal/jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:186)

"Finalizer thread" prio=5 Id=9448 RUNNABLE

"Attachment portNumber: 43683" prio=10 Id=89195 RUNNABLE
        at java.base@19-internal/openj9.internal.tools.attach.target.DiagnosticUtils.dumpAllThreadsImpl(Native Method)
        at java.base@19-internal/openj9.internal.tools.attach.target.DiagnosticUtils.getThreadInfo(DiagnosticUtils.java:245)
        at java.base@19-internal/openj9.internal.tools.attach.target.DiagnosticUtils.executeDiagnosticCommand(DiagnosticUtils.java:181)
        at java.base@19-internal/openj9.internal.tools.attach.target.Attachment.doCommand(Attachment.java:248)
        at java.base@19-internal/openj9.internal.tools.attach.target.Attachment.run(Attachment.java:159)

"file lock watchdog" prio=10 Id=89224 TIMED_WAITING
        at java.base@19-internal/java.lang.Object.wait(Native Method)
        at java.base@19-internal/java.lang.Object.wait(Object.java:219) 
        at java.base@19-internal/java.util.TimerThread.mainLoop(Timer.java:563)
        at java.base@19-internal/java.util.TimerThread.run(Timer.java:516)

--- Timeout information end.
thallium commented 1 year ago

already have an issue for this