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.28k stars 722 forks source link

JDK19 java/util/logging/LogManager/Configuration/updateConfiguration/UpdateConfigurationTest.java - RuntimeException: Expected 'barRef' to be cleared #15190

Open JasonFengJ9 opened 2 years ago

JasonFengJ9 commented 2 years ago

Failure link

From an internal build view/Test_grinder/job/Grinder/24384/console(cent7-aarch64-5):

12:44:45  openjdk version "19-internal" 2022-09-20
12:44:45  OpenJDK Runtime Environment (build 19-internal-adhoc.jenkins.BuildJDKnextaarch64linuxPersonal)
12:44:45  Eclipse OpenJ9 VM (build loom_patch-5264b46c002, JRE 19 Linux aarch64-64-Bit Compressed References 20220531_29 (JIT enabled, AOT enabled)
12:44:45  OpenJ9   - 5264b46c002
12:44:45  OMR      - e8fbaa89d50
12:44:45  JCL      - a66f9edf71a based on jdk-19+24)

Rerun in Grinder - Change TARGET to run only the failed test targets.

Optional info

Failure output (captured from console output)

13:28:20  ===============================================
13:28:20  Running test jdk_util_0 ...
13:28:20  ===============================================
13:28:20  jdk_util_0 Start Time: Wed Jun  1 13:28:19 2022 Epoch Time (ms): 1654104499998
13:28:20  "/home/jenkins/workspace/Grinder/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:destroyAll; "/home/jenkins/workspace/Grinder/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:groupAccess,destroyAll; echo "cache cleanup done";
13:28:20  JVMSHRC005I No shared class caches available
13:28:20  JVMSHRC005I No shared class caches available
13:28:20  cache cleanup done
13:28:20  variation: -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache Mode150
13:28:20  JVM_OPTIONS:  -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:+UseCompressedOops 

13:33:53  TEST: java/util/logging/LogManager/Configuration/updateConfiguration/UpdateConfigurationTest.java

13:33:53  java.lang.RuntimeException: java.lang.RuntimeException: Expected 'barRef' to be cleared
13:33:53    at UpdateConfigurationTest.test(UpdateConfigurationTest.java:308)
13:33:53    at UpdateConfigurationTest.test(UpdateConfigurationTest.java:545)
13:33:53    at UpdateConfigurationTest$TestCase.run(UpdateConfigurationTest.java:85)
13:33:53    at UpdateConfigurationTest.main(UpdateConfigurationTest.java:393)
13:33:53    at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
13:33:53    at java.base/java.lang.reflect.Method.invoke(Method.java:578)
13:33:53    at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
13:33:53    at java.base/java.lang.Thread.run(Thread.java:1555)
13:33:53  Caused by: java.lang.RuntimeException: Expected 'barRef' to be cleared
13:33:53    at UpdateConfigurationTest.test(UpdateConfigurationTest.java:234)
13:33:53    ... 7 more
13:33:53  
13:33:53  JavaTest Message: Test threw exception: java.lang.RuntimeException: java.lang.RuntimeException: Expected 'barRef' to be cleared

13:40:53  jdk_util_0_FAILED

This is an intermittent failure, rely on GC behaviours, seems a test issue.

pshipton commented 2 years ago

Passing on a later build. I will un-exclude. https://openj9-jenkins.osuosl.org/view/Test/job/Grinder/1001

pshipton commented 2 years ago

Actually just noticed it's intermittent, will run more iterations.

pshipton commented 2 years ago

78 tests passed (no failures) in https://openj9-jenkins.osuosl.org/view/Test/job/Grinder/1003 Running more testing in https://openj9-jenkins.osuosl.org/view/Test/job/Grinder/1004 https://openj9-jenkins.osuosl.org/view/Test/job/Grinder/1005

pshipton commented 2 years ago

All the grinders passed, re-including the test. https://github.com/adoptium/aqa-tests/pull/3784

JasonFengJ9 commented 1 year ago

JDK19 x86-64_windows internal build(win11x86-rt3-1)

[2023-04-08T20:57:02.578Z] variation: -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache Mode150
[2023-04-08T20:57:02.578Z] JVM_OPTIONS:  -Xdump:system:none -Xdump:heap:none -Xdump:system:events=gpf+abort+traceassert+corruptcache -XX:+UseCompressedOops 

[2023-04-08T21:39:52.779Z] TEST: java/util/logging/LogManager/Configuration/updateConfiguration/UpdateConfigurationTest.java

[2023-04-08T21:39:52.780Z] java.lang.RuntimeException: java.lang.RuntimeException: Expected 'barRef' to be cleared
[2023-04-08T21:39:52.780Z]  at UpdateConfigurationTest.test(UpdateConfigurationTest.java:308)
[2023-04-08T21:39:52.780Z]  at UpdateConfigurationTest.test(UpdateConfigurationTest.java:545)
[2023-04-08T21:39:52.780Z]  at UpdateConfigurationTest$TestCase.run(UpdateConfigurationTest.java:85)
[2023-04-08T21:39:52.780Z]  at UpdateConfigurationTest.main(UpdateConfigurationTest.java:393)
[2023-04-08T21:39:52.780Z]  at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
[2023-04-08T21:39:52.780Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:578)
[2023-04-08T21:39:52.780Z]  at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
[2023-04-08T21:39:52.780Z]  at java.base/java.lang.Thread.run(Thread.java:1573)
[2023-04-08T21:39:52.780Z] Caused by: java.lang.RuntimeException: Expected 'barRef' to be cleared
[2023-04-08T21:39:52.780Z]  at UpdateConfigurationTest.test(UpdateConfigurationTest.java:234)
[2023-04-08T21:39:52.780Z]  ... 7 more
[2023-04-08T21:39:52.780Z] 
[2023-04-08T21:39:52.780Z] JavaTest Message: Test threw exception: java.lang.RuntimeException: java.lang.RuntimeException: Expected 'barRef' to be cleared

[2023-04-08T21:39:52.780Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: java.lang.RuntimeException: Expected 'barRef' to be cleared
[2023-04-08T21:39:52.780Z] --------------------------------------------------
[2023-04-08T22:40:12.219Z] Test results: passed: 914; failed: 1
[2023-04-08T22:41:11.722Z] Report written to C:\Users\jenkins\workspace\Test_openjdk19_j9_sanity.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_1680976237304\jdk_util_0\report\html\report.html
[2023-04-08T22:41:11.722Z] Results written to C:\Users\jenkins\workspace\Test_openjdk19_j9_sanity.openjdk_x86-64_windows_testList_1\aqa-tests\TKG\output_1680976237304\jdk_util_0\work
[2023-04-08T22:41:11.722Z] Error: Some tests failed or other problems occurred.
[2023-04-08T22:41:11.722Z] -----------------------------------
[2023-04-08T22:41:11.722Z] jdk_util_0_FAILED

50x internal grinder - passed

pshipton commented 1 year ago

The grinder passed.