[2026-04-22T14:50:58.266Z] Running test renaissance-philosophers_0 ... [2026-04-22T14:50:58.266Z] =============================================== [2026-04-22T14:50:58.266Z] renaissance-philosophers_0 Start Time: Wed Apr 22 14:50:58 2026 Epoch Time (ms): 1776869458112 [2026-04-22T14:50:58.266Z] variation: NoOptions [2026-04-22T14:50:58.266Z] JVM_OPTIONS: [2026-04-22T14:50:58.266Z] { \ [2026-04-22T14:50:58.266Z] echo ""; echo "TEST SETUP:"; \ [2026-04-22T14:50:58.266Z] echo "Nothing to be done for setup."; \ [2026-04-22T14:50:58.266Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17768676246767/renaissance-philosophers_0"; \ [2026-04-22T14:50:58.266Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17768676246767/renaissance-philosophers_0"; \ [2026-04-22T14:50:58.266Z] echo ""; echo "TESTING:"; \ [2026-04-22T14:50:58.266Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17768676246767/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-04-22T14:50:58.266Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17768676246767/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-22T14:50:58.266Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-22T14:50:58.266Z] echo "Nothing to be done for teardown."; \ [2026-04-22T14:50:58.266Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17768676246767/TestTargetResult"; [2026-04-22T14:50:58.266Z] [2026-04-22T14:50:58.266Z] TEST SETUP: [2026-04-22T14:50:58.266Z] Nothing to be done for setup. [2026-04-22T14:50:58.266Z] [2026-04-22T14:50:58.266Z] TESTING: [2026-04-22T14:50:59.474Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-04-22T14:50:59.474Z] GC before operation: completed in 11.306 ms, heap usage 14.051 MB -> 4.644 MB. [2026-04-22T14:51:05.722Z] Camera thread performed 122 scans. [2026-04-22T14:51:05.722Z] ====== philosophers (scala) [default], iteration 0 completed (6473.454 ms) ====== [2026-04-22T14:51:05.722Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-04-22T14:51:05.722Z] GC before operation: completed in 17.380 ms, heap usage 23.283 MB -> 4.992 MB. [2026-04-22T14:51:08.916Z] Camera thread performed 122 scans. [2026-04-22T14:51:08.916Z] ====== philosophers (scala) [default], iteration 1 completed (2569.132 ms) ====== [2026-04-22T14:51:08.916Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-04-22T14:51:08.916Z] GC before operation: completed in 11.886 ms, heap usage 21.051 MB -> 4.991 MB. [2026-04-22T14:51:10.694Z] Camera thread performed 122 scans. [2026-04-22T14:51:10.694Z] ====== philosophers (scala) [default], iteration 2 completed (1931.172 ms) ====== [2026-04-22T14:51:10.694Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-04-22T14:51:10.694Z] GC before operation: completed in 11.623 ms, heap usage 38.098 MB -> 4.992 MB. [2026-04-22T14:51:12.440Z] Camera thread performed 122 scans. [2026-04-22T14:51:12.440Z] ====== philosophers (scala) [default], iteration 3 completed (1972.943 ms) ====== [2026-04-22T14:51:12.440Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-04-22T14:51:12.440Z] GC before operation: completed in 11.913 ms, heap usage 68.205 MB -> 4.993 MB. [2026-04-22T14:51:14.324Z] Camera thread performed 122 scans. [2026-04-22T14:51:14.324Z] ====== philosophers (scala) [default], iteration 4 completed (1931.409 ms) ====== [2026-04-22T14:51:14.324Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-04-22T14:51:14.324Z] GC before operation: completed in 14.985 ms, heap usage 73.797 MB -> 4.993 MB. [2026-04-22T14:51:16.721Z] Camera thread performed 122 scans. [2026-04-22T14:51:16.721Z] ====== philosophers (scala) [default], iteration 5 completed (1975.927 ms) ====== [2026-04-22T14:51:16.721Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-04-22T14:51:16.721Z] GC before operation: completed in 11.788 ms, heap usage 41.978 MB -> 4.993 MB. [2026-04-22T14:51:18.465Z] Camera thread performed 122 scans. [2026-04-22T14:51:18.465Z] ====== philosophers (scala) [default], iteration 6 completed (1910.451 ms) ====== [2026-04-22T14:51:18.465Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-04-22T14:51:18.465Z] GC before operation: completed in 12.162 ms, heap usage 61.014 MB -> 4.994 MB. [2026-04-22T14:51:20.212Z] Camera thread performed 122 scans. [2026-04-22T14:51:20.212Z] ====== philosophers (scala) [default], iteration 7 completed (1831.310 ms) ====== [2026-04-22T14:51:20.212Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-04-22T14:51:20.212Z] GC before operation: completed in 11.729 ms, heap usage 42.224 MB -> 4.994 MB. [2026-04-22T14:51:22.587Z] Camera thread performed 122 scans. [2026-04-22T14:51:22.587Z] ====== philosophers (scala) [default], iteration 8 completed (2054.380 ms) ====== [2026-04-22T14:51:22.587Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-04-22T14:51:22.587Z] GC before operation: completed in 12.052 ms, heap usage 22.222 MB -> 4.994 MB. [2026-04-22T14:51:24.333Z] Camera thread performed 122 scans. [2026-04-22T14:51:24.333Z] ====== philosophers (scala) [default], iteration 9 completed (2031.206 ms) ====== [2026-04-22T14:51:24.333Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-04-22T14:51:24.333Z] GC before operation: completed in 12.006 ms, heap usage 59.570 MB -> 4.995 MB. [2026-04-22T14:51:26.075Z] Camera thread performed 122 scans. [2026-04-22T14:51:26.075Z] ====== philosophers (scala) [default], iteration 10 completed (1950.390 ms) ====== [2026-04-22T14:51:26.075Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-04-22T14:51:26.075Z] GC before operation: completed in 11.864 ms, heap usage 28.240 MB -> 4.995 MB. [2026-04-22T14:51:28.453Z] Camera thread performed 122 scans. [2026-04-22T14:51:28.453Z] ====== philosophers (scala) [default], iteration 11 completed (1966.772 ms) ====== [2026-04-22T14:51:28.453Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-04-22T14:51:28.453Z] GC before operation: completed in 12.250 ms, heap usage 15.069 MB -> 4.995 MB. [2026-04-22T14:51:30.204Z] Camera thread performed 122 scans. [2026-04-22T14:51:30.204Z] ====== philosophers (scala) [default], iteration 12 completed (1977.984 ms) ====== [2026-04-22T14:51:30.204Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-04-22T14:51:30.204Z] GC before operation: completed in 12.097 ms, heap usage 76.027 MB -> 4.995 MB. [2026-04-22T14:51:31.950Z] Camera thread performed 122 scans. [2026-04-22T14:51:31.950Z] ====== philosophers (scala) [default], iteration 13 completed (1890.476 ms) ====== [2026-04-22T14:51:31.950Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-04-22T14:51:31.950Z] GC before operation: completed in 12.227 ms, heap usage 28.121 MB -> 4.995 MB. [2026-04-22T14:51:34.332Z] Camera thread performed 122 scans. [2026-04-22T14:51:34.332Z] ====== philosophers (scala) [default], iteration 14 completed (1909.627 ms) ====== [2026-04-22T14:51:34.332Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-04-22T14:51:34.332Z] GC before operation: completed in 12.382 ms, heap usage 76.634 MB -> 4.996 MB. [2026-04-22T14:51:36.079Z] Camera thread performed 122 scans. [2026-04-22T14:51:36.079Z] ====== philosophers (scala) [default], iteration 15 completed (1903.186 ms) ====== [2026-04-22T14:51:36.079Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-04-22T14:51:36.079Z] GC before operation: completed in 11.945 ms, heap usage 51.597 MB -> 4.996 MB. [2026-04-22T14:51:37.825Z] Camera thread performed 122 scans. [2026-04-22T14:51:37.825Z] ====== philosophers (scala) [default], iteration 16 completed (1923.826 ms) ====== [2026-04-22T14:51:37.825Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-04-22T14:51:37.825Z] GC before operation: completed in 12.013 ms, heap usage 33.246 MB -> 4.996 MB. [2026-04-22T14:51:39.733Z] Camera thread performed 122 scans. [2026-04-22T14:51:39.733Z] ====== philosophers (scala) [default], iteration 17 completed (1996.318 ms) ====== [2026-04-22T14:51:39.733Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-04-22T14:51:39.733Z] GC before operation: completed in 12.033 ms, heap usage 71.924 MB -> 4.996 MB. [2026-04-22T14:51:42.101Z] Camera thread performed 122 scans. [2026-04-22T14:51:42.101Z] ====== philosophers (scala) [default], iteration 18 completed (1905.499 ms) ====== [2026-04-22T14:51:42.101Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-04-22T14:51:42.101Z] GC before operation: completed in 12.109 ms, heap usage 24.651 MB -> 4.996 MB. [2026-04-22T14:51:43.846Z] Camera thread performed 122 scans. [2026-04-22T14:51:43.846Z] ====== philosophers (scala) [default], iteration 19 completed (1963.772 ms) ====== [2026-04-22T14:51:43.846Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-04-22T14:51:43.846Z] GC before operation: completed in 12.411 ms, heap usage 43.988 MB -> 4.996 MB. [2026-04-22T14:51:45.594Z] Camera thread performed 122 scans. [2026-04-22T14:51:45.594Z] ====== philosophers (scala) [default], iteration 20 completed (1905.113 ms) ====== [2026-04-22T14:51:45.594Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-04-22T14:51:45.594Z] GC before operation: completed in 12.265 ms, heap usage 26.122 MB -> 4.996 MB. [2026-04-22T14:51:47.961Z] Camera thread performed 122 scans. [2026-04-22T14:51:47.961Z] ====== philosophers (scala) [default], iteration 21 completed (1923.340 ms) ====== [2026-04-22T14:51:47.961Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-04-22T14:51:47.961Z] GC before operation: completed in 12.180 ms, heap usage 10.656 MB -> 4.996 MB. [2026-04-22T14:51:49.712Z] Camera thread performed 122 scans. [2026-04-22T14:51:49.712Z] ====== philosophers (scala) [default], iteration 22 completed (1939.661 ms) ====== [2026-04-22T14:51:49.712Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-04-22T14:51:49.712Z] GC before operation: completed in 12.506 ms, heap usage 20.031 MB -> 4.997 MB. [2026-04-22T14:51:51.476Z] Camera thread performed 122 scans. [2026-04-22T14:51:51.476Z] ====== philosophers (scala) [default], iteration 23 completed (1997.872 ms) ====== [2026-04-22T14:51:51.476Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-04-22T14:51:51.476Z] GC before operation: completed in 12.095 ms, heap usage 38.608 MB -> 4.997 MB. [2026-04-22T14:51:53.859Z] Camera thread performed 122 scans. [2026-04-22T14:51:53.859Z] ====== philosophers (scala) [default], iteration 24 completed (1968.402 ms) ====== [2026-04-22T14:51:53.859Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-04-22T14:51:53.859Z] GC before operation: completed in 12.330 ms, heap usage 43.215 MB -> 4.997 MB. [2026-04-22T14:51:55.631Z] Camera thread performed 122 scans. [2026-04-22T14:51:55.631Z] ====== philosophers (scala) [default], iteration 25 completed (1938.216 ms) ====== [2026-04-22T14:51:55.631Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-04-22T14:51:55.631Z] GC before operation: completed in 12.435 ms, heap usage 10.138 MB -> 4.996 MB. [2026-04-22T14:51:57.399Z] Camera thread performed 122 scans. [2026-04-22T14:51:57.399Z] ====== philosophers (scala) [default], iteration 26 completed (1944.313 ms) ====== [2026-04-22T14:51:57.399Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-04-22T14:51:57.399Z] GC before operation: completed in 12.700 ms, heap usage 56.135 MB -> 4.997 MB. [2026-04-22T14:51:59.774Z] Camera thread performed 122 scans. [2026-04-22T14:51:59.774Z] ====== philosophers (scala) [default], iteration 27 completed (1942.670 ms) ====== [2026-04-22T14:51:59.774Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-04-22T14:51:59.774Z] GC before operation: completed in 11.951 ms, heap usage 13.730 MB -> 4.996 MB. [2026-04-22T14:52:01.526Z] Camera thread performed 122 scans. [2026-04-22T14:52:01.526Z] ====== philosophers (scala) [default], iteration 28 completed (1894.200 ms) ====== [2026-04-22T14:52:01.526Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-04-22T14:52:01.526Z] GC before operation: completed in 12.201 ms, heap usage 44.625 MB -> 4.997 MB. [2026-04-22T14:52:03.383Z] Camera thread performed 122 scans. [2026-04-22T14:52:03.383Z] ====== philosophers (scala) [default], iteration 29 completed (1988.245 ms) ====== [2026-04-22T14:52:03.729Z] ----------------------------------- [2026-04-22T14:52:03.729Z] renaissance-philosophers_0_PASSED [2026-04-22T14:52:03.729Z] ----------------------------------- [2026-04-22T14:52:03.729Z] [2026-04-22T14:52:03.729Z] TEST TEARDOWN: [2026-04-22T14:52:03.729Z] Nothing to be done for teardown. [2026-04-22T14:52:03.729Z] renaissance-philosophers_0 Finish Time: Wed Apr 22 14:52:03 2026 Epoch Time (ms): 1776869523397