SE80_GIT testGuestOSMXBeanRemote_0 intermittent AssertionError: Received a valid exception, test failed

JasonFengJ9 commented 5 years ago

Failure link

Public link to the failing test. If the link is not public, instead include

test category: SE80/functional/JLM_Tests
test suite name: testGuestOSMXBeanRemote_0
OS/architecture: linux_x86-64, linux_x86
OpenJDK version: JCL - 20190529_01 based on Oracle jdk8u221-b02

public build SHAs:

IBM J9 VM (build 2.9, JRE 1.8.0 Linux amd64-64-Bit Compressed References 20190610_418911 (JIT enabled, AOT enabled)
OpenJ9   - 6328e8e
OMR      - cf35c3a
IBM      - 7f7bec6)
JCL - 20190529_01 based on Oracle jdk8u221-b02

Optional info

intermittent failure: yes
regression or new test: regression
if regression, what are the last passing / first failing public SHAs (OpenJ9, OMR, JCL) : N/A

Failure output

[GuestOSMXBeanTest] [INFO]  ---------------------------------------
[GuestOSMXBeanTest] [INFO]  Starting the GuestOSMXBean API tests....
[GuestOSMXBeanTest] [INFO]  ---------------------------------------
[GuestOSMXBeanTest] [INFO] Starting Remote Server!
[GuestOSMXBeanTest] [INFO] /bluebird/builds/bld_418911/sdk/xa6480/jre/bin/java -classpath /bluebird/builds/bld_418911/jvmtest/test/SE80/TestConfig/resources:/bluebird/builds/bld_418911/jvmtest/test/SE80/TestConfig/lib/testng.jar:/bluebird/builds/bld_418911/jvmtest/test/SE80/TestConfig/lib/jcommander.jar:/bluebird/builds/bld_418911/jvmtest/test/SE80/functional/JLM_Tests/jlm_tests.jar -Xnocompressedrefs -Xint -Xgcpolicy:optthruput -Xnocompressedrefs  -Dcom.sun.management.jmxremote.port=9999 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false org.openj9.test.management.RemoteServer 
[GuestOSMXBeanTest] [INFO] Remote Server stdout: [RemoteServer] [INFO] =========RemoteServer Starts!=========
[GuestOSMXBeanTest] [INFO]  Guest Memory Usage tests....
[GuestOSMXBeanTest] [WARN] Exception occurred while retrieving Guest memory usage: -818: Failed retrieving GuestOS Memory Usage Info. No such file or directory
[GuestOSMXBeanTest] [INFO] Remote Server stdout: [RemoteServer] [INFO] RemoteTestServer Stops!
FAILED: runGuestOSMXBeanTest
java.lang.AssertionError: Received a valid exception, test failed
    at org.testng.Assert.fail(Assert.java:96)
    at org.openj9.test.management.GuestOSMXBeanTest.test_memoryInfo(GuestOSMXBeanTest.java:337)
    at org.openj9.test.management.GuestOSMXBeanTest.runGuestOSMXBeanTest(GuestOSMXBeanTest.java:202)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:90)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
    at java.lang.reflect.Method.invoke(Method.java:508)
    at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
    at org.testng.internal.Invoker.invokeMethod(Invoker.java:580)
    at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:716)
    at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:988)
    at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
    at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
    at org.testng.TestRunner.privateRun(TestRunner.java:648)
    at org.testng.TestRunner.run(TestRunner.java:505)
    at org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
    at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
    at org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
    at org.testng.SuiteRunner.run(SuiteRunner.java:364)
    at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
    at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
    at org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
    at org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
    at org.testng.TestNG.runSuites(TestNG.java:1049)
    at org.testng.TestNG.run(TestNG.java:1017)
    at org.testng.TestNG.privateMain(TestNG.java:1354)
    at org.testng.TestNG.main(TestNG.java:1323)

JasonFengJ9 commented 4 years ago

This failure is seen in Windows platform as well in ibuild 453452.

JasonFengJ9 commented 3 years ago

Seen again at an internal ibuild job_output.php?id=672556444

[linux_x86-64] SE80_GIT testGuestOSMXBeanRemote_1
FAILED: runGuestOSMXBeanTest
java.lang.AssertionError: Received a valid exception, test failed
    at org.testng.Assert.fail(Assert.java:96)
    at org.openj9.test.management.GuestOSMXBeanTest.test_memoryInfo(GuestOSMXBeanTest.java:337)
    at org.openj9.test.management.GuestOSMXBeanTest.runGuestOSMXBeanTest(GuestOSMXBeanTest.java:202)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:90)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
    at java.lang.reflect.Method.invoke(Method.java:508)
    at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
    at org.testng.internal.Invoker.invokeMethod(Invoker.java:580)
    at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:716)
    at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:988)
    at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
    at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
    at org.testng.TestRunner.privateRun(TestRunner.java:648)
    at org.testng.TestRunner.run(TestRunner.java:505)
    at org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
    at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
    at org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
    at org.testng.SuiteRunner.run(SuiteRunner.java:364)
    at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
    at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
    at org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
    at org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
    at org.testng.TestNG.runSuites(TestNG.java:1049)
    at org.testng.TestNG.run(TestNG.java:1017)
    at org.testng.TestNG.privateMain(TestNG.java:1354)
    at org.testng.TestNG.main(TestNG.java:1323)

