JDK-8183263 : compiler/rtm tests fail on SKL hosts
  • Type: Bug
  • Component: hotspot
  • Sub-Component: compiler
  • Affected Version: 8,9,10,11,13,14,15,16
  • Priority: P3
  • Status: Closed
  • Resolution: Won't Fix
  • CPU: x86_64
  • Submitted: 2017-06-29
  • Updated: 2024-07-08
  • Resolved: 2024-07-08
Related Reports
Duplicate :  
JDK-8230093 - compiler/rtm/locking/TestUseRTMXendForLockBusy.java fails
Relates :  
JDK-8295915 - Problemlist compiler/rtm failures specific to 8u
Relates :  
JDK-8180723 - Compiler RTM tests fail
Relates :  
JDK-8329141 - Obsolete RTM flags and code
Sub Tasks
JDK-8226899 :  
Problemlist compiler/rtm tests - Resolved
JDK-8230388 :  
Problemlist additional compiler/rtm tests - Resolved
JDK-8295915 :  
Problemlist compiler/rtm failures specific to 8u - Resolved
JDK-8295952 :  
Problemlist existing compiler/rtm tests also on x86 - Resolved
Description
the following tests failed when run w/ jdk9+175 on hosts w/ Intel SKL -- Intel(R) Xeon(R) Platinum 8168 CPU @ 2.70GHz 

