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

jdk_util_0_FAILED - JSR166TestCase AssertionFailedError: timed out waiting for thread to terminate #13000

Open JasonFengJ9 opened 3 years ago

JasonFengJ9 commented 3 years ago

Failure link

From an internal build Test_openjdk11_j9_sanity.openjdk_s390x_linux/83/ (rhel7s390x-4-3):

java version "11.0.12-beta" 2021-07-20
Java(TM) SE Runtime Environment 11.0.12.0-IBM (build 11.0.12-beta+5-202106180120)
Eclipse OpenJ9 VM 11.0.12.0-IBM (build master-e70c5a4e4, JRE 11 Linux s390x-64-Bit Compressed References 20210617_95 (JIT enabled, AOT enabled)
OpenJ9   - e70c5a4e4
OMR      - b7eb96336
JCL      - 877d68cf02 based on jdk-11.0.12+5)

Rerun in Grinder

Optional info

Failure output (captured from console output)

[2021-06-18T02:49:08.429Z] Running test jdk_util_0 ...
[2021-06-18T02:49:08.429Z] ===============================================
[2021-06-18T02:49:08.429Z] jdk_util_0 Start Time: Thu Jun 17 19:49:01 2021 Epoch Time (ms): 1623984541318
[2021-06-18T02:49:08.429Z] "/home/jenkins/workspace/Test_openjdk11_j9_sanity.openjdk_s390x_linux/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:destroyAll; "/home/jenkins/workspace/Test_openjdk11_j9_sanity.openjdk_s390x_linux/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:groupAccess,destroyAll; echo "cache cleanup done";
[2021-06-18T02:49:08.429Z] JVMSHRC005I No shared class caches available
[2021-06-18T02:49:08.429Z] JVMSHRC005I No shared class caches available
[2021-06-18T02:49:08.429Z] cache cleanup done
[2021-06-18T02:49:08.429Z] variation: -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache Mode150
[2021-06-18T02:49:08.429Z] JVM_OPTIONS:  -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:+UseCompressedOops 