JasonFengJ9 commented 2 years ago

Observed in JDK17 head build job/Test_openjdk17_j9_extended.functional_x86-64_windows_testList_0/53/ (win16x64cudart1)

openjdk version "17-beta" 2021-09-14
IBM Semeru Runtime Open Edition 17+35-202110141303 (build 17-beta+35-202110141303)
Eclipse OpenJ9 VM 17+35-202110141303 (build master-83f34032f, JRE 17 Windows Server 2016 amd64-64-Bit Compressed References 20211014_14 (JIT enabled, AOT enabled)
OpenJ9   - 83f34032f
OMR      - 078596a07
JCL      - 92442f0e28 based on jdk-17+35)

[2021-10-14T19:28:00.406Z] Running test testGuestOSMXBeanRemote_0 ...
[2021-10-14T19:28:00.406Z] ===============================================

[2021-10-14T19:28:00.406Z] 
[2021-10-14T19:28:00.407Z] Attempting to destroy all caches in cacheDir C:\Users\jenkins\AppData\Local\javasharedresources\
[2021-10-14T19:28:00.407Z] 
[2021-10-14T19:28:00.407Z] JVMSHRC241E Error: unable to delete shared class cache file
[2021-10-14T19:28:00.407Z] JVMSHRC336E Port layer error code = -100
[2021-10-14T19:28:00.407Z] JVMSHRC337E Platform error message: (32) The process cannot access the file because it is being used by another process.
[2021-10-14T19:28:00.407Z] JVMSHRC430I Failed to remove current generation of shared class cache "sharedcc_jenkins"
[2021-10-14T19:28:00.407Z] JVMSHRC241E Error: unable to delete shared class cache file
[2021-10-14T19:28:00.407Z] JVMSHRC336E Port layer error code = -100

[2021-10-14T19:28:00.407Z] variation: Mode100
[2021-10-14T19:28:00.407Z] JVM_OPTIONS:  -Xint -Xgcpolicy:optthruput -Xnocompressedrefs 

[2021-10-14T19:28:23.040Z] [GuestOSMXBeanTest] [INFO]  Guest Memory Usage tests....
[2021-10-14T19:28:23.040Z] [GuestOSMXBeanTest] [WARN] Exception occurred while retrieving Guest memory usage: JVMJ9CL034 
[2021-10-14T19:28:33.376Z] FAILED: runGuestOSMXBeanTest
[2021-10-14T19:28:33.376Z] java.lang.AssertionError: Received a valid exception, test failed
[2021-10-14T19:28:33.376Z]  at org.testng.Assert.fail(Assert.java:96)
[2021-10-14T19:28:33.376Z]  at org.openj9.test.management.GuestOSMXBeanTest.test_memoryInfo(GuestOSMXBeanTest.java:337)
[2021-10-14T19:28:33.376Z]  at org.openj9.test.management.GuestOSMXBeanTest.runGuestOSMXBeanTest(GuestOSMXBeanTest.java:202)
[2021-10-14T19:28:33.376Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[2021-10-14T19:28:33.376Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
[2021-10-14T19:28:33.376Z]  at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[2021-10-14T19:28:33.376Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:568)
[2021-10-14T19:28:33.376Z]  at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
[2021-10-14T19:28:33.376Z]  at org.testng.internal.Invoker.invokeMethod(Invoker.java:580)
[2021-10-14T19:28:33.376Z]  at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:716)
[2021-10-14T19:28:33.376Z]  at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:988)
[2021-10-14T19:28:33.376Z]  at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
[2021-10-14T19:28:33.376Z]  at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
[2021-10-14T19:28:33.376Z]  at org.testng.TestRunner.privateRun(TestRunner.java:648)
[2021-10-14T19:28:33.376Z]  at org.testng.TestRunner.run(TestRunner.java:505)
[2021-10-14T19:28:33.376Z]  at org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
[2021-10-14T19:28:33.376Z]  at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
[2021-10-14T19:28:33.376Z]  at org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
[2021-10-14T19:28:33.376Z]  at org.testng.SuiteRunner.run(SuiteRunner.java:364)
[2021-10-14T19:28:33.376Z]  at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
[2021-10-14T19:28:33.376Z]  at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
[2021-10-14T19:28:33.376Z]  at org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
[2021-10-14T19:28:33.376Z]  at org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
[2021-10-14T19:28:33.376Z]  at org.testng.TestNG.runSuites(TestNG.java:1049)
[2021-10-14T19:28:33.376Z]  at org.testng.TestNG.run(TestNG.java:1017)
[2021-10-14T19:28:33.376Z]  at org.testng.TestNG.privateMain(TestNG.java:1354)
[2021-10-14T19:28:33.376Z]  at org.testng.TestNG.main(TestNG.java:1323)
[2021-10-14T19:28:33.376Z] 
[2021-10-14T19:28:33.377Z] 
[2021-10-14T19:28:33.377Z] ===============================================
[2021-10-14T19:28:33.377Z]     testGuestOSMXBean
[2021-10-14T19:28:33.377Z]     Tests run: 1, Failures: 1, Skips: 0
[2021-10-14T19:28:33.377Z] ===============================================
[2021-10-14T19:28:33.377Z] 
[2021-10-14T19:28:33.377Z] testGuestOSMXBeanRemote_0_FAILED

