[2026-04-02T02:12:32.964Z] Running test renaissance-philosophers_0 ... [2026-04-02T02:12:32.964Z] =============================================== [2026-04-02T02:12:32.964Z] renaissance-philosophers_0 Start Time: Thu Apr 2 02:12:32 2026 Epoch Time (ms): 1775095952486 [2026-04-02T02:12:32.964Z] variation: NoOptions [2026-04-02T02:12:32.964Z] JVM_OPTIONS: [2026-04-02T02:12:32.964Z] { \ [2026-04-02T02:12:32.964Z] echo ""; echo "TEST SETUP:"; \ [2026-04-02T02:12:32.964Z] echo "Nothing to be done for setup."; \ [2026-04-02T02:12:32.964Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-philosophers_0"; \ [2026-04-02T02:12:32.965Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-philosophers_0"; \ [2026-04-02T02:12:32.965Z] echo ""; echo "TESTING:"; \ [2026-04-02T02:12:32.965Z] "/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_1775092997766/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-04-02T02:12:32.965Z] 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_1775092997766/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-02T02:12:32.965Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-02T02:12:32.965Z] echo "Nothing to be done for teardown."; \ [2026-04-02T02:12:32.965Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/TestTargetResult"; [2026-04-02T02:12:32.965Z] [2026-04-02T02:12:32.965Z] TEST SETUP: [2026-04-02T02:12:32.965Z] Nothing to be done for setup. [2026-04-02T02:12:32.965Z] [2026-04-02T02:12:32.965Z] TESTING: [2026-04-02T02:12:34.951Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-04-02T02:12:34.951Z] GC before operation: completed in 59.346 ms, heap usage 14.781 MB -> 4.844 MB. [2026-04-02T02:12:44.020Z] Camera thread performed 122 scans. [2026-04-02T02:12:44.020Z] ====== philosophers (scala) [default], iteration 0 completed (7965.699 ms) ====== [2026-04-02T02:12:44.020Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-04-02T02:12:44.020Z] GC before operation: completed in 64.094 ms, heap usage 30.977 MB -> 5.193 MB. [2026-04-02T02:12:48.281Z] Camera thread performed 122 scans. [2026-04-02T02:12:48.281Z] ====== philosophers (scala) [default], iteration 1 completed (4867.859 ms) ====== [2026-04-02T02:12:48.281Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-04-02T02:12:48.281Z] GC before operation: completed in 46.005 ms, heap usage 37.883 MB -> 5.193 MB. [2026-04-02T02:12:50.272Z] Camera thread performed 122 scans. [2026-04-02T02:12:50.273Z] ====== philosophers (scala) [default], iteration 2 completed (2217.402 ms) ====== [2026-04-02T02:12:50.273Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-04-02T02:12:50.273Z] GC before operation: completed in 33.630 ms, heap usage 61.923 MB -> 5.194 MB. [2026-04-02T02:12:53.372Z] Camera thread performed 122 scans. [2026-04-02T02:12:53.372Z] ====== philosophers (scala) [default], iteration 3 completed (2312.434 ms) ====== [2026-04-02T02:12:53.372Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-04-02T02:12:53.372Z] GC before operation: completed in 36.692 ms, heap usage 8.920 MB -> 5.194 MB. [2026-04-02T02:12:55.379Z] Camera thread performed 122 scans. [2026-04-02T02:12:55.379Z] ====== philosophers (scala) [default], iteration 4 completed (2327.289 ms) ====== [2026-04-02T02:12:55.379Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-04-02T02:12:55.379Z] GC before operation: completed in 37.727 ms, heap usage 16.249 MB -> 5.195 MB. [2026-04-02T02:12:57.384Z] Camera thread performed 122 scans. [2026-04-02T02:12:57.384Z] ====== philosophers (scala) [default], iteration 5 completed (2091.506 ms) ====== [2026-04-02T02:12:57.384Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-04-02T02:12:57.384Z] GC before operation: completed in 52.537 ms, heap usage 78.870 MB -> 5.195 MB. [2026-04-02T02:12:59.373Z] Camera thread performed 122 scans. [2026-04-02T02:12:59.373Z] ====== philosophers (scala) [default], iteration 6 completed (2044.144 ms) ====== [2026-04-02T02:12:59.373Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-04-02T02:12:59.373Z] GC before operation: completed in 34.298 ms, heap usage 23.156 MB -> 5.195 MB. [2026-04-02T02:13:01.366Z] Camera thread performed 122 scans. [2026-04-02T02:13:01.366Z] ====== philosophers (scala) [default], iteration 7 completed (2339.314 ms) ====== [2026-04-02T02:13:01.366Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-04-02T02:13:01.366Z] GC before operation: completed in 37.407 ms, heap usage 21.172 MB -> 5.195 MB. [2026-04-02T02:13:04.439Z] Camera thread performed 122 scans. [2026-04-02T02:13:04.439Z] ====== philosophers (scala) [default], iteration 8 completed (2172.819 ms) ====== [2026-04-02T02:13:04.439Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-04-02T02:13:04.439Z] GC before operation: completed in 34.505 ms, heap usage 55.187 MB -> 5.196 MB. [2026-04-02T02:13:06.463Z] Camera thread performed 122 scans. [2026-04-02T02:13:06.463Z] ====== philosophers (scala) [default], iteration 9 completed (2046.395 ms) ====== [2026-04-02T02:13:06.463Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-04-02T02:13:06.463Z] GC before operation: completed in 36.144 ms, heap usage 67.067 MB -> 5.196 MB. [2026-04-02T02:13:08.496Z] Camera thread performed 122 scans. [2026-04-02T02:13:08.496Z] ====== philosophers (scala) [default], iteration 10 completed (2038.850 ms) ====== [2026-04-02T02:13:08.496Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-04-02T02:13:08.496Z] GC before operation: completed in 35.817 ms, heap usage 17.313 MB -> 5.197 MB. [2026-04-02T02:13:10.500Z] Camera thread performed 122 scans. [2026-04-02T02:13:10.500Z] ====== philosophers (scala) [default], iteration 11 completed (2269.181 ms) ====== [2026-04-02T02:13:10.500Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-04-02T02:13:10.500Z] GC before operation: completed in 32.214 ms, heap usage 26.313 MB -> 5.197 MB. [2026-04-02T02:13:12.497Z] Camera thread performed 122 scans. [2026-04-02T02:13:12.497Z] ====== philosophers (scala) [default], iteration 12 completed (2400.728 ms) ====== [2026-04-02T02:13:12.497Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-04-02T02:13:12.497Z] GC before operation: completed in 38.618 ms, heap usage 35.029 MB -> 5.197 MB. [2026-04-02T02:13:15.567Z] Camera thread performed 122 scans. [2026-04-02T02:13:15.567Z] ====== philosophers (scala) [default], iteration 13 completed (2100.403 ms) ====== [2026-04-02T02:13:15.567Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-04-02T02:13:15.567Z] GC before operation: completed in 36.441 ms, heap usage 61.872 MB -> 5.197 MB. [2026-04-02T02:13:16.536Z] Camera thread performed 122 scans. [2026-04-02T02:13:16.536Z] ====== philosophers (scala) [default], iteration 14 completed (1819.668 ms) ====== [2026-04-02T02:13:16.536Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-04-02T02:13:16.536Z] GC before operation: completed in 32.757 ms, heap usage 31.075 MB -> 5.198 MB. [2026-04-02T02:13:19.632Z] Camera thread performed 122 scans. [2026-04-02T02:13:19.632Z] ====== philosophers (scala) [default], iteration 15 completed (2193.939 ms) ====== [2026-04-02T02:13:19.632Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-04-02T02:13:19.632Z] GC before operation: completed in 44.194 ms, heap usage 61.298 MB -> 5.197 MB. [2026-04-02T02:13:21.635Z] Camera thread performed 122 scans. [2026-04-02T02:13:21.635Z] ====== philosophers (scala) [default], iteration 16 completed (1921.864 ms) ====== [2026-04-02T02:13:21.635Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-04-02T02:13:21.635Z] GC before operation: completed in 34.556 ms, heap usage 76.846 MB -> 5.198 MB. [2026-04-02T02:13:22.600Z] Camera thread performed 122 scans. [2026-04-02T02:13:22.600Z] ====== philosophers (scala) [default], iteration 17 completed (1898.819 ms) ====== [2026-04-02T02:13:22.601Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-04-02T02:13:22.601Z] GC before operation: completed in 39.222 ms, heap usage 15.215 MB -> 5.235 MB. [2026-04-02T02:13:24.602Z] Camera thread performed 122 scans. [2026-04-02T02:13:24.602Z] ====== philosophers (scala) [default], iteration 18 completed (1795.999 ms) ====== [2026-04-02T02:13:24.602Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-04-02T02:13:24.602Z] GC before operation: completed in 41.604 ms, heap usage 56.436 MB -> 5.199 MB. [2026-04-02T02:13:27.679Z] Camera thread performed 122 scans. [2026-04-02T02:13:27.679Z] ====== philosophers (scala) [default], iteration 19 completed (2185.188 ms) ====== [2026-04-02T02:13:27.679Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-04-02T02:13:27.679Z] GC before operation: completed in 32.642 ms, heap usage 57.343 MB -> 5.198 MB. [2026-04-02T02:13:29.855Z] Camera thread performed 122 scans. [2026-04-02T02:13:29.855Z] ====== philosophers (scala) [default], iteration 20 completed (2073.529 ms) ====== [2026-04-02T02:13:29.855Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-04-02T02:13:29.855Z] GC before operation: completed in 35.215 ms, heap usage 47.169 MB -> 5.198 MB. [2026-04-02T02:13:30.823Z] Camera thread performed 122 scans. [2026-04-02T02:13:30.823Z] ====== philosophers (scala) [default], iteration 21 completed (1853.538 ms) ====== [2026-04-02T02:13:30.823Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-04-02T02:13:30.823Z] GC before operation: completed in 52.902 ms, heap usage 52.191 MB -> 5.198 MB. [2026-04-02T02:13:33.511Z] Camera thread performed 122 scans. [2026-04-02T02:13:33.511Z] ====== philosophers (scala) [default], iteration 22 completed (2509.499 ms) ====== [2026-04-02T02:13:33.511Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-04-02T02:13:33.511Z] GC before operation: completed in 28.362 ms, heap usage 14.321 MB -> 5.198 MB. [2026-04-02T02:13:36.585Z] Camera thread performed 122 scans. [2026-04-02T02:13:36.586Z] ====== philosophers (scala) [default], iteration 23 completed (2537.703 ms) ====== [2026-04-02T02:13:36.586Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-04-02T02:13:36.586Z] GC before operation: completed in 32.387 ms, heap usage 12.361 MB -> 5.198 MB. [2026-04-02T02:13:38.587Z] Camera thread performed 122 scans. [2026-04-02T02:13:38.587Z] ====== philosophers (scala) [default], iteration 24 completed (2185.506 ms) ====== [2026-04-02T02:13:38.587Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-04-02T02:13:38.587Z] GC before operation: completed in 28.478 ms, heap usage 36.341 MB -> 5.199 MB. [2026-04-02T02:13:40.577Z] Camera thread performed 122 scans. [2026-04-02T02:13:40.577Z] ====== philosophers (scala) [default], iteration 25 completed (2449.263 ms) ====== [2026-04-02T02:13:40.577Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-04-02T02:13:40.577Z] GC before operation: completed in 32.241 ms, heap usage 32.150 MB -> 5.199 MB. [2026-04-02T02:13:43.643Z] Camera thread performed 122 scans. [2026-04-02T02:13:43.643Z] ====== philosophers (scala) [default], iteration 26 completed (2316.052 ms) ====== [2026-04-02T02:13:43.643Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-04-02T02:13:43.643Z] GC before operation: completed in 40.877 ms, heap usage 14.380 MB -> 5.199 MB. [2026-04-02T02:13:45.635Z] Camera thread performed 122 scans. [2026-04-02T02:13:45.635Z] ====== philosophers (scala) [default], iteration 27 completed (2124.435 ms) ====== [2026-04-02T02:13:45.635Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-04-02T02:13:45.635Z] GC before operation: completed in 35.520 ms, heap usage 52.278 MB -> 5.199 MB. [2026-04-02T02:13:47.617Z] Camera thread performed 122 scans. [2026-04-02T02:13:47.617Z] ====== philosophers (scala) [default], iteration 28 completed (2499.791 ms) ====== [2026-04-02T02:13:47.617Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-04-02T02:13:47.617Z] GC before operation: completed in 29.061 ms, heap usage 20.651 MB -> 5.199 MB. [2026-04-02T02:13:50.693Z] Camera thread performed 122 scans. [2026-04-02T02:13:50.693Z] ====== philosophers (scala) [default], iteration 29 completed (2348.795 ms) ====== [2026-04-02T02:13:50.693Z] ----------------------------------- [2026-04-02T02:13:50.693Z] renaissance-philosophers_0_PASSED [2026-04-02T02:13:50.693Z] ----------------------------------- [2026-04-02T02:13:50.693Z] [2026-04-02T02:13:50.693Z] TEST TEARDOWN: [2026-04-02T02:13:50.693Z] Nothing to be done for teardown. [2026-04-02T02:13:50.693Z] renaissance-philosophers_0 Finish Time: Thu Apr 2 02:13:50 2026 Epoch Time (ms): 1775096030281