[2026-04-01T21:34:57.413Z] Running test renaissance-philosophers_0 ... [2026-04-01T21:34:57.413Z] =============================================== [2026-04-01T21:34:57.413Z] renaissance-philosophers_0 Start Time: Wed Apr 1 21:34:56 2026 Epoch Time (ms): 1775079296713 [2026-04-01T21:34:57.413Z] variation: NoOptions [2026-04-01T21:34:57.413Z] JVM_OPTIONS: [2026-04-01T21:34:57.413Z] { \ [2026-04-01T21:34:57.413Z] echo ""; echo "TEST SETUP:"; \ [2026-04-01T21:34:57.413Z] echo "Nothing to be done for setup."; \ [2026-04-01T21:34:57.413Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-philosophers_0"; \ [2026-04-01T21:34:57.413Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-philosophers_0"; \ [2026-04-01T21:34:57.413Z] echo ""; echo "TESTING:"; \ [2026-04-01T21:34:57.413Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/bin/java" --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.util=ALL-UNNAMED --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.base/java.lang.invoke=ALL-UNNAMED -jar "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-04-01T21:34:57.413Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-01T21:34:57.413Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-01T21:34:57.413Z] echo "Nothing to be done for teardown."; \ [2026-04-01T21:34:57.413Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/TestTargetResult"; [2026-04-01T21:34:57.413Z] [2026-04-01T21:34:57.413Z] TEST SETUP: [2026-04-01T21:34:57.413Z] Nothing to be done for setup. [2026-04-01T21:34:57.413Z] [2026-04-01T21:34:57.413Z] TESTING: [2026-04-01T21:34:57.413Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-04-01T21:34:57.413Z] GC before operation: completed in 15.990 ms, heap usage 16.090 MB -> 5.641 MB. [2026-04-01T21:35:03.301Z] Camera thread performed 122 scans. [2026-04-01T21:35:03.301Z] ====== philosophers (scala) [default], iteration 0 completed (4948.118 ms) ====== [2026-04-01T21:35:03.301Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-04-01T21:35:03.301Z] GC before operation: completed in 25.519 ms, heap usage 81.241 MB -> 5.995 MB. [2026-04-01T21:35:05.558Z] Camera thread performed 122 scans. [2026-04-01T21:35:05.558Z] ====== philosophers (scala) [default], iteration 1 completed (2891.286 ms) ====== [2026-04-01T21:35:05.558Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-04-01T21:35:05.558Z] GC before operation: completed in 18.577 ms, heap usage 70.182 MB -> 5.995 MB. [2026-04-01T21:35:09.409Z] Camera thread performed 122 scans. [2026-04-01T21:35:09.409Z] ====== philosophers (scala) [default], iteration 2 completed (3397.374 ms) ====== [2026-04-01T21:35:09.409Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-04-01T21:35:09.409Z] GC before operation: completed in 14.126 ms, heap usage 62.184 MB -> 5.996 MB. [2026-04-01T21:35:12.311Z] Camera thread performed 122 scans. [2026-04-01T21:35:12.311Z] ====== philosophers (scala) [default], iteration 3 completed (3411.173 ms) ====== [2026-04-01T21:35:12.311Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-04-01T21:35:12.311Z] GC before operation: completed in 15.259 ms, heap usage 15.277 MB -> 5.996 MB. [2026-04-01T21:35:16.055Z] Camera thread performed 122 scans. [2026-04-01T21:35:16.055Z] ====== philosophers (scala) [default], iteration 4 completed (3621.334 ms) ====== [2026-04-01T21:35:16.055Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-04-01T21:35:16.055Z] GC before operation: completed in 16.118 ms, heap usage 54.035 MB -> 5.997 MB. [2026-04-01T21:35:19.777Z] Camera thread performed 122 scans. [2026-04-01T21:35:19.777Z] ====== philosophers (scala) [default], iteration 5 completed (3211.090 ms) ====== [2026-04-01T21:35:19.777Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-04-01T21:35:19.777Z] GC before operation: completed in 16.659 ms, heap usage 69.049 MB -> 5.996 MB. [2026-04-01T21:35:22.728Z] Camera thread performed 122 scans. [2026-04-01T21:35:22.728Z] ====== philosophers (scala) [default], iteration 6 completed (3217.445 ms) ====== [2026-04-01T21:35:22.728Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-04-01T21:35:22.728Z] GC before operation: completed in 14.637 ms, heap usage 52.612 MB -> 5.998 MB. [2026-04-01T21:35:25.663Z] Camera thread performed 122 scans. [2026-04-01T21:35:25.663Z] ====== philosophers (scala) [default], iteration 7 completed (3235.736 ms) ====== [2026-04-01T21:35:25.663Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-04-01T21:35:25.663Z] GC before operation: completed in 14.952 ms, heap usage 10.661 MB -> 5.997 MB. [2026-04-01T21:35:29.620Z] Camera thread performed 122 scans. [2026-04-01T21:35:29.620Z] ====== philosophers (scala) [default], iteration 8 completed (3369.586 ms) ====== [2026-04-01T21:35:29.620Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-04-01T21:35:29.620Z] GC before operation: completed in 13.053 ms, heap usage 18.680 MB -> 5.998 MB. [2026-04-01T21:35:32.669Z] Camera thread performed 122 scans. [2026-04-01T21:35:32.669Z] ====== philosophers (scala) [default], iteration 9 completed (3137.692 ms) ====== [2026-04-01T21:35:32.669Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-04-01T21:35:32.669Z] GC before operation: completed in 17.010 ms, heap usage 86.207 MB -> 5.998 MB. [2026-04-01T21:35:36.453Z] Camera thread performed 122 scans. [2026-04-01T21:35:36.453Z] ====== philosophers (scala) [default], iteration 10 completed (3741.046 ms) ====== [2026-04-01T21:35:36.453Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-04-01T21:35:36.453Z] GC before operation: completed in 16.990 ms, heap usage 46.607 MB -> 5.998 MB. [2026-04-01T21:35:39.409Z] Camera thread performed 122 scans. [2026-04-01T21:35:39.409Z] ====== philosophers (scala) [default], iteration 11 completed (3295.322 ms) ====== [2026-04-01T21:35:39.409Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-04-01T21:35:39.409Z] GC before operation: completed in 14.172 ms, heap usage 74.200 MB -> 5.998 MB. [2026-04-01T21:35:42.368Z] Camera thread performed 122 scans. [2026-04-01T21:35:42.368Z] ====== philosophers (scala) [default], iteration 12 completed (3232.795 ms) ====== [2026-04-01T21:35:42.368Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-04-01T21:35:42.368Z] GC before operation: completed in 18.091 ms, heap usage 54.600 MB -> 5.999 MB. [2026-04-01T21:35:46.073Z] Camera thread performed 122 scans. [2026-04-01T21:35:46.073Z] ====== philosophers (scala) [default], iteration 13 completed (3313.509 ms) ====== [2026-04-01T21:35:46.073Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-04-01T21:35:46.073Z] GC before operation: completed in 17.435 ms, heap usage 11.192 MB -> 5.999 MB. [2026-04-01T21:35:48.961Z] Camera thread performed 122 scans. [2026-04-01T21:35:48.961Z] ====== philosophers (scala) [default], iteration 14 completed (3244.870 ms) ====== [2026-04-01T21:35:48.961Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-04-01T21:35:48.961Z] GC before operation: completed in 16.407 ms, heap usage 57.422 MB -> 5.999 MB. [2026-04-01T21:35:52.685Z] Camera thread performed 122 scans. [2026-04-01T21:35:52.685Z] ====== philosophers (scala) [default], iteration 15 completed (3438.908 ms) ====== [2026-04-01T21:35:52.685Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-04-01T21:35:52.685Z] GC before operation: completed in 16.293 ms, heap usage 28.217 MB -> 5.999 MB. [2026-04-01T21:35:56.487Z] Camera thread performed 122 scans. [2026-04-01T21:35:56.487Z] ====== philosophers (scala) [default], iteration 16 completed (3506.880 ms) ====== [2026-04-01T21:35:56.487Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-04-01T21:35:56.487Z] GC before operation: completed in 14.458 ms, heap usage 46.195 MB -> 5.999 MB. [2026-04-01T21:35:59.468Z] Camera thread performed 122 scans. [2026-04-01T21:35:59.468Z] ====== philosophers (scala) [default], iteration 17 completed (3078.896 ms) ====== [2026-04-01T21:35:59.468Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-04-01T21:35:59.468Z] GC before operation: completed in 17.892 ms, heap usage 33.012 MB -> 5.999 MB. [2026-04-01T21:36:03.222Z] Camera thread performed 122 scans. [2026-04-01T21:36:03.222Z] ====== philosophers (scala) [default], iteration 18 completed (3543.310 ms) ====== [2026-04-01T21:36:03.222Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-04-01T21:36:03.222Z] GC before operation: completed in 19.041 ms, heap usage 58.209 MB -> 6.000 MB. [2026-04-01T21:36:06.981Z] Camera thread performed 122 scans. [2026-04-01T21:36:06.981Z] ====== philosophers (scala) [default], iteration 19 completed (3674.854 ms) ====== [2026-04-01T21:36:06.981Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-04-01T21:36:06.981Z] GC before operation: completed in 13.991 ms, heap usage 41.433 MB -> 6.000 MB. [2026-04-01T21:36:09.863Z] Camera thread performed 122 scans. [2026-04-01T21:36:09.863Z] ====== philosophers (scala) [default], iteration 20 completed (3480.490 ms) ====== [2026-04-01T21:36:09.863Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-04-01T21:36:09.863Z] GC before operation: completed in 10.869 ms, heap usage 89.055 MB -> 5.999 MB. [2026-04-01T21:36:12.738Z] Camera thread performed 122 scans. [2026-04-01T21:36:12.738Z] ====== philosophers (scala) [default], iteration 21 completed (2627.891 ms) ====== [2026-04-01T21:36:12.738Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-04-01T21:36:12.738Z] GC before operation: completed in 15.562 ms, heap usage 60.678 MB -> 5.999 MB. [2026-04-01T21:36:16.424Z] Camera thread performed 122 scans. [2026-04-01T21:36:16.424Z] ====== philosophers (scala) [default], iteration 22 completed (3281.818 ms) ====== [2026-04-01T21:36:16.424Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-04-01T21:36:16.424Z] GC before operation: completed in 15.251 ms, heap usage 18.673 MB -> 6.000 MB. [2026-04-01T21:36:19.360Z] Camera thread performed 122 scans. [2026-04-01T21:36:19.360Z] ====== philosophers (scala) [default], iteration 23 completed (3119.520 ms) ====== [2026-04-01T21:36:19.360Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-04-01T21:36:19.360Z] GC before operation: completed in 16.296 ms, heap usage 37.774 MB -> 6.000 MB. [2026-04-01T21:36:22.239Z] Camera thread performed 122 scans. [2026-04-01T21:36:22.239Z] ====== philosophers (scala) [default], iteration 24 completed (3317.746 ms) ====== [2026-04-01T21:36:22.239Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-04-01T21:36:22.239Z] GC before operation: completed in 15.542 ms, heap usage 81.811 MB -> 6.000 MB. [2026-04-01T21:36:26.007Z] Camera thread performed 122 scans. [2026-04-01T21:36:26.007Z] ====== philosophers (scala) [default], iteration 25 completed (3434.952 ms) ====== [2026-04-01T21:36:26.007Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-04-01T21:36:26.007Z] GC before operation: completed in 16.109 ms, heap usage 74.216 MB -> 5.999 MB. [2026-04-01T21:36:29.727Z] Camera thread performed 122 scans. [2026-04-01T21:36:29.727Z] ====== philosophers (scala) [default], iteration 26 completed (3595.947 ms) ====== [2026-04-01T21:36:29.727Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-04-01T21:36:29.727Z] GC before operation: completed in 17.608 ms, heap usage 11.561 MB -> 6.000 MB. [2026-04-01T21:36:32.674Z] Camera thread performed 122 scans. [2026-04-01T21:36:32.674Z] ====== philosophers (scala) [default], iteration 27 completed (3094.057 ms) ====== [2026-04-01T21:36:32.674Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-04-01T21:36:32.674Z] GC before operation: completed in 16.040 ms, heap usage 23.866 MB -> 6.000 MB. [2026-04-01T21:36:36.381Z] Camera thread performed 122 scans. [2026-04-01T21:36:36.381Z] ====== philosophers (scala) [default], iteration 28 completed (3637.190 ms) ====== [2026-04-01T21:36:36.381Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-04-01T21:36:36.381Z] GC before operation: completed in 16.124 ms, heap usage 72.210 MB -> 6.000 MB. [2026-04-01T21:36:40.109Z] Camera thread performed 122 scans. [2026-04-01T21:36:40.109Z] ====== philosophers (scala) [default], iteration 29 completed (3462.561 ms) ====== [2026-04-01T21:36:40.109Z] ----------------------------------- [2026-04-01T21:36:40.109Z] renaissance-philosophers_0_PASSED [2026-04-01T21:36:40.109Z] ----------------------------------- [2026-04-01T21:36:40.109Z] [2026-04-01T21:36:40.109Z] TEST TEARDOWN: [2026-04-01T21:36:40.109Z] Nothing to be done for teardown. [2026-04-01T21:36:40.109Z] renaissance-philosophers_0 Finish Time: Wed Apr 1 21:36:39 2026 Epoch Time (ms): 1775079399649