[2021-06-18T02:53:05.409Z] JavaTest Message: JUnit Failure: testParkNeg_parkUntilBlocker(LockSupportTest): timed out waiting for thread to terminate
[2021-06-18T02:53:05.409Z] junit.framework.AssertionFailedError: timed out waiting for thread to terminate
[2021-06-18T02:53:05.409Z]  at junit.framework.Assert.fail(Assert.java:50)
[2021-06-18T02:53:05.409Z]  at JSR166TestCase.threadFail(JSR166TestCase.java:826)
[2021-06-18T02:53:05.409Z]  at JSR166TestCase.awaitTermination(JSR166TestCase.java:1452)
[2021-06-18T02:53:05.409Z]  at JSR166TestCase.awaitTermination(JSR166TestCase.java:1463)
[2021-06-18T02:53:05.409Z]  at LockSupportTest.testParkNeg(LockSupportTest.java:403)
[2021-06-18T02:53:05.409Z]  at LockSupportTest.testParkNeg_parkUntilBlocker(LockSupportTest.java:395)
[2021-06-18T02:53:05.409Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[2021-06-18T02:53:05.409Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[2021-06-18T02:53:05.409Z]  at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[2021-06-18T02:53:05.409Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestCase.runTest(TestCase.java:168)
[2021-06-18T02:53:05.409Z]  at JSR166TestCase.runTest(JSR166TestCase.java:361)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestCase.runBare(TestCase.java:134)
[2021-06-18T02:53:05.409Z]  at JSR166TestCase.runBare(JSR166TestCase.java:352)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestResult$1.protect(TestResult.java:110)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestResult.runProtected(TestResult.java:128)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestResult.run(TestResult.java:113)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestCase.run(TestCase.java:124)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestSuite.runTest(TestSuite.java:243)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestSuite.run(TestSuite.java:238)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestSuite.runTest(TestSuite.java:243)
[2021-06-18T02:53:05.409Z]  at junit.framework.TestSuite.run(TestSuite.java:238)
[2021-06-18T02:53:05.409Z]  at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.Suite.runChild(Suite.java:128)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.Suite.runChild(Suite.java:24)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
[2021-06-18T02:53:05.409Z]  at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
[2021-06-18T02:53:05.409Z]  at org.junit.runner.JUnitCore.run(JUnitCore.java:157)
[2021-06-18T02:53:05.410Z]  at org.junit.runner.JUnitCore.run(JUnitCore.java:136)
[2021-06-18T02:53:05.410Z]  at org.junit.runner.JUnitCore.run(JUnitCore.java:127)
[2021-06-18T02:53:05.410Z]  at org.junit.runner.JUnitCore.runClasses(JUnitCore.java:76)
[2021-06-18T02:53:05.410Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
[2021-06-18T02:53:05.410Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
[2021-06-18T02:53:05.410Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[2021-06-18T02:53:05.410Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[2021-06-18T02:53:05.410Z]  at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[2021-06-18T02:53:05.410Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[2021-06-18T02:53:05.410Z]  at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
[2021-06-18T02:53:05.410Z]  at java.base/java.lang.Thread.run(Thread.java:866)
[2021-06-18T02:53:05.410Z] 
[2021-06-18T02:53:05.410Z] java.lang.Exception: JUnit test failure
[2021-06-18T02:53:05.410Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:92)
[2021-06-18T02:53:05.410Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
[2021-06-18T02:53:05.410Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[2021-06-18T02:53:05.410Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[2021-06-18T02:53:05.410Z]  at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[2021-06-18T02:53:05.410Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[2021-06-18T02:53:05.410Z]  at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
[2021-06-18T02:53:05.410Z]  at java.base/java.lang.Thread.run(Thread.java:866)
[2021-06-18T02:53:05.410Z] 
[2021-06-18T02:53:05.410Z] JavaTest Message: Test threw exception: java.lang.Exception: JUnit test failure

[2021-06-18T02:53:05.410Z] --------------------------------------------------
[2021-06-18T03:04:20.479Z] Test results: passed: 838; failed: 1
[2021-06-18T03:04:20.479Z] Report written to /home/jenkins/workspace/Test_openjdk11_j9_sanity.openjdk_s390x_linux/jvmtest/openjdk/report/html/report.html
[2021-06-18T03:04:20.479Z] Results written to /home/jenkins/workspace/Test_openjdk11_j9_sanity.openjdk_s390x_linux/aqa-tests/TKG/output_16239823803937/jdk_util_0/work
[2021-06-18T03:04:20.479Z] Error: Some tests failed or other problems occurred.
[2021-06-18T03:04:20.479Z] 
[2021-06-18T03:04:20.479Z] jdk_util_0_FAILED

3x grinder at Grinder/16392 (passed), same machine grinder at Grinder/16393.

pshipton commented 3 years ago

The same machine grinder failed a pack200 test (https://github.com/eclipse-openj9/openj9/issues/12789#issuecomment-864254964), but this failure wasn't reproduced.

pshipton commented 2 years ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk11_j9_sanity.openjdk_s390x_linux_Nightly/126 jdk_util_0 -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:+UseCompressedOops java/util/concurrent/tck/JSR166TestCase.java

01:31:01  ACTION: junit -- Failed. Execution failed: `main' threw exception: java.lang.Exception: JUnit test failure
01:31:01  REASON: User specified action: run junit/othervm/timeout=1000/policy=tck.policy --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djsr166.testImplementationDetails=true JSR166TestCase 
01:31:01  TIME:   92.526 seconds
01:31:01  messages:
01:31:01  command: junit --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djsr166.testImplementationDetails=true JSR166TestCase
01:31:01  reason: User specified action: run junit/othervm/timeout=1000/policy=tck.policy --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djsr166.testImplementationDetails=true JSR166TestCase 
01:31:01  Mode: othervm [/othervm specified]
01:31:01  Additional options from @modules: --add-modules java.management
01:31:01  elapsed time (seconds): 92.526
01:31:01  configuration:
01:31:01  Boot Layer
01:31:01    add modules: java.management                
01:31:01    add opens:   java.base/java.lang            ALL-UNNAMED
01:31:01                 java.base/java.util.concurrent ALL-UNNAMED
01:31:01  
01:31:01  STDOUT:
01:31:01  STDERR:
01:31:01  junit.framework.AssertionFailedError: timed out waiting for thread to terminate
01:31:01  JavaTest Message: JUnit Failure: testParkNeg_parkUntil(LockSupportTest): timed out waiting for thread to terminate
01:31:01  junit.framework.AssertionFailedError: timed out waiting for thread to terminate
01:31:01    at junit.framework.Assert.fail(Assert.java:50)
01:31:01    at JSR166TestCase.threadFail(JSR166TestCase.java:826)
01:31:01    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1452)
01:31:01    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1463)
01:31:01    at LockSupportTest.testParkNeg(LockSupportTest.java:403)
01:31:01    at LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
01:31:01    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
01:31:01    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
01:31:01    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
01:31:01    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
01:31:01    at junit.framework.TestCase.runTest(TestCase.java:168)
01:31:01    at JSR166TestCase.runTest(JSR166TestCase.java:361)
01:31:01    at junit.framework.TestCase.runBare(TestCase.java:134)
01:31:01    at JSR166TestCase.runBare(JSR166TestCase.java:352)
pshipton commented 2 years ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk17_j9_sanity.openjdk_x86-64_linux_Nightly/61 jdk_util_1 -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:-UseCompressedOops java/util/concurrent/tck/JSR166TestCase.java

https://openj9-artifactory.osuosl.org/artifactory/ci-openj9/Test/Test_openjdk17_j9_sanity.openjdk_x86-64_linux_Nightly/61/openjdk_test_output.tar.gz

01:02:15  ACTION: junit -- Failed. Execution failed: `main' threw exception: java.lang.Exception: JUnit test failure
01:02:15  REASON: User specified action: run junit/othervm/timeout=1000 --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djava.security.manager=allow -Djsr166.testImplementationDetails=true -Djava.util.concurrent.ForkJoinPool.common.parallelism=1 -Djava.util.secureRandomSeed=true JSR166TestCase 
01:02:15  TIME:   107.492 seconds
01:02:15  messages:
01:02:15  command: junit --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djava.security.manager=allow -Djsr166.testImplementationDetails=true -Djava.util.concurrent.ForkJoinPool.common.parallelism=1 -Djava.util.secureRandomSeed=true JSR166TestCase
01:02:15  reason: User specified action: run junit/othervm/timeout=1000 --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djava.security.manager=allow -Djsr166.testImplementationDetails=true -Djava.util.concurrent.ForkJoinPool.common.parallelism=1 -Djava.util.secureRandomSeed=true JSR166TestCase 
01:02:15  Mode: othervm [/othervm specified]
01:02:15  Additional options from @modules: --add-modules java.management
01:02:15  elapsed time (seconds): 107.492
01:02:15  configuration:
01:02:15  Boot Layer
01:02:15    add modules: java.management                
01:02:15    add opens:   java.base/java.lang            ALL-UNNAMED
01:02:15                 java.base/java.util.concurrent ALL-UNNAMED
01:02:15  
01:02:15  STDOUT:
01:02:15  STDERR:
01:02:15  WARNING: A terminally deprecated method in java.lang.System has been called
01:02:15  WARNING: System::setSecurityManager has been called by JSR166TestCase (file:/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_x86-64_linux_Nightly/aqa-tests/TKG/output_16353025992499/jdk_util_1/work/classes/0/java/util/concurrent/tck/JSR166TestCase.d/)
01:02:15  WARNING: Please consider reporting this to the maintainers of JSR166TestCase
01:02:15  WARNING: System::setSecurityManager will be removed in a future release
01:02:15  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[Thread-443,5,MainThreadGroup], state=TIMED_WAITING
01:02:15  ------ stacktrace dump start ------
01:02:15  "main" prio=5 Id=1 WAITING
01:02:15    at java.base@17.0.1-internal/java.lang.Object.wait(Native Method)
01:02:15    at java.base@17.0.1-internal/java.lang.Object.wait(Object.java:221)
01:02:15    at java.base@17.0.1-internal/java.lang.Thread.join(Thread.java:764)
01:02:15    at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:74)
01:02:15  "JIT Compilation Thread-000" prio=10 Id=3 RUNNABLE
01:02:15  "JIT Compilation Thread-001 Suspended" prio=10 Id=4 RUNNABLE
01:02:15  "JIT Compilation Thread-002 Suspended" prio=10 Id=5 RUNNABLE
01:02:15  "JIT Compilation Thread-003 Suspended" prio=10 Id=6 RUNNABLE
01:02:15  "JIT Compilation Thread-004 Suspended" prio=10 Id=7 RUNNABLE
01:02:15  "JIT Compilation Thread-005 Suspended" prio=10 Id=8 RUNNABLE
01:02:15  "JIT Compilation Thread-006 Suspended" prio=10 Id=9 RUNNABLE
01:02:15  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=10 RUNNABLE
01:02:15  "JIT-SamplerThread" prio=10 Id=11 TIMED_WAITING
01:02:15  "IProfiler" prio=5 Id=12 RUNNABLE
01:02:15  "Concurrent Mark Helper" prio=1 Id=13 RUNNABLE
01:02:15  "GC Worker" prio=5 Id=14 RUNNABLE
01:02:15  "Finalizer thread" prio=5 Id=15 RUNNABLE
01:02:15  "GC Worker" prio=5 Id=16 RUNNABLE
01:02:15  "GC Worker" prio=5 Id=17 RUNNABLE
01:02:15  "MainThread" prio=5 Id=21 RUNNABLE
01:02:15    at java.management@17.0.1-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsImpl(Native Method)
01:02:15    at java.management@17.0.1-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsCommon(ThreadMXBeanImpl.java:687)
01:02:15    at java.management@17.0.1-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreads(ThreadMXBeanImpl.java:669)
01:02:15    at app//JSR166TestCase.dumpTestThreads(JSR166TestCase.java:1182)
01:02:15    at app//JSR166TestCase.threadRecordFailure(JSR166TestCase.java:813)
01:02:15    at app//JSR166TestCase.threadFail(JSR166TestCase.java:887)
01:02:15    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1653)
01:02:15    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1667)
01:02:15    at app//LockSupportTest.testParkNeg(LockSupportTest.java:403)
01:02:15    at app//LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
01:02:15    at java.base@17.0.1-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
01:02:15    at java.base@17.0.1-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
01:02:15    at java.base@17.0.1-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
01:02:15    at java.base@17.0.1-internal/java.lang.reflect.Method.invoke(Method.java:568)
01:02:15    at app//junit.framework.TestCase.runTest(TestCase.java:177)
01:02:15    at app//JSR166TestCase.runTest(JSR166TestCase.java:383)
01:02:15    at app//junit.framework.TestCase.runBare(TestCase.java:142)
01:02:15    at app//JSR166TestCase.runBare(JSR166TestCase.java:374)
01:02:15    at app//junit.framework.TestResult$1.protect(TestResult.java:122)
01:02:15    at app//junit.framework.TestResult.runProtected(TestResult.java:142)
01:02:15    at app//junit.framework.TestResult.run(TestResult.java:125)
01:02:15    at app//junit.framework.TestCase.run(TestCase.java:130)
01:02:15    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
01:02:15    at app//junit.framework.TestSuite.run(TestSuite.java:236)
01:02:15    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
01:02:15    at app//junit.framework.TestSuite.run(TestSuite.java:236)
01:02:15    at app//org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
01:02:15    at app//org.junit.runners.Suite.runChild(Suite.java:128)
01:02:15    at app//org.junit.runners.Suite.runChild(Suite.java:27)
01:02:15    at app//org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
01:02:15    at app//org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
01:02:15    at app//org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
01:02:15    at app//org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
01:02:15    at app//org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
01:02:15    at app//org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
01:02:15    at app//org.junit.runners.ParentRunner.run(ParentRunner.java:413)
01:02:15    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:137)
01:02:15    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:115)
01:02:15    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:105)
01:02:15    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:62)
01:02:15    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:49)
01:02:15    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
01:02:15    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
01:02:15    at java.base@17.0.1-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
01:02:15    at java.base@17.0.1-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
01:02:15    at java.base@17.0.1-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
01:02:15    at java.base@17.0.1-internal/java.lang.reflect.Method.invoke(Method.java:568)
01:02:15    at app//com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
01:02:15    at java.base@17.0.1-internal/java.lang.Thread.run(Thread.java:884)
01:02:15  "Attach API wait loop" prio=10 Id=22 RUNNABLE
01:02:15    at java.base@17.0.1-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
01:02:15    at java.base@17.0.1-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
01:02:15    at java.base@17.0.1-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
01:02:15    at java.base@17.0.1-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
01:02:15  "ClassCache Reaper" prio=5 Id=461 WAITING
01:02:15    at java.base@17.0.1-internal/java.lang.Object.wait(Native Method)
01:02:15    at java.base@17.0.1-internal/java.lang.Object.wait(Object.java:221)
01:02:15    at java.base@17.0.1-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:138)
01:02:15    at java.base@17.0.1-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:110)
01:02:15    at java.base@17.0.1-internal/java.io.ClassCache$Reaper.run(ClassCache.java:234)
01:02:15    at java.base@17.0.1-internal/java.lang.Thread.run(Thread.java:884)
01:02:15  "Thread-443" prio=5 Id=1178 TIMED_WAITING
01:02:15    at java.base@17.0.1-internal/jdk.internal.misc.Unsafe.park(Native Method)
01:02:15    at java.base@17.0.1-internal/java.util.concurrent.locks.LockSupport.parkUntil(LockSupport.java:410)
01:02:15    at app//LockSupportTest$ParkMethod$2.park(LockSupportTest.java:78)
01:02:15    at app//LockSupportTest$8.realRun(LockSupportTest.java:400)
01:02:15    at app//JSR166TestCase$CheckedRunnable.run(JSR166TestCase.java:1677)
01:02:15    at java.base@17.0.1-internal/java.lang.Thread.run(Thread.java:884)
01:02:15  ------ stacktrace dump end ------
01:02:15  JavaTest Message: JUnit Failure: testParkNeg_parkUntil(LockSupportTest): timed out waiting for thread to terminate, thread=Thread[Thread-443,5,MainThreadGroup], state=TIMED_WAITING
01:02:15  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[Thread-443,5,MainThreadGroup], state=TIMED_WAITING
01:02:15    at junit.framework.Assert.fail(Assert.java:57)
01:02:15    at junit.framework.TestCase.fail(TestCase.java:223)
01:02:15    at JSR166TestCase.threadFail(JSR166TestCase.java:885)
01:02:15    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1653)
01:02:15    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1667)
01:02:15    at LockSupportTest.testParkNeg(LockSupportTest.java:403)
01:02:15    at LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
01:02:15    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
01:02:15    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
01:02:15    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
01:02:15    at java.base/java.lang.reflect.Method.invoke(Method.java:568)
01:02:15    at junit.framework.TestCase.runTest(TestCase.java:177)
01:02:15    at JSR166TestCase.runTest(JSR166TestCase.java:383)
01:02:15    at junit.framework.TestCase.runBare(TestCase.java:142)
01:02:15    at JSR166TestCase.runBare(JSR166TestCase.java:374)
01:02:15    at junit.framework.TestResult$1.protect(TestResult.java:122)
01:02:15    at junit.framework.TestResult.runProtected(TestResult.java:142)
01:02:15    at junit.framework.TestResult.run(TestResult.java:125)
01:02:15    at junit.framework.TestCase.run(TestCase.java:130)
01:02:15    at junit.framework.TestSuite.runTest(TestSuite.java:241)
01:02:15    at junit.framework.TestSuite.run(TestSuite.java:236)
01:02:15    at junit.framework.TestSuite.runTest(TestSuite.java:241)
01:02:15    at junit.framework.TestSuite.run(TestSuite.java:236)
01:02:15    at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
01:02:15    at org.junit.runners.Suite.runChild(Suite.java:128)
01:02:15    at org.junit.runners.Suite.runChild(Suite.java:27)
01:02:15    at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
01:02:15    at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
01:02:15    at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
01:02:15    at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
01:02:15    at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
01:02:15    at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
01:02:15    at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
01:02:15    at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
01:02:15    at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
01:02:15    at org.junit.runner.JUnitCore.run(JUnitCore.java:105)
01:02:15    at org.junit.runner.JUnitCore.runClasses(JUnitCore.java:62)
01:02:15    at org.junit.runner.JUnitCore.runClasses(JUnitCore.java:49)
01:02:15    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
01:02:15    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
01:02:15    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
01:02:15    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
01:02:15    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
01:02:15    at java.base/java.lang.reflect.Method.invoke(Method.java:568)
01:02:15    at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
01:02:15    at java.base/java.lang.Thread.run(Thread.java:884)
01:02:15  
01:02:15  java.lang.Exception: JUnit test failure
01:02:15    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:92)
01:02:15    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
01:02:15    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
01:02:15    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
01:02:15    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
01:02:15    at java.base/java.lang.reflect.Method.invoke(Method.java:568)
01:02:15    at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
01:02:15    at java.base/java.lang.Thread.run(Thread.java:884)
01:02:15  
01:02:15  JavaTest Message: Test threw exception: java.lang.Exception: JUnit test failure
01:02:15  JavaTest Message: shutting down test
01:02:15  
01:02:15  STATUS:Failed.`main' threw exception: java.lang.Exception: JUnit test failure
pshipton commented 1 year ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk11_j9_sanity.openjdk_ppc64_aix_Nightly/369 jdk_util_0 java/util/concurrent/tck/JSR166TestCase.java

https://openj9-artifactory.osuosl.org/artifactory/ci-openj9/Test/Test_openjdk11_j9_sanity.openjdk_ppc64_aix_Nightly/369/openjdk_test_output.tar.gz

00:35:41  ACTION: junit -- Failed. Execution failed: `main' threw exception: java.lang.Exception: JUnit test failure
00:35:41  REASON: User specified action: run junit/othervm/timeout=1000 --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djsr166.testImplementationDetails=true JSR166TestCase 
00:35:41  TIME:   19.514 seconds
00:35:41  messages:
00:35:41  command: junit --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djsr166.testImplementationDetails=true JSR166TestCase
00:35:41  reason: User specified action: run junit/othervm/timeout=1000 --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED -Djsr166.testImplementationDetails=true JSR166TestCase 
00:35:41  Mode: othervm [/othervm specified]
00:35:41  Additional options from @modules: --add-modules java.management
00:35:41  elapsed time (seconds): 19.514
00:35:41  configuration:
00:35:41  Boot Layer
00:35:41    add modules: java.management                
00:35:41    add opens:   java.base/java.lang            ALL-UNNAMED
00:35:41                 java.base/java.util.concurrent ALL-UNNAMED
00:35:41  
00:35:41  STDOUT:
00:35:41  STDERR:
00:35:41  junit.framework.AssertionFailedError
00:35:41  ------ stacktrace dump start ------
00:35:41  "main" prio=5 Id=1 WAITING
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Native Method)
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Object.java:219)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.join(Thread.java:766)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.join(Thread.java:721)
00:35:41    at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:74)
00:35:41  "JIT Compilation Thread-000" prio=10 Id=3 RUNNABLE
00:35:41  "JIT Compilation Thread-001 Suspended" prio=10 Id=4 RUNNABLE
00:35:41  "JIT Compilation Thread-002 Suspended" prio=10 Id=5 RUNNABLE
00:35:41  "JIT Compilation Thread-003 Suspended" prio=10 Id=6 RUNNABLE
00:35:41  "JIT Compilation Thread-004 Suspended" prio=10 Id=7 RUNNABLE
00:35:41  "JIT Compilation Thread-005 Suspended" prio=10 Id=8 RUNNABLE
00:35:41  "JIT Compilation Thread-006 Suspended" prio=10 Id=9 RUNNABLE
00:35:41  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=10 RUNNABLE
00:35:41  "JIT-SamplerThread" prio=10 Id=11 TIMED_WAITING
00:35:41  "IProfiler" prio=5 Id=12 RUNNABLE
00:35:41  "Common-Cleaner" prio=8 Id=2 TIMED_WAITING
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Native Method)
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Object.java:219)
00:35:41    at java.base@11.0.17-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
00:35:41    at java.base@11.0.17-internal/jdk.internal.ref.CleanerImpl.run(CleanerImpl.java:148)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.run(Thread.java:839)
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:161)
00:35:41  "Finalizer thread" prio=5 Id=13 RUNNABLE
00:35:41  "Concurrent Mark Helper" prio=1 Id=14 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=15 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=16 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=17 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=18 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=19 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=20 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=21 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=22 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=23 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=24 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=25 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=26 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=27 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=28 RUNNABLE
00:35:41  "GC Worker" prio=5 Id=29 RUNNABLE
00:35:41  "Attach API wait loop" prio=10 Id=32 RUNNABLE
00:35:41    at java.base@11.0.17-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
00:35:41    at java.base@11.0.17-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
00:35:41    at java.base@11.0.17-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
00:35:41    at java.base@11.0.17-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
00:35:41  "MainThread" prio=5 Id=34 WAITING
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Native Method)
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Object.java:219)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinTask.externalAwaitDone(ForkJoinTask.java:330)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinTask.doJoin(ForkJoinTask.java:398)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinTask.join(ForkJoinTask.java:721)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.invoke(ForkJoinPool.java:2423)
00:35:41    at app//ForkJoinTask8Test.testInvokeOnPool(ForkJoinTask8Test.java:110)
00:35:41    at app//ForkJoinTask8Test.testForkHelpQuiesce(ForkJoinTask8Test.java:561)
00:35:41    at app//ForkJoinTask8Test.testForkHelpQuiesce(ForkJoinTask8Test.java:547)
00:35:41    at java.base@11.0.17-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
00:35:41    at java.base@11.0.17-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
00:35:41    at java.base@11.0.17-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
00:35:41    at java.base@11.0.17-internal/java.lang.reflect.Method.invoke(Method.java:566)
00:35:41    at app//junit.framework.TestCase.runTest(TestCase.java:177)
00:35:41    at app//JSR166TestCase.runTest(JSR166TestCase.java:361)
00:35:41    at app//junit.framework.TestCase.runBare(TestCase.java:142)
00:35:41    at app//JSR166TestCase.runBare(JSR166TestCase.java:352)
00:35:41    at app//junit.framework.TestResult$1.protect(TestResult.java:122)
00:35:41    at app//junit.framework.TestResult.runProtected(TestResult.java:142)
00:35:41    at app//junit.framework.TestResult.run(TestResult.java:125)
00:35:41    at app//junit.framework.TestCase.run(TestCase.java:130)
00:35:41    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
00:35:41    at app//junit.framework.TestSuite.run(TestSuite.java:236)
00:35:41    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
00:35:41    at app//junit.framework.TestSuite.run(TestSuite.java:236)
00:35:41    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
00:35:41    at app//junit.framework.TestSuite.run(TestSuite.java:236)
00:35:41    at app//org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
00:35:41    at app//org.junit.runners.Suite.runChild(Suite.java:128)
00:35:41    at app//org.junit.runners.Suite.runChild(Suite.java:27)
00:35:41    at app//org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
00:35:41    at app//org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
00:35:41    at app//org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
00:35:41    at app//org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
00:35:41    at app//org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
00:35:41    at app//org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
00:35:41    at app//org.junit.runners.ParentRunner.run(ParentRunner.java:413)
00:35:41    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:137)
00:35:41    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:115)
00:35:41    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:105)
00:35:41    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:62)
00:35:41    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:49)
00:35:41    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
00:35:41    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
00:35:41    at java.base@11.0.17-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
00:35:41    at java.base@11.0.17-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
00:35:41    at java.base@11.0.17-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
00:35:41    at java.base@11.0.17-internal/java.lang.reflect.Method.invoke(Method.java:566)
00:35:41    at app//com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.run(Thread.java:839)
00:35:41  "ClassByNameCache Reaper" prio=5 Id=1395 WAITING
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Native Method)
00:35:41    at java.base@11.0.17-internal/java.lang.Object.wait(Object.java:219)
00:35:41    at java.base@11.0.17-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
00:35:41    at java.base@11.0.17-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:109)
00:35:41    at java.base@11.0.17-internal/java.io.ClassByNameCache$Reaper.run(ClassByNameCache.java:232)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.run(Thread.java:839)
00:35:41  "ForkJoinPool.commonPool-worker-19" prio=5 Id=1593 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-5" prio=5 Id=1594 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-23" prio=5 Id=1595 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-9" prio=5 Id=1614 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-27" prio=5 Id=2272 TIMED_WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.parkUntil(LockSupport.java:275)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1619)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "CompletableFutureDelayScheduler" prio=5 Id=2869 TIMED_WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.run(Thread.java:839)
00:35:41  "ForkJoinPool.commonPool-worker-13" prio=5 Id=2870 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-31" prio=5 Id=3220 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-21" prio=5 Id=3222 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-7" prio=5 Id=3223 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-3" prio=5 Id=3221 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-17" prio=5 Id=3219 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-25" prio=5 Id=3597 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-29" prio=5 Id=3599 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-11" prio=5 Id=3598 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool.commonPool-worker-15" prio=5 Id=3600 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-19" prio=5 Id=3797 RUNNABLE
00:35:41    at java.management@11.0.17-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsImpl(Native Method)
00:35:41    at java.management@11.0.17-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsCommon(ThreadMXBeanImpl.java:686)
00:35:41    at java.management@11.0.17-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreads(ThreadMXBeanImpl.java:668)
00:35:41    at app//JSR166TestCase.dumpTestThreads(JSR166TestCase.java:1091)
00:35:41    at app//JSR166TestCase.threadRecordFailure(JSR166TestCase.java:753)
00:35:41    at app//JSR166TestCase.threadUnexpectedException(JSR166TestCase.java:939)
00:35:41    at app//JSR166TestCase$CheckedRecursiveAction.compute(JSR166TestCase.java:1700)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.RecursiveAction.exec(RecursiveAction.java:189)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:290)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1020)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1656)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1594)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-5" prio=5 Id=3798 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-23" prio=5 Id=3799 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-9" prio=5 Id=3800 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-27" prio=5 Id=3801 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-13" prio=5 Id=3802 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-3" prio=5 Id=3805 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-7" prio=5 Id=3807 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-11" prio=5 Id=3810 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-15" prio=5 Id=3809 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-25" prio=5 Id=3808 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-1" prio=5 Id=3812 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-29" prio=5 Id=3811 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-21" prio=5 Id=3806 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-17" prio=5 Id=3804 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "ForkJoinPool-303-worker-31" prio=5 Id=3803 WAITING
00:35:41    at java.base@11.0.17-internal/jdk.internal.misc.Unsafe.park(Native Method)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1628)
00:35:41    at java.base@11.0.17-internal/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  "OperatingSystemMXBean notification dispatcher" prio=6 Id=3813 RUNNABLE
00:35:41    at jdk.management@11.0.17-internal/com.ibm.lang.management.internal.OperatingSystemNotificationThread.processNotificationLoop(Native Method)
00:35:41    at jdk.management@11.0.17-internal/com.ibm.lang.management.internal.OperatingSystemNotificationThread.run(OperatingSystemNotificationThread.java:70)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.run(Thread.java:839)
00:35:41  "OperatingSystemMXBean notification dispatcher" prio=6 Id=3815 RUNNABLE
00:35:41    at jdk.management@11.0.17-internal/com.ibm.lang.management.internal.OperatingSystemNotificationThread.processNotificationLoop(Native Method)
00:35:41    at jdk.management@11.0.17-internal/com.ibm.lang.management.internal.OperatingSystemNotificationThread.run(OperatingSystemNotificationThread.java:70)
00:35:41    at java.base@11.0.17-internal/java.lang.Thread.run(Thread.java:839)
00:35:41  ------ stacktrace dump end ------
00:35:41  junit.framework.AssertionFailedError
00:35:41    at junit.framework.Assert.fail(Assert.java:55)
00:35:41    at junit.framework.Assert.assertTrue(Assert.java:22)
00:35:41    at junit.framework.Assert.assertTrue(Assert.java:31)
00:35:41    at junit.framework.TestCase.assertTrue(TestCase.java:200)
00:35:41    at ForkJoinTask8Test.checkCompletedNormally(ForkJoinTask8Test.java:144)
00:35:41    at ForkJoinTask8Test.checkCompletedNormally(ForkJoinTask8Test.java:140)
00:35:41    at ForkJoinTask8Test$AsyncFib.checkCompletedNormally(ForkJoinTask8Test.java:362)
00:35:41    at ForkJoinTask8Test$8.realCompute(ForkJoinTask8Test.java:559)
00:35:41    at JSR166TestCase$CheckedRecursiveAction.compute(JSR166TestCase.java:1698)
00:35:41    at java.base/java.util.concurrent.RecursiveAction.exec(RecursiveAction.java:189)
00:35:41    at java.base/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:290)
00:35:41    at java.base/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1020)
00:35:41    at java.base/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1656)
00:35:41    at java.base/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1594)
00:35:41    at java.base/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  JavaTest Message: JUnit Failure: testForkHelpQuiesce(ForkJoinTask8Test): null
00:35:41  junit.framework.AssertionFailedError
00:35:41    at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
00:35:41    at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
00:35:41    at java.base/jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
00:35:41    at java.base/java.lang.reflect.Constructor.newInstance(Constructor.java:490)
00:35:41    at java.base/java.util.concurrent.ForkJoinTask.getThrowableException(ForkJoinTask.java:603)
00:35:41    at java.base/java.util.concurrent.ForkJoinTask.reportException(ForkJoinTask.java:678)
00:35:41    at java.base/java.util.concurrent.ForkJoinTask.join(ForkJoinTask.java:722)
00:35:41    at java.base/java.util.concurrent.ForkJoinPool.invoke(ForkJoinPool.java:2423)
00:35:41    at ForkJoinTask8Test.testInvokeOnPool(ForkJoinTask8Test.java:110)
00:35:41    at ForkJoinTask8Test.testForkHelpQuiesce(ForkJoinTask8Test.java:561)
00:35:41    at ForkJoinTask8Test.testForkHelpQuiesce(ForkJoinTask8Test.java:547)
00:35:41    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
00:35:41    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
00:35:41    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
00:35:41    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
00:35:41    at junit.framework.TestCase.runTest(TestCase.java:177)
00:35:41    at JSR166TestCase.runTest(JSR166TestCase.java:361)
00:35:41    at junit.framework.TestCase.runBare(TestCase.java:142)
00:35:41    at JSR166TestCase.runBare(JSR166TestCase.java:352)
00:35:41    at junit.framework.TestResult$1.protect(TestResult.java:122)
00:35:41    at junit.framework.TestResult.runProtected(TestResult.java:142)
00:35:41    at junit.framework.TestResult.run(TestResult.java:125)
00:35:41    at junit.framework.TestCase.run(TestCase.java:130)
00:35:41    at junit.framework.TestSuite.runTest(TestSuite.java:241)
00:35:41    at junit.framework.TestSuite.run(TestSuite.java:236)
00:35:41    at junit.framework.TestSuite.runTest(TestSuite.java:241)
00:35:41    at junit.framework.TestSuite.run(TestSuite.java:236)
00:35:41    at junit.framework.TestSuite.runTest(TestSuite.java:241)
00:35:41    at junit.framework.TestSuite.run(TestSuite.java:236)
00:35:41    at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
00:35:41    at org.junit.runners.Suite.runChild(Suite.java:128)
00:35:41    at org.junit.runners.Suite.runChild(Suite.java:27)
00:35:41    at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
00:35:41    at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
00:35:41    at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
00:35:41    at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
00:35:41    at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
00:35:41    at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
00:35:41    at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
00:35:41    at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
00:35:41    at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
00:35:41    at org.junit.runner.JUnitCore.run(JUnitCore.java:105)
00:35:41    at org.junit.runner.JUnitCore.runClasses(JUnitCore.java:62)
00:35:41    at org.junit.runner.JUnitCore.runClasses(JUnitCore.java:49)
00:35:41    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
00:35:41    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
00:35:41    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
00:35:41    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
00:35:41    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
00:35:41    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
00:35:41    at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
00:35:41    at java.base/java.lang.Thread.run(Thread.java:839)
00:35:41  Caused by: junit.framework.AssertionFailedError
00:35:41    at junit.framework.Assert.fail(Assert.java:55)
00:35:41    at junit.framework.Assert.assertTrue(Assert.java:22)
00:35:41    at junit.framework.Assert.assertTrue(Assert.java:31)
00:35:41    at junit.framework.TestCase.assertTrue(TestCase.java:200)
00:35:41    at ForkJoinTask8Test.checkCompletedNormally(ForkJoinTask8Test.java:144)
00:35:41    at ForkJoinTask8Test.checkCompletedNormally(ForkJoinTask8Test.java:140)
00:35:41    at ForkJoinTask8Test$AsyncFib.checkCompletedNormally(ForkJoinTask8Test.java:362)
00:35:41    at ForkJoinTask8Test$8.realCompute(ForkJoinTask8Test.java:559)
00:35:41    at JSR166TestCase$CheckedRecursiveAction.compute(JSR166TestCase.java:1698)
00:35:41    at java.base/java.util.concurrent.RecursiveAction.exec(RecursiveAction.java:189)
00:35:41    at java.base/java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:290)
00:35:41    at java.base/java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1020)
00:35:41    at java.base/java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1656)
00:35:41    at java.base/java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1594)
00:35:41    at java.base/java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:183)
00:35:41  
00:35:41  java.lang.Exception: JUnit test failure
00:35:41    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:92)
00:35:41    at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
00:35:41    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
00:35:41    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
00:35:41    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
00:35:41    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
00:35:41    at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
00:35:41    at java.base/java.lang.Thread.run(Thread.java:839)
00:35:41  
00:35:41  JavaTest Message: Test threw exception: java.lang.Exception: JUnit test failure
00:35:41  JavaTest Message: shutting down test
00:35:41  
00:35:41  STATUS:Failed.`main' threw exception: java.lang.Exception: JUnit test failure
pshipton commented 1 year ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk17_j9_sanity.openjdk_x86-64_linux_Release/49 jdk_util_0 java/util/concurrent/tck/JSR166TestCase.java

No diagnostics.

22:06:05  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[Thread-443,5,MainThreadGroup], state=TIMED_WAITING
22:06:05  ------ stacktrace dump start ------
22:06:05  "main" prio=5 Id=1 WAITING
22:06:05    at java.base@17.0.6-internal/java.lang.Object.waitImpl(Native Method)
22:06:05    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:251)
22:06:05    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:219)
22:06:05    at java.base@17.0.6-internal/java.lang.Thread.join(Thread.java:784)
22:06:05    at java.base@17.0.6-internal/java.lang.Thread.join(Thread.java:739)
22:06:05    at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:74)
22:06:05  "JIT Compilation Thread-000" prio=10 Id=3 RUNNABLE
22:06:05  "JIT Compilation Thread-001 Suspended" prio=10 Id=4 RUNNABLE
22:06:05  "JIT Compilation Thread-002 Suspended" prio=10 Id=5 RUNNABLE
22:06:05  "JIT Compilation Thread-003 Suspended" prio=10 Id=6 RUNNABLE
22:06:05  "JIT Compilation Thread-004 Suspended" prio=10 Id=7 RUNNABLE
22:06:05  "JIT Compilation Thread-005 Suspended" prio=10 Id=8 RUNNABLE
22:06:05  "JIT Compilation Thread-006 Suspended" prio=10 Id=9 RUNNABLE
22:06:05  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=10 RUNNABLE
22:06:05  "JIT-SamplerThread" prio=10 Id=11 TIMED_WAITING
22:06:05  "IProfiler" prio=5 Id=12 RUNNABLE
22:06:05  "Concurrent Mark Helper" prio=1 Id=13 RUNNABLE
22:06:05  "Finalizer thread" prio=5 Id=14 RUNNABLE
22:06:05  "GC Worker" prio=5 Id=15 RUNNABLE
22:06:05  "GC Worker" prio=5 Id=16 RUNNABLE
22:06:05  "GC Worker" prio=5 Id=17 RUNNABLE
22:06:05  "Attach API wait loop" prio=10 Id=20 RUNNABLE
22:06:05    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
22:06:05    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
22:06:05    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
22:06:05    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
22:06:05  "MainThread" prio=5 Id=22 RUNNABLE
22:06:05    at java.management@17.0.6-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsImpl(Native Method)
22:06:05    at java.management@17.0.6-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsCommon(ThreadMXBeanImpl.java:687)
22:06:05    at java.management@17.0.6-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreads(ThreadMXBeanImpl.java:669)
22:06:05    at app//JSR166TestCase.dumpTestThreads(JSR166TestCase.java:1182)
22:06:05    at app//JSR166TestCase.threadRecordFailure(JSR166TestCase.java:813)
22:06:05    at app//JSR166TestCase.threadFail(JSR166TestCase.java:887)
22:06:05    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1653)
22:06:05    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1667)
22:06:05    at app//LockSupportTest.testParkNeg(LockSupportTest.java:403)
22:06:05    at app//LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
22:06:05    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
22:06:05    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
22:06:05    at java.base@17.0.6-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
22:06:05    at java.base@17.0.6-internal/java.lang.reflect.Method.invoke(Method.java:568)
22:06:05    at app//junit.framework.TestCase.runTest(TestCase.java:177)
22:06:05    at app//JSR166TestCase.runTest(JSR166TestCase.java:383)
22:06:05    at app//junit.framework.TestCase.runBare(TestCase.java:142)
22:06:05    at app//JSR166TestCase.runBare(JSR166TestCase.java:374)
22:06:05    at app//junit.framework.TestResult$1.protect(TestResult.java:122)
22:06:05    at app//junit.framework.TestResult.runProtected(TestResult.java:142)
22:06:05    at app//junit.framework.TestResult.run(TestResult.java:125)
22:06:05    at app//junit.framework.TestCase.run(TestCase.java:130)
22:06:05    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
22:06:05    at app//junit.framework.TestSuite.run(TestSuite.java:236)
22:06:05    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
22:06:05    at app//junit.framework.TestSuite.run(TestSuite.java:236)
22:06:05    at app//org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
22:06:05    at app//org.junit.runners.Suite.runChild(Suite.java:128)
22:06:05    at app//org.junit.runners.Suite.runChild(Suite.java:27)
22:06:05    at app//org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
22:06:05    at app//org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
22:06:05    at app//org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
22:06:05    at app//org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
22:06:05    at app//org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
22:06:05    at app//org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
22:06:05    at app//org.junit.runners.ParentRunner.run(ParentRunner.java:413)
22:06:05    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:137)
22:06:05    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:115)
22:06:05    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:105)
22:06:05    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:62)
22:06:05    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:49)
22:06:05    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
22:06:05    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
22:06:05    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
22:06:05    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
22:06:05    at java.base@17.0.6-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
22:06:05    at java.base@17.0.6-internal/java.lang.reflect.Method.invoke(Method.java:568)
22:06:05    at app//com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
22:06:05    at java.base@17.0.6-internal/java.lang.Thread.run(Thread.java:857)
22:06:05  "ClassByNameCache Reaper" prio=5 Id=467 WAITING
22:06:05    at java.base@17.0.6-internal/java.lang.Object.waitImpl(Native Method)
22:06:05    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:251)
22:06:05    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:219)
22:06:05    at java.base@17.0.6-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
22:06:05    at java.base@17.0.6-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:109)
22:06:05    at java.base@17.0.6-internal/java.io.ClassByNameCache$Reaper.run(ClassByNameCache.java:232)
22:06:05    at java.base@17.0.6-internal/java.lang.Thread.run(Thread.java:857)
22:06:05  "Thread-443" prio=5 Id=1178 TIMED_WAITING
22:06:05    at java.base@17.0.6-internal/jdk.internal.misc.Unsafe.park(Native Method)
22:06:05    at java.base@17.0.6-internal/java.util.concurrent.locks.LockSupport.parkUntil(LockSupport.java:410)
22:06:05    at app//LockSupportTest$ParkMethod$2.park(LockSupportTest.java:78)
22:06:05    at app//LockSupportTest$8.realRun(LockSupportTest.java:400)
22:06:05    at app//JSR166TestCase$CheckedRunnable.run(JSR166TestCase.java:1677)
22:06:05    at java.base@17.0.6-internal/java.lang.Thread.run(Thread.java:857)
22:06:05  ------ stacktrace dump end ------
22:06:05  JavaTest Message: JUnit Failure: testParkNeg_parkUntil(LockSupportTest): timed out waiting for thread to terminate, thread=Thread[Thread-443,5,MainThreadGroup], state=TIMED_WAITING
22:06:05  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[Thread-443,5,MainThreadGroup], state=TIMED_WAITING
22:06:05    at junit.framework.Assert.fail(Assert.java:57)
22:06:05    at junit.framework.TestCase.fail(TestCase.java:223)
22:06:05    at JSR166TestCase.threadFail(JSR166TestCase.java:885)
22:06:05    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1653)
22:06:05    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1667)
22:06:05    at LockSupportTest.testParkNeg(LockSupportTest.java:403)
22:06:05    at LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
pshipton commented 1 year ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk17_j9_sanity.openjdk_x86-64_linux_Release/52 - cent7-x64-6 jdk_util_0 java/util/concurrent/tck/JSR166TestCase.java

No diagnostics.

22:12:32  ------ stacktrace dump start ------
22:12:32  "main" prio=5 Id=1 WAITING
22:12:32    at java.base@17.0.6-internal/java.lang.Object.waitImpl(Native Method)
22:12:32    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:251)
22:12:32    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:219)
22:12:32    at java.base@17.0.6-internal/java.lang.Thread.join(Thread.java:784)
22:12:32    at java.base@17.0.6-internal/java.lang.Thread.join(Thread.java:739)
22:12:32    at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:74)
22:12:32  "JIT Compilation Thread-000" prio=10 Id=3 RUNNABLE
22:12:32  "JIT Compilation Thread-001 Suspended" prio=10 Id=4 RUNNABLE
22:12:32  "JIT Compilation Thread-002 Suspended" prio=10 Id=5 RUNNABLE
22:12:32  "JIT Compilation Thread-003 Suspended" prio=10 Id=6 RUNNABLE
22:12:32  "JIT Compilation Thread-004 Suspended" prio=10 Id=7 RUNNABLE
22:12:32  "JIT Compilation Thread-005 Suspended" prio=10 Id=8 RUNNABLE
22:12:32  "JIT Compilation Thread-006 Suspended" prio=10 Id=9 RUNNABLE
22:12:32  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=10 RUNNABLE
22:12:32  "JIT-SamplerThread" prio=10 Id=11 TIMED_WAITING
22:12:32  "IProfiler" prio=5 Id=12 RUNNABLE
22:12:32  "Finalizer thread" prio=5 Id=13 RUNNABLE
22:12:32  "Concurrent Mark Helper" prio=1 Id=14 RUNNABLE
22:12:32  "GC Worker" prio=5 Id=15 RUNNABLE
22:12:32  "GC Worker" prio=5 Id=16 RUNNABLE
22:12:32  "GC Worker" prio=5 Id=17 RUNNABLE
22:12:32  "Attach API wait loop" prio=10 Id=20 RUNNABLE
22:12:32    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
22:12:32    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
22:12:32    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
22:12:32    at java.base@17.0.6-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
22:12:32  "MainThread" prio=5 Id=22 RUNNABLE
22:12:32    at java.management@17.0.6-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsImpl(Native Method)
22:12:32    at java.management@17.0.6-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsCommon(ThreadMXBeanImpl.java:687)
22:12:32    at java.management@17.0.6-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreads(ThreadMXBeanImpl.java:669)
22:12:32    at app//JSR166TestCase.dumpTestThreads(JSR166TestCase.java:1182)
22:12:32    at app//JSR166TestCase.threadRecordFailure(JSR166TestCase.java:813)
22:12:32    at app//JSR166TestCase.threadFail(JSR166TestCase.java:887)
22:12:32    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1653)
22:12:32    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1667)
22:12:32    at app//LockSupportTest.testParkNeg(LockSupportTest.java:403)
22:12:32    at app//LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
22:12:32    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
22:12:32    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
22:12:32    at java.base@17.0.6-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
22:12:32    at java.base@17.0.6-internal/java.lang.reflect.Method.invoke(Method.java:568)
22:12:32    at app//junit.framework.TestCase.runTest(TestCase.java:177)
22:12:32    at app//JSR166TestCase.runTest(JSR166TestCase.java:383)
22:12:32    at app//junit.framework.TestCase.runBare(TestCase.java:142)
22:12:32    at app//JSR166TestCase.runBare(JSR166TestCase.java:374)
22:12:32    at app//junit.framework.TestResult$1.protect(TestResult.java:122)
22:12:32    at app//junit.framework.TestResult.runProtected(TestResult.java:142)
22:12:32    at app//junit.framework.TestResult.run(TestResult.java:125)
22:12:32    at app//junit.framework.TestCase.run(TestCase.java:130)
22:12:32    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
22:12:32    at app//junit.framework.TestSuite.run(TestSuite.java:236)
22:12:32    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
22:12:32    at app//junit.framework.TestSuite.run(TestSuite.java:236)
22:12:32    at app//org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
22:12:32    at app//org.junit.runners.Suite.runChild(Suite.java:128)
22:12:32    at app//org.junit.runners.Suite.runChild(Suite.java:27)
22:12:32    at app//org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
22:12:32    at app//org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
22:12:32    at app//org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
22:12:32    at app//org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
22:12:32    at app//org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
22:12:32    at app//org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
22:12:32    at app//org.junit.runners.ParentRunner.run(ParentRunner.java:413)
22:12:32    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:137)
22:12:32    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:115)
22:12:32    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:105)
22:12:32    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:62)
22:12:32    at app//org.junit.runner.JUnitCore.runClasses(JUnitCore.java:49)
22:12:32    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
22:12:32    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
22:12:32    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
22:12:32    at java.base@17.0.6-internal/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
22:12:32    at java.base@17.0.6-internal/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
22:12:32    at java.base@17.0.6-internal/java.lang.reflect.Method.invoke(Method.java:568)
22:12:32    at app//com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
22:12:32    at java.base@17.0.6-internal/java.lang.Thread.run(Thread.java:857)
22:12:32  "ClassByNameCache Reaper" prio=5 Id=463 WAITING
22:12:32    at java.base@17.0.6-internal/java.lang.Object.waitImpl(Native Method)
22:12:32    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:251)
22:12:32    at java.base@17.0.6-internal/java.lang.Object.wait(Object.java:219)
22:12:32    at java.base@17.0.6-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
22:12:32    at java.base@17.0.6-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:109)
22:12:32    at java.base@17.0.6-internal/java.io.ClassByNameCache$Reaper.run(ClassByNameCache.java:232)
22:12:32    at java.base@17.0.6-internal/java.lang.Thread.run(Thread.java:857)
22:12:32  "Thread-364" prio=5 Id=1111 TIMED_WAITING
22:12:32    at java.base@17.0.6-internal/jdk.internal.misc.Unsafe.park(Native Method)
22:12:32    at java.base@17.0.6-internal/java.util.concurrent.locks.LockSupport.parkUntil(LockSupport.java:410)
22:12:32    at app//LockSupportTest$ParkMethod$2.park(LockSupportTest.java:78)
22:12:32    at app//LockSupportTest$8.realRun(LockSupportTest.java:400)
22:12:32    at app//JSR166TestCase$CheckedRunnable.run(JSR166TestCase.java:1677)
22:12:32    at java.base@17.0.6-internal/java.lang.Thread.run(Thread.java:857)
22:12:32  ------ stacktrace dump end ------
22:12:32  JavaTest Message: JUnit Failure: testParkNeg_parkUntil(LockSupportTest): timed out waiting for thread to terminate, thread=Thread[Thread-364,5,MainThreadGroup], state=TIMED_WAITING
22:12:32  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[Thread-364,5,MainThreadGroup], state=TIMED_WAITING
22:12:32    at junit.framework.Assert.fail(Assert.java:57)
22:12:32    at junit.framework.TestCase.fail(TestCase.java:223)
22:12:32    at JSR166TestCase.threadFail(JSR166TestCase.java:885)
22:12:32    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1653)
22:12:32    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1667)
22:12:32    at LockSupportTest.testParkNeg(LockSupportTest.java:403)
22:12:32    at LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
JasonFengJ9 commented 1 year ago

JDK19 ppc64le_linux internal build(pll021)

openjdk version "19.0.2-beta" 2023-01-17
IBM Semeru Runtime Open Edition 19.0.2+7-202302280045 (build 19.0.2-beta+7-202302280045)
Eclipse OpenJ9 VM 19.0.2+7-202302280045 (build master-9bf20a075, JRE 19 Linux ppc64le-64-Bit Compressed References 20230227_52 (JIT enabled, AOT enabled)
OpenJ9   - 9bf20a075
OMR      - 084e87a92
JCL      - 3c83ead7fc based on jdk-19.0.2+7)

[2023-02-28T04:48:32.836Z] variation: -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache Mode650
[2023-02-28T04:48:32.837Z] JVM_OPTIONS:  -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:-UseCompressedOops 

[2023-02-28T04:55:12.450Z] TEST: java/util/concurrent/tck/JSR166TestCase.java

[2023-02-28T04:55:12.457Z] JavaTest Message: JUnit Failure: testParkNeg_parkUntilBlocker(LockSupportTest): timed out waiting for thread to terminate, thread=Thread[#1164,Thread-432,5,MainThreadGroup], state=TIMED_WAITING
[2023-02-28T04:55:12.457Z] junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[#1164,Thread-432,5,MainThreadGroup], state=TIMED_WAITING
[2023-02-28T04:55:12.457Z]  at junit.framework.Assert.fail(Assert.java:57)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestCase.fail(TestCase.java:223)
[2023-02-28T04:55:12.457Z]  at JSR166TestCase.threadFail(JSR166TestCase.java:898)
[2023-02-28T04:55:12.457Z]  at JSR166TestCase.awaitTermination(JSR166TestCase.java:1674)
[2023-02-28T04:55:12.457Z]  at JSR166TestCase.awaitTermination(JSR166TestCase.java:1688)
[2023-02-28T04:55:12.457Z]  at LockSupportTest.testParkNeg(LockSupportTest.java:403)
[2023-02-28T04:55:12.457Z]  at LockSupportTest.testParkNeg_parkUntilBlocker(LockSupportTest.java:395)
[2023-02-28T04:55:12.457Z]  at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
[2023-02-28T04:55:12.457Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:578)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestCase.runTest(TestCase.java:177)
[2023-02-28T04:55:12.457Z]  at JSR166TestCase.runTest(JSR166TestCase.java:382)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestCase.runBare(TestCase.java:142)
[2023-02-28T04:55:12.457Z]  at JSR166TestCase.runBare(JSR166TestCase.java:373)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestResult$1.protect(TestResult.java:122)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestResult.runProtected(TestResult.java:142)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestResult.run(TestResult.java:125)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestCase.run(TestCase.java:130)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestSuite.runTest(TestSuite.java:241)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestSuite.run(TestSuite.java:236)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestSuite.runTest(TestSuite.java:241)
[2023-02-28T04:55:12.457Z]  at junit.framework.TestSuite.run(TestSuite.java:236)
[2023-02-28T04:55:12.457Z]  at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.Suite.runChild(Suite.java:128)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.Suite.runChild(Suite.java:27)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
[2023-02-28T04:55:12.457Z]  at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
[2023-02-28T04:55:12.457Z]  at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
[2023-02-28T04:55:12.457Z]  at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
[2023-02-28T04:55:12.457Z]  at org.junit.runner.JUnitCore.run(JUnitCore.java:105)
[2023-02-28T04:55:12.457Z]  at org.junit.runner.JUnitCore.runClasses(JUnitCore.java:62)
[2023-02-28T04:55:12.458Z]  at org.junit.runner.JUnitCore.runClasses(JUnitCore.java:49)
[2023-02-28T04:55:12.458Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:76)
[2023-02-28T04:55:12.458Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
[2023-02-28T04:55:12.458Z]  at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
[2023-02-28T04:55:12.458Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:578)
[2023-02-28T04:55:12.458Z]  at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
[2023-02-28T04:55:12.458Z]  at java.base/java.lang.Thread.run(Thread.java:1573)
[2023-02-28T04:55:12.458Z] 
[2023-02-28T04:55:12.458Z] java.lang.Exception: JUnit test failure
[2023-02-28T04:55:12.458Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:92)
[2023-02-28T04:55:12.458Z]  at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:43)
[2023-02-28T04:55:12.458Z]  at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
[2023-02-28T04:55:12.458Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:578)
[2023-02-28T04:55:12.458Z]  at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
[2023-02-28T04:55:12.458Z]  at java.base/java.lang.Thread.run(Thread.java:1573)
[2023-02-28T04:55:12.458Z] 
[2023-02-28T04:55:12.458Z] JavaTest Message: Test threw exception: java.lang.Exception: JUnit test failure

[2023-02-28T05:07:17.658Z] jdk_util_1_FAILED

Also seen at s390x_linux

JasonFengJ9 commented 1 year ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk11_j9_sanity.openjdk_aarch64_linux_Nightly/383/consoleFull

23:45:34  variation: -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache Mode650
23:45:34  JVM_OPTIONS:  -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:-UseCompressedOops 

23:49:44  TEST: java/util/concurrent/tck/JSR166TestCase.java

23:49:44  ACTION: junit -- Failed. Execution failed: `main' threw exception: junit.framework.AssertionFailedError: should throw InterruptedException

