[2026-02-12T02:07:50.836Z] Running test renaissance-philosophers_0 ... [2026-02-12T02:07:50.836Z] =============================================== [2026-02-12T02:07:50.836Z] renaissance-philosophers_0 Start Time: Thu Feb 12 02:07:44 2026 Epoch Time (ms): 1770862064145 [2026-02-12T02:07:50.836Z] variation: NoOptions [2026-02-12T02:07:50.836Z] JVM_OPTIONS: [2026-02-12T02:07:50.836Z] { \ [2026-02-12T02:07:50.836Z] echo ""; echo "TEST SETUP:"; \ [2026-02-12T02:07:50.836Z] echo "Nothing to be done for setup."; \ [2026-02-12T02:07:50.836Z] mkdir -p "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17708599366683/renaissance-philosophers_0"; \ [2026-02-12T02:07:50.836Z] cd "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17708599366683/renaissance-philosophers_0"; \ [2026-02-12T02:07:50.836Z] echo ""; echo "TESTING:"; \ [2026-02-12T02:07:50.836Z] "/ssd/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 "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17708599366683/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-12T02:07:50.836Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/..; rm -f -r "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17708599366683/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-12T02:07:50.836Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-12T02:07:50.836Z] echo "Nothing to be done for teardown."; \ [2026-02-12T02:07:50.836Z] } 2>&1 | tee -a "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17708599366683/TestTargetResult"; [2026-02-12T02:07:50.836Z] [2026-02-12T02:07:50.836Z] TEST SETUP: [2026-02-12T02:07:50.836Z] Nothing to be done for setup. [2026-02-12T02:07:50.836Z] [2026-02-12T02:07:50.836Z] TESTING: [2026-02-12T02:07:50.836Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-12T02:07:50.836Z] GC before operation: completed in 59.985 ms, heap usage 6.261 MB -> 4.598 MB. [2026-02-12T02:08:32.484Z] Camera thread performed 122 scans. [2026-02-12T02:08:32.484Z] ====== philosophers (scala) [default], iteration 0 completed (40542.135 ms) ====== [2026-02-12T02:08:32.484Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-12T02:08:32.484Z] GC before operation: completed in 57.328 ms, heap usage 11.531 MB -> 5.019 MB. [2026-02-12T02:09:01.700Z] Camera thread performed 122 scans. [2026-02-12T02:09:01.700Z] ====== philosophers (scala) [default], iteration 1 completed (33205.182 ms) ====== [2026-02-12T02:09:01.700Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-12T02:09:01.700Z] GC before operation: completed in 68.908 ms, heap usage 14.553 MB -> 5.024 MB. [2026-02-12T02:09:36.535Z] Camera thread performed 122 scans. [2026-02-12T02:09:36.535Z] ====== philosophers (scala) [default], iteration 2 completed (31321.748 ms) ====== [2026-02-12T02:09:36.535Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-12T02:09:36.535Z] GC before operation: completed in 40.750 ms, heap usage 25.531 MB -> 5.025 MB. [2026-02-12T02:10:11.360Z] Camera thread performed 122 scans. [2026-02-12T02:10:11.360Z] ====== philosophers (scala) [default], iteration 3 completed (33126.587 ms) ====== [2026-02-12T02:10:11.360Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-12T02:10:11.360Z] GC before operation: completed in 59.984 ms, heap usage 10.780 MB -> 5.025 MB. [2026-02-12T02:10:40.570Z] Camera thread performed 122 scans. [2026-02-12T02:10:40.570Z] ====== philosophers (scala) [default], iteration 4 completed (32174.481 ms) ====== [2026-02-12T02:10:40.570Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-12T02:10:40.570Z] GC before operation: completed in 40.993 ms, heap usage 19.232 MB -> 5.026 MB. [2026-02-12T02:11:15.405Z] Camera thread performed 122 scans. [2026-02-12T02:11:15.405Z] ====== philosophers (scala) [default], iteration 5 completed (32478.659 ms) ====== [2026-02-12T02:11:15.405Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-12T02:11:15.405Z] GC before operation: completed in 48.426 ms, heap usage 7.719 MB -> 5.026 MB. [2026-02-12T02:11:50.318Z] Camera thread performed 122 scans. [2026-02-12T02:11:50.318Z] ====== philosophers (scala) [default], iteration 6 completed (33835.048 ms) ====== [2026-02-12T02:11:50.318Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-12T02:11:50.318Z] GC before operation: completed in 40.250 ms, heap usage 29.423 MB -> 5.026 MB. [2026-02-12T02:12:19.774Z] Camera thread performed 122 scans. [2026-02-12T02:12:19.774Z] ====== philosophers (scala) [default], iteration 7 completed (34056.499 ms) ====== [2026-02-12T02:12:19.774Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-12T02:12:19.774Z] GC before operation: completed in 46.075 ms, heap usage 25.316 MB -> 5.026 MB. [2026-02-12T02:12:54.715Z] Camera thread performed 122 scans. [2026-02-12T02:12:54.715Z] ====== philosophers (scala) [default], iteration 8 completed (32572.982 ms) ====== [2026-02-12T02:12:54.715Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-12T02:12:54.715Z] GC before operation: completed in 41.532 ms, heap usage 7.235 MB -> 5.027 MB. [2026-02-12T02:13:29.547Z] Camera thread performed 122 scans. [2026-02-12T02:13:29.547Z] ====== philosophers (scala) [default], iteration 9 completed (32687.680 ms) ====== [2026-02-12T02:13:29.547Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-12T02:13:29.547Z] GC before operation: completed in 63.027 ms, heap usage 24.736 MB -> 5.026 MB. [2026-02-12T02:13:58.648Z] Camera thread performed 122 scans. [2026-02-12T02:13:58.649Z] ====== philosophers (scala) [default], iteration 10 completed (31419.705 ms) ====== [2026-02-12T02:13:58.649Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-12T02:13:58.649Z] GC before operation: completed in 58.147 ms, heap usage 13.648 MB -> 5.027 MB. [2026-02-12T02:14:33.490Z] Camera thread performed 122 scans. [2026-02-12T02:14:33.490Z] ====== philosophers (scala) [default], iteration 11 completed (32503.933 ms) ====== [2026-02-12T02:14:33.490Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-12T02:14:33.490Z] GC before operation: completed in 58.380 ms, heap usage 18.673 MB -> 5.027 MB. [2026-02-12T02:15:02.583Z] Camera thread performed 122 scans. [2026-02-12T02:15:02.583Z] ====== philosophers (scala) [default], iteration 12 completed (31314.877 ms) ====== [2026-02-12T02:15:02.583Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-12T02:15:02.583Z] GC before operation: completed in 53.050 ms, heap usage 17.984 MB -> 5.027 MB. [2026-02-12T02:15:37.448Z] Camera thread performed 122 scans. [2026-02-12T02:15:37.448Z] ====== philosophers (scala) [default], iteration 13 completed (32808.086 ms) ====== [2026-02-12T02:15:37.448Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-12T02:15:37.448Z] GC before operation: completed in 41.431 ms, heap usage 19.074 MB -> 5.027 MB. [2026-02-12T02:16:06.596Z] Camera thread performed 122 scans. [2026-02-12T02:16:06.596Z] ====== philosophers (scala) [default], iteration 14 completed (32917.479 ms) ====== [2026-02-12T02:16:06.596Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-12T02:16:06.596Z] GC before operation: completed in 53.333 ms, heap usage 31.065 MB -> 4.303 MB. [2026-02-12T02:16:41.480Z] Camera thread performed 122 scans. [2026-02-12T02:16:41.480Z] ====== philosophers (scala) [default], iteration 15 completed (33130.638 ms) ====== [2026-02-12T02:16:41.480Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-12T02:16:41.480Z] GC before operation: completed in 44.239 ms, heap usage 9.298 MB -> 4.302 MB. [2026-02-12T02:17:16.292Z] Camera thread performed 122 scans. [2026-02-12T02:17:16.292Z] ====== philosophers (scala) [default], iteration 16 completed (33052.483 ms) ====== [2026-02-12T02:17:16.292Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-12T02:17:16.292Z] GC before operation: completed in 39.386 ms, heap usage 10.525 MB -> 3.641 MB. [2026-02-12T02:17:51.109Z] Camera thread performed 122 scans. [2026-02-12T02:17:51.109Z] ====== philosophers (scala) [default], iteration 17 completed (33741.963 ms) ====== [2026-02-12T02:17:51.109Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-12T02:17:51.109Z] GC before operation: completed in 36.667 ms, heap usage 7.600 MB -> 3.641 MB. [2026-02-12T02:18:20.314Z] Camera thread performed 122 scans. [2026-02-12T02:18:20.314Z] ====== philosophers (scala) [default], iteration 18 completed (33225.930 ms) ====== [2026-02-12T02:18:20.314Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-12T02:18:20.314Z] GC before operation: completed in 36.132 ms, heap usage 25.974 MB -> 3.641 MB. [2026-02-12T02:18:55.135Z] Camera thread performed 122 scans. [2026-02-12T02:18:55.135Z] ====== philosophers (scala) [default], iteration 19 completed (33278.638 ms) ====== [2026-02-12T02:18:55.135Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-12T02:18:55.135Z] GC before operation: completed in 35.255 ms, heap usage 4.652 MB -> 3.641 MB. [2026-02-12T02:19:29.973Z] Camera thread performed 122 scans. [2026-02-12T02:19:29.973Z] ====== philosophers (scala) [default], iteration 20 completed (33278.546 ms) ====== [2026-02-12T02:19:29.973Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-12T02:19:29.973Z] GC before operation: completed in 54.547 ms, heap usage 9.142 MB -> 3.641 MB. [2026-02-12T02:19:59.092Z] Camera thread performed 122 scans. [2026-02-12T02:19:59.092Z] ====== philosophers (scala) [default], iteration 21 completed (33300.720 ms) ====== [2026-02-12T02:19:59.092Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-12T02:19:59.092Z] GC before operation: completed in 55.145 ms, heap usage 20.831 MB -> 3.641 MB. [2026-02-12T02:20:33.944Z] Camera thread performed 122 scans. [2026-02-12T02:20:33.944Z] ====== philosophers (scala) [default], iteration 22 completed (33551.279 ms) ====== [2026-02-12T02:20:33.944Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-12T02:20:33.944Z] GC before operation: completed in 51.670 ms, heap usage 6.576 MB -> 3.642 MB. [2026-02-12T02:21:08.858Z] Camera thread performed 122 scans. [2026-02-12T02:21:08.858Z] ====== philosophers (scala) [default], iteration 23 completed (33245.990 ms) ====== [2026-02-12T02:21:08.858Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-12T02:21:08.858Z] GC before operation: completed in 47.437 ms, heap usage 25.267 MB -> 3.641 MB. [2026-02-12T02:21:43.697Z] Camera thread performed 122 scans. [2026-02-12T02:21:43.697Z] ====== philosophers (scala) [default], iteration 24 completed (33546.146 ms) ====== [2026-02-12T02:21:43.697Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-12T02:21:43.697Z] GC before operation: completed in 35.400 ms, heap usage 25.861 MB -> 3.642 MB. [2026-02-12T02:22:18.573Z] Camera thread performed 122 scans. [2026-02-12T02:22:18.573Z] ====== philosophers (scala) [default], iteration 25 completed (33863.642 ms) ====== [2026-02-12T02:22:18.573Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-12T02:22:18.573Z] GC before operation: completed in 33.625 ms, heap usage 9.865 MB -> 3.641 MB. [2026-02-12T02:22:47.769Z] Camera thread performed 122 scans. [2026-02-12T02:22:47.769Z] ====== philosophers (scala) [default], iteration 26 completed (32847.189 ms) ====== [2026-02-12T02:22:47.769Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-12T02:22:47.769Z] GC before operation: completed in 49.520 ms, heap usage 11.355 MB -> 3.641 MB. [2026-02-12T02:23:22.654Z] Camera thread performed 122 scans. [2026-02-12T02:23:22.654Z] ====== philosophers (scala) [default], iteration 27 completed (32784.126 ms) ====== [2026-02-12T02:23:22.654Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-12T02:23:22.654Z] GC before operation: completed in 50.732 ms, heap usage 6.514 MB -> 3.641 MB. [2026-02-12T02:23:57.484Z] Camera thread performed 122 scans. [2026-02-12T02:23:57.484Z] ====== philosophers (scala) [default], iteration 28 completed (32872.573 ms) ====== [2026-02-12T02:23:57.484Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-12T02:23:57.484Z] GC before operation: completed in 55.014 ms, heap usage 12.158 MB -> 3.642 MB. [2026-02-12T02:24:26.583Z] Camera thread performed 122 scans. [2026-02-12T02:24:26.583Z] ====== philosophers (scala) [default], iteration 29 completed (31469.680 ms) ====== [2026-02-12T02:24:26.583Z] ----------------------------------- [2026-02-12T02:24:26.583Z] renaissance-philosophers_0_PASSED [2026-02-12T02:24:26.583Z] ----------------------------------- [2026-02-12T02:24:26.583Z] [2026-02-12T02:24:26.583Z] TEST TEARDOWN: [2026-02-12T02:24:26.583Z] Nothing to be done for teardown. [2026-02-12T02:24:26.583Z] renaissance-philosophers_0 Finish Time: Thu Feb 12 02:24:24 2026 Epoch Time (ms): 1770863064121