[2025-08-30T01:10:47.395Z] Running test renaissance-philosophers_0 ... [2025-08-30T01:10:47.395Z] =============================================== [2025-08-30T01:10:47.395Z] renaissance-philosophers_0 Start Time: Sat Aug 30 01:10:46 2025 Epoch Time (ms): 1756516246411 [2025-08-30T01:10:47.395Z] variation: NoOptions [2025-08-30T01:10:47.395Z] JVM_OPTIONS: [2025-08-30T01:10:47.395Z] { \ [2025-08-30T01:10:47.395Z] echo ""; echo "TEST SETUP:"; \ [2025-08-30T01:10:47.395Z] echo "Nothing to be done for setup."; \ [2025-08-30T01:10:47.395Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17565151221772/renaissance-philosophers_0"; \ [2025-08-30T01:10:47.395Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17565151221772/renaissance-philosophers_0"; \ [2025-08-30T01:10:47.395Z] echo ""; echo "TESTING:"; \ [2025-08-30T01:10:47.395Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-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_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17565151221772/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-08-30T01:10:47.395Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17565151221772/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-30T01:10:47.395Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-30T01:10:47.395Z] echo "Nothing to be done for teardown."; \ [2025-08-30T01:10:47.395Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17565151221772/TestTargetResult"; [2025-08-30T01:10:47.395Z] [2025-08-30T01:10:47.395Z] TEST SETUP: [2025-08-30T01:10:47.395Z] Nothing to be done for setup. [2025-08-30T01:10:47.395Z] [2025-08-30T01:10:47.395Z] TESTING: [2025-08-30T01:10:48.354Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-08-30T01:10:48.354Z] GC before operation: completed in 18.877 ms, heap usage 14.393 MB -> 4.660 MB. [2025-08-30T01:10:52.483Z] Camera thread performed 122 scans. [2025-08-30T01:10:52.483Z] ====== philosophers (scala) [default], iteration 0 completed (3828.807 ms) ====== [2025-08-30T01:10:52.483Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-08-30T01:10:52.483Z] GC before operation: completed in 21.710 ms, heap usage 23.848 MB -> 5.033 MB. [2025-08-30T01:10:54.421Z] Camera thread performed 122 scans. [2025-08-30T01:10:54.422Z] ====== philosophers (scala) [default], iteration 1 completed (2475.015 ms) ====== [2025-08-30T01:10:54.422Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-08-30T01:10:54.422Z] GC before operation: completed in 20.168 ms, heap usage 67.725 MB -> 5.033 MB. [2025-08-30T01:10:57.418Z] Camera thread performed 122 scans. [2025-08-30T01:10:57.419Z] ====== philosophers (scala) [default], iteration 2 completed (2714.945 ms) ====== [2025-08-30T01:10:57.419Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-08-30T01:10:57.419Z] GC before operation: completed in 14.663 ms, heap usage 5.449 MB -> 5.034 MB. [2025-08-30T01:10:59.359Z] Camera thread performed 122 scans. [2025-08-30T01:10:59.359Z] ====== philosophers (scala) [default], iteration 3 completed (2590.186 ms) ====== [2025-08-30T01:10:59.359Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-08-30T01:10:59.359Z] GC before operation: completed in 14.974 ms, heap usage 25.855 MB -> 5.034 MB. [2025-08-30T01:11:01.337Z] Camera thread performed 122 scans. [2025-08-30T01:11:01.337Z] ====== philosophers (scala) [default], iteration 4 completed (1948.109 ms) ====== [2025-08-30T01:11:01.337Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-08-30T01:11:01.337Z] GC before operation: completed in 15.363 ms, heap usage 34.815 MB -> 5.035 MB. [2025-08-30T01:11:03.276Z] Camera thread performed 122 scans. [2025-08-30T01:11:03.276Z] ====== philosophers (scala) [default], iteration 5 completed (2063.503 ms) ====== [2025-08-30T01:11:03.276Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-08-30T01:11:03.276Z] GC before operation: completed in 15.740 ms, heap usage 54.080 MB -> 5.035 MB. [2025-08-30T01:11:06.272Z] Camera thread performed 122 scans. [2025-08-30T01:11:06.272Z] ====== philosophers (scala) [default], iteration 6 completed (2600.159 ms) ====== [2025-08-30T01:11:06.272Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-08-30T01:11:06.272Z] GC before operation: completed in 14.793 ms, heap usage 20.761 MB -> 5.036 MB. [2025-08-30T01:11:08.217Z] Camera thread performed 122 scans. [2025-08-30T01:11:08.217Z] ====== philosophers (scala) [default], iteration 7 completed (1559.761 ms) ====== [2025-08-30T01:11:08.217Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-08-30T01:11:08.217Z] GC before operation: completed in 16.317 ms, heap usage 57.091 MB -> 5.035 MB. [2025-08-30T01:11:10.865Z] Camera thread performed 122 scans. [2025-08-30T01:11:10.865Z] ====== philosophers (scala) [default], iteration 8 completed (2276.265 ms) ====== [2025-08-30T01:11:10.865Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-08-30T01:11:10.865Z] GC before operation: completed in 14.597 ms, heap usage 28.123 MB -> 5.036 MB. [2025-08-30T01:11:12.808Z] Camera thread performed 122 scans. [2025-08-30T01:11:12.808Z] ====== philosophers (scala) [default], iteration 9 completed (2694.657 ms) ====== [2025-08-30T01:11:12.808Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-08-30T01:11:12.808Z] GC before operation: completed in 15.312 ms, heap usage 56.244 MB -> 5.036 MB. [2025-08-30T01:11:14.745Z] Camera thread performed 122 scans. [2025-08-30T01:11:14.745Z] ====== philosophers (scala) [default], iteration 10 completed (2125.893 ms) ====== [2025-08-30T01:11:14.745Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-08-30T01:11:14.745Z] GC before operation: completed in 15.318 ms, heap usage 37.750 MB -> 5.036 MB. [2025-08-30T01:11:16.687Z] Camera thread performed 122 scans. [2025-08-30T01:11:16.687Z] ====== philosophers (scala) [default], iteration 11 completed (1673.381 ms) ====== [2025-08-30T01:11:16.687Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-08-30T01:11:16.687Z] GC before operation: completed in 18.419 ms, heap usage 26.748 MB -> 5.036 MB. [2025-08-30T01:11:19.686Z] Camera thread performed 122 scans. [2025-08-30T01:11:19.686Z] ====== philosophers (scala) [default], iteration 12 completed (2409.552 ms) ====== [2025-08-30T01:11:19.686Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-08-30T01:11:19.686Z] GC before operation: completed in 14.988 ms, heap usage 46.236 MB -> 5.037 MB. [2025-08-30T01:11:20.631Z] Camera thread performed 122 scans. [2025-08-30T01:11:20.631Z] ====== philosophers (scala) [default], iteration 13 completed (1825.812 ms) ====== [2025-08-30T01:11:20.631Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-08-30T01:11:20.631Z] GC before operation: completed in 15.821 ms, heap usage 74.210 MB -> 5.037 MB. [2025-08-30T01:11:22.572Z] Camera thread performed 122 scans. [2025-08-30T01:11:22.572Z] ====== philosophers (scala) [default], iteration 14 completed (1947.565 ms) ====== [2025-08-30T01:11:22.572Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-08-30T01:11:22.572Z] GC before operation: completed in 16.701 ms, heap usage 31.251 MB -> 5.037 MB. [2025-08-30T01:11:24.517Z] Camera thread performed 122 scans. [2025-08-30T01:11:24.517Z] ====== philosophers (scala) [default], iteration 15 completed (1575.958 ms) ====== [2025-08-30T01:11:24.517Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-08-30T01:11:24.517Z] GC before operation: completed in 15.439 ms, heap usage 26.964 MB -> 5.037 MB. [2025-08-30T01:11:26.458Z] Camera thread performed 122 scans. [2025-08-30T01:11:26.458Z] ====== philosophers (scala) [default], iteration 16 completed (1687.437 ms) ====== [2025-08-30T01:11:26.458Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-08-30T01:11:26.458Z] GC before operation: completed in 17.236 ms, heap usage 83.182 MB -> 5.037 MB. [2025-08-30T01:11:28.401Z] Camera thread performed 122 scans. [2025-08-30T01:11:28.401Z] ====== philosophers (scala) [default], iteration 17 completed (2256.988 ms) ====== [2025-08-30T01:11:28.401Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-08-30T01:11:28.401Z] GC before operation: completed in 16.287 ms, heap usage 50.118 MB -> 5.037 MB. [2025-08-30T01:11:30.357Z] Camera thread performed 122 scans. [2025-08-30T01:11:30.357Z] ====== philosophers (scala) [default], iteration 18 completed (1939.530 ms) ====== [2025-08-30T01:11:30.357Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-08-30T01:11:30.357Z] GC before operation: completed in 15.709 ms, heap usage 13.253 MB -> 5.037 MB. [2025-08-30T01:11:32.297Z] Camera thread performed 122 scans. [2025-08-30T01:11:32.297Z] ====== philosophers (scala) [default], iteration 19 completed (1604.478 ms) ====== [2025-08-30T01:11:32.297Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-08-30T01:11:32.297Z] GC before operation: completed in 17.735 ms, heap usage 80.093 MB -> 5.037 MB. [2025-08-30T01:11:34.238Z] Camera thread performed 122 scans. [2025-08-30T01:11:34.238Z] ====== philosophers (scala) [default], iteration 20 completed (2186.614 ms) ====== [2025-08-30T01:11:34.238Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-08-30T01:11:34.238Z] GC before operation: completed in 16.090 ms, heap usage 16.253 MB -> 5.037 MB. [2025-08-30T01:11:36.181Z] Camera thread performed 122 scans. [2025-08-30T01:11:36.181Z] ====== philosophers (scala) [default], iteration 21 completed (1989.107 ms) ====== [2025-08-30T01:11:36.181Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-08-30T01:11:36.181Z] GC before operation: completed in 15.683 ms, heap usage 14.750 MB -> 5.037 MB. [2025-08-30T01:11:38.125Z] Camera thread performed 122 scans. [2025-08-30T01:11:38.125Z] ====== philosophers (scala) [default], iteration 22 completed (1919.295 ms) ====== [2025-08-30T01:11:38.125Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-08-30T01:11:38.125Z] GC before operation: completed in 16.641 ms, heap usage 27.987 MB -> 5.037 MB. [2025-08-30T01:11:40.061Z] Camera thread performed 122 scans. [2025-08-30T01:11:40.061Z] ====== philosophers (scala) [default], iteration 23 completed (2075.213 ms) ====== [2025-08-30T01:11:40.061Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-08-30T01:11:40.061Z] GC before operation: completed in 17.674 ms, heap usage 60.637 MB -> 5.037 MB. [2025-08-30T01:11:43.056Z] Camera thread performed 122 scans. [2025-08-30T01:11:43.056Z] ====== philosophers (scala) [default], iteration 24 completed (2132.540 ms) ====== [2025-08-30T01:11:43.056Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-08-30T01:11:43.056Z] GC before operation: completed in 15.970 ms, heap usage 63.011 MB -> 5.038 MB. [2025-08-30T01:11:44.995Z] Camera thread performed 122 scans. [2025-08-30T01:11:45.943Z] ====== philosophers (scala) [default], iteration 25 completed (2916.576 ms) ====== [2025-08-30T01:11:45.943Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-08-30T01:11:45.943Z] GC before operation: completed in 15.386 ms, heap usage 30.700 MB -> 5.037 MB. [2025-08-30T01:11:46.886Z] Camera thread performed 122 scans. [2025-08-30T01:11:46.886Z] ====== philosophers (scala) [default], iteration 26 completed (1776.749 ms) ====== [2025-08-30T01:11:46.886Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-08-30T01:11:46.886Z] GC before operation: completed in 22.655 ms, heap usage 72.081 MB -> 5.038 MB. [2025-08-30T01:11:49.881Z] Camera thread performed 122 scans. [2025-08-30T01:11:49.881Z] ====== philosophers (scala) [default], iteration 27 completed (2065.983 ms) ====== [2025-08-30T01:11:49.881Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-08-30T01:11:49.881Z] GC before operation: completed in 15.633 ms, heap usage 13.752 MB -> 5.037 MB. [2025-08-30T01:11:51.825Z] Camera thread performed 122 scans. [2025-08-30T01:11:51.825Z] ====== philosophers (scala) [default], iteration 28 completed (2497.638 ms) ====== [2025-08-30T01:11:51.825Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-08-30T01:11:51.825Z] GC before operation: completed in 15.690 ms, heap usage 59.929 MB -> 5.038 MB. [2025-08-30T01:11:53.767Z] Camera thread performed 122 scans. [2025-08-30T01:11:53.767Z] ====== philosophers (scala) [default], iteration 29 completed (2032.836 ms) ====== [2025-08-30T01:11:53.767Z] ----------------------------------- [2025-08-30T01:11:53.767Z] renaissance-philosophers_0_PASSED [2025-08-30T01:11:53.767Z] ----------------------------------- [2025-08-30T01:11:53.767Z] [2025-08-30T01:11:53.767Z] TEST TEARDOWN: [2025-08-30T01:11:53.767Z] Nothing to be done for teardown. [2025-08-30T01:11:53.767Z] renaissance-philosophers_0 Finish Time: Sat Aug 30 01:11:53 2025 Epoch Time (ms): 1756516313583