compiler/rtm/locking/TestRTMAbortThreshold.java                                                                  Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Expected that method with rtm lock elision was deoptimized after 1 lock attempts: expected 10000 to equal 1
compiler/rtm/locking/TestRTMAfterNonRTMDeopt.java                                                                Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Two uncommon traps with reason rtm_state_change should be fired.: expected 0 to equal 2
compiler/rtm/locking/TestRTMDeoptOnHighAbortRatio.java                                                           Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Expected to get only one deoptimization due to rtm state change: expected 0 to equal 1
compiler/rtm/locking/TestRTMDeoptOnLowAbortRatio.java                                                            Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Expected to get only one deoptimization due to rtm state change: expected 0 to equal 1
compiler/rtm/locking/TestRTMLockingCalculationDelay.java                                                         Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: At least one deoptimization due to rtm_state_chage is expected: expected 0 > 0
compiler/rtm/locking/TestRTMLockingThreshold.java                                                                Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: VM output should contain two RTM locking statistics entries.: expected 1 to equal 2
compiler/rtm/locking/TestUseRTMXendForLockBusy.java                                                              Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: VM output should contain exactly one rtm locking statistics entry for method compiler.testlibrary.rtm.BusyLock::test: expected 0 to equal 1
compiler/rtm/print/TestPrintPreciseRTMLockingStatistics.java                                                     Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: RTM locking statistics should contain non zero aborts count for abort reason 0: expected 0 > 0
Comments
Thank you.
08-07-2024
Yes [~kvn] I think that makes sense so I went ahead and did it.
08-07-2024
[~lujaniuk] I agree. Is it fine for you if we close it as "Will Not Fix"? Realistically nobody from our group will work on it.
05-07-2024
[~kvn] Is the "not an issue" status really appropriate for this ticket? RTM was removed in 24, yes, but is still present in previous versions. This ticket JDK-8183263 describes an issue with that functionality, affecting 8, 9, 10, 11, 13, 14, 15, 16. Just because the code disappeared in 24, does that really make it "Not an issue" in the previous releases?
05-07-2024
Not an issue after RTM code and tests are removed by JDK-8329141.
06-06-2024
I have created subtask to problemlist jdk8u specific failures. Also I have created another subtask to problemlist existing ones also on x86 (32-bit).
26-10-2022
I would like to problem list failures higher on jdk8u (probably just on 8 as I have not seem them elsewhere), because these are currently the only failures in hotspot_tier1 of jdk8u on x86_64 architecture. And I would like to enable hotspot_tier1 testing in github actions for jdk8u.
13-10-2022
I attached archive with jtrs
12-10-2022
I see some additional failures (not yet excluded) on JDK8, when executed in github actions. (These are not showing up for newer JDKs.) CPU: model name : Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz TEST: compiler/rtm/locking/TestRTMTotalCountIncrRate.java TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Total locks should be exactly the same as amount of iterations. TEST: compiler/rtm/locking/TestUseRTMAfterLockInflation.java TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Total lock count should be greater or equal to 20000 TEST: compiler/rtm/locking/TestUseRTMForInflatedLocks.java TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Total lock count should be greater or equal to 10000 TEST: compiler/rtm/locking/TestUseRTMForStackLocks.java TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Total locks count should be greater or equal to 10000 TEST: compiler/rtm/method_options/TestUseRTMLockElidingOption.java TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Expected to get total locks count equal to total amount of lock attempts.
12-10-2022
Yes, I just put the link here for future reference.
15-08-2022
[~thartmann] JDK-8292082 is a proposal to remove RTM based on the assumption it is no longer relevant, but that assumption may not be correct.
15-08-2022
There are plans to remove RTM support, see JDK-8292082.
15-08-2022
Yes, they should be problem listed in 8.
04-03-2020
I haven't checked but these tests should probably be problem listed in 8 as well.
04-03-2020
I see the subtasks problem listing & excluding these tests for 11 through 14, but not for e.g. 8. Should these not be excluded for 8 as well, or was there a regression in 11?
04-03-2020
Setting fix version to JDK 14 and raising priority because this started to show up more often. I've problem listed additional tests (JDK-8230388).
30-08-2019
it happens not only w/ zgc, e.g. on linux-x64-debug w/ Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:+IgnoreUnrecognizedVMOptions -XX:-UseCompressedOops, test/hotspot/jtreg/compiler/rtm/locking/TestRTMAbortRatio.java failed w/ the following in .jtr: #section:main ----------messages:(5/478)---------- command: main -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.locking.TestRTMAbortRatio reason: User specified action: run main/othervm/native -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.locking.TestRTMAbortRatio Mode: othervm [/othervm specified] Additional options from @modules: --add-modules java.base,java.management --add-exports java.base/jdk.internal.misc=ALL-UNNAMED elapsed time (seconds): 24.908 ----------configuration:(4/111)---------- Boot Layer add modules: java.base java.management add exports: java.base/jdk.internal.misc ALL-UNNAMED ----------System.out:(96/17944)---------- Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/linux-x64-debug.jdk/jdk-13/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/compiler/rtm/locking/TestRTMAbortRatio.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg/compiler/rtm/locking:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/lib:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:+IgnoreUnrecognizedVMOptions -XX:-UseCompressedOops -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=0 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true ] [2019-08-02T10:53:08.959926Z] Gathering output for process 13613 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 11 # rtm lock aborts : 1 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-08-02T10:53:10.950265Z] Waiting for completion for process 13613 [2019-08-02T10:53:10.974043Z] Waiting for completion finished for process 13613 Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/linux-x64-debug.jdk/jdk-13/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/compiler/rtm/locking/TestRTMAbortRatio.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg/compiler/rtm/locking:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/lib:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:+IgnoreUnrecognizedVMOptions -XX:-UseCompressedOops -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=10 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true ] [2019-08-02T10:53:11.574309Z] Gathering output for process 13657 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 1104 # rtm lock aborts : 111 # rtm lock aborts 0: 103 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-08-02T10:53:12.101751Z] Waiting for completion for process 13657 [2019-08-02T10:53:12.102520Z] Waiting for completion finished for process 13657 Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/linux-x64-debug.jdk/jdk-13/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/compiler/rtm/locking/TestRTMAbortRatio.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg/compiler/rtm/locking:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/lib:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:+IgnoreUnrecognizedVMOptions -XX:-UseCompressedOops -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=50 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true ] [2019-08-02T10:53:12.205285Z] Gathering output for process 13681 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 1966 # rtm lock aborts : 983 # rtm lock aborts 0: 965 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-08-02T10:53:12.802655Z] Waiting for completion for process 13681 [2019-08-02T10:53:12.805650Z] Waiting for completion finished for process 13681 Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/linux-x64-debug.jdk/jdk-13/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/compiler/rtm/locking/TestRTMAbortRatio.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg/compiler/rtm/locking:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/lib:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:+IgnoreUnrecognizedVMOptions -XX:-UseCompressedOops -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=100 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true ] [2019-08-02T10:53:12.862007Z] Gathering output for process 13705 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 10000 # rtm lock aborts : 9001 # rtm lock aborts 0: 8998 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-08-02T10:53:13.552672Z] Waiting for completion for process 13705 [2019-08-02T10:53:13.553153Z] Waiting for completion finished for process 13705 Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/linux-x64-debug.jdk/jdk-13/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/compiler/rtm/locking/TestRTMAbortRatio.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg/compiler/rtm/locking:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/lib:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:+IgnoreUnrecognizedVMOptions -XX:-UseCompressedOops -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:+UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=0 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test false ] [2019-08-02T10:53:13.710316Z] Gathering output for process 13749 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 13 # rtm lock aborts : 1 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-08-02T10:53:14.311833Z] Waiting for completion for process 13749 [2019-08-02T10:53:14.312401Z] Waiting for completion finished for process 13749 Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/linux-x64-debug.jdk/jdk-13/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/compiler/rtm/locking/TestRTMAbortRatio.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg/compiler/rtm/locking:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/lib:/opt/mach5/mesos/work_dir/slaves/00f4d7f9-7805-4b6a-aef8-9bb130db2435-S650/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/0c4013a1-cd2a-4f38-9803-021d0eda4f62/runs/e4c76f36-3bac-4f46-b57d-d3cf468bcd6e/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-13-1493/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:+IgnoreUnrecognizedVMOptions -XX:-UseCompressedOops -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:+UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=10 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test false ] [2019-08-02T10:53:14.314556Z] Gathering output for process 13777 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 27 # rtm lock aborts : 3 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-08-02T10:53:14.965996Z] Waiting for completion for process 13777 [2019-08-02T10:53:14.966632Z] Waiting for completion finished for process 13777 ----------System.err:(18/1373)---------- java.lang.RuntimeException: Actual abort ratio (13) should lower or equal to specified (10).: expected that 13 <= 10 at jdk.test.lib.Asserts.fail(Asserts.java:594) at jdk.test.lib.Asserts.assertLessThanOrEqual(Asserts.java:154) at jdk.test.lib.Asserts.assertLTE(Asserts.java:125) at compiler.rtm.locking.TestRTMAbortRatio.verifyAbortRatio(TestRTMAbortRatio.java:109) at compiler.rtm.locking.TestRTMAbortRatio.runTestCases(TestRTMAbortRatio.java:67) at compiler.rtm.locking.TestRTMAbortRatio.main(TestRTMAbortRatio.java:163) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:567) at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127) at java.base/java.lang.Thread.run(Thread.java:830) JavaTest Message: Test threw exception: java.lang.RuntimeException: Actual abort ratio (13) should lower or equal to specified (10).: expected that 13 <= 10 JavaTest Message: shutting down test STATUS:Failed.`main' threw exception: java.lang.RuntimeException: Actual abort ratio (13) should lower or equal to specified (10).: expected that 13 <= 10
02-08-2019
The latest failure from JDK14 testing 06/31/2019: compiler/rtm/locking/TestRTMAbortRatio.java Oracle_Linux_7.6 VM with 8 cores on CPU Xeon Platinum 8167 fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush mmx fxsr sse sse2 ss ht syscall nx pdpe1gb rdtscp lm constant tsc arch perfmon rep good nopl xtopology cpuid tsc known freq pni pclmulqdq vmx ssse3 fma cx16 pcid sse4 1 sse4 2 x2apic movbe popcnt tsc deadline timer aes xsave avx f16c rdrand hypervisor lahf lm abm 3dnowprefetch invpcid single pti ssbd ibrs ibpb stibp tpr shadow vnmi flexpriority ept fsgsbase tsc adjust bmi1 hle avx2 smep bmi2 erms invpcid rtm mpx avx512f rdseed adx smap avx512cd xsaveopt xsavec xgetbv1 xsaves arat md clear Command line flags: -XX:MaxRAMPercentage=6 -XX:+UnlockExperimentalVMOptions -XX:+UseZGC -XX:+IgnoreUnrecognizedVMOptions -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=0 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 272 # rtm lock aborts : 1 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 -XX:MaxRAMPercentage=6 -XX:+UnlockExperimentalVMOptions -XX:+UseZGC -XX:+IgnoreUnrecognizedVMOptions -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=10 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 14 # rtm lock aborts : 2 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 ----------System.err:(18/1373)---------- java.lang.RuntimeException: Actual abort ratio (14) should lower or equal to specified (10).: expected that 14 <= 10 at jdk.test.lib.Asserts.fail(Asserts.java:594) at jdk.test.lib.Asserts.assertLessThanOrEqual(Asserts.java:154) at jdk.test.lib.Asserts.assertLTE(Asserts.java:125) at compiler.rtm.locking.TestRTMAbortRatio.verifyAbortRatio(TestRTMAbortRatio.java:109) at compiler.rtm.locking.TestRTMAbortRatio.runTestCases(TestRTMAbortRatio.java:62) at compiler.rtm.locking.TestRTMAbortRatio.main(TestRTMAbortRatio.java:163) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:565) at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127) at java.base/java.lang.Thread.run(Thread.java:830)
01-08-2019
an excerpt from test/hotspot/jtreg/compiler/rtm/locking/TestRTMAbortRatio.java 's .jtr: #section:main ----------messages:(5/477)---------- command: main -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.locking.TestRTMAbortRatio reason: User specified action: run main/othervm/native -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.locking.TestRTMAbortRatio Mode: othervm [/othervm specified] Additional options from @modules: --add-modules java.base,java.management --add-exports java.base/jdk.internal.misc=ALL-UNNAMED elapsed time (seconds): 4.009 ----------configuration:(4/111)---------- Boot Layer add modules: java.base java.management add exports: java.base/jdk.internal.misc ALL-UNNAMED ----------System.out:(32/5756)---------- Command line: [$JAVA_HOME/bin/java -cp $WORK_DIR/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_compiler_all_gcs/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-14+8-245/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -XX:+UnlockExperimentalVMOptions -XX:+UseZGC -XX:+IgnoreUnrecognizedVMOptions -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=0 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true ] [2019-07-31T06:15:13.015665Z] Gathering output for process 31761 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 272 # rtm lock aborts : 1 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-07-31T06:15:14.134268Z] Waiting for completion for process 31761 [2019-07-31T06:15:14.134488Z] Waiting for completion finished for process 31761 Command line: [$JAVA_HOME/bin/java -cp $WORK_DIR/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_compiler_all_gcs/classes/0:/opt/mach5/mesos/work_dir/jib-master/install/jdk-14+8-245/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b14/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=6 -XX:+UnlockExperimentalVMOptions -XX:+UseZGC -XX:+IgnoreUnrecognizedVMOptions -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:CompileCommand=compileonly,*.doAbort -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=10 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true ] [2019-07-31T06:15:14.184805Z] Gathering output for process 31919 CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock CompileCommand: compileonly *.doAbort compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 14 # rtm lock aborts : 2 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 [2019-07-31T06:15:15.304698Z] Waiting for completion for process 31919 [2019-07-31T06:15:15.305203Z] Waiting for completion finished for process 31919 ----------System.err:(18/1373)---------- java.lang.RuntimeException: Actual abort ratio (14) should lower or equal to specified (10).: expected that 14 <= 10 at jdk.test.lib.Asserts.fail(Asserts.java:594) at jdk.test.lib.Asserts.assertLessThanOrEqual(Asserts.java:154) at jdk.test.lib.Asserts.assertLTE(Asserts.java:125) at compiler.rtm.locking.TestRTMAbortRatio.verifyAbortRatio(TestRTMAbortRatio.java:109) at compiler.rtm.locking.TestRTMAbortRatio.runTestCases(TestRTMAbortRatio.java:62) at compiler.rtm.locking.TestRTMAbortRatio.main(TestRTMAbortRatio.java:163) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:565) at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127) at java.base/java.lang.Thread.run(Thread.java:830) JavaTest Message: Test threw exception: java.lang.RuntimeException: Actual abort ratio (14) should lower or equal to specified (10).: expected that 14 <= 10 JavaTest Message: shutting down test STATUS:Failed.`main' threw exception: java.lang.RuntimeException: Actual abort ratio (14) should lower or equal to specified (10).: expected that 14 <= 10
01-08-2019
jdk11u-cpu - noticed when syncing 11.0.4/11.0.5 changes into jdk11u-cpu. https://mach5.us.oracle.com/mdash/jobs/robm-jdk11u-cpu-20190717-1808-3862824/tasks/robm-jdk11u-cpu-20190717-1808-3862824-tier3-graal-open_test_hotspot_jtreg_hotspot_not_fast_compiler-windows-x64-debug-287/results?search=status%3Afailed%20AND%20-state%3Ainvalid
17-07-2019
compiler/rtm/locking/TestRTMAbortRatio.java also failed w/ similar error: ----------System.err:(18/1391)---------- java.lang.RuntimeException: Actual abort ratio (10000) should lower or equal to specified (50).: expected that 10000 <= 50 at jdk.test.lib.Asserts.fail(Asserts.java:594) at jdk.test.lib.Asserts.assertLessThanOrEqual(Asserts.java:154) at jdk.test.lib.Asserts.assertLTE(Asserts.java:125) at compiler.rtm.locking.TestRTMAbortRatio.verifyAbortRatio(TestRTMAbortRatio.java:109) at compiler.rtm.locking.TestRTMAbortRatio.runTestCases(TestRTMAbortRatio.java:63) at compiler.rtm.locking.TestRTMAbortRatio.main(TestRTMAbortRatio.java:163) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:115) at java.base/java.lang.Thread.run(Thread.java:844)
20-12-2017
compiler/rtm/locking/TestUseRTMDeopt.java failed on SKL host: Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk/10/36/linux-x64.jdk/jdk-10/bin/java -cp /opt/mach5/mesos/work_dir/slaves/450fa0f5-8733-43f8-b866-79fe3e86d200-S3211/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/9d496b5b-6a48-42f7-a07b-6fed2f473832/runs/fd024f83-4a87-4d8b-8ea6-7d881a9a72e7/testoutput/jtreg/JTwork/classes/1/compiler/rtm/locking/TestRTMAbortRatio.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk/10/36/src.full/open/test/hotspot/jtreg/compiler/rtm/locking:/opt/mach5/mesos/work_dir/slaves/450fa0f5-8733-43f8-b866-79fe3e86d200-S3211/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/9d496b5b-6a48-42f7-a07b-6fed2f473832/runs/fd024f83-4a87-4d8b-8ea6-7d881a9a72e7/testoutput/jtreg/JTwork/classes/1/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk/10/36/src.full/open/test/lib:/opt/mach5/mesos/work_dir/slaves/450fa0f5-8733-43f8-b866-79fe3e86d200-S3211/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/9d496b5b-6a48-42f7-a07b-6fed2f473832/runs/fd024f83-4a87-4d8b-8ea6-7d881a9a72e7/testoutput/jtreg/JTwork/classes/1:/opt/mach5/mesos/work_dir/jib-master/install/jdk/10/36/src.full/open/test/hotspot/jtreg:/opt/mach5/mesos/work_dir/jib-master/install/com/oracle/java/jib/jib/3.0-SNAPSHOT/jib-3.0-SNAPSHOT-distribution.zip/jib-3.0-SNAPSHOT-distribution/lib/jib-3.0-SNAPSHOT.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b10/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/java/re/jtreg/4.2/promoted/all/b10/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=2 -Xcomp -server -XX:-TieredCompilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly,compiler.rtm.locking.TestRTMAbortRatio$Test::lock -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMAbortThreshold=0 -XX:RTMLockingThreshold=100000 -XX:RTMAbortRatio=50 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMAbortRatio$Test true ] CompileCommand: compileonly compiler/rtm/locking/TestRTMAbortRatio$Test.lock compiler/rtm/locking/TestRTMAbortRatio$Test.lock@6 # rtm locks total (estimated): 10000 # rtm lock aborts : 2 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 ----------System.err:(18/1391)---------- java.lang.RuntimeException: Actual abort ratio (10000) should lower or equal to specified (50).: expected that 10000 <= 50 at jdk.test.lib.Asserts.fail(Asserts.java:594) at jdk.test.lib.Asserts.assertLessThanOrEqual(Asserts.java:154) at jdk.test.lib.Asserts.assertLTE(Asserts.java:125) at compiler.rtm.locking.TestRTMAbortRatio.verifyAbortRatio(TestRTMAbortRatio.java:109) at compiler.rtm.locking.TestRTMAbortRatio.runTestCases(TestRTMAbortRatio.java:63) at compiler.rtm.locking.TestRTMAbortRatio.main(TestRTMAbortRatio.java:163) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:115) at java.base/java.lang.Thread.run(Thread.java:844)
20-12-2017
[~vdeshpande] [~mcberg] Guys in Intel, please, look on this. All RTM tests fail on SKL machine.
08-07-2017
ILW = incorrect behavior (either issue with PrintPreciseRTMLockingStatistics diagnostic flag or rtm support), 8 test failures in Intel SKL, disable RTMLocking (false by default) = HLL = P4
30-06-2017
compiler.rtm.locking.TestRTMLockingThreshold.jtr: #section:main ----------messages:(5/482)---------- command: main -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.locking.TestRTMLockingThreshold reason: User specified action: run main/othervm -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.locking.TestRTMLockingThreshold Mode: othervm [/othervm specified] Additional options from @modules: --add-modules java.base,java.management --add-exports java.base/jdk.internal.misc=ALL-UNNAMED elapsed time (seconds): 1.492 ----------configuration:(4/111)---------- Boot Layer add modules: java.base java.management add exports: java.base/jdk.internal.misc ALL-UNNAMED ----------System.out:(12/1310)---------- Command line: [/tmp/iignatyev/jdk/jdk-9/bin/java -cp /tmp/iignatyev/run/JTwork/classes/compiler/rtm/locking:/tmp/iignatyev/ws/ws/hotspot/test/compiler/rtm/locking:/tmp/iignatyev/run/JTwork/classes/test/lib:/tm p/iignatyev/ws/ws/test/lib:/tmp/iignatyev/run/JTwork/classes:/tmp/iignatyev/ws/ws/hotspot/test:/tmp/iignatyev/jtreg/jtreg/lib/javatest.jar:/tmp/iignatyev/jtreg/jtreg/lib/jtreg.jar -Xcomp -server -XX:-TieredCom pilation -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compile only,compiler.rtm.locking.TestRTMLockingThreshold$Test::lock -XX:CompileThreshold=1 -XX:-UseRTMForStackLocks -XX:+UseRTMDeopt -XX:RTMTotalCountIncrRate=1 -XX:RTMRetryCount=0 -XX:RTMAbortThreshold=10 -XX:RTMLoc kingThreshold=0 -XX:RTMAbortRatio=100 -XX:+PrintPreciseRTMLockingStatistics compiler.rtm.locking.TestRTMLockingThreshold$Test true 0 ] CompileCommand: compileonly compiler/rtm/locking/TestRTMLockingThreshold$Test.lock compiler/rtm/locking/TestRTMLockingThreshold$Test.lock@6 # rtm locks total (estimated): 10000 # rtm lock aborts : 0 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 ----------System.err:(19/1470)---------- java.lang.RuntimeException: VM output should contain two RTM locking statistics entries.: expected 1 to equal 2 at jdk.test.lib.Asserts.fail(Asserts.java:594) at jdk.test.lib.Asserts.assertEquals(Asserts.java:205) at jdk.test.lib.Asserts.assertEQ(Asserts.java:178) at compiler.rtm.locking.TestRTMLockingThreshold.verifyLockingThreshold(TestRTMLockingThreshold.java:115) at compiler.rtm.locking.TestRTMLockingThreshold.runTestCases(TestRTMLockingThreshold.java:75) at jdk.test.lib.cli.CommandLineOptionTest.test(CommandLineOptionTest.java:536) at compiler.rtm.locking.TestRTMLockingThreshold.main(TestRTMLockingThreshold.java:186) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:115) at java.base/java.lang.Thread.run(Thread.java:844) JavaTest Message: Test threw exception: java.lang.RuntimeException: VM output should contain two RTM locking statistics entries.: expected 1 to equal 2 JavaTest Message: shutting down test STATUS:Failed.`main' threw exception: java.lang.RuntimeException: VM output should contain two RTM locking statistics entries.: expected 1 to equal 2
29-06-2017
compiler.rtm.print.TestPrintPreciseRTMLockingStatistics.jtr: #section:main ----------messages:(5/503)---------- command: main -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.print.TestPrintPreciseRTMLockingStatistics reason: User specified action: run main/othervm -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI compiler.rtm.print.TestPrintPreciseRTMLockingStatistics Mode: othervm [/othervm specified] Additional options from @modules: --add-modules java.base,java.management --add-exports java.base/jdk.internal.misc=ALL-UNNAMED elapsed time (seconds): 3.38 ----------configuration:(4/111)---------- Boot Layer add modules: java.base java.management add exports: java.base/jdk.internal.misc ALL-UNNAMED ----------System.out:(25/4132)---------- Command line: [/tmp/iignatyev/jdk/jdk-9/bin/java -cp /tmp/iignatyev/run/JTwork/classes/compiler/rtm/print:/tmp/iignatyev/ws/ws/hotspot/test/compiler/rtm/print:/tmp/iignatyev/run/JTwork/classes/test/lib:/tmp/ii gnatyev/ws/ws/test/lib:/tmp/iignatyev/run/JTwork/classes:/tmp/iignatyev/ws/ws/hotspot/test:/tmp/iignatyev/jtreg/jtreg/lib/javatest.jar:/tmp/iignatyev/jtreg/jtreg/lib/jtreg.jar -Xcomp -server -XX:-TieredCompila tion -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly ,compiler.testlibrary.rtm.XAbortProvoker::forceAbort -XX:CompileCommand=compileonly,jdk.internal.misc.Unsafe::addressSize compiler.testlibrary.rtm.AbortProvoker 0 ] CompileCommand: compileonly compiler/testlibrary/rtm/XAbortProvoker.forceAbort CompileCommand: compileonly jdk/internal/misc/Unsafe.addressSize Command line: [/tmp/iignatyev/jdk/jdk-9/bin/java -cp /tmp/iignatyev/run/JTwork/classes/compiler/rtm/print:/tmp/iignatyev/ws/ws/hotspot/test/compiler/rtm/print:/tmp/iignatyev/run/JTwork/classes/test/lib:/tmp/ii gnatyev/ws/ws/test/lib:/tmp/iignatyev/run/JTwork/classes:/tmp/iignatyev/ws/ws/hotspot/test:/tmp/iignatyev/jtreg/jtreg/lib/javatest.jar:/tmp/iignatyev/jtreg/jtreg/lib/jtreg.jar -Xcomp -server -XX:-TieredCompila tion -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly ,compiler.testlibrary.rtm.XAbortProvoker::forceAbort -XX:CompileCommand=compileonly,jdk.internal.misc.Unsafe::addressSize -XX:-PrintPreciseRTMLockingStatistics compiler.testlibrary.rtm.AbortProvoker 0 ] CompileCommand: compileonly compiler/testlibrary/rtm/XAbortProvoker.forceAbort CompileCommand: compileonly jdk/internal/misc/Unsafe.addressSize Command line: [/tmp/iignatyev/jdk/jdk-9/bin/java -cp /tmp/iignatyev/run/JTwork/classes/compiler/rtm/print:/tmp/iignatyev/ws/ws/hotspot/test/compiler/rtm/print:/tmp/iignatyev/run/JTwork/classes/test/lib:/tmp/ii gnatyev/ws/ws/test/lib:/tmp/iignatyev/run/JTwork/classes:/tmp/iignatyev/ws/ws/hotspot/test:/tmp/iignatyev/jtreg/jtreg/lib/javatest.jar:/tmp/iignatyev/jtreg/jtreg/lib/jtreg.jar -Xcomp -server -XX:-TieredCompila tion -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly ,compiler.testlibrary.rtm.XAbortProvoker::forceAbort -XX:CompileCommand=compileonly,jdk.internal.misc.Unsafe::addressSize -XX:-UseRTMLocking -XX:+PrintPreciseRTMLockingStatistics compiler.testlibrary.rtm.Abort Provoker 0 ] CompileCommand: compileonly compiler/testlibrary/rtm/XAbortProvoker.forceAbort CompileCommand: compileonly jdk/internal/misc/Unsafe.addressSize Command line: [/tmp/iignatyev/jdk/jdk-9/bin/java -cp /tmp/iignatyev/run/JTwork/classes/compiler/rtm/print:/tmp/iignatyev/ws/ws/hotspot/test/compiler/rtm/print:/tmp/iignatyev/run/JTwork/classes/test/lib:/tmp/ii gnatyev/ws/ws/test/lib:/tmp/iignatyev/run/JTwork/classes:/tmp/iignatyev/ws/ws/hotspot/test:/tmp/iignatyev/jtreg/jtreg/lib/javatest.jar:/tmp/iignatyev/jtreg/jtreg/lib/jtreg.jar -Xcomp -server -XX:-TieredCompila tion -XX:+UseRTMLocking -XX:+UnlockDiagnosticVMOptions -XX:+UnlockExperimentalVMOptions -Xbootclasspath/a:. -XX:+WhiteBoxAPI --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:CompileCommand=compileonly ,compiler.testlibrary.rtm.XAbortProvoker::forceAbort -XX:CompileCommand=compileonly,jdk.internal.misc.Unsafe::addressSize -XX:+PrintPreciseRTMLockingStatistics compiler.testlibrary.rtm.AbortProvoker 0 ] CompileCommand: compileonly compiler/testlibrary/rtm/XAbortProvoker.forceAbort CompileCommand: compileonly jdk/internal/misc/Unsafe.addressSize compiler/testlibrary/rtm/XAbortProvoker.forceAbort@6 # rtm locks total (estimated): 21056 # rtm lock aborts : 1 # rtm lock aborts 0: 0 # rtm lock aborts 1: 0 # rtm lock aborts 2: 0 # rtm lock aborts 3: 0 # rtm lock aborts 4: 0 # rtm lock aborts 5: 0 ----------System.err:(20/1698)---------- java.lang.RuntimeException: RTM locking statistics should contain non zero aborts count for abort reason 0: expected 0 > 0 at jdk.test.lib.Asserts.fail(Asserts.java:594) at jdk.test.lib.Asserts.assertGreaterThan(Asserts.java:343) at jdk.test.lib.Asserts.assertGT(Asserts.java:314) at compiler.rtm.print.TestPrintPreciseRTMLockingStatistics.verifyAbortsCount(TestPrintPreciseRTMLockingStatistics.java:144) at compiler.rtm.print.TestPrintPreciseRTMLockingStatistics.verifyStatistics(TestPrintPreciseRTMLockingStatistics.java:94) at compiler.rtm.print.TestPrintPreciseRTMLockingStatistics.runTestCases(TestPrintPreciseRTMLockingStatistics.java:76) at jdk.test.lib.cli.CommandLineOptionTest.test(CommandLineOptionTest.java:536) at compiler.rtm.print.TestPrintPreciseRTMLockingStatistics.main(TestPrintPreciseRTMLockingStatistics.java:150) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:115) at java.base/java.lang.Thread.run(Thread.java:844) JavaTest Message: Test threw exception: java.lang.RuntimeException: RTM locking statistics should contain non zero aborts count for abort reason 0: expected 0 > 0 JavaTest Message: shutting down test STATUS:Failed.`main' threw exception: java.lang.RuntimeException: RTM locking statistics should contain non zero aborts count for abort reason 0: expected 0 > 0
29-06-2017
it seems all compiler/rtm/locking/ tests use output of -XX:+PrintPreciseRTMLockingStatistics, so it might be just an issue w/ this diagnostic flag and not rtm support itself.
29-06-2017