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

OpenJDK java/lang/Thread/virtual/Parking timeout #18128

Open pshipton opened 1 year ago

pshipton commented 1 year ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk21_j9_sanity.openjdk_s390x_linux_Nightly_testList_1/52/ - ub20-390-1 jdk_lang_1 java/lang/Thread/virtual/Parking.java

00:06:46  ACTION: junit -- Error. Agent error: java.lang.Exception: Agent 32 timed out with a timeout of 960 seconds; check console log for any additional details
00:06:46  REASON: User specified action: run junit Parking 
00:06:46  TIME:   992.085 seconds
00:06:46  messages:
00:06:46  command: junit Parking
00:06:46  reason: User specified action: run junit Parking 
00:06:46  started: Tue Sep 12 03:50:04 UTC 2023
00:06:46  Mode: agentvm
00:06:46  Agent id: 32
00:06:46  Timeout refired 960 times
00:06:46  Timeout information:
00:06:46  Running jcmd on process 2521622
00:06:46  Dump written to /home/jenkins/workspace/Test_openjdk21_j9_sanity.openjdk_s390x_linux_Nightly_testList_1/aqa-tests/TKG/output_16944885599539/jdk_lang_1/work/scratch/0/core.20230912.040606.2521622.0001.dmp
00:06:46  Dump written to /home/jenkins/workspace/Test_openjdk21_j9_sanity.openjdk_s390x_linux_Nightly_testList_1/aqa-tests/TKG/output_16944885599539/jdk_lang_1/work/scratch/0/javacore.20230912.040635.2521622.0002.txt
00:06:46  Running jstack on process 2521622
00:06:46  2023-09-12T04:06:36.420534543
00:06:46  Virtual machine: 2521622 JVM information:
00:06:46  JRE 21 Linux s390x-64-Bit 20230911_59 (JIT enabled, AOT enabled)
00:06:46  OpenJ9   - 5bf1ff4e80b
00:06:46  OMR      - f8fecbefe36
00:06:46  JCL      - 29830aa8b90 based on jdk-21+35
00:06:46  
00:06:46  "main" prio=5 Id=2 WAITING
00:06:46    at java.base@21-internal/java.lang.Object.waitImpl(Native Method)
00:06:46    at java.base@21-internal/java.lang.Object.wait(Object.java:255)
00:06:46    at java.base@21-internal/java.lang.Object.wait(Object.java:221)
00:06:46    at java.base@21-internal/java.lang.Thread.join(Thread.java:2102)
00:06:46    at java.base@21-internal/java.lang.Thread.join(Thread.java:2178)
00:06:46    at app//com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219)
00:06:46    at app//com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:317)
00:06:46    at app//com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:242)
00:06:46    at app//com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71)
00:06:46  
00:06:46  "JIT Compilation Thread-000" prio=10 Id=4 RUNNABLE
00:06:46  
00:06:46  "JIT Compilation Thread-001 Suspended" prio=10 Id=5 RUNNABLE
00:06:46  
00:06:46  "JIT Compilation Thread-002 Suspended" prio=10 Id=6 RUNNABLE
00:06:46  
00:06:46  "JIT Compilation Thread-003 Suspended" prio=10 Id=7 RUNNABLE
00:06:46  
00:06:46  "JIT Compilation Thread-004 Suspended" prio=10 Id=8 RUNNABLE
00:06:46  
00:06:46  "JIT Compilation Thread-005 Suspended" prio=10 Id=9 RUNNABLE
00:06:46  
00:06:46  "JIT Compilation Thread-006 Suspended" prio=10 Id=10 RUNNABLE
00:06:46  
00:06:46  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=11 RUNNABLE
00:06:46  
00:06:46  "JIT-SamplerThread" prio=10 Id=12 TIMED_WAITING
00:06:46  
00:06:46  "IProfiler" prio=5 Id=13 RUNNABLE
00:06:46  
00:06:46  "Common-Cleaner" prio=8 Id=3 TIMED_WAITING
00:06:46    at java.base@21-internal/java.lang.Object.waitImpl(Native Method)
00:06:46    at java.base@21-internal/java.lang.Object.wait(Object.java:255)
00:06:46    at java.base@21-internal/java.lang.Object.wait(Object.java:221)
00:06:46    at java.base@21-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
00:06:46    at java.base@21-internal/jdk.internal.ref.CleanerImpl.run(CleanerImpl.java:140)
00:06:46    at java.base@21-internal/java.lang.Thread.run(Thread.java:1595)
00:06:46    at java.base@21-internal/jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:186)
00:06:46  
00:06:46  "Finalizer thread" prio=5 Id=14 RUNNABLE
00:06:46  
00:06:46  "Concurrent Mark Helper" prio=1 Id=15 RUNNABLE
00:06:46  
00:06:46  "GC Worker" prio=5 Id=16 RUNNABLE
00:06:46  
00:06:46  "GC Worker" prio=5 Id=17 RUNNABLE
00:06:46  
00:06:46  "GC Worker" prio=5 Id=18 RUNNABLE
00:06:46  
00:06:46  "Attach API wait loop" prio=10 Id=21 RUNNABLE
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
00:06:46  
00:06:46  "pool-1-thread-1" prio=5 Id=22 TIMED_WAITING
00:06:46    at java.base@21-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:06:46    at java.base@21-internal/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:269)
00:06:46    at java.base@21-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:1758)
00:06:46    at java.base@21-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
00:06:46    at java.base@21-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
00:06:46    at java.base@21-internal/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1070)
00:06:46    at java.base@21-internal/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
00:06:46    at java.base@21-internal/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
00:06:46    at java.base@21-internal/java.lang.Thread.run(Thread.java:1595)
00:06:46  
00:06:46  "AgentVMThread" prio=5 Id=40 WAITING
00:06:46    at java.base@21-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:06:46    at java.base@21-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:221)
00:06:46    at java.base@21-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:754)
00:06:46    at java.base@21-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1099)
00:06:46    at java.base@21-internal/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:230)
00:06:46    at java.base@21-internal/java.lang.VirtualThread.joinNanos(VirtualThread.java:840)
00:06:46    at java.base@21-internal/java.lang.Thread.join(Thread.java:2085)
00:06:46    at java.base@21-internal/java.lang.Thread.join(Thread.java:2178)
00:06:46    at Parking.testPark7(Parking.java:136)
00:06:46    at java.base@21-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
00:06:46    at java.base@21-internal/java.lang.reflect.Method.invoke(Method.java:580)
00:06:46    at app//org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727)
00:06:46    at app//org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
00:06:46    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131)
00:06:46    at app//org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156)
00:06:46    at app//org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147)
00:06:46    at app//org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:86)
00:06:46    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103)
00:06:46    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93)
00:06:46    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106)
00:06:46    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64)
00:06:46    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45)
00:06:46    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37)
00:06:46    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92)
00:06:46    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86)
00:06:46    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$7(TestMethodTestDescriptor.java:217)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
00:06:46    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213)
00:06:46    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138)
00:06:46    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
00:06:46    at java.base@21-internal/java.util.ArrayList.forEach(ArrayList.java:1596)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
00:06:46    at java.base@21-internal/java.util.ArrayList.forEach(ArrayList.java:1596)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
00:06:46    at app//org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54)
00:06:46    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147)
00:06:46    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127)
00:06:46    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90)
00:06:46    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55)
00:06:46    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102)
00:06:46    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54)
00:06:46    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114)
00:06:46    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86)
00:06:46    at app//org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86)
00:06:46    at app//com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142)
00:06:46    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95)
00:06:46    at java.base@21-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
00:06:46    at java.base@21-internal/java.lang.reflect.Method.invoke(Method.java:580)
00:06:46    at app//com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333)
00:06:46    at java.base@21-internal/java.lang.Thread.run(Thread.java:1595)
00:06:46  
00:06:46  "file lock watchdog" prio=10 Id=51 TIMED_WAITING
00:06:46    at java.base@21-internal/java.lang.Object.waitImpl(Native Method)
00:06:46    at java.base@21-internal/java.lang.Object.wait(Object.java:255)
00:06:46    at java.base@21-internal/java.lang.Object.wait(Object.java:221)
00:06:46    at java.base@21-internal/java.util.TimerThread.mainLoop(Timer.java:600)
00:06:46    at java.base@21-internal/java.util.TimerThread.run(Timer.java:543)
00:06:46  
00:06:46  "Attachment portNumber: 39353" prio=10 Id=53 RUNNABLE
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.DiagnosticUtils.dumpAllThreadsImpl(Native Method)
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.DiagnosticUtils.getThreadInfo(DiagnosticUtils.java:249)
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.DiagnosticUtils.executeDiagnosticCommand(DiagnosticUtils.java:185)
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.Attachment.doCommand(Attachment.java:248)
00:06:46    at java.base@21-internal/openj9.internal.tools.attach.target.Attachment.run(Attachment.java:159)
00:06:46  
00:06:46  
00:06:46  --- Timeout information end.
pshipton commented 1 year ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk21_j9_sanity.openjdk_s390x_linux_Nightly_testList_1/53 - rh7-390-4

