[2026-03-05T00:07:50.305Z] Running test renaissance-philosophers_0 ... [2026-03-05T00:07:50.305Z] =============================================== [2026-03-05T00:07:50.305Z] renaissance-philosophers_0 Start Time: Thu Mar 5 00:07:49 2026 Epoch Time (ms): 1772669269937 [2026-03-05T00:07:50.305Z] variation: NoOptions [2026-03-05T00:07:50.305Z] JVM_OPTIONS: [2026-03-05T00:07:50.305Z] { \ [2026-03-05T00:07:50.305Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T00:07:50.305Z] echo "Nothing to be done for setup."; \ [2026-03-05T00:07:50.305Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17726666918344/renaissance-philosophers_0"; \ [2026-03-05T00:07:50.305Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17726666918344/renaissance-philosophers_0"; \ [2026-03-05T00:07:50.305Z] echo ""; echo "TESTING:"; \ [2026-03-05T00:07:50.305Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-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_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17726666918344/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-03-05T00:07:50.305Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17726666918344/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T00:07:50.305Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T00:07:50.305Z] echo "Nothing to be done for teardown."; \ [2026-03-05T00:07:50.305Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17726666918344/TestTargetResult"; [2026-03-05T00:07:50.305Z] [2026-03-05T00:07:50.305Z] TEST SETUP: [2026-03-05T00:07:50.305Z] Nothing to be done for setup. [2026-03-05T00:07:50.305Z] [2026-03-05T00:07:50.305Z] TESTING: [2026-03-05T00:07:51.874Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-05T00:07:51.874Z] GC before operation: completed in 28.738 ms, heap usage 14.051 MB -> 4.639 MB. [2026-03-05T00:08:00.023Z] Camera thread performed 122 scans. [2026-03-05T00:08:00.023Z] ====== philosophers (scala) [default], iteration 0 completed (8102.388 ms) ====== [2026-03-05T00:08:00.023Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-05T00:08:00.023Z] GC before operation: completed in 43.217 ms, heap usage 27.115 MB -> 4.994 MB. [2026-03-05T00:08:03.884Z] Camera thread performed 122 scans. [2026-03-05T00:08:03.884Z] ====== philosophers (scala) [default], iteration 1 completed (3535.491 ms) ====== [2026-03-05T00:08:03.884Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-05T00:08:03.884Z] GC before operation: completed in 29.622 ms, heap usage 35.881 MB -> 4.993 MB. [2026-03-05T00:08:05.444Z] Camera thread performed 122 scans. [2026-03-05T00:08:05.444Z] ====== philosophers (scala) [default], iteration 2 completed (1852.321 ms) ====== [2026-03-05T00:08:05.444Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-05T00:08:05.444Z] GC before operation: completed in 27.114 ms, heap usage 66.814 MB -> 4.993 MB. [2026-03-05T00:08:06.996Z] Camera thread performed 122 scans. [2026-03-05T00:08:06.996Z] ====== philosophers (scala) [default], iteration 3 completed (1684.281 ms) ====== [2026-03-05T00:08:06.996Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-05T00:08:06.996Z] GC before operation: completed in 24.747 ms, heap usage 14.180 MB -> 4.994 MB. [2026-03-05T00:08:08.535Z] Camera thread performed 122 scans. [2026-03-05T00:08:08.536Z] ====== philosophers (scala) [default], iteration 4 completed (1553.439 ms) ====== [2026-03-05T00:08:08.536Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-05T00:08:08.536Z] GC before operation: completed in 30.729 ms, heap usage 31.874 MB -> 4.994 MB. [2026-03-05T00:08:10.148Z] Camera thread performed 122 scans. [2026-03-05T00:08:10.148Z] ====== philosophers (scala) [default], iteration 5 completed (1674.631 ms) ====== [2026-03-05T00:08:10.148Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-05T00:08:10.148Z] GC before operation: completed in 31.746 ms, heap usage 24.521 MB -> 4.995 MB. [2026-03-05T00:08:11.689Z] Camera thread performed 122 scans. [2026-03-05T00:08:11.689Z] ====== philosophers (scala) [default], iteration 6 completed (1399.263 ms) ====== [2026-03-05T00:08:11.689Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-05T00:08:11.689Z] GC before operation: completed in 29.426 ms, heap usage 8.053 MB -> 4.995 MB. [2026-03-05T00:08:13.238Z] Camera thread performed 122 scans. [2026-03-05T00:08:13.238Z] ====== philosophers (scala) [default], iteration 7 completed (1616.704 ms) ====== [2026-03-05T00:08:13.238Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-05T00:08:13.238Z] GC before operation: completed in 23.785 ms, heap usage 30.800 MB -> 4.995 MB. [2026-03-05T00:08:14.800Z] Camera thread performed 122 scans. [2026-03-05T00:08:14.800Z] ====== philosophers (scala) [default], iteration 8 completed (1651.882 ms) ====== [2026-03-05T00:08:14.800Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-05T00:08:14.800Z] GC before operation: completed in 28.798 ms, heap usage 19.611 MB -> 4.995 MB. [2026-03-05T00:08:16.394Z] Camera thread performed 122 scans. [2026-03-05T00:08:16.394Z] ====== philosophers (scala) [default], iteration 9 completed (1609.515 ms) ====== [2026-03-05T00:08:16.394Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-05T00:08:16.394Z] GC before operation: completed in 30.362 ms, heap usage 54.514 MB -> 4.995 MB. [2026-03-05T00:08:17.949Z] Camera thread performed 122 scans. [2026-03-05T00:08:17.949Z] ====== philosophers (scala) [default], iteration 10 completed (1596.985 ms) ====== [2026-03-05T00:08:17.949Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-05T00:08:18.703Z] GC before operation: completed in 33.525 ms, heap usage 53.494 MB -> 4.995 MB. [2026-03-05T00:08:20.249Z] Camera thread performed 122 scans. [2026-03-05T00:08:20.249Z] ====== philosophers (scala) [default], iteration 11 completed (1627.077 ms) ====== [2026-03-05T00:08:20.249Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-05T00:08:20.249Z] GC before operation: completed in 35.770 ms, heap usage 64.469 MB -> 4.995 MB. [2026-03-05T00:08:21.820Z] Camera thread performed 122 scans. [2026-03-05T00:08:21.820Z] ====== philosophers (scala) [default], iteration 12 completed (1389.119 ms) ====== [2026-03-05T00:08:21.820Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-05T00:08:21.820Z] GC before operation: completed in 22.600 ms, heap usage 10.949 MB -> 4.996 MB. [2026-03-05T00:08:22.564Z] Camera thread performed 122 scans. [2026-03-05T00:08:22.564Z] ====== philosophers (scala) [default], iteration 13 completed (1491.033 ms) ====== [2026-03-05T00:08:22.564Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-05T00:08:23.314Z] GC before operation: completed in 28.383 ms, heap usage 59.898 MB -> 4.996 MB. [2026-03-05T00:08:24.906Z] Camera thread performed 122 scans. [2026-03-05T00:08:24.906Z] ====== philosophers (scala) [default], iteration 14 completed (1758.666 ms) ====== [2026-03-05T00:08:24.906Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-05T00:08:24.906Z] GC before operation: completed in 39.561 ms, heap usage 36.164 MB -> 4.996 MB. [2026-03-05T00:08:26.457Z] Camera thread performed 122 scans. [2026-03-05T00:08:26.457Z] ====== philosophers (scala) [default], iteration 15 completed (1426.148 ms) ====== [2026-03-05T00:08:26.457Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-05T00:08:26.457Z] GC before operation: completed in 20.884 ms, heap usage 57.207 MB -> 4.996 MB. [2026-03-05T00:08:28.033Z] Camera thread performed 122 scans. [2026-03-05T00:08:28.033Z] ====== philosophers (scala) [default], iteration 16 completed (1587.240 ms) ====== [2026-03-05T00:08:28.033Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-05T00:08:28.033Z] GC before operation: completed in 31.764 ms, heap usage 11.498 MB -> 4.997 MB. [2026-03-05T00:08:29.580Z] Camera thread performed 122 scans. [2026-03-05T00:08:29.580Z] ====== philosophers (scala) [default], iteration 17 completed (1388.124 ms) ====== [2026-03-05T00:08:29.580Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-05T00:08:29.580Z] GC before operation: completed in 32.891 ms, heap usage 41.813 MB -> 4.997 MB. [2026-03-05T00:08:31.127Z] Camera thread performed 122 scans. [2026-03-05T00:08:31.127Z] ====== philosophers (scala) [default], iteration 18 completed (1760.494 ms) ====== [2026-03-05T00:08:31.127Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-05T00:08:31.127Z] GC before operation: completed in 38.964 ms, heap usage 78.537 MB -> 4.997 MB. [2026-03-05T00:08:32.735Z] Camera thread performed 122 scans. [2026-03-05T00:08:32.735Z] ====== philosophers (scala) [default], iteration 19 completed (1447.385 ms) ====== [2026-03-05T00:08:32.735Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-05T00:08:32.735Z] GC before operation: completed in 33.604 ms, heap usage 52.973 MB -> 4.997 MB. [2026-03-05T00:08:34.314Z] Camera thread performed 122 scans. [2026-03-05T00:08:34.314Z] ====== philosophers (scala) [default], iteration 20 completed (1536.478 ms) ====== [2026-03-05T00:08:34.314Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-05T00:08:34.314Z] GC before operation: completed in 29.576 ms, heap usage 20.148 MB -> 4.998 MB. [2026-03-05T00:08:35.869Z] Camera thread performed 122 scans. [2026-03-05T00:08:35.869Z] ====== philosophers (scala) [default], iteration 21 completed (1544.000 ms) ====== [2026-03-05T00:08:35.869Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-05T00:08:35.869Z] GC before operation: completed in 25.580 ms, heap usage 21.512 MB -> 4.998 MB. [2026-03-05T00:08:37.467Z] Camera thread performed 122 scans. [2026-03-05T00:08:37.467Z] ====== philosophers (scala) [default], iteration 22 completed (1826.420 ms) ====== [2026-03-05T00:08:37.467Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-05T00:08:37.467Z] GC before operation: completed in 22.734 ms, heap usage 61.151 MB -> 4.998 MB. [2026-03-05T00:08:39.013Z] Camera thread performed 122 scans. [2026-03-05T00:08:39.013Z] ====== philosophers (scala) [default], iteration 23 completed (1417.277 ms) ====== [2026-03-05T00:08:39.013Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-05T00:08:39.013Z] GC before operation: completed in 27.438 ms, heap usage 7.940 MB -> 5.033 MB. [2026-03-05T00:08:40.642Z] Camera thread performed 122 scans. [2026-03-05T00:08:40.642Z] ====== philosophers (scala) [default], iteration 24 completed (1301.517 ms) ====== [2026-03-05T00:08:40.642Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-05T00:08:40.642Z] GC before operation: completed in 28.646 ms, heap usage 32.881 MB -> 4.998 MB. [2026-03-05T00:08:42.408Z] Camera thread performed 122 scans. [2026-03-05T00:08:42.408Z] ====== philosophers (scala) [default], iteration 25 completed (1549.234 ms) ====== [2026-03-05T00:08:42.408Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-05T00:08:42.408Z] GC before operation: completed in 36.314 ms, heap usage 20.956 MB -> 4.998 MB. [2026-03-05T00:08:43.964Z] Camera thread performed 122 scans. [2026-03-05T00:08:43.964Z] ====== philosophers (scala) [default], iteration 26 completed (1746.363 ms) ====== [2026-03-05T00:08:43.964Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-05T00:08:43.964Z] GC before operation: completed in 24.526 ms, heap usage 30.557 MB -> 4.998 MB. [2026-03-05T00:08:45.508Z] Camera thread performed 122 scans. [2026-03-05T00:08:45.508Z] ====== philosophers (scala) [default], iteration 27 completed (1489.671 ms) ====== [2026-03-05T00:08:45.508Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-05T00:08:45.508Z] GC before operation: completed in 28.036 ms, heap usage 66.897 MB -> 5.033 MB. [2026-03-05T00:08:47.129Z] Camera thread performed 122 scans. [2026-03-05T00:08:47.129Z] ====== philosophers (scala) [default], iteration 28 completed (1707.078 ms) ====== [2026-03-05T00:08:47.129Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-05T00:08:47.129Z] GC before operation: completed in 33.463 ms, heap usage 32.682 MB -> 4.998 MB. [2026-03-05T00:08:48.686Z] Camera thread performed 122 scans. [2026-03-05T00:08:48.686Z] ====== philosophers (scala) [default], iteration 29 completed (1831.974 ms) ====== [2026-03-05T00:08:49.439Z] ----------------------------------- [2026-03-05T00:08:49.439Z] renaissance-philosophers_0_PASSED [2026-03-05T00:08:49.439Z] ----------------------------------- [2026-03-05T00:08:49.439Z] [2026-03-05T00:08:49.439Z] TEST TEARDOWN: [2026-03-05T00:08:49.439Z] Nothing to be done for teardown. [2026-03-05T00:08:49.439Z] renaissance-philosophers_0 Finish Time: Thu Mar 5 00:08:48 2026 Epoch Time (ms): 1772669328716