[2026-01-10T20:43:43.065Z] Running test renaissance-philosophers_0 ... [2026-01-10T20:43:43.065Z] =============================================== [2026-01-10T20:43:43.065Z] renaissance-philosophers_0 Start Time: Sat Jan 10 20:43:42 2026 Epoch Time (ms): 1768077822675 [2026-01-10T20:43:43.065Z] variation: NoOptions [2026-01-10T20:43:43.065Z] JVM_OPTIONS: [2026-01-10T20:43:43.065Z] { \ [2026-01-10T20:43:43.065Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T20:43:43.065Z] echo "Nothing to be done for setup."; \ [2026-01-10T20:43:43.065Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/aqa-tests/\\TKG\\output_17680761794427\\renaissance-philosophers_0"; \ [2026-01-10T20:43:43.065Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/aqa-tests/\\TKG\\output_17680761794427\\renaissance-philosophers_0"; \ [2026-01-10T20:43:43.065Z] echo ""; echo "TESTING:"; \ [2026-01-10T20:43:43.065Z] "c:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/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 "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/aqa-tests/\\TKG\\output_17680761794427\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-01-10T20:43:43.065Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/aqa-tests/\\TKG\\output_17680761794427\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T20:43:43.065Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T20:43:43.065Z] echo "Nothing to be done for teardown."; \ [2026-01-10T20:43:43.065Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-32_windows/aqa-tests/\\TKG\\output_17680761794427\\TestTargetResult"; [2026-01-10T20:43:43.065Z] [2026-01-10T20:43:43.065Z] TEST SETUP: [2026-01-10T20:43:43.065Z] Nothing to be done for setup. [2026-01-10T20:43:43.065Z] [2026-01-10T20:43:43.065Z] TESTING: [2026-01-10T20:43:44.209Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-10T20:43:44.209Z] GC before operation: completed in 9.916 ms, heap usage 6.212 MB -> 4.126 MB. [2026-01-10T20:43:47.150Z] Camera thread performed 122 scans. [2026-01-10T20:43:47.150Z] ====== philosophers (scala) [default], iteration 0 completed (2663.519 ms) ====== [2026-01-10T20:43:47.150Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-10T20:43:47.150Z] GC before operation: completed in 10.146 ms, heap usage 6.063 MB -> 4.593 MB. [2026-01-10T20:43:49.394Z] Camera thread performed 122 scans. [2026-01-10T20:43:49.394Z] ====== philosophers (scala) [default], iteration 1 completed (2477.225 ms) ====== [2026-01-10T20:43:49.394Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-10T20:43:49.394Z] GC before operation: completed in 10.023 ms, heap usage 8.714 MB -> 4.698 MB. [2026-01-10T20:43:52.340Z] Camera thread performed 122 scans. [2026-01-10T20:43:52.340Z] ====== philosophers (scala) [default], iteration 2 completed (2472.270 ms) ====== [2026-01-10T20:43:52.340Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-10T20:43:52.340Z] GC before operation: completed in 11.528 ms, heap usage 6.594 MB -> 4.458 MB. [2026-01-10T20:43:54.597Z] Camera thread performed 122 scans. [2026-01-10T20:43:54.597Z] ====== philosophers (scala) [default], iteration 3 completed (2472.816 ms) ====== [2026-01-10T20:43:54.597Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-10T20:43:54.597Z] GC before operation: completed in 11.163 ms, heap usage 4.706 MB -> 4.563 MB. [2026-01-10T20:43:56.837Z] Camera thread performed 122 scans. [2026-01-10T20:43:56.838Z] ====== philosophers (scala) [default], iteration 4 completed (2478.401 ms) ====== [2026-01-10T20:43:56.838Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-10T20:43:56.838Z] GC before operation: completed in 10.231 ms, heap usage 7.872 MB -> 4.422 MB. [2026-01-10T20:43:59.835Z] Camera thread performed 122 scans. [2026-01-10T20:43:59.835Z] ====== philosophers (scala) [default], iteration 5 completed (2491.693 ms) ====== [2026-01-10T20:43:59.835Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-10T20:43:59.835Z] GC before operation: completed in 9.954 ms, heap usage 5.747 MB -> 3.864 MB. [2026-01-10T20:44:02.077Z] Camera thread performed 122 scans. [2026-01-10T20:44:02.077Z] ====== philosophers (scala) [default], iteration 6 completed (2441.279 ms) ====== [2026-01-10T20:44:02.077Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-10T20:44:02.077Z] GC before operation: completed in 10.263 ms, heap usage 8.245 MB -> 3.366 MB. [2026-01-10T20:44:04.394Z] Camera thread performed 122 scans. [2026-01-10T20:44:04.394Z] ====== philosophers (scala) [default], iteration 7 completed (2482.662 ms) ====== [2026-01-10T20:44:04.394Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-10T20:44:04.394Z] GC before operation: completed in 8.029 ms, heap usage 4.602 MB -> 3.471 MB. [2026-01-10T20:44:06.644Z] Camera thread performed 122 scans. [2026-01-10T20:44:06.644Z] ====== philosophers (scala) [default], iteration 8 completed (2465.601 ms) ====== [2026-01-10T20:44:06.644Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-10T20:44:06.644Z] GC before operation: completed in 11.454 ms, heap usage 7.686 MB -> 3.576 MB. [2026-01-10T20:44:09.578Z] Camera thread performed 122 scans. [2026-01-10T20:44:09.578Z] ====== philosophers (scala) [default], iteration 9 completed (2446.754 ms) ====== [2026-01-10T20:44:09.578Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-10T20:44:09.578Z] GC before operation: completed in 7.861 ms, heap usage 4.838 MB -> 3.681 MB. [2026-01-10T20:44:11.831Z] Camera thread performed 122 scans. [2026-01-10T20:44:11.831Z] ====== philosophers (scala) [default], iteration 10 completed (2486.101 ms) ====== [2026-01-10T20:44:11.831Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-10T20:44:11.831Z] GC before operation: completed in 8.224 ms, heap usage 5.648 MB -> 3.366 MB. [2026-01-10T20:44:14.126Z] Camera thread performed 122 scans. [2026-01-10T20:44:14.126Z] ====== philosophers (scala) [default], iteration 11 completed (2476.525 ms) ====== [2026-01-10T20:44:14.126Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-10T20:44:14.126Z] GC before operation: completed in 8.225 ms, heap usage 4.716 MB -> 3.470 MB. [2026-01-10T20:44:17.049Z] Camera thread performed 122 scans. [2026-01-10T20:44:17.049Z] ====== philosophers (scala) [default], iteration 12 completed (2490.085 ms) ====== [2026-01-10T20:44:17.049Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-10T20:44:17.049Z] GC before operation: completed in 8.120 ms, heap usage 4.642 MB -> 3.576 MB. [2026-01-10T20:44:19.296Z] Camera thread performed 122 scans. [2026-01-10T20:44:19.296Z] ====== philosophers (scala) [default], iteration 13 completed (2493.749 ms) ====== [2026-01-10T20:44:19.296Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-10T20:44:19.296Z] GC before operation: completed in 7.873 ms, heap usage 4.530 MB -> 3.681 MB. [2026-01-10T20:44:21.564Z] Camera thread performed 122 scans. [2026-01-10T20:44:21.565Z] ====== philosophers (scala) [default], iteration 14 completed (2476.930 ms) ====== [2026-01-10T20:44:21.565Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-10T20:44:21.565Z] GC before operation: completed in 8.941 ms, heap usage 7.415 MB -> 3.366 MB. [2026-01-10T20:44:24.496Z] Camera thread performed 122 scans. [2026-01-10T20:44:24.496Z] ====== philosophers (scala) [default], iteration 15 completed (2463.158 ms) ====== [2026-01-10T20:44:24.496Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-10T20:44:24.496Z] GC before operation: completed in 8.462 ms, heap usage 7.226 MB -> 3.471 MB. [2026-01-10T20:44:26.769Z] Camera thread performed 122 scans. [2026-01-10T20:44:26.769Z] ====== philosophers (scala) [default], iteration 16 completed (2481.001 ms) ====== [2026-01-10T20:44:26.769Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-10T20:44:26.769Z] GC before operation: completed in 8.401 ms, heap usage 6.522 MB -> 3.576 MB. [2026-01-10T20:44:29.021Z] Camera thread performed 122 scans. [2026-01-10T20:44:29.021Z] ====== philosophers (scala) [default], iteration 17 completed (2479.681 ms) ====== [2026-01-10T20:44:29.021Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-10T20:44:29.021Z] GC before operation: completed in 8.888 ms, heap usage 6.811 MB -> 3.681 MB. [2026-01-10T20:44:31.959Z] Camera thread performed 122 scans. [2026-01-10T20:44:31.959Z] ====== philosophers (scala) [default], iteration 18 completed (2482.280 ms) ====== [2026-01-10T20:44:31.959Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-10T20:44:31.959Z] GC before operation: completed in 7.888 ms, heap usage 3.792 MB -> 3.366 MB. [2026-01-10T20:44:34.190Z] Camera thread performed 122 scans. [2026-01-10T20:44:34.190Z] ====== philosophers (scala) [default], iteration 19 completed (2462.918 ms) ====== [2026-01-10T20:44:34.190Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-10T20:44:34.190Z] GC before operation: completed in 8.498 ms, heap usage 7.086 MB -> 3.471 MB. [2026-01-10T20:44:37.130Z] Camera thread performed 122 scans. [2026-01-10T20:44:37.130Z] ====== philosophers (scala) [default], iteration 20 completed (2485.815 ms) ====== [2026-01-10T20:44:37.130Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-10T20:44:37.130Z] GC before operation: completed in 8.540 ms, heap usage 5.857 MB -> 3.576 MB. [2026-01-10T20:44:39.424Z] Camera thread performed 122 scans. [2026-01-10T20:44:39.424Z] ====== philosophers (scala) [default], iteration 21 completed (2466.697 ms) ====== [2026-01-10T20:44:39.424Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-10T20:44:39.424Z] GC before operation: completed in 8.092 ms, heap usage 4.026 MB -> 3.681 MB. [2026-01-10T20:44:41.649Z] Camera thread performed 122 scans. [2026-01-10T20:44:41.649Z] ====== philosophers (scala) [default], iteration 22 completed (2484.260 ms) ====== [2026-01-10T20:44:41.649Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-10T20:44:41.649Z] GC before operation: completed in 7.922 ms, heap usage 3.935 MB -> 3.366 MB. [2026-01-10T20:44:43.928Z] Camera thread performed 122 scans. [2026-01-10T20:44:43.928Z] ====== philosophers (scala) [default], iteration 23 completed (2493.444 ms) ====== [2026-01-10T20:44:43.928Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-10T20:44:44.269Z] GC before operation: completed in 8.648 ms, heap usage 6.892 MB -> 3.471 MB. [2026-01-10T20:44:46.548Z] Camera thread performed 122 scans. [2026-01-10T20:44:46.548Z] ====== philosophers (scala) [default], iteration 24 completed (2461.914 ms) ====== [2026-01-10T20:44:46.548Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-10T20:44:46.548Z] GC before operation: completed in 8.509 ms, heap usage 6.936 MB -> 3.576 MB. [2026-01-10T20:44:49.468Z] Camera thread performed 122 scans. [2026-01-10T20:44:49.468Z] ====== philosophers (scala) [default], iteration 25 completed (2454.822 ms) ====== [2026-01-10T20:44:49.468Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-10T20:44:49.468Z] GC before operation: completed in 8.438 ms, heap usage 7.123 MB -> 3.682 MB. [2026-01-10T20:44:51.693Z] Camera thread performed 122 scans. [2026-01-10T20:44:51.693Z] ====== philosophers (scala) [default], iteration 26 completed (2464.053 ms) ====== [2026-01-10T20:44:51.693Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-10T20:44:51.693Z] GC before operation: completed in 7.895 ms, heap usage 4.036 MB -> 3.366 MB. [2026-01-10T20:44:53.929Z] Camera thread performed 122 scans. [2026-01-10T20:44:53.929Z] ====== philosophers (scala) [default], iteration 27 completed (2478.448 ms) ====== [2026-01-10T20:44:53.929Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-10T20:44:53.930Z] GC before operation: completed in 8.323 ms, heap usage 5.965 MB -> 3.471 MB. [2026-01-10T20:44:56.888Z] Camera thread performed 122 scans. [2026-01-10T20:44:56.888Z] ====== philosophers (scala) [default], iteration 28 completed (2473.727 ms) ====== [2026-01-10T20:44:56.888Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-10T20:44:56.888Z] GC before operation: completed in 8.187 ms, heap usage 5.599 MB -> 3.577 MB. [2026-01-10T20:44:59.110Z] Camera thread performed 122 scans. [2026-01-10T20:44:59.110Z] ====== philosophers (scala) [default], iteration 29 completed (2479.225 ms) ====== [2026-01-10T20:44:59.110Z] ----------------------------------- [2026-01-10T20:44:59.110Z] renaissance-philosophers_0_PASSED [2026-01-10T20:44:59.110Z] ----------------------------------- [2026-01-10T20:44:59.110Z] [2026-01-10T20:44:59.110Z] TEST TEARDOWN: [2026-01-10T20:44:59.110Z] Nothing to be done for teardown. [2026-01-10T20:44:59.110Z] renaissance-philosophers_0 Finish Time: Sat Jan 10 20:44:59 2026 Epoch Time (ms): 1768077899030