pshipton commented 1 year ago

Changes between last good and first failure. https://github.com/eclipse-openj9/openj9/compare/b03d898a...5bf1ff4e80

Perhaps https://github.com/eclipse-openj9/openj9/pull/18093

@fengxue-IS @babsingh

babsingh commented 1 year ago

Perhaps https://github.com/eclipse-openj9/openj9/pull/18093

https://github.com/eclipse-openj9/openj9/pull/18093 shouldn't compile since the J9VM_PROF_CONTINUATION_ALLOCATION flag is disabled by default.

babsingh commented 1 year ago

The failure seems intermittent. Started a 100x grinder to study it further: https://openj9-jenkins.osuosl.org/job/Grinder/2889/.

babsingh commented 1 year ago

No failures seen in the 100x grinder: https://openj9-jenkins.osuosl.org/job/Grinder/2889; unable to reproduce the failure.

tajila commented 11 months ago

Moving this out of JDK21, if it reproduces we can add it back in.

pshipton commented 11 months ago

Removed any milestone.

pshipton commented 8 months ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk21_j9_sanity.openjdk_s390x_linux_Release_testList_0/10/ jdk_lang_0 java/lang/Thread/virtual/Parking.java

https://openj9-artifactory.osuosl.org/artifactory/ci-openj9/Test/Test_openjdk21_j9_sanity.openjdk_s390x_linux_Release_testList_0/10/openjdk_test_output.tar.gz

