[2024-07-31T20:18:44.463Z] Running test jcstress_SyncBarrier3Test_0 ... [2024-07-31T20:18:44.463Z] =============================================== [2024-07-31T20:18:44.463Z] jcstress_SyncBarrier3Test_0 Start Time: Wed Jul 31 20:18:44 2024 Epoch Time (ms): 1722457124209 [2024-07-31T20:18:44.463Z] variation: NoOptions [2024-07-31T20:18:44.463Z] JVM_OPTIONS: [2024-07-31T20:18:44.463Z] { \ [2024-07-31T20:18:44.463Z] echo ""; echo "TEST SETUP:"; \ [2024-07-31T20:18:44.463Z] echo "Nothing to be done for setup."; \ [2024-07-31T20:18:44.463Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224552688748/jcstress_SyncBarrier3Test_0"; \ [2024-07-31T20:18:44.463Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224552688748/jcstress_SyncBarrier3Test_0"; \ [2024-07-31T20:18:44.463Z] echo ""; echo "TESTING:"; \ [2024-07-31T20:18:44.463Z] "/home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-21.0.5+1/bin/..//bin/java" -jar "/home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/../../testDependency/system_lib/jcstress-tests-all-20240222.jar" -t SyncBarrier3Test; \ [2024-07-31T20:18:44.463Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jcstress_SyncBarrier3Test_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224552688748/jcstress_SyncBarrier3Test_0"; else echo "-----------------------------------"; echo "jcstress_SyncBarrier3Test_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-07-31T20:18:44.463Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-07-31T20:18:44.463Z] echo "Nothing to be done for teardown."; \ [2024-07-31T20:18:44.463Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224552688748/TestTargetResult"; [2024-07-31T20:18:44.463Z] [2024-07-31T20:18:44.463Z] TEST SETUP: [2024-07-31T20:18:44.463Z] Nothing to be done for setup. [2024-07-31T20:18:44.463Z] [2024-07-31T20:18:44.463Z] TESTING: [2024-07-31T20:18:45.204Z] Java Concurrency Stress Tests [2024-07-31T20:18:45.204Z] --------------------------------------------------------------------------------- [2024-07-31T20:18:45.204Z] Rev: 86dd040fcfa55590, built by buildbot with 17.0.9 at 2024-02-22T22:01:14Z [2024-07-31T20:18:45.204Z] [2024-07-31T20:18:46.683Z] Burning up to figure out the exact CPU count....... done! [2024-07-31T20:18:46.683Z] [2024-07-31T20:18:46.683Z] Probing the target OS: [2024-07-31T20:18:46.683Z] (all failures are non-fatal, but may affect testing accuracy) [2024-07-31T20:18:46.683Z] [2024-07-31T20:18:46.683Z] ----- [OK] Trying to set global affinity with taskset [2024-07-31T20:18:48.220Z] ----- [OK] Trying to set per-thread affinity with syscalls [2024-07-31T20:18:48.220Z] [2024-07-31T20:18:48.220Z] Initializing and probing the target VM: [2024-07-31T20:18:48.220Z] (all failures are non-fatal, but may affect testing accuracy) [2024-07-31T20:18:48.220Z] [2024-07-31T20:18:48.220Z] ----- [OK] Unlocking diagnostic VM options [2024-07-31T20:18:49.005Z] ----- [OK] Disabling performance data collection [2024-07-31T20:18:49.005Z] ----- [OK] Checking for C1 availability [2024-07-31T20:18:49.740Z] ----- [OK] Checking for C2 availability [2024-07-31T20:18:49.740Z] ----- [N/A] Checking for biased locking support [2024-07-31T20:18:49.740Z] Unrecognized VM option 'UseBiasedLocking' [2024-07-31T20:18:49.740Z] Error: Could not create the Java Virtual Machine. [2024-07-31T20:18:49.740Z] Error: A fatal exception has occurred. Program will exit. [2024-07-31T20:18:49.740Z] [2024-07-31T20:18:49.740Z] ----- [OK] Trimming down the VM heap size to 256M [2024-07-31T20:18:50.479Z] ----- [OK] Enabling Java heap pre-touch [2024-07-31T20:18:51.229Z] ----- [OK] Trimming down the number of parallel GC threads [2024-07-31T20:18:51.971Z] ----- [OK] Trimming down the number of concurrent GC threads [2024-07-31T20:18:52.723Z] ----- [OK] Trimming down the number of G1 concurrent refinement GC threads [2024-07-31T20:18:52.723Z] ----- [OK] Trimming down the number of compiler threads [2024-07-31T20:19:00.711Z] ----- [OK] Testing @Contended works on all results and infra objects [2024-07-31T20:19:01.448Z] ----- [OK] Unlocking debug information for non-safepoints [2024-07-31T20:19:02.183Z] ----- [OK] Unlocking C2 local code motion randomizer [2024-07-31T20:19:02.925Z] ----- [OK] Unlocking C2 global code motion randomizer [2024-07-31T20:19:03.692Z] ----- [OK] Unlocking C2 iterative global value numbering randomizer [2024-07-31T20:19:04.435Z] ----- [OK] Unlocking C2 conditional constant propagation randomizer [2024-07-31T20:19:04.435Z] ----- [OK] Unlocking C2 incremental inlining randomizer [2024-07-31T20:19:04.435Z] ----- [N/A] Unlocking C2 macro expansion randomizer [2024-07-31T20:19:04.435Z] Unrecognized VM option 'StressMacroExpansion' [2024-07-31T20:19:04.435Z] Error: Could not create the Java Virtual Machine. [2024-07-31T20:19:04.435Z] Error: A fatal exception has occurred. Program will exit. [2024-07-31T20:19:04.435Z] [2024-07-31T20:19:05.172Z] ----- [OK] Checking if C2 randomizers accept stress seed [2024-07-31T20:19:06.708Z] ----- [OK] Testing allocation profiling [2024-07-31T20:19:07.450Z] ----- [OK] Testing Thread.onSpinWait [2024-07-31T20:19:09.026Z] ----- [OK] Testing PrintAssembly [2024-07-31T20:19:09.788Z] ----- [OK] Testing compiler directives [2024-07-31T20:19:09.788Z] [2024-07-31T20:19:09.788Z] Probing what VM configurations are available: [2024-07-31T20:19:09.788Z] (failures are non-fatal, but may miss some interesting cases) [2024-07-31T20:19:09.788Z] (split compilation is requested and compiler directives are available) [2024-07-31T20:19:09.788Z] [2024-07-31T20:19:10.522Z] ----- [OK] [] [2024-07-31T20:19:11.274Z] ----- [OK] [-XX:+StressLCM, -XX:+StressGCM, -XX:+StressIGVN, -XX:+StressCCP, -XX:+StressIncrementalInlining] [2024-07-31T20:19:11.274Z] [2024-07-31T20:19:12.916Z] Detecting CPU topology and computing scheduling classes: [2024-07-31T20:19:12.916Z] Linux, using /sys/devices/system/cpu, /sys/devices/system/node [2024-07-31T20:19:12.916Z] 1 package, 8 cores per package, 2 threads per core [2024-07-31T20:19:12.916Z] [2024-07-31T20:19:12.916Z] CPU topology: [2024-07-31T20:19:12.916Z] CPU #0: package #0, core #0, thread #0 [2024-07-31T20:19:12.916Z] CPU #1: package #0, core #0, thread #1 [2024-07-31T20:19:12.916Z] CPU #2: package #0, core #1, thread #2 [2024-07-31T20:19:12.916Z] CPU #3: package #0, core #1, thread #3 [2024-07-31T20:19:12.916Z] CPU #4: package #0, core #2, thread #4 [2024-07-31T20:19:12.916Z] CPU #5: package #0, core #2, thread #5 [2024-07-31T20:19:12.916Z] CPU #6: package #0, core #3, thread #6 [2024-07-31T20:19:12.916Z] CPU #7: package #0, core #3, thread #7 [2024-07-31T20:19:12.916Z] CPU #8: package #0, core #4, thread #8 [2024-07-31T20:19:12.916Z] CPU #9: package #0, core #4, thread #9 [2024-07-31T20:19:12.916Z] CPU #10: package #0, core #5, thread #10 [2024-07-31T20:19:12.916Z] CPU #11: package #0, core #5, thread #11 [2024-07-31T20:19:12.916Z] CPU #12: package #0, core #6, thread #12 [2024-07-31T20:19:12.916Z] CPU #13: package #0, core #6, thread #13 [2024-07-31T20:19:12.916Z] CPU #14: package #0, core #7, thread #14 [2024-07-31T20:19:12.916Z] CPU #15: package #0, core #7, thread #15 [2024-07-31T20:19:12.916Z] [2024-07-31T20:19:12.916Z] Scheduling classes for matching tests: [2024-07-31T20:19:12.916Z] 2 actors: [2024-07-31T20:19:12.916Z] (PG 0, CG 0), (PG 0, CG 0) [2024-07-31T20:19:12.916Z] (PG 0, CG 0), (PG 0, CG 1) [2024-07-31T20:19:12.916Z] [2024-07-31T20:19:12.916Z] Test configuration: [2024-07-31T20:19:12.916Z] Hardware CPUs in use: 4 [2024-07-31T20:19:12.916Z] Spinning style: Thread.onSpinWait() [2024-07-31T20:19:12.916Z] Test selection: "SyncBarrier3Test" [2024-07-31T20:19:12.916Z] Forks per test: 1 normal, 3 stress [2024-07-31T20:19:12.916Z] Test stride: 40 strides x 256 tests, but taking no more than 64 Mb [2024-07-31T20:19:12.916Z] Test result blob: "jcstress-results-2024-07-31-20-18-45.bin.gz" [2024-07-31T20:19:12.916Z] Test results: "results/" [2024-07-31T20:19:12.916Z] [2024-07-31T20:19:12.916Z] Time budget: [2024-07-31T20:19:12.916Z] Initial completion estimate: 00:02:23 left; at Wed, 2024-07-31 20:21:36 [2024-07-31T20:19:12.916Z] Initial test time: 2964 ms [2024-07-31T20:19:12.916Z] [2024-07-31T20:19:13.769Z] Attached the non-interactive output stream. [2024-07-31T20:19:13.770Z] Printing the progress line at most every 15000 milliseconds. [2024-07-31T20:19:13.770Z] [2024-07-31T20:19:25.475Z] (Time: 00:02:12 left, 2 tests in flight, 2784 ms per test) [2024-07-31T20:19:25.475Z] (Sampling Rate: 43.11 K/sec) [2024-07-31T20:19:25.475Z] (JVMs: 1 starting, 1 running, 0 finishing) [2024-07-31T20:19:25.475Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:19:25.475Z] (Results: 48 planned; 1 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:19:25.475Z] [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:28.871Z] .......... [OK] o.o.j.t.locks.barriers.SyncBarrier3Test [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:28.871Z] Scheduling class: [2024-07-31T20:19:28.871Z] actor1: package group 0, core group 0 [2024-07-31T20:19:28.871Z] actor2: package group 0, core group 0 [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:28.871Z] CPU allocation: [2024-07-31T20:19:28.871Z] actor1: CPU #2 (package #0, core #1, thread #2) [2024-07-31T20:19:28.871Z] actor2: CPU #3 (package #0, core #1, thread #3) [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:28.871Z] Compilation: split [2024-07-31T20:19:28.871Z] actor1: C2 [2024-07-31T20:19:28.871Z] actor2: C2 [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:28.871Z] JVM args: [] [2024-07-31T20:19:28.871Z] Fork: #1 [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:28.871Z] RESULT SAMPLES FREQ EXPECT DESCRIPTION [2024-07-31T20:19:28.871Z] 0, 0 51,925 11.32% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:19:28.871Z] 0, 2 504 0.11% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:19:28.871Z] 1, 0 3 <0.01% Interesting The write to $b is observed, but write to $a is not. This... [2024-07-31T20:19:28.871Z] 1, 2 406,339 88.57% Acceptable The write to $b is observed, expected to see $a == 1. [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:28.871Z] (Time: 00:02:08 left, 2 tests in flight, 2768 ms per test) [2024-07-31T20:19:28.871Z] (Sampling Rate: 63.58 K/sec) [2024-07-31T20:19:28.871Z] (JVMs: 0 starting, 2 running, 0 finishing) [2024-07-31T20:19:28.871Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:19:28.871Z] (Results: 48 planned; 2 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:19:28.871Z] [2024-07-31T20:19:51.072Z] (Time: 00:01:47 left, 2 tests in flight, 2465 ms per test) [2024-07-31T20:19:51.072Z] (Sampling Rate: 96.62 K/sec) [2024-07-31T20:19:51.072Z] (JVMs: 1 starting, 1 running, 0 finishing) [2024-07-31T20:19:51.072Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:19:51.072Z] (Results: 48 planned; 5 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:19:51.072Z] [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:01.742Z] .......... [OK] o.o.j.t.locks.barriers.SyncBarrier3Test [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:01.742Z] Scheduling class: [2024-07-31T20:20:01.742Z] actor1: package group 0, core group 0 [2024-07-31T20:20:01.742Z] actor2: package group 0, core group 0 [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:01.742Z] CPU allocation: [2024-07-31T20:20:01.742Z] actor1: CPU #0 (package #0, core #0, thread #0) [2024-07-31T20:20:01.742Z] actor2: CPU #1 (package #0, core #0, thread #1) [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:01.742Z] Compilation: split [2024-07-31T20:20:01.742Z] actor1: C2 [2024-07-31T20:20:01.742Z] actor2: C2 [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:01.742Z] JVM args: [-XX:+StressLCM, -XX:+StressGCM, -XX:+StressIGVN, -XX:+StressCCP, -XX:+StressIncrementalInlining, -XX:StressSeed=712580206] [2024-07-31T20:20:01.742Z] Fork: #1 [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:01.742Z] RESULT SAMPLES FREQ EXPECT DESCRIPTION [2024-07-31T20:20:01.742Z] 0, 0 569,767 55.75% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:20:01.742Z] 0, 2 5,166 0.51% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:20:01.742Z] 1, 0 34 <0.01% Interesting The write to $b is observed, but write to $a is not. This... [2024-07-31T20:20:01.742Z] 1, 2 447,004 43.74% Acceptable The write to $b is observed, expected to see $a == 1. [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:01.742Z] (Time: 00:01:34 left, 2 tests in flight, 2284 ms per test) [2024-07-31T20:20:01.742Z] (Sampling Rate: 107.08 K/sec) [2024-07-31T20:20:01.742Z] (JVMs: 0 starting, 2 running, 0 finishing) [2024-07-31T20:20:01.742Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:20:01.742Z] (Results: 48 planned; 7 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:20:01.742Z] [2024-07-31T20:20:18.021Z] (Time: 00:01:19 left, 2 tests in flight, 2051 ms per test) [2024-07-31T20:20:18.021Z] (Sampling Rate: 109.80 K/sec) [2024-07-31T20:20:18.021Z] (JVMs: 1 starting, 1 running, 0 finishing) [2024-07-31T20:20:18.021Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:20:18.021Z] (Results: 48 planned; 10 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:20:18.021Z] [2024-07-31T20:20:40.113Z] (Time: 00:00:59 left, 2 tests in flight, 1670 ms per test) [2024-07-31T20:20:40.113Z] (Sampling Rate: 103.78 K/sec) [2024-07-31T20:20:40.113Z] (JVMs: 0 starting, 2 running, 0 finishing) [2024-07-31T20:20:40.113Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:20:40.113Z] (Results: 48 planned; 13 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:20:40.113Z] [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:48.380Z] .......... [OK] o.o.j.t.locks.barriers.SyncBarrier3Test [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:48.380Z] Scheduling class: [2024-07-31T20:20:48.380Z] actor1: package group 0, core group 0 [2024-07-31T20:20:48.380Z] actor2: package group 0, core group 0 [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:48.380Z] CPU allocation: [2024-07-31T20:20:48.380Z] actor1: CPU #2 (package #0, core #1, thread #2) [2024-07-31T20:20:48.380Z] actor2: CPU #3 (package #0, core #1, thread #3) [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:48.380Z] Compilation: split [2024-07-31T20:20:48.380Z] actor1: C2 [2024-07-31T20:20:48.380Z] actor2: C2 [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:48.380Z] JVM args: [-XX:+StressLCM, -XX:+StressGCM, -XX:+StressIGVN, -XX:+StressCCP, -XX:+StressIncrementalInlining, -XX:StressSeed=636621687] [2024-07-31T20:20:48.380Z] Fork: #2 [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:48.380Z] RESULT SAMPLES FREQ EXPECT DESCRIPTION [2024-07-31T20:20:48.380Z] 0, 0 48,708 10.16% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:20:48.380Z] 0, 2 815 0.17% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:20:48.380Z] 1, 0 5 <0.01% Interesting The write to $b is observed, but write to $a is not. This... [2024-07-31T20:20:48.380Z] 1, 2 429,723 89.67% Acceptable The write to $b is observed, expected to see $a == 1. [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:48.380Z] (Time: 00:00:48 left, 2 tests in flight, 1479 ms per test) [2024-07-31T20:20:48.380Z] (Sampling Rate: 107.07 K/sec) [2024-07-31T20:20:48.380Z] (JVMs: 0 starting, 2 running, 0 finishing) [2024-07-31T20:20:48.380Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:20:48.380Z] (Results: 48 planned; 16 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:20:48.380Z] [2024-07-31T20:20:58.275Z] [2024-07-31T20:20:58.275Z] .......... [OK] o.o.j.t.locks.barriers.SyncBarrier3Test [2024-07-31T20:20:58.275Z] [2024-07-31T20:20:58.275Z] Scheduling class: [2024-07-31T20:20:58.275Z] actor1: package group 0, core group 0 [2024-07-31T20:20:58.275Z] actor2: package group 0, core group 0 [2024-07-31T20:20:58.275Z] [2024-07-31T20:20:58.275Z] CPU allocation: [2024-07-31T20:20:58.275Z] actor1: CPU #0 (package #0, core #0, thread #0) [2024-07-31T20:20:58.275Z] actor2: CPU #1 (package #0, core #0, thread #1) [2024-07-31T20:20:58.275Z] [2024-07-31T20:20:58.275Z] Compilation: split [2024-07-31T20:20:58.275Z] actor1: Interpreter [2024-07-31T20:20:58.275Z] actor2: C2 [2024-07-31T20:20:58.275Z] [2024-07-31T20:20:58.275Z] JVM args: [] [2024-07-31T20:20:58.275Z] Fork: #1 [2024-07-31T20:20:58.276Z] [2024-07-31T20:20:58.276Z] RESULT SAMPLES FREQ EXPECT DESCRIPTION [2024-07-31T20:20:58.276Z] 0, 0 171,981 29.57% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:20:58.276Z] 0, 2 8,863 1.52% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:20:58.276Z] 1, 0 2 <0.01% Interesting The write to $b is observed, but write to $a is not. This... [2024-07-31T20:20:58.276Z] 1, 2 400,805 68.91% Acceptable The write to $b is observed, expected to see $a == 1. [2024-07-31T20:20:58.276Z] [2024-07-31T20:20:58.276Z] (Time: 00:00:39 left, 2 tests in flight, 1258 ms per test) [2024-07-31T20:20:58.276Z] (Sampling Rate: 104.05 K/sec) [2024-07-31T20:20:58.276Z] (JVMs: 0 starting, 2 running, 0 finishing) [2024-07-31T20:20:58.276Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:20:58.276Z] (Results: 48 planned; 17 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:20:58.276Z] [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:17.066Z] .......... [OK] o.o.j.t.locks.barriers.SyncBarrier3Test [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:17.066Z] Scheduling class: [2024-07-31T20:21:17.066Z] actor1: package group 0, core group 0 [2024-07-31T20:21:17.066Z] actor2: package group 0, core group 0 [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:17.066Z] CPU allocation: [2024-07-31T20:21:17.066Z] actor1: CPU #0 (package #0, core #0, thread #0) [2024-07-31T20:21:17.066Z] actor2: CPU #1 (package #0, core #0, thread #1) [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:17.066Z] Compilation: split [2024-07-31T20:21:17.066Z] actor1: C2 [2024-07-31T20:21:17.066Z] actor2: C2 [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:17.066Z] JVM args: [-XX:+StressLCM, -XX:+StressGCM, -XX:+StressIGVN, -XX:+StressCCP, -XX:+StressIncrementalInlining, -XX:StressSeed=1872810492] [2024-07-31T20:21:17.066Z] Fork: #3 [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:17.066Z] RESULT SAMPLES FREQ EXPECT DESCRIPTION [2024-07-31T20:21:17.066Z] 0, 0 90,408 33.16% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:21:17.066Z] 0, 2 990 0.36% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:21:17.066Z] 1, 0 3 <0.01% Interesting The write to $b is observed, but write to $a is not. This... [2024-07-31T20:21:17.066Z] 1, 2 181,240 66.48% Acceptable The write to $b is observed, expected to see $a == 1. [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:17.066Z] (Time: 00:00:21 left, 2 tests in flight, 767 ms per test) [2024-07-31T20:21:17.066Z] (Sampling Rate: 101.52 K/sec) [2024-07-31T20:21:17.066Z] (JVMs: 0 starting, 2 running, 0 finishing) [2024-07-31T20:21:17.066Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:21:17.066Z] (Results: 48 planned; 21 passed, 0 failed, 0 soft errs, 0 hard errs) [2024-07-31T20:21:17.066Z] [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:30.908Z] ....... [ERROR] o.o.j.t.locks.barriers.SyncBarrier3Test [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:30.908Z] Scheduling class: [2024-07-31T20:21:30.908Z] actor1: package group 0, core group 0 [2024-07-31T20:21:30.908Z] actor2: package group 0, core group 1 [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:30.908Z] CPU allocation: [2024-07-31T20:21:30.908Z] actor1: CPU #0 (package #0, core #0, thread #0) [2024-07-31T20:21:30.908Z] actor2: CPU #4 (package #0, core #2, thread #4) [2024-07-31T20:21:30.908Z] <system>: CPU #1 (package #0, core #0, thread #1) [2024-07-31T20:21:30.908Z] <system>: CPU #5 (package #0, core #2, thread #5) [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:30.908Z] Compilation: split [2024-07-31T20:21:30.908Z] actor1: C1 [2024-07-31T20:21:30.908Z] actor2: C2 [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:30.908Z] JVM args: [-XX:+StressLCM, -XX:+StressGCM, -XX:+StressIGVN, -XX:+StressCCP, -XX:+StressIncrementalInlining, -XX:StressSeed=2090989492] [2024-07-31T20:21:30.908Z] Fork: #1 [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:30.908Z] Messages: [2024-07-31T20:21:30.908Z] Unrecoverable error while running [2024-07-31T20:21:30.908Z] java.lang.IllegalStateException: Failed: 22 [2024-07-31T20:21:30.908Z] at org.openjdk.jcstress.os.AffinitySupport$Linux.set(AffinitySupport.java:135) [2024-07-31T20:21:30.908Z] at org.openjdk.jcstress.os.AffinitySupport$Linux.bind(AffinitySupport.java:108) [2024-07-31T20:21:30.908Z] at org.openjdk.jcstress.os.AffinitySupport.bind(AffinitySupport.java:37) [2024-07-31T20:21:30.908Z] at org.openjdk.jcstress.tests.locks.barriers.SyncBarrier3Test_jcstress$JcstressThread_actor2.jcstress_iteration_actor2(SyncBarrier3Test_jcstress.java:352) [2024-07-31T20:21:30.908Z] at org.openjdk.jcstress.tests.locks.barriers.SyncBarrier3Test_jcstress$JcstressThread_actor2.internalRun(SyncBarrier3Test_jcstress.java:345) [2024-07-31T20:21:30.908Z] at org.openjdk.jcstress.infra.runners.CounterThread.run(CounterThread.java:44) [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:30.908Z] (Time: 00:00:07 left, 1 tests in flight, 305 ms per test) [2024-07-31T20:21:30.908Z] (Sampling Rate: 100.05 K/sec) [2024-07-31T20:21:30.908Z] (JVMs: 0 starting, 1 running, 0 finishing) [2024-07-31T20:21:30.908Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:21:30.908Z] (Results: 48 planned; 24 passed, 0 failed, 0 soft errs, 1 hard errs) [2024-07-31T20:21:30.908Z] [2024-07-31T20:21:46.768Z] (Time: overtime 00:00:08, 1 tests in flight, 30 ms per test) [2024-07-31T20:21:46.768Z] (Sampling Rate: 89.55 K/sec) [2024-07-31T20:21:46.768Z] (JVMs: 0 starting, 1 running, 0 finishing) [2024-07-31T20:21:46.768Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:21:46.768Z] (Results: 48 planned; 32 passed, 0 failed, 0 soft errs, 1 hard errs) [2024-07-31T20:21:46.768Z] [2024-07-31T20:22:02.565Z] (Time: overtime 00:00:24, 1 tests in flight, 30 ms per test) [2024-07-31T20:22:02.565Z] (Sampling Rate: 81.11 K/sec) [2024-07-31T20:22:02.565Z] (JVMs: 0 starting, 1 running, 0 finishing) [2024-07-31T20:22:02.565Z] (CPUs: 4 configured, 4 allocated) [2024-07-31T20:22:02.565Z] (Results: 48 planned; 42 passed, 0 failed, 0 soft errs, 1 hard errs) [2024-07-31T20:22:02.565Z] [2024-07-31T20:22:10.732Z] (Time: overtime 00:00:33, 1 tests in flight, 30 ms per test) [2024-07-31T20:22:10.732Z] (Sampling Rate: 77.22 K/sec) [2024-07-31T20:22:10.732Z] (JVMs: 0 starting, 0 running, 0 finishing) [2024-07-31T20:22:10.732Z] (CPUs: 4 configured, 0 allocated) [2024-07-31T20:22:10.732Z] (Results: 48 planned; 47 passed, 0 failed, 0 soft errs, 1 hard errs) [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] RUN RESULTS: [2024-07-31T20:22:10.732Z] Interesting tests: No matches. [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] Failed tests: No matches. [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] Error tests: 1 matching test results. [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] ....... [ERROR] o.o.j.t.locks.barriers.SyncBarrier3Test [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] Results across all configurations: [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] RESULT SAMPLES FREQ EXPECT DESCRIPTION [2024-07-31T20:22:10.732Z] 0, 0 3,286,143 24.08% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:22:10.732Z] 0, 2 292,430 2.14% Acceptable The write to $b is not visible yet; we can observe whatev... [2024-07-31T20:22:10.732Z] 1, 0 47 <0.01% Interesting The write to $b is observed, but write to $a is not. This... [2024-07-31T20:22:10.732Z] 1, 2 10,067,779 73.78% Acceptable The write to $b is observed, expected to see $a == 1. [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] Messages: [2024-07-31T20:22:10.732Z] Unrecoverable error while running [2024-07-31T20:22:10.732Z] java.lang.IllegalStateException: Failed: 22 [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.os.AffinitySupport$Linux.set(AffinitySupport.java:135) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.os.AffinitySupport$Linux.bind(AffinitySupport.java:108) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.os.AffinitySupport.bind(AffinitySupport.java:37) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.tests.locks.barriers.SyncBarrier3Test_jcstress$JcstressThread_actor2.jcstress_iteration_actor2(SyncBarrier3Test_jcstress.java:352) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.tests.locks.barriers.SyncBarrier3Test_jcstress$JcstressThread_actor2.internalRun(SyncBarrier3Test_jcstress.java:345) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.infra.runners.CounterThread.run(CounterThread.java:44) [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] All remaining tests: No matches. [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] HTML report generated at /home/jenkins/workspace/Test_openjdk21_hs_dev.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17224552688748/jcstress_SyncBarrier3Test_0/results/index.html [2024-07-31T20:22:10.732Z] Exception in thread "main" java.lang.AssertionError: TEST FAILURES: [2024-07-31T20:22:10.732Z] org.openjdk.jcstress.tests.locks.barriers.SyncBarrier3Test [-XX:+StressLCM, -XX:+StressGCM, -XX:+StressIGVN, -XX:+StressCCP, -XX:+StressIncrementalInlining, -XX:StressSeed=2090989492] had failed with the test error. [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.infra.grading.ExceptionReportPrinter.work(ExceptionReportPrinter.java:63) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.JCStress.parseResults(JCStress.java:143) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.JCStress.run(JCStress.java:110) [2024-07-31T20:22:10.732Z] at org.openjdk.jcstress.Main.main(Main.java:60) [2024-07-31T20:22:10.732Z] ----------------------------------- [2024-07-31T20:22:10.732Z] jcstress_SyncBarrier3Test_0_FAILED [2024-07-31T20:22:10.732Z] ----------------------------------- [2024-07-31T20:22:10.732Z] [2024-07-31T20:22:10.732Z] TEST TEARDOWN: [2024-07-31T20:22:10.732Z] Nothing to be done for teardown. [2024-07-31T20:22:10.732Z] jcstress_SyncBarrier3Test_0 Finish Time: Wed Jul 31 20:22:10 2024 Epoch Time (ms): 1722457330139