openj9
openj9 copied to clipboard
Published
20 hours ago •
eclipse-openj9
eclipse-openj9
OpenJDK java/util/logging/LogManager/Configuration/TestConfigurationLock.java Found deadlocked threads
https://openj9-jenkins.osuosl.org/job/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/270 jdk_util_0 java/util/logging/LogManager/Configuration/TestConfigurationLock.java
No diagnostic files (core, java, etc)
21:24:26 ACTION: main -- Failed. Unexpected exit from test [exit code: 255]
21:24:26 REASON: User specified action: run main/othervm -Djava.security.manager=allow TestConfigurationLock
21:24:26 TIME: 1.615 seconds
21:24:26 messages:
21:24:26 command: main -Djava.security.manager=allow TestConfigurationLock
21:24:26 reason: User specified action: run main/othervm -Djava.security.manager=allow TestConfigurationLock
21:24:26 Mode: othervm [/othervm specified]
21:24:26 Additional options from @modules: --add-modules java.logging,java.management
21:24:26 elapsed time (seconds): 1.615
21:24:26 configuration:
21:24:26 Boot Layer
21:24:26 add modules: java.logging java.management
21:24:26
21:24:26 STDOUT:
21:24:26 No security
21:24:26 STDERR:
21:24:26 Jul. 20, 2022 9:24:15 P.M. TestConfigurationLock$Stopper run
21:24:26 INFO: 7967ms remaining...
21:24:26 Jul. 20, 2022 9:24:16 P.M. TestConfigurationLock$Stopper run
21:24:26 INFO: 6927ms remaining...
21:24:26 Found 6 deadlocked threads:
21:24:26 "Thread-4" daemon prio=5 Id=35 RUNNABLE
21:24:26 at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:279)
21:24:26 at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197)
21:24:26 at java.base/java.util.ArrayList$ArrayListSpliterator.tryAdvance(ArrayList.java:1602)
21:24:26 at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:129)
21:24:26 at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:540)
21:24:26 at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:526)
21:24:26 at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:512)
21:24:26 at java.base/java.util.stream.FindOps$FindOp.evaluateSequential(FindOps.java:150)
21:24:26 at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:239)
21:24:26 at java.base/java.util.stream.ReferencePipeline.findFirst(ReferencePipeline.java:647)
21:24:26 at java.logging/java.util.logging.Level$KnownLevel.findByName(Level.java:657)
21:24:26 - locked java.lang.Class@44b5a5e7
21:24:26 at java.logging/java.util.logging.Level.findLevel(Level.java:382)
21:24:26 at java.logging/java.util.logging.LogManager.createLoggerHandlers(LogManager.java:1011)
21:24:26 at java.logging/java.util.logging.LogManager$4.run(LogManager.java:975)
21:24:26 at java.logging/java.util.logging.LogManager$4.run(LogManager.java:971)
21:24:26 at java.base/java.security.AccessController.doPrivileged(AccessController.java:692)
21:24:26 at java.logging/java.util.logging.LogManager.loadLoggerHandlers(LogManager.java:971)
21:24:26 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2424)
21:24:26 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2526)
21:24:26 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2090)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:977)
21:24:26 at java.logging/java.util.logging.Logger.doLog(Logger.java:1007)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:1030)
21:24:26 at java.logging/java.util.logging.Logger.fine(Logger.java:1829)
21:24:26 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:254)
21:24:26
21:24:26 Number of locked synchronizers = 1
21:24:26 - java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49
21:24:26
21:24:26
21:24:26 "Thread-5" daemon prio=5 Id=36 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49 owned by "Thread-4" Id=35 (in native)
21:24:26 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
21:24:26 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49
21:24:26 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:211)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:715)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:938)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock$Sync.lock(ReentrantLock.java:153)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:322)
21:24:26 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2414)
21:24:26 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2526)
21:24:26 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2090)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:977)
21:24:26 at java.logging/java.util.logging.Logger.doLog(Logger.java:1007)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:1030)
21:24:26 at java.logging/java.util.logging.Logger.fine(Logger.java:1829)
21:24:26 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:254)
21:24:26
21:24:26
21:24:26 "Thread-6" daemon prio=5 Id=37 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49 owned by "Thread-4" Id=35 (in native)
21:24:26 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
21:24:26 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49
21:24:26 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:211)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:715)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:938)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock$Sync.lock(ReentrantLock.java:153)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:322)
21:24:26 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2414)
21:24:26 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2526)
21:24:26 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2090)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:977)
21:24:26 at java.logging/java.util.logging.Logger.doLog(Logger.java:1007)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:1030)
21:24:26 at java.logging/java.util.logging.Logger.fine(Logger.java:1829)
21:24:26 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:254)
21:24:26
21:24:26
21:24:26 "Thread-7" daemon prio=5 Id=38 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49 owned by "Thread-4" Id=35 (in native)
21:24:26 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
21:24:26 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49
21:24:26 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:211)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:715)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:938)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock$Sync.lock(ReentrantLock.java:153)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:322)
21:24:26 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2414)
21:24:26 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2526)
21:24:26 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2090)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:977)
21:24:26 at java.logging/java.util.logging.Logger.doLog(Logger.java:1007)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:1030)
21:24:26 at java.logging/java.util.logging.Logger.fine(Logger.java:1829)
21:24:26 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:287)
21:24:26
21:24:26
21:24:26 "Thread-8" daemon prio=5 Id=39 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49 owned by "Thread-4" Id=35 (in native)
21:24:26 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
21:24:26 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49
21:24:26 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:211)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:715)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:938)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock$Sync.lock(ReentrantLock.java:153)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:322)
21:24:26 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2414)
21:24:26 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2526)
21:24:26 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2090)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:977)
21:24:26 at java.logging/java.util.logging.Logger.doLog(Logger.java:1007)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:1030)
21:24:26 at java.logging/java.util.logging.Logger.fine(Logger.java:1829)
21:24:26 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:287)
21:24:26
21:24:26
21:24:26 "Thread-10" daemon prio=5 Id=41 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49 owned by "Thread-4" Id=35 (in native)
21:24:26 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
21:24:26 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@e5207b49
21:24:26 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:211)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:715)
21:24:26 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:938)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock$Sync.lock(ReentrantLock.java:153)
21:24:26 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:322)
21:24:26 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2414)
21:24:26 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2526)
21:24:26 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2090)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:977)
21:24:26 at java.logging/java.util.logging.Logger.doLog(Logger.java:1007)
21:24:26 at java.logging/java.util.logging.Logger.log(Logger.java:1030)
21:24:26 at java.logging/java.util.logging.Logger.fine(Logger.java:1829)
21:24:26 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:287)
21:24:26
21:24:26
21:24:26 java.lang.RuntimeException: Found 6 deadlocked threads
21:24:26 at TestConfigurationLock$DeadlockDetector.run(TestConfigurationLock.java:318)
21:24:26 Deadlock found: exiting forcibly.
21:24:26 rerun:
21:24:26 cd /home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/TKG/output_16583636572965/jdk_util_0/work/scratch/2 && \
21:24:26 DISPLAY=:0 \
21:24:26 HOME=/home/jenkins \
21:24:26 LANG=en_CA.UTF-8 \
21:24:26 PATH=/bin:/usr/bin:/usr/sbin \
21:24:26 CLASSPATH=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/TKG/output_16583636572965/jdk_util_0/work/classes/1/java/util/logging/LogManager/Configuration/TestConfigurationLock.d:/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/logging/LogManager/Configuration:/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/jvmtest/openjdk/jtreg/lib/jtreg.jar \
21:24:26 /home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/openjdkbinary/j2sdk-image/bin/java \
21:24:26 -Dtest.vm.opts='-ea -esa -Xmx1540m -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:+UseCompressedOops' \
21:24:26 -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx1540m -J-Xdump:system:none -J-Xdump:heap:none -J-Xdump:system:events=gpf+abort+traceassert+corruptcache -J-XX:+UseCompressedOops' \
21:24:26 -Dtest.compiler.opts= \
21:24:26 -Dtest.java.opts= \
21:24:26 -Dtest.jdk=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/openjdkbinary/j2sdk-image \
21:24:26 -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/openjdkbinary/j2sdk-image \
21:24:26 -Dtest.timeout.factor=8.0 \
21:24:26 -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/openjdkbinary/openjdk-test-image/jdk/jtreg/native \
21:24:26 -Dtest.root=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/openjdk/openjdk-jdk/test/jdk \
21:24:26 -Dtest.name=java/util/logging/LogManager/Configuration/TestConfigurationLock.java \
21:24:26 -Dtest.file=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/logging/LogManager/Configuration/TestConfigurationLock.java \
21:24:26 -Dtest.src=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/logging/LogManager/Configuration \
21:24:26 -Dtest.src.path=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/logging/LogManager/Configuration \
21:24:26 -Dtest.classes=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/TKG/output_16583636572965/jdk_util_0/work/classes/1/java/util/logging/LogManager/Configuration/TestConfigurationLock.d \
21:24:26 -Dtest.class.path=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/TKG/output_16583636572965/jdk_util_0/work/classes/1/java/util/logging/LogManager/Configuration/TestConfigurationLock.d \
21:24:26 -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/TKG/output_16583636572965/jdk_util_0/work/classes/1/java/util/logging/LogManager/Configuration/TestConfigurationLock.d:/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/logging/LogManager/Configuration \
21:24:26 -Dtest.modules='java.logging java.management' \
21:24:26 --add-modules java.logging,java.management \
21:24:26 -ea \
21:24:26 -esa \
21:24:26 -Xmx1540m \
21:24:26 -Xdump:system:none \
21:24:26 -Xdump:heap:none \
21:24:26 -Xdump:system:events=gpf+abort+traceassert+corruptcache \
21:24:26 -XX:+UseCompressedOops \
21:24:26 -Djava.library.path=/home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/openjdkbinary/openjdk-test-image/jdk/jtreg/native \
21:24:26 -Djava.security.manager=allow \
21:24:26 com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_Nightly/aqa-tests/TKG/output_16583636572965/jdk_util_0/work/java/util/logging/LogManager/Configuration/TestConfigurationLock.d/main.0.jta
Another one here: https://openj9-jenkins.osuosl.org/job/Test_openjdk11_j9_sanity.openjdk_ppc64le_linux_Nightly/343/consoleText
https://openj9-jenkins.osuosl.org/job/Test_openjdk11_j9_sanity.openjdk_ppc64le_linux_OMR/3/ jdk_util_0 java/util/logging/LogManager/Configuration/TestConfigurationLock.java
07:26:18 Found 6 deadlocked threads:
07:26:18 "Thread-1" daemon prio=5 Id=35 TIMED_WAITING (in native)
07:26:18 at java.base/java.lang.Thread.sleepImpl(Native Method)
07:26:18 at java.base/java.lang.Thread.sleep(Thread.java:991)
07:26:18 at java.base/java.lang.Thread.sleep(Thread.java:974)
07:26:18 at TestConfigurationLock.pause(TestConfigurationLock.java:442)
07:26:18 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:256)
07:26:18
07:26:18
07:26:18 "Thread-2" daemon prio=5 Id=36 RUNNABLE
07:26:18 at java.base/java.util.IdentityHashMap$Values.toArray(IdentityHashMap.java:1116)
07:26:18 at java.base/java.util.Collections$SynchronizedCollection.toArray(Collections.java:2029)
07:26:18 - locked java.util.Collections$SynchronizedMap@81597601
07:26:18 at java.logging/java.util.logging.LogManager.invokeConfigurationListeners(LogManager.java:2648)
07:26:18 at java.logging/java.util.logging.LogManager.readConfiguration(LogManager.java:1626)
07:26:18 at java.logging/java.util.logging.LogManager.readConfiguration(LogManager.java:1378)
07:26:18 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:247)
07:26:18 - locked java.util.logging.LogManager@4dbe8a9a
07:26:18
07:26:18
07:26:18 "Thread-3" daemon prio=5 Id=37 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@48b748c0 (in native)
07:26:18 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
07:26:18 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@48b748c0
07:26:18 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:917)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1240)
07:26:18 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:267)
07:26:18 at java.logging/java.util.logging.LogManager.readConfiguration(LogManager.java:1561)
07:26:18 at java.logging/java.util.logging.LogManager.readConfiguration(LogManager.java:1378)
07:26:18 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:250)
07:26:18
07:26:18
07:26:18 "Thread-4" daemon prio=5 Id=38 RUNNABLE (in native)
07:26:18 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
07:26:18 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:917)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1240)
07:26:18 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:267)
07:26:18 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2407)
07:26:18 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2511)
07:26:18 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2089)
07:26:18 at java.logging/java.util.logging.Logger.log(Logger.java:976)
07:26:18 at java.logging/java.util.logging.Logger.doLog(Logger.java:1006)
07:26:18 at java.logging/java.util.logging.Logger.log(Logger.java:1029)
07:26:18 at java.logging/java.util.logging.Logger.fine(Logger.java:1828)
07:26:18 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:287)
07:26:18
07:26:18
07:26:18 "Thread-6" daemon prio=5 Id=40 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@48b748c0 (in native)
07:26:18 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
07:26:18 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@48b748c0
07:26:18 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:917)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1240)
07:26:18 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:267)
07:26:18 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2407)
07:26:18 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2511)
07:26:18 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2089)
07:26:18 at java.logging/java.util.logging.Logger.log(Logger.java:976)
07:26:18 at java.logging/java.util.logging.Logger.doLog(Logger.java:1006)
07:26:18 at java.logging/java.util.logging.Logger.log(Logger.java:1029)
07:26:18 at java.logging/java.util.logging.Logger.fine(Logger.java:1828)
07:26:18 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:287)
07:26:18
07:26:18
07:26:18 "Thread-7" daemon prio=5 Id=41 WAITING on java.util.concurrent.locks.ReentrantLock$NonfairSync@48b748c0 (in native)
07:26:18 at java.base/jdk.internal.misc.Unsafe.park(Native Method)
07:26:18 - waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@48b748c0
07:26:18 at java.base/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:917)
07:26:18 at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1240)
07:26:18 at java.base/java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:267)
07:26:18 at java.logging/java.util.logging.LogManager.initializeGlobalHandlers(LogManager.java:2407)
07:26:18 at java.logging/java.util.logging.LogManager$RootLogger.accessCheckedHandlers(LogManager.java:2511)
07:26:18 at java.logging/java.util.logging.Logger.getHandlers(Logger.java:2089)
07:26:18 at java.logging/java.util.logging.Logger.log(Logger.java:976)
07:26:18 at java.logging/java.util.logging.Logger.doLog(Logger.java:1006)
07:26:18 at java.logging/java.util.logging.Logger.log(Logger.java:1029)
07:26:18 at java.logging/java.util.logging.Logger.fine(Logger.java:1828)
07:26:18 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:287)
07:26:18
07:26:18
07:26:18 java.lang.RuntimeException: Found 6 deadlocked threads
07:26:18 at TestConfigurationLock$DeadlockDetector.run(TestConfigurationLock.java:318)
07:26:18 Deadlock found: exiting forcibly.
JDK22 ppc64le_linux(ubu20le-rtp-rt10-1)
23:16:11 ===============================================
23:16:11 Running test jdk_util_0 ...
23:16:11 ===============================================
23:16:11 jdk_util_0 Start Time: Thu Feb 15 20:16:11 2024 Epoch Time (ms): 1708056971583
23:16:11 variation: -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache Mode150
23:16:11 JVM_OPTIONS: -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:+UseCompressedOops -Xverbosegclog
23:29:34 TEST: java/util/logging/LogManager/Configuration/TestConfigurationLock.java
23:29:34 java.lang.RuntimeException: Found 5 deadlocked threads
23:29:34 at TestConfigurationLock$DeadlockDetector.run(TestConfigurationLock.java:318)
23:29:34 Deadlock found: exiting forcibly.
23:29:34 TEST RESULT: Failed. Unexpected exit from test [exit code: 255]
23:29:34 --------------------------------------------------
23:48:04 Test results: passed: 970; failed: 1
23:49:07 Report written to /home/jenkins/workspace/Test_openjdk22_j9_sanity.openjdk_ppc64le_linux_Personal_testList_1/aqa-tests/TKG/output_17080527799595/jdk_util_0/report/html/report.html
23:49:07 Results written to /home/jenkins/workspace/Test_openjdk22_j9_sanity.openjdk_ppc64le_linux_Personal_testList_1/aqa-tests/TKG/output_17080527799595/jdk_util_0/work
23:49:07 Error: Some tests failed or other problems occurred.
23:49:07 -----------------------------------
23:49:07 jdk_util_0_FAILED
50x grinder - passed
https://openj9-jenkins.osuosl.org/job/Test_openjdk17_j9_sanity.openjdk_ppc64le_linux_OMR_testList_0/40/ jdk_util_1 java/util/logging/LogManager/Configuration/TestConfigurationLock.java
21:25:02 Found 5 deadlocked threads:
21:25:02 "Thread-1" daemon prio=5 Id=34 RUNNABLE
21:25:02 at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:129)
21:25:02 at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:540)
21:25:02 at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:526)
21:25:02 at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:512)
21:25:02 at java.base/java.util.stream.FindOps$FindOp.evaluateSequential(FindOps.java:150)
21:25:02 at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:239)
21:25:02 at java.base/java.util.stream.ReferencePipeline.findFirst(ReferencePipeline.java:647)
21:25:02 at java.logging/java.util.logging.Level$KnownLevel.findByName(Level.java:657)
21:25:02 - locked java.lang.Class@aa8ea567
21:25:02 at java.logging/java.util.logging.Level.findLevel(Level.java:382)
21:25:02 at java.logging/java.util.logging.LogManager.getLevelProperty(LogManager.java:2346)
21:25:02 at java.logging/java.util.logging.LogManager.setLevelsOnExistingLoggers(LogManager.java:2544)
21:25:02 at java.logging/java.util.logging.LogManager.readConfiguration(LogManager.java:1614)
21:25:02 at java.logging/java.util.logging.LogManager.readConfiguration(LogManager.java:1385)
21:25:02 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:247)
21:25:02 - locked java.util.logging.LogManager@217e0520
21:25:02
21:25:02 Number of locked synchronizers = 1
21:25:02 - java.util.concurrent.locks.ReentrantLock$NonfairSync@c7314948
21:25:02
21:25:02
21:25:02 "Thread-3" daemon prio=5 Id=36 TIMED_WAITING (in native)
21:25:02 at java.base/java.lang.Thread.sleepImpl(Native Method)
21:25:02 at java.base/java.lang.Thread.sleep(Thread.java:1009)
21:25:02 at java.base/java.lang.Thread.sleep(Thread.java:992)
21:25:02 at TestConfigurationLock.pause(TestConfigurationLock.java:442)
21:25:02 at TestConfigurationLock$ReadConf.run(TestConfigurationLock.java:256)
21:25:02
21:25:02
21:25:02 "Thread-4" daemon prio=5 Id=37 TIMED_WAITING (in native)
21:25:02 at java.base/java.lang.Thread.sleepImpl(Native Method)
21:25:02 at java.base/java.lang.Thread.sleep(Thread.java:1009)
21:25:02 at java.base/java.lang.Thread.sleep(Thread.java:992)
21:25:02 at TestConfigurationLock.pause(TestConfigurationLock.java:442)
21:25:02 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:289)
21:25:02
21:25:02
21:25:02 "Thread-6" daemon prio=5 Id=39 BLOCKED on java.util.logging.LogManager@217e0520 owned by "Thread-1" Id=34
21:25:02 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:280)
21:25:02 - blocked on java.util.logging.LogManager@217e0520
21:25:02
21:25:02
21:25:02 "Thread-7" daemon prio=5 Id=40 BLOCKED on java.util.logging.LogManager@217e0520 owned by "Thread-1" Id=34
21:25:02 at TestConfigurationLock$AddLogger.run(TestConfigurationLock.java:280)
21:25:02 - blocked on java.util.logging.LogManager@217e0520
21:25:02
21:25:02
21:25:02 java.lang.RuntimeException: Found 5 deadlocked threads
21:25:02 at TestConfigurationLock$DeadlockDetector.run(TestConfigurationLock.java:318)
21:25:02 Deadlock found: exiting forcibly.