Edit A similar AssertionError at job/Test_openjdk17_j9_extended.functional_x86-64_windows_testList_0/53/

[2021-10-14T19:27:43.473Z] FAILED: runTestOSMXBean
[2021-10-14T19:27:43.473Z] java.lang.AssertionError: Processor load did not increase. Test failed expected [false] but found [true]
[2021-10-14T19:27:43.473Z]  at org.testng.Assert.fail(Assert.java:96)
[2021-10-14T19:27:43.473Z]  at org.testng.Assert.failNotEquals(Assert.java:776)
[2021-10-14T19:27:43.473Z]  at org.testng.Assert.assertFalse(Assert.java:65)
[2021-10-14T19:27:43.473Z]  at org.openj9.test.management.TestOperatingSystemMXBean.test_getProcessCpuTimeByNS(TestOperatingSystemMXBean.java:420)
[2021-10-14T19:27:43.473Z]  at org.openj9.test.management.TestOperatingSystemMXBean.runTestOSMXBean(TestOperatingSystemMXBean.java:217)
[2021-10-14T19:27:43.473Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[2021-10-14T19:27:43.473Z]  at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
[2021-10-14T19:27:43.473Z]  at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[2021-10-14T19:27:43.473Z]  at java.base/java.lang.reflect.Method.invoke(Method.java:568)
[2021-10-14T19:27:43.473Z]  at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
[2021-10-14T19:27:43.473Z]  at org.testng.internal.Invoker.invokeMethod(Invoker.java:580)
[2021-10-14T19:27:43.473Z]  at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:716)
[2021-10-14T19:27:43.473Z]  at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:988)
[2021-10-14T19:27:43.473Z]  at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
[2021-10-14T19:27:43.473Z]  at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
[2021-10-14T19:27:43.473Z]  at org.testng.TestRunner.privateRun(TestRunner.java:648)
[2021-10-14T19:27:43.473Z]  at org.testng.TestRunner.run(TestRunner.java:505)
[2021-10-14T19:27:43.473Z]  at org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
[2021-10-14T19:27:43.473Z]  at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
[2021-10-14T19:27:43.473Z]  at org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
[2021-10-14T19:27:43.473Z]  at org.testng.SuiteRunner.run(SuiteRunner.java:364)
[2021-10-14T19:27:43.473Z]  at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
[2021-10-14T19:27:43.473Z]  at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
[2021-10-14T19:27:43.473Z]  at org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
[2021-10-14T19:27:43.473Z]  at org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
[2021-10-14T19:27:43.473Z]  at org.testng.TestNG.runSuites(TestNG.java:1049)
[2021-10-14T19:27:43.473Z]  at org.testng.TestNG.run(TestNG.java:1017)
[2021-10-14T19:27:43.473Z]  at org.testng.TestNG.privateMain(TestNG.java:1354)
[2021-10-14T19:27:43.473Z]  at org.testng.TestNG.main(TestNG.java:1323)
[2021-10-14T19:27:43.473Z] 
[2021-10-14T19:27:43.473Z] 
[2021-10-14T19:27:43.473Z] ===============================================
[2021-10-14T19:27:43.473Z]     testOSMXBean
[2021-10-14T19:27:43.473Z]     Tests run: 1, Failures: 1, Skips: 0
[2021-10-14T19:27:43.473Z] ===============================================

Could be related to the error deleting shared class cache file.

pshipton commented 2 years ago

Possibly a machine setup issue. J9CL034=%1$d\: Failed retrieving %2$s Info. %3$s which is J9NLS_JCL_HYPERVISOR_USAGE_RETRIEVAL_ERROR_MSG

eclipse-openj9 / openj9