23:49:44  STDERR:
23:49:44  junit.framework.AssertionFailedError: timed out waiting for thread to terminate

23:49:44  TEST RESULT: Failed. Execution failed: `main' threw exception: junit.framework.AssertionFailedError: should throw InterruptedException
23:49:44  --------------------------------------------------
00:03:37  Test results: passed: 848; failed: 1
00:03:46  Report written to /home/jenkins/workspace/Test_openjdk11_j9_sanity.openjdk_aarch64_linux_Nightly/aqa-tests/TKG/output_16784209869254/jdk_util_1/report/html/report.html
00:03:46  Results written to /home/jenkins/workspace/Test_openjdk11_j9_sanity.openjdk_aarch64_linux_Nightly/aqa-tests/TKG/output_16784209869254/jdk_util_1/work
00:03:46  Error: Some tests failed or other problems occurred.
00:03:46  -----------------------------------
00:03:46  jdk_util_1_FAILED
pshipton commented 5 months ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk22_j9_sanity.openjdk_s390x_linux_Nightly_testList_1/42 - ub20-390-2 jdk_util_0 java/util/concurrent/tck/JSR166TestCase.java#forkjoinpool-common-parallelism

02:00:57  STARTED    LockSupportTest::testParkNeg_parkUntilBlocker 'testParkNeg_parkUntilBlocker'
02:00:57  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[#1176,Thread-437,5,jsr1666TestThreadGroup], state=TIMED_WAITING
02:00:57  ------ stacktrace dump start ------
02:00:57  "main" prio=5 Id=2 WAITING
02:00:57    at java.base@22-internal/java.lang.Object.waitImpl(Native Method)
02:00:57    at java.base@22-internal/java.lang.Object.wait(Object.java:255)
02:00:57    at java.base@22-internal/java.lang.Object.wait(Object.java:221)
02:00:57    at java.base@22-internal/java.lang.Thread.join(Thread.java:2069)
02:00:57    at java.base@22-internal/java.lang.Thread.join(Thread.java:2145)
02:00:57    at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:85)
02:00:57  "JIT Compilation Thread-000" prio=10 Id=4 RUNNABLE
02:00:57  "JIT Compilation Thread-001 Suspended" prio=10 Id=5 RUNNABLE
02:00:57  "JIT Compilation Thread-002 Suspended" prio=10 Id=6 RUNNABLE
02:00:57  "JIT Compilation Thread-003 Suspended" prio=10 Id=7 RUNNABLE
02:00:57  "JIT Compilation Thread-004 Suspended" prio=10 Id=8 RUNNABLE
02:00:57  "JIT Compilation Thread-005 Suspended" prio=10 Id=9 RUNNABLE
02:00:57  "JIT Compilation Thread-006 Suspended" prio=10 Id=10 RUNNABLE
02:00:57  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=11 RUNNABLE
02:00:57  "JIT-SamplerThread" prio=10 Id=12 TIMED_WAITING
02:00:57  "IProfiler" prio=5 Id=13 RUNNABLE
02:00:57  "Finalizer thread" prio=5 Id=14 RUNNABLE
02:00:57  "Concurrent Mark Helper" prio=1 Id=15 RUNNABLE
02:00:57  "GC Worker" prio=5 Id=16 RUNNABLE
02:00:57  "GC Worker" prio=5 Id=17 RUNNABLE
02:00:57  "GC Worker" prio=5 Id=18 RUNNABLE
02:00:57  "Attach API update file access time" prio=5 Id=21 TIMED_WAITING
02:00:57    at java.base@22-internal/java.lang.Thread.sleepImpl(Native Method)
02:00:57    at java.base@22-internal/java.lang.Thread.sleepNanos(Thread.java:498)
02:00:57    at java.base@22-internal/java.lang.Thread.sleep(Thread.java:529)
02:00:57    at java.base@22-internal/openj9.internal.tools.attach.target.AttachHandler$1.run(AttachHandler.java:348)
02:00:57  "Attach API wait loop" prio=10 Id=22 RUNNABLE
02:00:57    at java.base@22-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
02:00:57    at java.base@22-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
02:00:57    at java.base@22-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
02:00:57    at java.base@22-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
02:00:57  "MainThread" prio=5 Id=23 RUNNABLE
02:00:57    at java.management@22-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsImpl(Native Method)
02:00:57    at java.management@22-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsCommon(ThreadMXBeanImpl.java:693)
02:00:57    at java.management@22-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreads(ThreadMXBeanImpl.java:675)
02:00:57    at app//JSR166TestCase.dumpTestThreads(JSR166TestCase.java:1229)
02:00:57    at app//JSR166TestCase.threadRecordFailure(JSR166TestCase.java:859)
02:00:57    at app//JSR166TestCase.threadFail(JSR166TestCase.java:933)
02:00:57    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1718)
02:00:57    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1732)
02:00:57    at app//LockSupportTest.testParkNeg(LockSupportTest.java:403)
02:00:57    at app//LockSupportTest.testParkNeg_parkUntilBlocker(LockSupportTest.java:395)
02:00:57    at java.base@22-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
02:00:57    at java.base@22-internal/java.lang.reflect.Method.invoke(Method.java:586)
02:00:57    at app//junit.framework.TestCase.runTest(TestCase.java:177)
02:00:57    at app//JSR166TestCase.runTest(JSR166TestCase.java:406)
02:00:57    at app//junit.framework.TestCase.runBare(TestCase.java:142)
02:00:57    at app//JSR166TestCase.runBare(JSR166TestCase.java:397)
02:00:57    at app//junit.framework.TestResult$1.protect(TestResult.java:122)
02:00:57    at app//junit.framework.TestResult.runProtected(TestResult.java:142)
02:00:57    at app//junit.framework.TestResult.run(TestResult.java:125)
02:00:57    at app//junit.framework.TestCase.run(TestCase.java:130)
02:00:57    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
02:00:57    at app//junit.framework.TestSuite.run(TestSuite.java:236)
02:00:57    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
02:00:57    at app//junit.framework.TestSuite.run(TestSuite.java:236)
02:00:57    at app//org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
02:00:57    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:137)
02:00:57    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:115)
02:00:57    at app//org.junit.vintage.engine.execution.RunnerExecutor.execute(RunnerExecutor.java:42)
02:00:57    at app//org.junit.vintage.engine.VintageTestEngine.executeAllChildren(VintageTestEngine.java:80)
02:00:57    at app//org.junit.vintage.engine.VintageTestEngine.execute(VintageTestEngine.java:72)
02:00:57    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147)
02:00:57    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127)
02:00:57    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90)
02:00:57    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55)
02:00:57    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102)
02:00:57    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54)
02:00:57    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114)
02:00:57    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86)
02:00:57    at app//org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86)
02:00:57    at app//com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142)
02:00:57    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95)
02:00:57    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:61)
02:00:57    at java.base@22-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
02:00:57    at java.base@22-internal/java.lang.reflect.Method.invoke(Method.java:586)
02:00:57    at app//com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138)
02:00:57    at java.base@22-internal/java.lang.Thread.run(Thread.java:1582)
02:00:57  "ClassByNameCache Reaper" prio=5 Id=456 WAITING
02:00:57    at java.base@22-internal/java.lang.Object.waitImpl(Native Method)
02:00:57    at java.base@22-internal/java.lang.Object.wait(Object.java:255)
02:00:57    at java.base@22-internal/java.lang.Object.wait(Object.java:221)
02:00:57    at java.base@22-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
02:00:57    at java.base@22-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:109)
02:00:57    at java.base@22-internal/java.io.ClassByNameCache$Reaper.run(ClassByNameCache.java:232)
02:00:57    at java.base@22-internal/java.lang.Thread.run(Thread.java:1582)
02:00:57  "Thread-437" prio=5 Id=1176 TIMED_WAITING
02:00:57    at java.base@22-internal/jdk.internal.misc.Unsafe.park(Native Method)
02:00:57    at java.base@22-internal/java.util.concurrent.locks.LockSupport.parkUntil(LockSupport.java:317)
02:00:57    at app//LockSupportTest$ParkMethod$5.park(LockSupportTest.java:94)
02:00:57    at app//LockSupportTest$8.realRun(LockSupportTest.java:400)
02:00:57    at app//JSR166TestCase$CheckedRunnable.run(JSR166TestCase.java:1742)
02:00:57    at java.base@22-internal/java.lang.Thread.run(Thread.java:1582)
02:00:57  ------ stacktrace dump end ------
02:00:57  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[#1176,Thread-437,5,jsr1666TestThreadGroup], state=TIMED_WAITING
02:00:57    at junit.framework.Assert.fail(Assert.java:57)
02:00:57    at junit.framework.TestCase.fail(TestCase.java:223)
02:00:57    at JSR166TestCase.threadFail(JSR166TestCase.java:931)
02:00:57    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1718)
02:00:57    at JSR166TestCase.awaitTermination(JSR166TestCase.java:1732)
02:00:57    at LockSupportTest.testParkNeg(LockSupportTest.java:403)
02:00:57    at LockSupportTest.testParkNeg_parkUntilBlocker(LockSupportTest.java:395)
pshipton commented 4 months ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk22_j9_sanity.openjdk_x86-64_linux_Release_testList_2/8/ jdk_util_1 java/util/concurrent/tck/JSR166TestCase.java#others

https://openj9-artifactory.osuosl.org/artifactory/ci-openj9/Test/Test_openjdk22_j9_sanity.openjdk_x86-64_linux_Release_testList_2/8/openjdk_test_output.tar.gz

12:26:12  STARTED    LockSupportTest::testParkNeg_parkUntil 'testParkNeg_parkUntil'
12:26:12  junit.framework.AssertionFailedError: timed out waiting for thread to terminate, thread=Thread[#1101,Thread-362,5,jsr1666TestThreadGroup], state=TIMED_WAITING
12:26:12  ------ stacktrace dump start ------
12:26:12  "main" prio=5 Id=2 WAITING
12:26:12    at java.base@22-internal/java.lang.Object.waitImpl(Native Method)
12:26:12    at java.base@22-internal/java.lang.Object.wait(Object.java:255)
12:26:12    at java.base@22-internal/java.lang.Object.wait(Object.java:221)
12:26:12    at java.base@22-internal/java.lang.Thread.join(Thread.java:2069)
12:26:12    at java.base@22-internal/java.lang.Thread.join(Thread.java:2145)
12:26:12    at app//com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:85)
12:26:12  "JIT Compilation Thread-000" prio=10 Id=4 RUNNABLE
12:26:12  "JIT Compilation Thread-001 Suspended" prio=10 Id=5 RUNNABLE
12:26:12  "JIT Compilation Thread-002 Suspended" prio=10 Id=6 RUNNABLE
12:26:12  "JIT Compilation Thread-003 Suspended" prio=10 Id=7 RUNNABLE
12:26:12  "JIT Compilation Thread-004 Suspended" prio=10 Id=8 RUNNABLE
12:26:12  "JIT Compilation Thread-005 Suspended" prio=10 Id=9 RUNNABLE
12:26:12  "JIT Compilation Thread-006 Suspended" prio=10 Id=10 RUNNABLE
12:26:12  "JIT Diagnostic Compilation Thread-007 Suspended" prio=10 Id=11 RUNNABLE
12:26:12  "JIT-SamplerThread" prio=10 Id=12 TIMED_WAITING
12:26:12  "IProfiler" prio=5 Id=13 RUNNABLE
12:26:12  "Finalizer thread" prio=5 Id=14 RUNNABLE
12:26:12  "Concurrent Mark Helper" prio=1 Id=15 RUNNABLE
12:26:12  "GC Worker" prio=5 Id=16 RUNNABLE
12:26:12  "GC Worker" prio=5 Id=17 RUNNABLE
12:26:12  "GC Worker" prio=5 Id=18 RUNNABLE
12:26:12  "Attach API update file access time" prio=5 Id=21 TIMED_WAITING
12:26:12    at java.base@22-internal/java.lang.Thread.sleepImpl(Native Method)
12:26:12    at java.base@22-internal/java.lang.Thread.sleepNanos(Thread.java:498)
12:26:12    at java.base@22-internal/java.lang.Thread.sleep(Thread.java:529)
12:26:12    at java.base@22-internal/openj9.internal.tools.attach.target.AttachHandler$1.run(AttachHandler.java:348)
12:26:12  "Attach API wait loop" prio=10 Id=22 RUNNABLE
12:26:12    at java.base@22-internal/openj9.internal.tools.attach.target.IPC.waitSemaphore(Native Method)
12:26:12    at java.base@22-internal/openj9.internal.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:264)
12:26:12    at java.base@22-internal/openj9.internal.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
12:26:12    at java.base@22-internal/openj9.internal.tools.attach.target.WaitLoop.run(WaitLoop.java:157)
12:26:12  "MainThread" prio=5 Id=23 RUNNABLE
12:26:12    at java.management@22-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsImpl(Native Method)
12:26:12    at java.management@22-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreadsCommon(ThreadMXBeanImpl.java:693)
12:26:12    at java.management@22-internal/com.ibm.java.lang.management.internal.ThreadMXBeanImpl.dumpAllThreads(ThreadMXBeanImpl.java:675)
12:26:12    at app//JSR166TestCase.dumpTestThreads(JSR166TestCase.java:1229)
12:26:12    at app//JSR166TestCase.threadRecordFailure(JSR166TestCase.java:859)
12:26:12    at app//JSR166TestCase.threadFail(JSR166TestCase.java:933)
12:26:12    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1718)
12:26:12    at app//JSR166TestCase.awaitTermination(JSR166TestCase.java:1732)
12:26:12    at app//LockSupportTest.testParkNeg(LockSupportTest.java:403)
12:26:12    at app//LockSupportTest.testParkNeg_parkUntil(LockSupportTest.java:389)
12:26:12    at java.base@22-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
12:26:12    at java.base@22-internal/java.lang.reflect.Method.invoke(Method.java:586)
12:26:12    at app//junit.framework.TestCase.runTest(TestCase.java:177)
12:26:12    at app//JSR166TestCase.runTest(JSR166TestCase.java:406)
12:26:12    at app//junit.framework.TestCase.runBare(TestCase.java:142)
12:26:12    at app//JSR166TestCase.runBare(JSR166TestCase.java:397)
12:26:12    at app//junit.framework.TestResult$1.protect(TestResult.java:122)
12:26:12    at app//junit.framework.TestResult.runProtected(TestResult.java:142)
12:26:12    at app//junit.framework.TestResult.run(TestResult.java:125)
12:26:12    at app//junit.framework.TestCase.run(TestCase.java:130)
12:26:12    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
12:26:12    at app//junit.framework.TestSuite.run(TestSuite.java:236)
12:26:12    at app//junit.framework.TestSuite.runTest(TestSuite.java:241)
12:26:12    at app//junit.framework.TestSuite.run(TestSuite.java:236)
12:26:12    at app//org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90)
12:26:12    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:137)
12:26:12    at app//org.junit.runner.JUnitCore.run(JUnitCore.java:115)
12:26:12    at app//org.junit.vintage.engine.execution.RunnerExecutor.execute(RunnerExecutor.java:42)
12:26:12    at app//org.junit.vintage.engine.VintageTestEngine.executeAllChildren(VintageTestEngine.java:80)
12:26:12    at app//org.junit.vintage.engine.VintageTestEngine.execute(VintageTestEngine.java:72)
12:26:12    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147)
12:26:12    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127)
12:26:12    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90)
12:26:12    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55)
12:26:12    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102)
12:26:12    at app//org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54)
12:26:12    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114)
12:26:12    at app//org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86)
12:26:12    at app//org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86)
12:26:12    at app//com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142)
12:26:12    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95)
12:26:12    at app//com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:61)
12:26:12    at java.base@22-internal/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
12:26:12    at java.base@22-internal/java.lang.reflect.Method.invoke(Method.java:586)
12:26:12    at app//com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138)
12:26:12    at java.base@22-internal/java.lang.Thread.run(Thread.java:1582)
12:26:12  "ClassByNameCache Reaper" prio=5 Id=459 WAITING
12:26:12    at java.base@22-internal/java.lang.Object.waitImpl(Native Method)
12:26:12    at java.base@22-internal/java.lang.Object.wait(Object.java:255)
12:26:12    at java.base@22-internal/java.lang.Object.wait(Object.java:221)
12:26:12    at java.base@22-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:137)
12:26:12    at java.base@22-internal/java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:109)
12:26:12    at java.base@22-internal/java.io.ClassByNameCache$Reaper.run(ClassByNameCache.java:232)
12:26:12    at java.base@22-internal/java.lang.Thread.run(Thread.java:1582)
12:26:12  "Thread-362" prio=5 Id=1101 TIMED_WAITING
12:26:12    at java.base@22-internal/jdk.internal.misc.Unsafe.park(Native Method)
12:26:12    at java.base@22-internal/java.util.concurrent.locks.LockSupport.parkUntil(LockSupport.java:449)
12:26:12    at app//LockSupportTest$ParkMethod$2.park(LockSupportTest.java:78)
12:26:12    at app//LockSupportTest$8.realRun(LockSupportTest.java:400)
12:26:12    at app//JSR166TestCase$CheckedRunnable.run(JSR166TestCase.java:1742)
12:26:12    at java.base@22-internal/java.lang.Thread.run(Thread.java:1582)
12:26:12  ------ stacktrace dump end ------
pshipton commented 1 week ago

https://openj9-jenkins.osuosl.org/job/Test_openjdk23_j9_sanity.openjdk_x86-64_linux_OpenJDK23_testList_0/5 jdk_util_1 java/util/concurrent/tck/JSR166TestCase.java#forkjoinpool-common-parallelism