[2026-03-05T05:39:25.203Z] Running test renaissance-philosophers_0 ... [2026-03-05T05:39:25.203Z] =============================================== [2026-03-05T05:39:25.503Z] renaissance-philosophers_0 Start Time: Thu Mar 5 05:39:25 2026 Epoch Time (ms): 1772689165259 [2026-03-05T05:39:25.503Z] variation: NoOptions [2026-03-05T05:39:25.805Z] JVM_OPTIONS: [2026-03-05T05:39:25.805Z] { \ [2026-03-05T05:39:25.805Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T05:39:25.805Z] echo "Nothing to be done for setup."; \ [2026-03-05T05:39:25.805Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17726882616991\\renaissance-philosophers_0"; \ [2026-03-05T05:39:25.805Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17726882616991\\renaissance-philosophers_0"; \ [2026-03-05T05:39:25.805Z] echo ""; echo "TESTING:"; \ [2026-03-05T05:39:25.805Z] "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/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 "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17726882616991\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-03-05T05:39:25.805Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/; rm -f -r "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17726882616991\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T05:39:25.805Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T05:39:25.805Z] echo "Nothing to be done for teardown."; \ [2026-03-05T05:39:25.805Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17726882616991\\TestTargetResult"; [2026-03-05T05:39:25.805Z] [2026-03-05T05:39:25.805Z] TEST SETUP: [2026-03-05T05:39:25.805Z] Nothing to be done for setup. [2026-03-05T05:39:25.805Z] [2026-03-05T05:39:25.805Z] TESTING: [2026-03-05T05:39:27.359Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-05T05:39:27.359Z] GC before operation: completed in 11.972 ms, heap usage 15.923 MB -> 4.576 MB. [2026-03-05T05:39:29.482Z] Camera thread performed 122 scans. [2026-03-05T05:39:29.482Z] ====== philosophers (scala) [default], iteration 0 completed (1973.656 ms) ====== [2026-03-05T05:39:29.482Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-05T05:39:29.482Z] GC before operation: completed in 14.065 ms, heap usage 23.760 MB -> 4.949 MB. [2026-03-05T05:39:30.546Z] Camera thread performed 122 scans. [2026-03-05T05:39:30.546Z] ====== philosophers (scala) [default], iteration 1 completed (1200.706 ms) ====== [2026-03-05T05:39:30.546Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-05T05:39:30.546Z] GC before operation: completed in 10.897 ms, heap usage 48.133 MB -> 4.950 MB. [2026-03-05T05:39:31.605Z] Camera thread performed 122 scans. [2026-03-05T05:39:31.605Z] ====== philosophers (scala) [default], iteration 2 completed (1328.822 ms) ====== [2026-03-05T05:39:31.605Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-05T05:39:31.605Z] GC before operation: completed in 9.588 ms, heap usage 63.675 MB -> 4.952 MB. [2026-03-05T05:39:33.144Z] Camera thread performed 122 scans. [2026-03-05T05:39:33.144Z] ====== philosophers (scala) [default], iteration 3 completed (1313.505 ms) ====== [2026-03-05T05:39:33.144Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-05T05:39:33.144Z] GC before operation: completed in 9.389 ms, heap usage 63.143 MB -> 4.952 MB. [2026-03-05T05:39:34.218Z] Camera thread performed 122 scans. [2026-03-05T05:39:34.218Z] ====== philosophers (scala) [default], iteration 4 completed (1093.665 ms) ====== [2026-03-05T05:39:34.218Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-05T05:39:34.218Z] GC before operation: completed in 9.762 ms, heap usage 46.128 MB -> 4.952 MB. [2026-03-05T05:39:35.291Z] Camera thread performed 122 scans. [2026-03-05T05:39:35.291Z] ====== philosophers (scala) [default], iteration 5 completed (1231.119 ms) ====== [2026-03-05T05:39:35.291Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-05T05:39:35.291Z] GC before operation: completed in 9.467 ms, heap usage 62.457 MB -> 4.956 MB. [2026-03-05T05:39:36.837Z] Camera thread performed 122 scans. [2026-03-05T05:39:36.837Z] ====== philosophers (scala) [default], iteration 6 completed (1204.069 ms) ====== [2026-03-05T05:39:36.837Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-05T05:39:36.837Z] GC before operation: completed in 9.042 ms, heap usage 37.124 MB -> 4.957 MB. [2026-03-05T05:39:37.897Z] Camera thread performed 122 scans. [2026-03-05T05:39:37.897Z] ====== philosophers (scala) [default], iteration 7 completed (1249.516 ms) ====== [2026-03-05T05:39:37.897Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-05T05:39:37.897Z] GC before operation: completed in 9.393 ms, heap usage 63.163 MB -> 4.957 MB. [2026-03-05T05:39:39.444Z] Camera thread performed 122 scans. [2026-03-05T05:39:39.444Z] ====== philosophers (scala) [default], iteration 8 completed (1347.010 ms) ====== [2026-03-05T05:39:39.445Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-05T05:39:39.445Z] GC before operation: completed in 9.013 ms, heap usage 6.554 MB -> 4.958 MB. [2026-03-05T05:39:40.519Z] Camera thread performed 122 scans. [2026-03-05T05:39:40.519Z] ====== philosophers (scala) [default], iteration 9 completed (1347.113 ms) ====== [2026-03-05T05:39:40.519Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-05T05:39:40.519Z] GC before operation: completed in 9.103 ms, heap usage 7.102 MB -> 4.958 MB. [2026-03-05T05:39:42.062Z] Camera thread performed 122 scans. [2026-03-05T05:39:42.062Z] ====== philosophers (scala) [default], iteration 10 completed (1321.581 ms) ====== [2026-03-05T05:39:42.062Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-05T05:39:42.062Z] GC before operation: completed in 9.936 ms, heap usage 54.952 MB -> 4.958 MB. [2026-03-05T05:39:43.122Z] Camera thread performed 122 scans. [2026-03-05T05:39:43.122Z] ====== philosophers (scala) [default], iteration 11 completed (1178.999 ms) ====== [2026-03-05T05:39:43.122Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-05T05:39:43.122Z] GC before operation: completed in 9.466 ms, heap usage 21.817 MB -> 4.959 MB. [2026-03-05T05:39:44.664Z] Camera thread performed 122 scans. [2026-03-05T05:39:44.664Z] ====== philosophers (scala) [default], iteration 12 completed (1218.761 ms) ====== [2026-03-05T05:39:44.664Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-05T05:39:44.664Z] GC before operation: completed in 9.216 ms, heap usage 28.493 MB -> 4.959 MB. [2026-03-05T05:39:45.731Z] Camera thread performed 122 scans. [2026-03-05T05:39:45.731Z] ====== philosophers (scala) [default], iteration 13 completed (1197.822 ms) ====== [2026-03-05T05:39:45.731Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-05T05:39:45.731Z] GC before operation: completed in 9.229 ms, heap usage 25.063 MB -> 4.959 MB. [2026-03-05T05:39:46.797Z] Camera thread performed 122 scans. [2026-03-05T05:39:46.797Z] ====== philosophers (scala) [default], iteration 14 completed (1311.327 ms) ====== [2026-03-05T05:39:46.797Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-05T05:39:46.797Z] GC before operation: completed in 9.398 ms, heap usage 19.841 MB -> 4.959 MB. [2026-03-05T05:39:48.346Z] Camera thread performed 122 scans. [2026-03-05T05:39:48.346Z] ====== philosophers (scala) [default], iteration 15 completed (1230.401 ms) ====== [2026-03-05T05:39:48.346Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-05T05:39:48.346Z] GC before operation: completed in 9.318 ms, heap usage 52.823 MB -> 4.959 MB. [2026-03-05T05:39:49.480Z] Camera thread performed 122 scans. [2026-03-05T05:39:49.480Z] ====== philosophers (scala) [default], iteration 16 completed (1212.015 ms) ====== [2026-03-05T05:39:49.480Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-05T05:39:49.480Z] GC before operation: completed in 9.565 ms, heap usage 47.057 MB -> 4.959 MB. [2026-03-05T05:39:50.546Z] Camera thread performed 122 scans. [2026-03-05T05:39:50.546Z] ====== philosophers (scala) [default], iteration 17 completed (1291.119 ms) ====== [2026-03-05T05:39:50.546Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-05T05:39:50.546Z] GC before operation: completed in 9.789 ms, heap usage 60.081 MB -> 4.959 MB. [2026-03-05T05:39:52.086Z] Camera thread performed 122 scans. [2026-03-05T05:39:52.086Z] ====== philosophers (scala) [default], iteration 18 completed (1177.824 ms) ====== [2026-03-05T05:39:52.086Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-05T05:39:52.086Z] GC before operation: completed in 9.606 ms, heap usage 60.024 MB -> 4.959 MB. [2026-03-05T05:39:53.148Z] Camera thread performed 122 scans. [2026-03-05T05:39:53.149Z] ====== philosophers (scala) [default], iteration 19 completed (1304.861 ms) ====== [2026-03-05T05:39:53.149Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-05T05:39:53.149Z] GC before operation: completed in 9.574 ms, heap usage 46.834 MB -> 4.959 MB. [2026-03-05T05:39:54.204Z] Camera thread performed 122 scans. [2026-03-05T05:39:54.204Z] ====== philosophers (scala) [default], iteration 20 completed (1186.275 ms) ====== [2026-03-05T05:39:54.204Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-05T05:39:54.506Z] GC before operation: completed in 10.020 ms, heap usage 22.788 MB -> 4.959 MB. [2026-03-05T05:39:55.566Z] Camera thread performed 122 scans. [2026-03-05T05:39:55.566Z] ====== philosophers (scala) [default], iteration 21 completed (1275.759 ms) ====== [2026-03-05T05:39:55.566Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-05T05:39:55.566Z] GC before operation: completed in 9.469 ms, heap usage 14.777 MB -> 4.959 MB. [2026-03-05T05:39:57.106Z] Camera thread performed 122 scans. [2026-03-05T05:39:57.106Z] ====== philosophers (scala) [default], iteration 22 completed (1220.253 ms) ====== [2026-03-05T05:39:57.106Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-05T05:39:57.106Z] GC before operation: completed in 9.556 ms, heap usage 31.157 MB -> 4.959 MB. [2026-03-05T05:39:58.160Z] Camera thread performed 122 scans. [2026-03-05T05:39:58.160Z] ====== philosophers (scala) [default], iteration 23 completed (1193.823 ms) ====== [2026-03-05T05:39:58.160Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-05T05:39:58.160Z] GC before operation: completed in 8.931 ms, heap usage 9.770 MB -> 4.959 MB. [2026-03-05T05:39:59.216Z] Camera thread performed 122 scans. [2026-03-05T05:39:59.216Z] ====== philosophers (scala) [default], iteration 24 completed (1231.409 ms) ====== [2026-03-05T05:39:59.216Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-05T05:39:59.216Z] GC before operation: completed in 9.403 ms, heap usage 60.165 MB -> 4.960 MB. [2026-03-05T05:40:00.753Z] Camera thread performed 122 scans. [2026-03-05T05:40:00.753Z] ====== philosophers (scala) [default], iteration 25 completed (1193.015 ms) ====== [2026-03-05T05:40:00.753Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-05T05:40:00.753Z] GC before operation: completed in 9.063 ms, heap usage 33.159 MB -> 4.960 MB. [2026-03-05T05:40:01.822Z] Camera thread performed 122 scans. [2026-03-05T05:40:01.822Z] ====== philosophers (scala) [default], iteration 26 completed (1209.906 ms) ====== [2026-03-05T05:40:01.822Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-05T05:40:01.822Z] GC before operation: completed in 9.068 ms, heap usage 24.480 MB -> 4.960 MB. [2026-03-05T05:40:03.364Z] Camera thread performed 122 scans. [2026-03-05T05:40:03.364Z] ====== philosophers (scala) [default], iteration 27 completed (1306.882 ms) ====== [2026-03-05T05:40:03.364Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-05T05:40:03.364Z] GC before operation: completed in 9.721 ms, heap usage 10.122 MB -> 4.960 MB. [2026-03-05T05:40:04.423Z] Camera thread performed 122 scans. [2026-03-05T05:40:04.423Z] ====== philosophers (scala) [default], iteration 28 completed (1257.957 ms) ====== [2026-03-05T05:40:04.423Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-05T05:40:04.423Z] GC before operation: completed in 9.079 ms, heap usage 36.041 MB -> 4.960 MB. [2026-03-05T05:40:05.481Z] Camera thread performed 122 scans. [2026-03-05T05:40:05.481Z] ====== philosophers (scala) [default], iteration 29 completed (1224.957 ms) ====== [2026-03-05T05:40:05.784Z] ----------------------------------- [2026-03-05T05:40:05.784Z] renaissance-philosophers_0_PASSED [2026-03-05T05:40:05.784Z] ----------------------------------- [2026-03-05T05:40:05.784Z] [2026-03-05T05:40:05.784Z] TEST TEARDOWN: [2026-03-05T05:40:05.784Z] Nothing to be done for teardown. [2026-03-05T05:40:05.784Z] renaissance-philosophers_0 Finish Time: Thu Mar 5 05:40:05 2026 Epoch Time (ms): 1772689205770