[2026-02-11T00:06:17.059Z] Running test renaissance-philosophers_0 ... [2026-02-11T00:06:17.059Z] =============================================== [2026-02-11T00:06:17.059Z] renaissance-philosophers_0 Start Time: Wed Feb 11 00:06:16 2026 Epoch Time (ms): 1770768376639 [2026-02-11T00:06:17.059Z] variation: NoOptions [2026-02-11T00:06:17.059Z] JVM_OPTIONS: [2026-02-11T00:06:17.059Z] { \ [2026-02-11T00:06:17.059Z] echo ""; echo "TEST SETUP:"; \ [2026-02-11T00:06:17.059Z] echo "Nothing to be done for setup."; \ [2026-02-11T00:06:17.059Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17707669071718/renaissance-philosophers_0"; \ [2026-02-11T00:06:17.059Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17707669071718/renaissance-philosophers_0"; \ [2026-02-11T00:06:17.059Z] echo ""; echo "TESTING:"; \ [2026-02-11T00:06:17.059Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17707669071718/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-11T00:06:17.059Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17707669071718/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-11T00:06:17.059Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-11T00:06:17.059Z] echo "Nothing to be done for teardown."; \ [2026-02-11T00:06:17.059Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17707669071718/TestTargetResult"; [2026-02-11T00:06:17.059Z] [2026-02-11T00:06:17.059Z] TEST SETUP: [2026-02-11T00:06:17.059Z] Nothing to be done for setup. [2026-02-11T00:06:17.059Z] [2026-02-11T00:06:17.059Z] TESTING: [2026-02-11T00:06:17.772Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-11T00:06:17.773Z] GC before operation: completed in 17.481 ms, heap usage 15.274 MB -> 4.214 MB. [2026-02-11T00:06:20.754Z] Camera thread performed 122 scans. [2026-02-11T00:06:20.754Z] ====== philosophers (scala) [default], iteration 0 completed (2713.731 ms) ====== [2026-02-11T00:06:20.754Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-11T00:06:20.754Z] GC before operation: completed in 25.061 ms, heap usage 42.033 MB -> 4.626 MB. [2026-02-11T00:06:23.717Z] Camera thread performed 122 scans. [2026-02-11T00:06:23.717Z] ====== philosophers (scala) [default], iteration 1 completed (2873.745 ms) ====== [2026-02-11T00:06:23.717Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-11T00:06:23.717Z] GC before operation: completed in 22.782 ms, heap usage 80.819 MB -> 4.626 MB. [2026-02-11T00:06:26.678Z] Camera thread performed 122 scans. [2026-02-11T00:06:26.678Z] ====== philosophers (scala) [default], iteration 2 completed (3007.176 ms) ====== [2026-02-11T00:06:26.678Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-11T00:06:26.678Z] GC before operation: completed in 17.836 ms, heap usage 45.666 MB -> 4.630 MB. [2026-02-11T00:06:28.945Z] Camera thread performed 122 scans. [2026-02-11T00:06:28.945Z] ====== philosophers (scala) [default], iteration 3 completed (2405.108 ms) ====== [2026-02-11T00:06:28.945Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-11T00:06:28.945Z] GC before operation: completed in 19.412 ms, heap usage 80.789 MB -> 4.632 MB. [2026-02-11T00:06:31.907Z] Camera thread performed 122 scans. [2026-02-11T00:06:31.907Z] ====== philosophers (scala) [default], iteration 4 completed (2888.695 ms) ====== [2026-02-11T00:06:31.907Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-11T00:06:31.907Z] GC before operation: completed in 18.213 ms, heap usage 48.970 MB -> 4.634 MB. [2026-02-11T00:06:34.873Z] Camera thread performed 122 scans. [2026-02-11T00:06:34.873Z] ====== philosophers (scala) [default], iteration 5 completed (2937.130 ms) ====== [2026-02-11T00:06:34.873Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-11T00:06:34.873Z] GC before operation: completed in 16.157 ms, heap usage 14.310 MB -> 4.633 MB. [2026-02-11T00:06:37.836Z] Camera thread performed 122 scans. [2026-02-11T00:06:37.836Z] ====== philosophers (scala) [default], iteration 6 completed (2938.561 ms) ====== [2026-02-11T00:06:37.836Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-11T00:06:37.836Z] GC before operation: completed in 17.238 ms, heap usage 18.376 MB -> 4.635 MB. [2026-02-11T00:06:40.890Z] Camera thread performed 122 scans. [2026-02-11T00:06:40.890Z] ====== philosophers (scala) [default], iteration 7 completed (3201.418 ms) ====== [2026-02-11T00:06:40.890Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-11T00:06:40.890Z] GC before operation: completed in 17.450 ms, heap usage 51.263 MB -> 4.635 MB. [2026-02-11T00:06:43.850Z] Camera thread performed 122 scans. [2026-02-11T00:06:43.851Z] ====== philosophers (scala) [default], iteration 8 completed (2924.688 ms) ====== [2026-02-11T00:06:43.851Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-11T00:06:43.851Z] GC before operation: completed in 19.731 ms, heap usage 59.864 MB -> 4.635 MB. [2026-02-11T00:06:46.811Z] Camera thread performed 122 scans. [2026-02-11T00:06:46.811Z] ====== philosophers (scala) [default], iteration 9 completed (3093.275 ms) ====== [2026-02-11T00:06:46.811Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-11T00:06:46.811Z] GC before operation: completed in 20.001 ms, heap usage 71.818 MB -> 4.635 MB. [2026-02-11T00:06:50.622Z] Camera thread performed 122 scans. [2026-02-11T00:06:50.622Z] ====== philosophers (scala) [default], iteration 10 completed (3246.739 ms) ====== [2026-02-11T00:06:50.622Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-11T00:06:50.622Z] GC before operation: completed in 15.110 ms, heap usage 11.854 MB -> 4.636 MB. [2026-02-11T00:06:53.586Z] Camera thread performed 122 scans. [2026-02-11T00:06:53.586Z] ====== philosophers (scala) [default], iteration 11 completed (3213.211 ms) ====== [2026-02-11T00:06:53.586Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-11T00:06:53.586Z] GC before operation: completed in 16.177 ms, heap usage 15.800 MB -> 4.636 MB. [2026-02-11T00:06:56.550Z] Camera thread performed 122 scans. [2026-02-11T00:06:56.550Z] ====== philosophers (scala) [default], iteration 12 completed (3025.753 ms) ====== [2026-02-11T00:06:56.550Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-11T00:06:56.550Z] GC before operation: completed in 17.859 ms, heap usage 40.362 MB -> 4.637 MB. [2026-02-11T00:06:59.516Z] Camera thread performed 122 scans. [2026-02-11T00:06:59.516Z] ====== philosophers (scala) [default], iteration 13 completed (3096.365 ms) ====== [2026-02-11T00:06:59.516Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-11T00:06:59.516Z] GC before operation: completed in 18.559 ms, heap usage 35.570 MB -> 4.637 MB. [2026-02-11T00:07:03.313Z] Camera thread performed 122 scans. [2026-02-11T00:07:03.313Z] ====== philosophers (scala) [default], iteration 14 completed (3230.256 ms) ====== [2026-02-11T00:07:03.313Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-11T00:07:03.313Z] GC before operation: completed in 19.632 ms, heap usage 79.847 MB -> 4.637 MB. [2026-02-11T00:07:06.276Z] Camera thread performed 122 scans. [2026-02-11T00:07:06.276Z] ====== philosophers (scala) [default], iteration 15 completed (2995.710 ms) ====== [2026-02-11T00:07:06.276Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-11T00:07:06.276Z] GC before operation: completed in 16.125 ms, heap usage 12.757 MB -> 4.637 MB. [2026-02-11T00:07:09.328Z] Camera thread performed 122 scans. [2026-02-11T00:07:09.328Z] ====== philosophers (scala) [default], iteration 16 completed (3032.922 ms) ====== [2026-02-11T00:07:09.328Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-11T00:07:09.328Z] GC before operation: completed in 18.001 ms, heap usage 67.312 MB -> 4.637 MB. [2026-02-11T00:07:12.293Z] Camera thread performed 122 scans. [2026-02-11T00:07:12.293Z] ====== philosophers (scala) [default], iteration 17 completed (3079.550 ms) ====== [2026-02-11T00:07:12.293Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-11T00:07:12.293Z] GC before operation: completed in 19.780 ms, heap usage 64.608 MB -> 4.637 MB. [2026-02-11T00:07:14.553Z] Camera thread performed 122 scans. [2026-02-11T00:07:14.553Z] ====== philosophers (scala) [default], iteration 18 completed (2740.617 ms) ====== [2026-02-11T00:07:14.553Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-11T00:07:14.553Z] GC before operation: completed in 15.408 ms, heap usage 11.370 MB -> 4.637 MB. [2026-02-11T00:07:17.516Z] Camera thread performed 122 scans. [2026-02-11T00:07:17.516Z] ====== philosophers (scala) [default], iteration 19 completed (2872.343 ms) ====== [2026-02-11T00:07:17.516Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-11T00:07:17.516Z] GC before operation: completed in 15.973 ms, heap usage 27.861 MB -> 4.637 MB. [2026-02-11T00:07:20.481Z] Camera thread performed 122 scans. [2026-02-11T00:07:20.481Z] ====== philosophers (scala) [default], iteration 20 completed (2444.800 ms) ====== [2026-02-11T00:07:20.481Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-11T00:07:20.481Z] GC before operation: completed in 19.334 ms, heap usage 77.535 MB -> 4.638 MB. [2026-02-11T00:07:23.450Z] Camera thread performed 122 scans. [2026-02-11T00:07:23.450Z] ====== philosophers (scala) [default], iteration 21 completed (3063.784 ms) ====== [2026-02-11T00:07:23.450Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-11T00:07:23.450Z] GC before operation: completed in 18.578 ms, heap usage 78.281 MB -> 4.638 MB. [2026-02-11T00:07:26.417Z] Camera thread performed 122 scans. [2026-02-11T00:07:26.417Z] ====== philosophers (scala) [default], iteration 22 completed (3142.121 ms) ====== [2026-02-11T00:07:26.417Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-11T00:07:26.417Z] GC before operation: completed in 18.242 ms, heap usage 77.808 MB -> 4.638 MB. [2026-02-11T00:07:29.380Z] Camera thread performed 122 scans. [2026-02-11T00:07:29.380Z] ====== philosophers (scala) [default], iteration 23 completed (3191.837 ms) ====== [2026-02-11T00:07:29.380Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-11T00:07:29.380Z] GC before operation: completed in 18.406 ms, heap usage 68.253 MB -> 4.638 MB. [2026-02-11T00:07:33.166Z] Camera thread performed 122 scans. [2026-02-11T00:07:33.166Z] ====== philosophers (scala) [default], iteration 24 completed (3245.138 ms) ====== [2026-02-11T00:07:33.166Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-11T00:07:33.166Z] GC before operation: completed in 16.800 ms, heap usage 14.864 MB -> 4.638 MB. [2026-02-11T00:07:36.221Z] Camera thread performed 122 scans. [2026-02-11T00:07:36.221Z] ====== philosophers (scala) [default], iteration 25 completed (3020.381 ms) ====== [2026-02-11T00:07:36.221Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-11T00:07:36.221Z] GC before operation: completed in 18.467 ms, heap usage 58.840 MB -> 4.638 MB. [2026-02-11T00:07:39.193Z] Camera thread performed 122 scans. [2026-02-11T00:07:39.193Z] ====== philosophers (scala) [default], iteration 26 completed (3035.703 ms) ====== [2026-02-11T00:07:39.193Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-11T00:07:39.193Z] GC before operation: completed in 19.416 ms, heap usage 95.865 MB -> 4.638 MB. [2026-02-11T00:07:42.155Z] Camera thread performed 122 scans. [2026-02-11T00:07:42.155Z] ====== philosophers (scala) [default], iteration 27 completed (3221.815 ms) ====== [2026-02-11T00:07:42.155Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-11T00:07:42.155Z] GC before operation: completed in 20.445 ms, heap usage 69.850 MB -> 4.639 MB. [2026-02-11T00:07:45.120Z] Camera thread performed 122 scans. [2026-02-11T00:07:45.120Z] ====== philosophers (scala) [default], iteration 28 completed (3185.361 ms) ====== [2026-02-11T00:07:45.120Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-11T00:07:45.451Z] GC before operation: completed in 17.936 ms, heap usage 49.867 MB -> 4.639 MB. [2026-02-11T00:07:48.410Z] Camera thread performed 122 scans. [2026-02-11T00:07:48.410Z] ====== philosophers (scala) [default], iteration 29 completed (3052.256 ms) ====== [2026-02-11T00:07:48.410Z] ----------------------------------- [2026-02-11T00:07:48.410Z] renaissance-philosophers_0_PASSED [2026-02-11T00:07:48.410Z] ----------------------------------- [2026-02-11T00:07:48.410Z] [2026-02-11T00:07:48.410Z] TEST TEARDOWN: [2026-02-11T00:07:48.410Z] Nothing to be done for teardown. [2026-02-11T00:07:48.410Z] renaissance-philosophers_0 Finish Time: Wed Feb 11 00:07:48 2026 Epoch Time (ms): 1770768468396