cmdLineTester_criu_nonPortableRestore_10_FAILED TestSingleThreadModeRestoreException j9vm.225 ASSERTION FAILED openj9/runtime/vm/VMAccess.cpp:133: (!(vmThread->inNative))

[JasonFengJ9]

Failure link

From internal Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0 (ubu22lert-1)

java version "11.0.25-beta" 2024-10-15
IBM Semeru Runtime Certified Edition 11.0.25+8-202410142211 (build 11.0.25-beta+8-202410142211)
Eclipse OpenJ9 VM 11.0.25+8-202410142211 (build master-edb9e2e598, JRE 11 Linux ppc64le-64-Bit Compressed References 20241014_968 (JIT enabled, AOT enabled)
OpenJ9   - edb9e2e598
OMR      - 870b1c9be
JCL      - 2daf44a148 based on jdk-11.0.25+8)

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

Optional info

Failure output (captured from console output)

[2024-10-14T23:41:39.358Z] variation: -XX:+DebugOnRestore -Xjit:count=0
[2024-10-14T23:41:39.358Z] JVM_OPTIONS:  -XX:+DebugOnRestore -Xjit:count=0 

[2024-10-14T23:45:54.044Z] Testing: Create and Restore Criu Checkpoint Image once - TestSingleThreadModeRestoreException
[2024-10-14T23:45:54.044Z] Test start time: 2024/10/14 23:45:53 Coordinated Universal Time
[2024-10-14T23:45:54.044Z] Running command: bash /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/functional/cmdLineTests/criu/criuScript.sh /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/functional/cmdLineTests/criu /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java " -XX:+DebugOnRestore -Xjit:count=0 " org.openj9.criu.TestSingleThreadModeRestoreException unusedArgument 1 false false
[2024-10-14T23:45:54.044Z] Time spent starting: 1 milliseconds
[2024-10-14T23:46:13.998Z] Time spent executing: 19629 milliseconds
[2024-10-14T23:46:13.998Z] Test result: FAILED
[2024-10-14T23:46:13.998Z] Output from test:
[2024-10-14T23:46:13.998Z]  [OUT] start running script
[2024-10-14T23:46:13.998Z]  [OUT] export GLIBC_TUNABLES=glibc.cpu.hwcaps=-XSAVEC,-XSAVE,-AVX2,-ERMS,-AVX,-AVX_Fast_Unaligned_Load
[2024-10-14T23:46:13.998Z]  [OUT] export LD_BIND_NOT=on
[2024-10-14T23:46:13.998Z]  [OUT] /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java -XX:+EnableCRIUSupport  -XX:+DebugOnRestore -Xjit:count=0  -cp /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/functional/cmdLineTests/criu/criu.jar org.openj9.criu.TestSingleThreadModeRestoreException unusedArgument 1
[2024-10-14T23:46:13.998Z]  [OUT] main: Mon Oct 14 23:46:03 UTC 2024, testSingleThreadModeRestoreExceptionSynLock() before synchronized on java.lang.Object@57059115, System.currentTimeMillis(): 1728949563461, System.nanoTime(): 549202040890935
[2024-10-14T23:46:13.998Z]  [OUT] main: Mon Oct 14 23:46:07 UTC 2024, testSingleThreadModeRestoreExceptionSynLock() before doCheckpointSynLock(), System.currentTimeMillis(): 1728949567883, System.nanoTime(): 549206463350597
[2024-10-14T23:46:13.998Z]  [OUT] Pre-checkpoint
[2024-10-14T23:46:13.998Z]  [OUT] Thread-0: Mon Oct 14 23:46:07 UTC 2024, Performing CRIUSupport.checkpointJVM(), System.currentTimeMillis(): 1728949567915, System.nanoTime(): 549206494736991
[2024-10-14T23:46:13.998Z]  [OUT] JVMJITM044W Some or all compiled code in the code cache invalidated post restore.
[2024-10-14T23:46:13.998Z]  [OUT] 23:46:12.183 0x253200    j9vm.225    *   ** ASSERTION FAILED ** at ../../../../../openj9/runtime/vm/VMAccess.cpp:133: (!(vmThread->inNative))
[2024-10-14T23:46:13.998Z]  [OUT] JVMDUMP039I Processing dump event "traceassert", detail "" at 2024/10/14 23:46:12 - please wait.
[2024-10-14T23:46:13.999Z]  [OUT] JVMDUMP032I JVM requested System dump using '/home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/output_17289474876438/cmdLineTester_criu_nonPortableRestore_10/core.20241014.234612.666771.0001.dmp' in response to an event
[2024-10-14T23:46:13.999Z]  [OUT] JVMDUMP010I System dump written to /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/output_17289474876438/cmdLineTester_criu_nonPortableRestore_10/core.20241014.234612.666771.0001.dmp
[2024-10-14T23:46:13.999Z]  [OUT] JVMDUMP032I JVM requested Java dump using '/home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/output_17289474876438/cmdLineTester_criu_nonPortableRestore_10/javacore.20241014.234612.666771.0002.txt' in response to an event
[2024-10-14T23:46:13.999Z]  [OUT] JVMDUMP010I Java dump written to /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/output_17289474876438/cmdLineTester_criu_nonPortableRestore_10/javacore.20241014.234612.666771.0002.txt
[2024-10-14T23:46:13.999Z]  [OUT] JVMDUMP032I JVM requested Snap dump using '/home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/output_17289474876438/cmdLineTester_criu_nonPortableRestore_10/Snap.20241014.234612.666771.0003.trc' in response to an event
[2024-10-14T23:46:13.999Z]  [OUT] JVMDUMP010I Snap dump written to /home/jenkins/workspace/Test_openjdk11_j9_sanity.functional_ppc64le_linux_testList_0/aqa-tests/TKG/output_17289474876438/cmdLineTester_criu_nonPortableRestore_10/Snap.20241014.234612.666771.0003.trc
[2024-10-14T23:46:13.999Z]  [OUT] JVMDUMP013I Processed dump event "traceassert", detail "".
[2024-10-14T23:46:13.999Z]  [OUT] initiate restore
[2024-10-14T23:46:13.999Z]  [OUT] Removed test output files
[2024-10-14T23:46:13.999Z]  [OUT] finished script

[2024-10-15T00:03:53.447Z] ---TEST RESULTS---
[2024-10-15T00:03:53.447Z] Number of PASSED tests: 64 out of 65
[2024-10-15T00:03:53.447Z] Number of FAILED tests: 1 out of 65
[2024-10-15T00:03:53.447Z] 
[2024-10-15T00:03:53.447Z] ---SUMMARY OF FAILED TESTS---
[2024-10-15T00:03:53.447Z] Create and Restore Criu Checkpoint Image once - TestSingleThreadModeRestoreException
[2024-10-15T00:03:53.447Z] -----------------------------
[2024-10-15T00:03:53.447Z] 
[2024-10-15T00:03:53.447Z] -----------------------------------
[2024-10-15T00:03:53.447Z] cmdLineTester_criu_nonPortableRestore_10_FAILED

50x internal Grinder - 30 passed, other 20 not run due to infra error
200x internal Grinder - reproduced once at rhel8le-svl-rt3-1

[github-actions]

Issue Number: 20359
Status: Open
Recommended Components: comp:test, comp:gc, comp:vm
Recommended Assignees: babsingh, jasonfengj9, tajila