[2026-01-14T03:36:37.302Z] Running test renaissance-philosophers_0 ... [2026-01-14T03:36:37.302Z] =============================================== [2026-01-14T03:36:37.302Z] renaissance-philosophers_0 Start Time: Wed Jan 14 03:36:36 2026 Epoch Time (ms): 1768361796389 [2026-01-14T03:36:37.302Z] variation: NoOptions [2026-01-14T03:36:37.302Z] JVM_OPTIONS: [2026-01-14T03:36:37.302Z] { \ [2026-01-14T03:36:37.302Z] echo ""; echo "TEST SETUP:"; \ [2026-01-14T03:36:37.302Z] echo "Nothing to be done for setup."; \ [2026-01-14T03:36:37.302Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17683612596880/renaissance-philosophers_0"; \ [2026-01-14T03:36:37.302Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17683612596880/renaissance-philosophers_0"; \ [2026-01-14T03:36:37.302Z] echo ""; echo "TESTING:"; \ [2026-01-14T03:36:37.302Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_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_arm_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17683612596880/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-14T03:36:37.302Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17683612596880/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-14T03:36:37.302Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-14T03:36:37.302Z] echo "Nothing to be done for teardown."; \ [2026-01-14T03:36:37.302Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17683612596880/TestTargetResult"; [2026-01-14T03:36:37.302Z] [2026-01-14T03:36:37.302Z] TEST SETUP: [2026-01-14T03:36:37.302Z] Nothing to be done for setup. [2026-01-14T03:36:37.302Z] [2026-01-14T03:36:37.302Z] TESTING: [2026-01-14T03:36:38.261Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-14T03:36:38.261Z] GC before operation: completed in 29.603 ms, heap usage 16.023 MB -> 4.705 MB. [2026-01-14T03:36:45.023Z] Camera thread performed 122 scans. [2026-01-14T03:36:45.023Z] ====== philosophers (scala) [default], iteration 0 completed (5660.641 ms) ====== [2026-01-14T03:36:45.023Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-14T03:36:45.023Z] GC before operation: completed in 28.364 ms, heap usage 29.229 MB -> 5.097 MB. [2026-01-14T03:36:50.456Z] Camera thread performed 122 scans. [2026-01-14T03:36:50.456Z] ====== philosophers (scala) [default], iteration 1 completed (5779.292 ms) ====== [2026-01-14T03:36:50.456Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-14T03:36:50.456Z] GC before operation: completed in 12.719 ms, heap usage 34.346 MB -> 5.104 MB. [2026-01-14T03:36:58.652Z] Camera thread performed 122 scans. [2026-01-14T03:36:58.652Z] ====== philosophers (scala) [default], iteration 2 completed (7744.862 ms) ====== [2026-01-14T03:36:58.652Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-14T03:36:58.652Z] GC before operation: completed in 15.504 ms, heap usage 34.786 MB -> 5.106 MB. [2026-01-14T03:37:04.065Z] Camera thread performed 122 scans. [2026-01-14T03:37:04.065Z] ====== philosophers (scala) [default], iteration 3 completed (6042.902 ms) ====== [2026-01-14T03:37:04.065Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-14T03:37:04.065Z] GC before operation: completed in 11.712 ms, heap usage 28.578 MB -> 5.106 MB. [2026-01-14T03:37:10.186Z] Camera thread performed 122 scans. [2026-01-14T03:37:10.187Z] ====== philosophers (scala) [default], iteration 4 completed (5645.040 ms) ====== [2026-01-14T03:37:10.187Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-14T03:37:10.187Z] GC before operation: completed in 14.208 ms, heap usage 15.394 MB -> 5.107 MB. [2026-01-14T03:37:14.384Z] Camera thread performed 122 scans. [2026-01-14T03:37:14.384Z] ====== philosophers (scala) [default], iteration 5 completed (4487.900 ms) ====== [2026-01-14T03:37:14.384Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-14T03:37:14.384Z] GC before operation: completed in 15.451 ms, heap usage 16.941 MB -> 5.108 MB. [2026-01-14T03:37:19.797Z] Camera thread performed 122 scans. [2026-01-14T03:37:19.797Z] ====== philosophers (scala) [default], iteration 6 completed (5941.216 ms) ====== [2026-01-14T03:37:19.797Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-14T03:37:19.797Z] GC before operation: completed in 15.737 ms, heap usage 5.728 MB -> 5.109 MB. [2026-01-14T03:37:26.541Z] Camera thread performed 122 scans. [2026-01-14T03:37:26.541Z] ====== philosophers (scala) [default], iteration 7 completed (5766.420 ms) ====== [2026-01-14T03:37:26.541Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-14T03:37:26.541Z] GC before operation: completed in 16.522 ms, heap usage 13.338 MB -> 5.109 MB. [2026-01-14T03:37:33.276Z] Camera thread performed 122 scans. [2026-01-14T03:37:33.276Z] ====== philosophers (scala) [default], iteration 8 completed (7839.660 ms) ====== [2026-01-14T03:37:33.276Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-14T03:37:33.276Z] GC before operation: completed in 11.645 ms, heap usage 19.856 MB -> 5.109 MB. [2026-01-14T03:37:37.454Z] Camera thread performed 122 scans. [2026-01-14T03:37:37.454Z] ====== philosophers (scala) [default], iteration 9 completed (4304.121 ms) ====== [2026-01-14T03:37:37.454Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-14T03:37:38.413Z] GC before operation: completed in 15.763 ms, heap usage 28.352 MB -> 5.109 MB. [2026-01-14T03:37:44.001Z] Camera thread performed 122 scans. [2026-01-14T03:37:44.001Z] ====== philosophers (scala) [default], iteration 10 completed (6279.104 ms) ====== [2026-01-14T03:37:44.001Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-14T03:37:44.001Z] GC before operation: completed in 10.803 ms, heap usage 35.976 MB -> 5.109 MB. [2026-01-14T03:37:50.749Z] Camera thread performed 122 scans. [2026-01-14T03:37:50.749Z] ====== philosophers (scala) [default], iteration 11 completed (5812.787 ms) ====== [2026-01-14T03:37:50.749Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-14T03:37:50.749Z] GC before operation: completed in 10.654 ms, heap usage 29.120 MB -> 5.110 MB. [2026-01-14T03:37:56.155Z] Camera thread performed 122 scans. [2026-01-14T03:37:56.155Z] ====== philosophers (scala) [default], iteration 12 completed (6078.676 ms) ====== [2026-01-14T03:37:56.155Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-14T03:37:56.155Z] GC before operation: completed in 10.429 ms, heap usage 32.827 MB -> 5.110 MB. [2026-01-14T03:38:02.888Z] Camera thread performed 122 scans. [2026-01-14T03:38:02.888Z] ====== philosophers (scala) [default], iteration 13 completed (6873.711 ms) ====== [2026-01-14T03:38:02.888Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-14T03:38:02.888Z] GC before operation: completed in 13.005 ms, heap usage 26.171 MB -> 5.110 MB. [2026-01-14T03:38:08.301Z] Camera thread performed 122 scans. [2026-01-14T03:38:08.301Z] ====== philosophers (scala) [default], iteration 14 completed (5493.910 ms) ====== [2026-01-14T03:38:08.301Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-14T03:38:08.301Z] GC before operation: completed in 13.275 ms, heap usage 38.576 MB -> 5.110 MB. [2026-01-14T03:38:14.413Z] Camera thread performed 122 scans. [2026-01-14T03:38:14.413Z] ====== philosophers (scala) [default], iteration 15 completed (6103.675 ms) ====== [2026-01-14T03:38:14.413Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-14T03:38:14.413Z] GC before operation: completed in 13.209 ms, heap usage 7.588 MB -> 5.111 MB. [2026-01-14T03:38:21.198Z] Camera thread performed 122 scans. [2026-01-14T03:38:21.198Z] ====== philosophers (scala) [default], iteration 16 completed (6272.032 ms) ====== [2026-01-14T03:38:21.199Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-14T03:38:21.199Z] GC before operation: completed in 10.546 ms, heap usage 32.193 MB -> 5.112 MB. [2026-01-14T03:38:29.444Z] Camera thread performed 122 scans. [2026-01-14T03:38:29.444Z] ====== philosophers (scala) [default], iteration 17 completed (7816.334 ms) ====== [2026-01-14T03:38:29.444Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-14T03:38:29.444Z] GC before operation: completed in 10.869 ms, heap usage 13.392 MB -> 5.112 MB. [2026-01-14T03:38:34.845Z] Camera thread performed 122 scans. [2026-01-14T03:38:34.845Z] ====== philosophers (scala) [default], iteration 18 completed (5808.460 ms) ====== [2026-01-14T03:38:34.846Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-14T03:38:34.846Z] GC before operation: completed in 12.170 ms, heap usage 9.663 MB -> 5.112 MB. [2026-01-14T03:38:40.250Z] Camera thread performed 122 scans. [2026-01-14T03:38:40.250Z] ====== philosophers (scala) [default], iteration 19 completed (4937.139 ms) ====== [2026-01-14T03:38:40.250Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-14T03:38:40.250Z] GC before operation: completed in 11.272 ms, heap usage 21.939 MB -> 5.112 MB. [2026-01-14T03:38:47.123Z] Camera thread performed 122 scans. [2026-01-14T03:38:47.123Z] ====== philosophers (scala) [default], iteration 20 completed (7028.433 ms) ====== [2026-01-14T03:38:47.123Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-14T03:38:47.123Z] GC before operation: completed in 17.284 ms, heap usage 31.275 MB -> 5.112 MB. [2026-01-14T03:38:51.317Z] Camera thread performed 122 scans. [2026-01-14T03:38:51.317Z] ====== philosophers (scala) [default], iteration 21 completed (4993.731 ms) ====== [2026-01-14T03:38:51.317Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-14T03:38:51.317Z] GC before operation: completed in 16.380 ms, heap usage 15.955 MB -> 5.112 MB. [2026-01-14T03:38:58.062Z] Camera thread performed 122 scans. [2026-01-14T03:38:58.062Z] ====== philosophers (scala) [default], iteration 22 completed (6194.885 ms) ====== [2026-01-14T03:38:58.062Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-14T03:38:58.062Z] GC before operation: completed in 12.219 ms, heap usage 36.903 MB -> 5.113 MB. [2026-01-14T03:39:04.801Z] Camera thread performed 122 scans. [2026-01-14T03:39:04.801Z] ====== philosophers (scala) [default], iteration 23 completed (7164.457 ms) ====== [2026-01-14T03:39:04.801Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-14T03:39:04.801Z] GC before operation: completed in 12.600 ms, heap usage 16.201 MB -> 5.113 MB. [2026-01-14T03:39:11.527Z] Camera thread performed 122 scans. [2026-01-14T03:39:11.527Z] ====== philosophers (scala) [default], iteration 24 completed (6183.203 ms) ====== [2026-01-14T03:39:11.527Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-14T03:39:11.527Z] GC before operation: completed in 11.652 ms, heap usage 9.379 MB -> 5.113 MB. [2026-01-14T03:39:17.622Z] Camera thread performed 122 scans. [2026-01-14T03:39:17.622Z] ====== philosophers (scala) [default], iteration 25 completed (6519.925 ms) ====== [2026-01-14T03:39:17.622Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-14T03:39:17.622Z] GC before operation: completed in 11.428 ms, heap usage 23.985 MB -> 5.113 MB. [2026-01-14T03:39:24.366Z] Camera thread performed 122 scans. [2026-01-14T03:39:24.366Z] ====== philosophers (scala) [default], iteration 26 completed (6202.185 ms) ====== [2026-01-14T03:39:24.366Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-14T03:39:24.366Z] GC before operation: completed in 15.682 ms, heap usage 31.361 MB -> 5.113 MB. [2026-01-14T03:39:31.115Z] Camera thread performed 122 scans. [2026-01-14T03:39:31.115Z] ====== philosophers (scala) [default], iteration 27 completed (7287.729 ms) ====== [2026-01-14T03:39:31.115Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-14T03:39:31.115Z] GC before operation: completed in 12.064 ms, heap usage 20.282 MB -> 5.113 MB. [2026-01-14T03:39:37.903Z] Camera thread performed 122 scans. [2026-01-14T03:39:37.903Z] ====== philosophers (scala) [default], iteration 28 completed (6663.155 ms) ====== [2026-01-14T03:39:37.903Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-14T03:39:37.903Z] GC before operation: completed in 15.182 ms, heap usage 14.099 MB -> 5.113 MB. [2026-01-14T03:39:44.685Z] Camera thread performed 122 scans. [2026-01-14T03:39:44.685Z] ====== philosophers (scala) [default], iteration 29 completed (6466.200 ms) ====== [2026-01-14T03:39:44.685Z] ----------------------------------- [2026-01-14T03:39:44.685Z] renaissance-philosophers_0_PASSED [2026-01-14T03:39:44.685Z] ----------------------------------- [2026-01-14T03:39:44.685Z] [2026-01-14T03:39:44.685Z] TEST TEARDOWN: [2026-01-14T03:39:44.685Z] Nothing to be done for teardown. [2026-01-14T03:39:44.685Z] renaissance-philosophers_0 Finish Time: Wed Jan 14 03:39:44 2026 Epoch Time (ms): 1768361984205