[2026-03-05T06:25:05.243Z] Running test renaissance-philosophers_0 ... [2026-03-05T06:25:05.243Z] =============================================== [2026-03-05T06:25:05.243Z] renaissance-philosophers_0 Start Time: Thu Mar 5 06:25:04 2026 Epoch Time (ms): 1772691904688 [2026-03-05T06:25:05.243Z] variation: NoOptions [2026-03-05T06:25:05.243Z] JVM_OPTIONS: [2026-03-05T06:25:05.243Z] { \ [2026-03-05T06:25:05.243Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T06:25:05.243Z] echo "Nothing to be done for setup."; \ [2026-03-05T06:25:05.243Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17726914567027/renaissance-philosophers_0"; \ [2026-03-05T06:25:05.243Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17726914567027/renaissance-philosophers_0"; \ [2026-03-05T06:25:05.243Z] echo ""; echo "TESTING:"; \ [2026-03-05T06:25:05.243Z] "/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_17726914567027/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-03-05T06:25:05.243Z] 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_17726914567027/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T06:25:05.243Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T06:25:05.243Z] echo "Nothing to be done for teardown."; \ [2026-03-05T06:25:05.243Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17726914567027/TestTargetResult"; [2026-03-05T06:25:05.243Z] [2026-03-05T06:25:05.243Z] TEST SETUP: [2026-03-05T06:25:05.243Z] Nothing to be done for setup. [2026-03-05T06:25:05.243Z] [2026-03-05T06:25:05.243Z] TESTING: [2026-03-05T06:25:06.206Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-05T06:25:06.206Z] GC before operation: completed in 25.099 ms, heap usage 17.458 MB -> 4.607 MB. [2026-03-05T06:25:12.999Z] Camera thread performed 122 scans. [2026-03-05T06:25:12.999Z] ====== philosophers (scala) [default], iteration 0 completed (6659.726 ms) ====== [2026-03-05T06:25:12.999Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-05T06:25:12.999Z] GC before operation: completed in 41.702 ms, heap usage 54.506 MB -> 5.018 MB. [2026-03-05T06:25:14.990Z] Camera thread performed 122 scans. [2026-03-05T06:25:14.990Z] ====== philosophers (scala) [default], iteration 1 completed (2132.004 ms) ====== [2026-03-05T06:25:14.990Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-05T06:25:14.990Z] GC before operation: completed in 21.061 ms, heap usage 9.902 MB -> 5.023 MB. [2026-03-05T06:25:18.045Z] Camera thread performed 122 scans. [2026-03-05T06:25:18.045Z] ====== philosophers (scala) [default], iteration 2 completed (2206.375 ms) ====== [2026-03-05T06:25:18.045Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-05T06:25:18.045Z] GC before operation: completed in 30.789 ms, heap usage 45.254 MB -> 5.029 MB. [2026-03-05T06:25:20.025Z] Camera thread performed 122 scans. [2026-03-05T06:25:20.025Z] ====== philosophers (scala) [default], iteration 3 completed (2503.267 ms) ====== [2026-03-05T06:25:20.025Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-05T06:25:20.025Z] GC before operation: completed in 29.064 ms, heap usage 31.322 MB -> 5.030 MB. [2026-03-05T06:25:23.080Z] Camera thread performed 122 scans. [2026-03-05T06:25:23.080Z] ====== philosophers (scala) [default], iteration 4 completed (2465.585 ms) ====== [2026-03-05T06:25:23.080Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-05T06:25:23.080Z] GC before operation: completed in 42.916 ms, heap usage 22.578 MB -> 5.032 MB. [2026-03-05T06:25:25.059Z] Camera thread performed 122 scans. [2026-03-05T06:25:25.059Z] ====== philosophers (scala) [default], iteration 5 completed (2321.379 ms) ====== [2026-03-05T06:25:25.059Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-05T06:25:25.059Z] GC before operation: completed in 57.409 ms, heap usage 48.530 MB -> 5.035 MB. [2026-03-05T06:25:27.040Z] Camera thread performed 122 scans. [2026-03-05T06:25:27.040Z] ====== philosophers (scala) [default], iteration 6 completed (2338.438 ms) ====== [2026-03-05T06:25:27.040Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-05T06:25:27.040Z] GC before operation: completed in 41.817 ms, heap usage 30.274 MB -> 5.035 MB. [2026-03-05T06:25:30.097Z] Camera thread performed 122 scans. [2026-03-05T06:25:30.097Z] ====== philosophers (scala) [default], iteration 7 completed (2186.360 ms) ====== [2026-03-05T06:25:30.097Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-05T06:25:30.097Z] GC before operation: completed in 33.909 ms, heap usage 32.046 MB -> 5.035 MB. [2026-03-05T06:25:32.073Z] Camera thread performed 122 scans. [2026-03-05T06:25:32.073Z] ====== philosophers (scala) [default], iteration 8 completed (2294.682 ms) ====== [2026-03-05T06:25:32.073Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-05T06:25:32.073Z] GC before operation: completed in 35.690 ms, heap usage 32.195 MB -> 5.038 MB. [2026-03-05T06:25:34.176Z] Camera thread performed 122 scans. [2026-03-05T06:25:34.176Z] ====== philosophers (scala) [default], iteration 9 completed (2349.846 ms) ====== [2026-03-05T06:25:34.176Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-05T06:25:34.176Z] GC before operation: completed in 39.902 ms, heap usage 30.969 MB -> 5.038 MB. [2026-03-05T06:25:37.236Z] Camera thread performed 122 scans. [2026-03-05T06:25:37.236Z] ====== philosophers (scala) [default], iteration 10 completed (2278.260 ms) ====== [2026-03-05T06:25:37.236Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-05T06:25:37.236Z] GC before operation: completed in 30.517 ms, heap usage 38.260 MB -> 5.038 MB. [2026-03-05T06:25:39.224Z] Camera thread performed 122 scans. [2026-03-05T06:25:39.224Z] ====== philosophers (scala) [default], iteration 11 completed (2286.655 ms) ====== [2026-03-05T06:25:39.224Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-05T06:25:39.224Z] GC before operation: completed in 27.176 ms, heap usage 20.554 MB -> 5.038 MB. [2026-03-05T06:25:41.204Z] Camera thread performed 122 scans. [2026-03-05T06:25:41.204Z] ====== philosophers (scala) [default], iteration 12 completed (2394.282 ms) ====== [2026-03-05T06:25:41.204Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-05T06:25:41.204Z] GC before operation: completed in 31.844 ms, heap usage 32.646 MB -> 5.038 MB. [2026-03-05T06:25:44.269Z] Camera thread performed 122 scans. [2026-03-05T06:25:44.269Z] ====== philosophers (scala) [default], iteration 13 completed (2597.738 ms) ====== [2026-03-05T06:25:44.269Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-05T06:25:44.269Z] GC before operation: completed in 29.426 ms, heap usage 10.839 MB -> 5.038 MB. [2026-03-05T06:25:46.247Z] Camera thread performed 122 scans. [2026-03-05T06:25:46.247Z] ====== philosophers (scala) [default], iteration 14 completed (2271.014 ms) ====== [2026-03-05T06:25:46.247Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-05T06:25:46.247Z] GC before operation: completed in 29.162 ms, heap usage 43.462 MB -> 5.039 MB. [2026-03-05T06:25:49.307Z] Camera thread performed 122 scans. [2026-03-05T06:25:49.307Z] ====== philosophers (scala) [default], iteration 15 completed (2364.624 ms) ====== [2026-03-05T06:25:49.307Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-05T06:25:49.307Z] GC before operation: completed in 40.614 ms, heap usage 22.262 MB -> 5.039 MB. [2026-03-05T06:25:51.291Z] Camera thread performed 122 scans. [2026-03-05T06:25:51.291Z] ====== philosophers (scala) [default], iteration 16 completed (2352.364 ms) ====== [2026-03-05T06:25:51.291Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-05T06:25:51.291Z] GC before operation: completed in 27.613 ms, heap usage 39.140 MB -> 5.039 MB. [2026-03-05T06:25:53.271Z] Camera thread performed 122 scans. [2026-03-05T06:25:53.271Z] ====== philosophers (scala) [default], iteration 17 completed (2146.739 ms) ====== [2026-03-05T06:25:53.272Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-05T06:25:53.272Z] GC before operation: completed in 34.798 ms, heap usage 27.775 MB -> 5.039 MB. [2026-03-05T06:25:55.259Z] Camera thread performed 122 scans. [2026-03-05T06:25:55.259Z] ====== philosophers (scala) [default], iteration 18 completed (2275.328 ms) ====== [2026-03-05T06:25:55.259Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-05T06:25:55.259Z] GC before operation: completed in 23.756 ms, heap usage 28.033 MB -> 5.039 MB. [2026-03-05T06:25:58.314Z] Camera thread performed 122 scans. [2026-03-05T06:25:58.314Z] ====== philosophers (scala) [default], iteration 19 completed (2288.164 ms) ====== [2026-03-05T06:25:58.314Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-05T06:25:58.314Z] GC before operation: completed in 24.567 ms, heap usage 12.965 MB -> 5.039 MB. [2026-03-05T06:26:00.293Z] Camera thread performed 122 scans. [2026-03-05T06:26:00.293Z] ====== philosophers (scala) [default], iteration 20 completed (2188.925 ms) ====== [2026-03-05T06:26:00.293Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-05T06:26:00.293Z] GC before operation: completed in 24.035 ms, heap usage 24.654 MB -> 5.039 MB. [2026-03-05T06:26:02.268Z] Camera thread performed 122 scans. [2026-03-05T06:26:02.269Z] ====== philosophers (scala) [default], iteration 21 completed (1916.054 ms) ====== [2026-03-05T06:26:02.269Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-05T06:26:02.269Z] GC before operation: completed in 20.249 ms, heap usage 8.597 MB -> 5.039 MB. [2026-03-05T06:26:04.239Z] Camera thread performed 122 scans. [2026-03-05T06:26:04.239Z] ====== philosophers (scala) [default], iteration 22 completed (1853.091 ms) ====== [2026-03-05T06:26:04.239Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-05T06:26:04.239Z] GC before operation: completed in 23.767 ms, heap usage 9.248 MB -> 5.040 MB. [2026-03-05T06:26:06.211Z] Camera thread performed 122 scans. [2026-03-05T06:26:06.211Z] ====== philosophers (scala) [default], iteration 23 completed (2170.973 ms) ====== [2026-03-05T06:26:06.211Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-05T06:26:06.211Z] GC before operation: completed in 19.916 ms, heap usage 21.101 MB -> 5.039 MB. [2026-03-05T06:26:08.183Z] Camera thread performed 122 scans. [2026-03-05T06:26:08.183Z] ====== philosophers (scala) [default], iteration 24 completed (2330.386 ms) ====== [2026-03-05T06:26:08.183Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-05T06:26:08.183Z] GC before operation: completed in 21.177 ms, heap usage 41.299 MB -> 5.040 MB. [2026-03-05T06:26:11.225Z] Camera thread performed 122 scans. [2026-03-05T06:26:11.225Z] ====== philosophers (scala) [default], iteration 25 completed (2478.322 ms) ====== [2026-03-05T06:26:11.225Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-05T06:26:11.225Z] GC before operation: completed in 14.826 ms, heap usage 26.065 MB -> 5.040 MB. [2026-03-05T06:26:14.143Z] Camera thread performed 122 scans. [2026-03-05T06:26:14.144Z] ====== philosophers (scala) [default], iteration 26 completed (2199.043 ms) ====== [2026-03-05T06:26:14.144Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-05T06:26:14.144Z] GC before operation: completed in 15.767 ms, heap usage 45.284 MB -> 5.040 MB. [2026-03-05T06:26:16.116Z] Camera thread performed 122 scans. [2026-03-05T06:26:16.116Z] ====== philosophers (scala) [default], iteration 27 completed (2691.173 ms) ====== [2026-03-05T06:26:16.116Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-05T06:26:16.116Z] GC before operation: completed in 16.134 ms, heap usage 23.032 MB -> 5.040 MB. [2026-03-05T06:26:18.088Z] Camera thread performed 122 scans. [2026-03-05T06:26:18.088Z] ====== philosophers (scala) [default], iteration 28 completed (2181.599 ms) ====== [2026-03-05T06:26:18.088Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-05T06:26:18.088Z] GC before operation: completed in 19.185 ms, heap usage 40.877 MB -> 5.040 MB. [2026-03-05T06:26:20.062Z] Camera thread performed 122 scans. [2026-03-05T06:26:20.062Z] ====== philosophers (scala) [default], iteration 29 completed (2321.672 ms) ====== [2026-03-05T06:26:21.022Z] ----------------------------------- [2026-03-05T06:26:21.022Z] renaissance-philosophers_0_PASSED [2026-03-05T06:26:21.022Z] ----------------------------------- [2026-03-05T06:26:21.022Z] [2026-03-05T06:26:21.022Z] TEST TEARDOWN: [2026-03-05T06:26:21.022Z] Nothing to be done for teardown. [2026-03-05T06:26:21.022Z] renaissance-philosophers_0 Finish Time: Thu Mar 5 06:26:20 2026 Epoch Time (ms): 1772691980182