[2026-04-25T13:55:23.664Z] Running test renaissance-philosophers_0 ... [2026-04-25T13:55:23.664Z] =============================================== [2026-04-25T13:55:23.664Z] renaissance-philosophers_0 Start Time: Sat Apr 25 13:55:22 2026 Epoch Time (ms): 1777125322657 [2026-04-25T13:55:23.664Z] variation: NoOptions [2026-04-25T13:55:23.664Z] JVM_OPTIONS: [2026-04-25T13:55:23.664Z] { \ [2026-04-25T13:55:23.664Z] echo ""; echo "TEST SETUP:"; \ [2026-04-25T13:55:23.664Z] echo "Nothing to be done for setup."; \ [2026-04-25T13:55:23.664Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17771245801316/renaissance-philosophers_0"; \ [2026-04-25T13:55:23.664Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17771245801316/renaissance-philosophers_0"; \ [2026-04-25T13:55:23.664Z] echo ""; echo "TESTING:"; \ [2026-04-25T13:55:23.664Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17771245801316/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-04-25T13:55:23.664Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17771245801316/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-25T13:55:23.664Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-25T13:55:23.664Z] echo "Nothing to be done for teardown."; \ [2026-04-25T13:55:23.664Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17771245801316/TestTargetResult"; [2026-04-25T13:55:23.664Z] [2026-04-25T13:55:23.664Z] TEST SETUP: [2026-04-25T13:55:23.664Z] Nothing to be done for setup. [2026-04-25T13:55:23.664Z] [2026-04-25T13:55:23.664Z] TESTING: [2026-04-25T13:55:24.639Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-04-25T13:55:24.639Z] GC before operation: completed in 31.189 ms, heap usage 17.456 MB -> 4.608 MB. [2026-04-25T13:55:30.098Z] Camera thread performed 122 scans. [2026-04-25T13:55:30.098Z] ====== philosophers (scala) [default], iteration 0 completed (4855.160 ms) ====== [2026-04-25T13:55:30.098Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-04-25T13:55:30.098Z] GC before operation: completed in 31.549 ms, heap usage 48.036 MB -> 5.018 MB. [2026-04-25T13:55:32.090Z] Camera thread performed 122 scans. [2026-04-25T13:55:32.090Z] ====== philosophers (scala) [default], iteration 1 completed (2648.048 ms) ====== [2026-04-25T13:55:32.090Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-04-25T13:55:32.090Z] GC before operation: completed in 35.443 ms, heap usage 41.817 MB -> 5.023 MB. [2026-04-25T13:55:36.340Z] Camera thread performed 122 scans. [2026-04-25T13:55:36.341Z] ====== philosophers (scala) [default], iteration 2 completed (3561.126 ms) ====== [2026-04-25T13:55:36.341Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-04-25T13:55:36.341Z] GC before operation: completed in 27.004 ms, heap usage 40.666 MB -> 5.029 MB. [2026-04-25T13:55:40.592Z] Camera thread performed 122 scans. [2026-04-25T13:55:40.592Z] ====== philosophers (scala) [default], iteration 3 completed (4441.827 ms) ====== [2026-04-25T13:55:40.592Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-04-25T13:55:40.592Z] GC before operation: completed in 31.741 ms, heap usage 33.823 MB -> 5.031 MB. [2026-04-25T13:55:43.879Z] Camera thread performed 122 scans. [2026-04-25T13:55:43.879Z] ====== philosophers (scala) [default], iteration 4 completed (3720.683 ms) ====== [2026-04-25T13:55:43.879Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-04-25T13:55:43.879Z] GC before operation: completed in 24.982 ms, heap usage 30.526 MB -> 5.032 MB. [2026-04-25T13:55:48.190Z] Camera thread performed 122 scans. [2026-04-25T13:55:48.190Z] ====== philosophers (scala) [default], iteration 5 completed (4298.831 ms) ====== [2026-04-25T13:55:48.190Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-04-25T13:55:48.190Z] GC before operation: completed in 33.170 ms, heap usage 23.786 MB -> 5.035 MB. [2026-04-25T13:55:51.302Z] Camera thread performed 122 scans. [2026-04-25T13:55:51.302Z] ====== philosophers (scala) [default], iteration 6 completed (2745.260 ms) ====== [2026-04-25T13:55:51.302Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-04-25T13:55:51.302Z] GC before operation: completed in 23.278 ms, heap usage 7.983 MB -> 5.035 MB. [2026-04-25T13:55:54.515Z] Camera thread performed 122 scans. [2026-04-25T13:55:54.515Z] ====== philosophers (scala) [default], iteration 7 completed (3102.090 ms) ====== [2026-04-25T13:55:54.515Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-04-25T13:55:54.515Z] GC before operation: completed in 29.707 ms, heap usage 10.603 MB -> 5.038 MB. [2026-04-25T13:55:58.815Z] Camera thread performed 122 scans. [2026-04-25T13:55:58.815Z] ====== philosophers (scala) [default], iteration 8 completed (3781.245 ms) ====== [2026-04-25T13:55:58.815Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-04-25T13:55:58.815Z] GC before operation: completed in 31.166 ms, heap usage 24.110 MB -> 5.038 MB. [2026-04-25T13:56:00.817Z] Camera thread performed 122 scans. [2026-04-25T13:56:00.817Z] ====== philosophers (scala) [default], iteration 9 completed (2376.905 ms) ====== [2026-04-25T13:56:00.817Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-04-25T13:56:00.817Z] GC before operation: completed in 30.106 ms, heap usage 14.159 MB -> 5.038 MB. [2026-04-25T13:56:03.010Z] Camera thread performed 122 scans. [2026-04-25T13:56:03.010Z] ====== philosophers (scala) [default], iteration 10 completed (2579.107 ms) ====== [2026-04-25T13:56:03.010Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-04-25T13:56:03.010Z] GC before operation: completed in 27.034 ms, heap usage 45.873 MB -> 5.038 MB. [2026-04-25T13:56:05.177Z] Camera thread performed 122 scans. [2026-04-25T13:56:05.177Z] ====== philosophers (scala) [default], iteration 11 completed (2331.312 ms) ====== [2026-04-25T13:56:05.177Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-04-25T13:56:05.177Z] GC before operation: completed in 29.864 ms, heap usage 14.285 MB -> 5.038 MB. [2026-04-25T13:56:08.260Z] Camera thread performed 122 scans. [2026-04-25T13:56:08.260Z] ====== philosophers (scala) [default], iteration 12 completed (2494.621 ms) ====== [2026-04-25T13:56:08.260Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-04-25T13:56:08.260Z] GC before operation: completed in 24.104 ms, heap usage 6.276 MB -> 5.039 MB. [2026-04-25T13:56:11.351Z] Camera thread performed 122 scans. [2026-04-25T13:56:11.351Z] ====== philosophers (scala) [default], iteration 13 completed (2625.669 ms) ====== [2026-04-25T13:56:11.351Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-04-25T13:56:11.351Z] GC before operation: completed in 34.273 ms, heap usage 34.277 MB -> 5.040 MB. [2026-04-25T13:56:14.038Z] Camera thread performed 122 scans. [2026-04-25T13:56:14.038Z] ====== philosophers (scala) [default], iteration 14 completed (3030.840 ms) ====== [2026-04-25T13:56:14.038Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-04-25T13:56:14.038Z] GC before operation: completed in 34.112 ms, heap usage 15.646 MB -> 5.040 MB. [2026-04-25T13:56:16.042Z] Camera thread performed 122 scans. [2026-04-25T13:56:16.042Z] ====== philosophers (scala) [default], iteration 15 completed (2639.460 ms) ====== [2026-04-25T13:56:16.042Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-04-25T13:56:17.281Z] GC before operation: completed in 41.215 ms, heap usage 40.721 MB -> 5.040 MB. [2026-04-25T13:56:19.440Z] Camera thread performed 122 scans. [2026-04-25T13:56:19.440Z] ====== philosophers (scala) [default], iteration 16 completed (2719.190 ms) ====== [2026-04-25T13:56:19.440Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-04-25T13:56:19.440Z] GC before operation: completed in 307.358 ms, heap usage 40.250 MB -> 5.041 MB. [2026-04-25T13:56:22.538Z] Camera thread performed 122 scans. [2026-04-25T13:56:22.538Z] ====== philosophers (scala) [default], iteration 17 completed (2620.926 ms) ====== [2026-04-25T13:56:22.538Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-04-25T13:56:22.538Z] GC before operation: completed in 31.519 ms, heap usage 9.989 MB -> 5.040 MB. [2026-04-25T13:56:24.817Z] Camera thread performed 122 scans. [2026-04-25T13:56:24.817Z] ====== philosophers (scala) [default], iteration 18 completed (2629.743 ms) ====== [2026-04-25T13:56:24.817Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-04-25T13:56:24.817Z] GC before operation: completed in 36.276 ms, heap usage 18.286 MB -> 5.041 MB. [2026-04-25T13:56:26.826Z] Camera thread performed 122 scans. [2026-04-25T13:56:26.826Z] ====== philosophers (scala) [default], iteration 19 completed (2304.014 ms) ====== [2026-04-25T13:56:26.826Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-04-25T13:56:26.826Z] GC before operation: completed in 31.892 ms, heap usage 12.830 MB -> 5.040 MB. [2026-04-25T13:56:29.946Z] Camera thread performed 122 scans. [2026-04-25T13:56:29.946Z] ====== philosophers (scala) [default], iteration 20 completed (2661.448 ms) ====== [2026-04-25T13:56:29.946Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-04-25T13:56:29.947Z] GC before operation: completed in 34.731 ms, heap usage 21.211 MB -> 5.041 MB. [2026-04-25T13:56:33.509Z] Camera thread performed 122 scans. [2026-04-25T13:56:33.509Z] ====== philosophers (scala) [default], iteration 21 completed (3961.064 ms) ====== [2026-04-25T13:56:33.509Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-04-25T13:56:33.509Z] GC before operation: completed in 35.405 ms, heap usage 38.024 MB -> 5.040 MB. [2026-04-25T13:56:36.625Z] Camera thread performed 122 scans. [2026-04-25T13:56:36.625Z] ====== philosophers (scala) [default], iteration 22 completed (2969.973 ms) ====== [2026-04-25T13:56:36.625Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-04-25T13:56:36.625Z] GC before operation: completed in 25.919 ms, heap usage 6.921 MB -> 5.041 MB. [2026-04-25T13:56:41.242Z] Camera thread performed 122 scans. [2026-04-25T13:56:41.242Z] ====== philosophers (scala) [default], iteration 23 completed (3639.237 ms) ====== [2026-04-25T13:56:41.242Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-04-25T13:56:41.242Z] GC before operation: completed in 218.218 ms, heap usage 16.959 MB -> 5.040 MB. [2026-04-25T13:56:43.272Z] Camera thread performed 122 scans. [2026-04-25T13:56:43.272Z] ====== philosophers (scala) [default], iteration 24 completed (2785.714 ms) ====== [2026-04-25T13:56:43.272Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-04-25T13:56:43.272Z] GC before operation: completed in 37.538 ms, heap usage 43.282 MB -> 5.041 MB. [2026-04-25T13:56:47.631Z] Camera thread performed 122 scans. [2026-04-25T13:56:47.631Z] ====== philosophers (scala) [default], iteration 25 completed (3598.987 ms) ====== [2026-04-25T13:56:47.631Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-04-25T13:56:47.631Z] GC before operation: completed in 25.996 ms, heap usage 42.573 MB -> 5.040 MB. [2026-04-25T13:56:49.693Z] Camera thread performed 122 scans. [2026-04-25T13:56:49.693Z] ====== philosophers (scala) [default], iteration 26 completed (2924.560 ms) ====== [2026-04-25T13:56:49.693Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-04-25T13:56:50.799Z] GC before operation: completed in 33.870 ms, heap usage 35.486 MB -> 5.041 MB. [2026-04-25T13:56:52.797Z] Camera thread performed 122 scans. [2026-04-25T13:56:52.797Z] ====== philosophers (scala) [default], iteration 27 completed (2544.340 ms) ====== [2026-04-25T13:56:52.797Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-04-25T13:56:52.797Z] GC before operation: completed in 24.224 ms, heap usage 8.168 MB -> 5.040 MB. [2026-04-25T13:56:56.071Z] Camera thread performed 122 scans. [2026-04-25T13:56:56.071Z] ====== philosophers (scala) [default], iteration 28 completed (3507.864 ms) ====== [2026-04-25T13:56:56.071Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-04-25T13:56:56.071Z] GC before operation: completed in 29.320 ms, heap usage 33.608 MB -> 5.041 MB. [2026-04-25T13:56:59.342Z] Camera thread performed 122 scans. [2026-04-25T13:56:59.342Z] ====== philosophers (scala) [default], iteration 29 completed (3046.843 ms) ====== [2026-04-25T13:57:00.312Z] ----------------------------------- [2026-04-25T13:57:00.312Z] renaissance-philosophers_0_PASSED [2026-04-25T13:57:00.312Z] ----------------------------------- [2026-04-25T13:57:00.312Z] [2026-04-25T13:57:00.312Z] TEST TEARDOWN: [2026-04-25T13:57:00.312Z] Nothing to be done for teardown. [2026-04-25T13:57:00.312Z] renaissance-philosophers_0 Finish Time: Sat Apr 25 13:56:59 2026 Epoch Time (ms): 1777125419502