18:04:00  Running jstack on process 1333050
18:04:00  2024-01-17T23:03:53.449873150
18:04:00  Virtual machine: 1333050 JVM information:
18:04:00  JRE 21 Linux s390x-64-Bit Compressed References 20240117_11 (JIT enabled, AOT enabled)
18:04:00  OpenJ9   - 2640954d2a8
18:04:00  OMR      - 2dfe70d0cd8
18:04:00  JCL      - ec9f012f6e3 based on jdk-21.0.2+13
18:04:00  
18:04:00  "main" prio=5 Id=2 WAITING
18:04:00    at java.base@21.0.2-internal/java.lang.Object.waitImpl(Native Method)
18:04:00    at java.base@21.0.2-internal/java.lang.Object.wait(Object.java:255)
18:04:00    at java.base@21.0.2-internal/java.lang.Object.wait(Object.java:221)
18:04:00    at java.base@21.0.2-internal/java.lang.Thread.join(Thread.java:2102)
18:04:00    at java.base@21.0.2-internal/java.lang.Thread.join(Thread.java:2178)
18:04:00    at app//com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219)
18:04:00    at app//com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:317)
18:04:00    at app//com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:242)
18:04:00    at app//com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71)
18:04:00  
18:04:00  "JIT Compilation Thread-000" prio=10 Id=4 RUNNABLE
18:04:00  
18:04:00  "JIT Compilation Thread-001" prio=10 Id=5 RUNNABLE
18:04:00  
18:04:00  "JIT Compilation Thread-002" prio=10 Id=6 RUNNABLE
18:04:00  
18:04:00  "JIT Compilation Thread-003 Suspended" prio=10 Id=7 RUNNABLE
18:04:00  
18:04:00  "JIT Compilation Thread-004 Suspended" prio=10 Id=8 RUNNABLE
18:04:00  
18:04:00  "JIT Compilation Thread-005 Suspended" prio=10 Id=9 RUNNABLE
18:04:00  
18:04:00  "JIT Compilation Thread-006 Suspended" prio=10 Id=10 RUNNABLE
18:04:00  
18:04:00  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=11 RUNNABLE
18:04:00  
18:04:00  "JIT-SamplerThread" prio=10 Id=12 TIMED_WAITING
18:04:00  
18:04:00  "IProfiler" prio=5 Id=13 RUNNABLE
18:04:00  
18:04:00  "Common-Cleaner" prio=8 Id=3 TIMED_WAITING
18:04:00    at java.base@21.0.2-internal/java.lang.Object.waitImpl(Native Method)
18:04:00    at java.base@21.0.2-internal/java.lang.Object.wait(Object.java:255)
18:04:00    at java.base@21.0.2-internal/java.lang.Object.wait(Object.java:221)
18:04:00    at java.base@21.0.2-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
18:04:00    at java.base@21.0.2-internal/jdk.internal.ref.CleanerImpl.run(CleanerImpl.java:140)
18:04:00    at java.base@21.0.2-internal/java.lang.Thread.run(Thread.java:1595)
18:04:00    at java.base@21.0.2-internal/jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:186)
18:04:00  
18:04:00  "Finalizer thread" prio=5 Id=14 RUNNABLE
18:04:00  
18:04:00  "Concurrent Mark Helper" prio=1 Id=15 RUNNABLE
18:04:00  
18:04:00  "GC Worker" prio=5 Id=16 RUNNABLE
18:04:00  
18:04:00  "GC Worker" prio=5 Id=17 RUNNABLE
18:04:00  
18:04:00  "GC Worker" prio=5 Id=18 RUNNABLE
18:04:00  
18:04:00  "Attach API wait loop" prio=10 Id=21 RUNNABLE
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
18:04:00  
18:04:00  "pool-1-thread-1" prio=5 Id=22 TIMED_WAITING
18:04:00    at java.base@21.0.2-internal/jdk.internal.misc.Unsafe.park(Native Method)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:269)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:1758)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1070)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
18:04:00    at java.base@21.0.2-internal/java.lang.Thread.run(Thread.java:1595)
18:04:00  
18:04:00  "AgentVMThread" prio=5 Id=46 WAITING
18:04:00    at java.base@21.0.2-internal/jdk.internal.misc.Unsafe.park(Native Method)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:221)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:754)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1099)
18:04:00    at java.base@21.0.2-internal/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:230)
18:04:00    at java.base@21.0.2-internal/java.lang.VirtualThread.joinNanos(VirtualThread.java:832)
18:04:00    at java.base@21.0.2-internal/java.lang.Thread.join(Thread.java:2085)
18:04:00    at java.base@21.0.2-internal/java.lang.Thread.join(Thread.java:2178)
18:04:00    at Parking.testPark7(Parking.java:136)
18:04:00    at java.base@21.0.2-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
18:04:00    at java.base@21.0.2-internal/java.lang.reflect.Method.invoke(Method.java:586)
18:04:00    at app//org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727)
18:04:00    at app//org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
18:04:00    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131)
18:04:00    at app//org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156)
18:04:00    at app//org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147)
18:04:00    at app//org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:86)
18:04:00    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103)
18:04:00    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93)
18:04:00    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106)
18:04:00    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64)
18:04:00    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45)
18:04:00    at app//org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37)
18:04:00    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92)
18:04:00    at app//org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86)
18:04:00    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$7(TestMethodTestDescriptor.java:217)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
18:04:00    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213)
18:04:00    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138)
18:04:00    at app//org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
18:04:00    at java.base@21.0.2-internal/java.util.ArrayList.forEach(ArrayList.java:1596)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
18:04:00    at java.base@21.0.2-internal/java.util.ArrayList.forEach(ArrayList.java:1596)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
18:04:00    at app//org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54)
18:04:00    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147)
18:04:00    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127)
18:04:00    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90)
18:04:00    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55)
18:04:00    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102)
18:04:00    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54)
18:04:00    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114)
18:04:00    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86)
18:04:00    at app//org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86)
18:04:00    at app//com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142)
18:04:00    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95)
18:04:00    at java.base@21.0.2-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
18:04:00    at java.base@21.0.2-internal/java.lang.reflect.Method.invoke(Method.java:586)
18:04:00    at app//com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333)
18:04:00    at java.base@21.0.2-internal/java.lang.Thread.run(Thread.java:1595)
18:04:00  
18:04:00  "file lock watchdog" prio=10 Id=56 TIMED_WAITING
18:04:00    at java.base@21.0.2-internal/java.lang.Object.waitImpl(Native Method)
18:04:00    at java.base@21.0.2-internal/java.lang.Object.wait(Object.java:255)
18:04:00    at java.base@21.0.2-internal/java.lang.Object.wait(Object.java:221)
18:04:00    at java.base@21.0.2-internal/java.util.TimerThread.mainLoop(Timer.java:602)
18:04:00    at java.base@21.0.2-internal/java.util.TimerThread.run(Timer.java:543)
18:04:00  
18:04:00  "Attachment portNumber: 39533" prio=10 Id=58 RUNNABLE
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.DiagnosticUtils.dumpAllThreadsImpl(Native Method)
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.DiagnosticUtils.getThreadInfo(DiagnosticUtils.java:249)
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.DiagnosticUtils.executeDiagnosticCommand(DiagnosticUtils.java:185)
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.Attachment.doCommand(Attachment.java:248)
18:04:00    at java.base@21.0.2-internal/openj9.internal.tools.attach.target.Attachment.run(Attachment.java:159)
18:04:00  
18:04:00  
18:04:00  --- Timeout information end.