[2026-01-31T10:10:22.590Z] Running test renaissance-philosophers_0 ... [2026-01-31T10:10:22.590Z] =============================================== [2026-01-31T10:10:22.590Z] renaissance-philosophers_0 Start Time: Sat Jan 31 05:10:22 2026 Epoch Time (ms): 1769854222318 [2026-01-31T10:10:22.590Z] variation: NoOptions [2026-01-31T10:10:22.590Z] JVM_OPTIONS: [2026-01-31T10:10:22.590Z] { \ [2026-01-31T10:10:22.590Z] echo ""; echo "TEST SETUP:"; \ [2026-01-31T10:10:22.590Z] echo "Nothing to be done for setup."; \ [2026-01-31T10:10:22.590Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1769853476485/renaissance-philosophers_0"; \ [2026-01-31T10:10:22.590Z] cd "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1769853476485/renaissance-philosophers_0"; \ [2026-01-31T10:10:22.590Z] echo ""; echo "TESTING:"; \ [2026-01-31T10:10:22.590Z] "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1769853476485/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-31T10:10:22.590Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1769853476485/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-31T10:10:22.590Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-31T10:10:22.590Z] echo "Nothing to be done for teardown."; \ [2026-01-31T10:10:22.590Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1769853476485/TestTargetResult"; [2026-01-31T10:10:22.590Z] [2026-01-31T10:10:22.590Z] TEST SETUP: [2026-01-31T10:10:22.590Z] Nothing to be done for setup. [2026-01-31T10:10:22.590Z] [2026-01-31T10:10:22.590Z] TESTING: [2026-01-31T10:10:22.947Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-31T10:10:22.947Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/output_1769853476485/renaissance-philosophers_0/launcher-051022-16470541975459295054/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-31T10:10:22.947Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-31T10:10:22.947Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-31T10:10:23.306Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-31T10:10:23.306Z] GC before operation: completed in 13.885 ms, heap usage 27.623 MB -> 5.018 MB. [2026-01-31T10:10:24.541Z] Camera thread performed 122 scans. [2026-01-31T10:10:24.541Z] ====== philosophers (scala) [default], iteration 0 completed (1029.946 ms) ====== [2026-01-31T10:10:24.541Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-31T10:10:24.541Z] GC before operation: completed in 9.843 ms, heap usage 10.555 MB -> 5.360 MB. [2026-01-31T10:10:24.905Z] Camera thread performed 122 scans. [2026-01-31T10:10:24.905Z] ====== philosophers (scala) [default], iteration 1 completed (687.495 ms) ====== [2026-01-31T10:10:24.905Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-31T10:10:24.905Z] GC before operation: completed in 10.266 ms, heap usage 12.465 MB -> 5.360 MB. [2026-01-31T10:10:25.700Z] Camera thread performed 122 scans. [2026-01-31T10:10:25.700Z] ====== philosophers (scala) [default], iteration 2 completed (681.777 ms) ====== [2026-01-31T10:10:25.700Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-31T10:10:25.700Z] GC before operation: completed in 6.952 ms, heap usage 68.551 MB -> 5.362 MB. [2026-01-31T10:10:26.463Z] Camera thread performed 122 scans. [2026-01-31T10:10:26.463Z] ====== philosophers (scala) [default], iteration 3 completed (657.738 ms) ====== [2026-01-31T10:10:26.463Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-31T10:10:26.463Z] GC before operation: completed in 7.094 ms, heap usage 81.519 MB -> 5.362 MB. [2026-01-31T10:10:26.823Z] Camera thread performed 122 scans. [2026-01-31T10:10:26.823Z] ====== philosophers (scala) [default], iteration 4 completed (482.172 ms) ====== [2026-01-31T10:10:26.823Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-31T10:10:26.823Z] GC before operation: completed in 5.345 ms, heap usage 66.615 MB -> 5.362 MB. [2026-01-31T10:10:27.181Z] Camera thread performed 122 scans. [2026-01-31T10:10:27.181Z] ====== philosophers (scala) [default], iteration 5 completed (404.124 ms) ====== [2026-01-31T10:10:27.181Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-31T10:10:27.181Z] GC before operation: completed in 5.005 ms, heap usage 18.569 MB -> 5.362 MB. [2026-01-31T10:10:27.942Z] Camera thread performed 122 scans. [2026-01-31T10:10:27.942Z] ====== philosophers (scala) [default], iteration 6 completed (471.596 ms) ====== [2026-01-31T10:10:27.942Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-31T10:10:27.942Z] GC before operation: completed in 5.541 ms, heap usage 70.392 MB -> 5.363 MB. [2026-01-31T10:10:28.302Z] Camera thread performed 122 scans. [2026-01-31T10:10:28.302Z] ====== philosophers (scala) [default], iteration 7 completed (429.211 ms) ====== [2026-01-31T10:10:28.302Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-31T10:10:28.302Z] GC before operation: completed in 5.250 ms, heap usage 58.891 MB -> 5.363 MB. [2026-01-31T10:10:28.656Z] Camera thread performed 122 scans. [2026-01-31T10:10:28.656Z] ====== philosophers (scala) [default], iteration 8 completed (442.124 ms) ====== [2026-01-31T10:10:28.656Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-31T10:10:28.656Z] GC before operation: completed in 4.951 ms, heap usage 43.527 MB -> 5.363 MB. [2026-01-31T10:10:29.009Z] Camera thread performed 122 scans. [2026-01-31T10:10:29.009Z] ====== philosophers (scala) [default], iteration 9 completed (463.781 ms) ====== [2026-01-31T10:10:29.009Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-31T10:10:29.009Z] GC before operation: completed in 4.824 ms, heap usage 43.828 MB -> 5.364 MB. [2026-01-31T10:10:29.769Z] Camera thread performed 122 scans. [2026-01-31T10:10:29.769Z] ====== philosophers (scala) [default], iteration 10 completed (625.609 ms) ====== [2026-01-31T10:10:29.769Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-31T10:10:29.769Z] GC before operation: completed in 5.070 ms, heap usage 12.456 MB -> 5.364 MB. [2026-01-31T10:10:30.124Z] Camera thread performed 122 scans. [2026-01-31T10:10:30.124Z] ====== philosophers (scala) [default], iteration 11 completed (454.181 ms) ====== [2026-01-31T10:10:30.124Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-31T10:10:30.124Z] GC before operation: completed in 5.178 ms, heap usage 18.939 MB -> 5.364 MB. [2026-01-31T10:10:30.887Z] Camera thread performed 122 scans. [2026-01-31T10:10:30.887Z] ====== philosophers (scala) [default], iteration 12 completed (626.135 ms) ====== [2026-01-31T10:10:30.887Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-31T10:10:30.887Z] GC before operation: completed in 6.776 ms, heap usage 17.848 MB -> 5.365 MB. [2026-01-31T10:10:31.645Z] Camera thread performed 122 scans. [2026-01-31T10:10:31.645Z] ====== philosophers (scala) [default], iteration 13 completed (632.411 ms) ====== [2026-01-31T10:10:31.645Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-31T10:10:31.645Z] GC before operation: completed in 5.365 ms, heap usage 45.992 MB -> 5.365 MB. [2026-01-31T10:10:32.002Z] Camera thread performed 122 scans. [2026-01-31T10:10:32.002Z] ====== philosophers (scala) [default], iteration 14 completed (417.188 ms) ====== [2026-01-31T10:10:32.002Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-31T10:10:32.002Z] GC before operation: completed in 5.068 ms, heap usage 17.341 MB -> 5.365 MB. [2026-01-31T10:10:32.357Z] Camera thread performed 122 scans. [2026-01-31T10:10:32.357Z] ====== philosophers (scala) [default], iteration 15 completed (600.032 ms) ====== [2026-01-31T10:10:32.357Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-31T10:10:32.357Z] GC before operation: completed in 5.020 ms, heap usage 17.579 MB -> 5.365 MB. [2026-01-31T10:10:32.714Z] Camera thread performed 122 scans. [2026-01-31T10:10:32.714Z] ====== philosophers (scala) [default], iteration 16 completed (414.751 ms) ====== [2026-01-31T10:10:32.714Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-31T10:10:32.714Z] GC before operation: completed in 5.174 ms, heap usage 59.565 MB -> 5.365 MB. [2026-01-31T10:10:33.478Z] Camera thread performed 122 scans. [2026-01-31T10:10:33.478Z] ====== philosophers (scala) [default], iteration 17 completed (598.393 ms) ====== [2026-01-31T10:10:33.478Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-31T10:10:33.478Z] GC before operation: completed in 5.454 ms, heap usage 19.579 MB -> 5.365 MB. [2026-01-31T10:10:34.250Z] Camera thread performed 122 scans. [2026-01-31T10:10:34.250Z] ====== philosophers (scala) [default], iteration 18 completed (775.952 ms) ====== [2026-01-31T10:10:34.250Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-31T10:10:34.250Z] GC before operation: completed in 6.324 ms, heap usage 7.542 MB -> 5.365 MB. [2026-01-31T10:10:35.016Z] Camera thread performed 122 scans. [2026-01-31T10:10:35.016Z] ====== philosophers (scala) [default], iteration 19 completed (700.990 ms) ====== [2026-01-31T10:10:35.016Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-31T10:10:35.016Z] GC before operation: completed in 7.971 ms, heap usage 83.931 MB -> 5.365 MB. [2026-01-31T10:10:35.782Z] Camera thread performed 122 scans. [2026-01-31T10:10:35.782Z] ====== philosophers (scala) [default], iteration 20 completed (701.646 ms) ====== [2026-01-31T10:10:35.782Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-31T10:10:35.782Z] GC before operation: completed in 7.108 ms, heap usage 46.879 MB -> 5.365 MB. [2026-01-31T10:10:36.138Z] Camera thread performed 122 scans. [2026-01-31T10:10:36.138Z] ====== philosophers (scala) [default], iteration 21 completed (476.598 ms) ====== [2026-01-31T10:10:36.138Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-31T10:10:36.138Z] GC before operation: completed in 5.277 ms, heap usage 60.931 MB -> 5.365 MB. [2026-01-31T10:10:36.493Z] Camera thread performed 122 scans. [2026-01-31T10:10:36.493Z] ====== philosophers (scala) [default], iteration 22 completed (435.856 ms) ====== [2026-01-31T10:10:36.493Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-31T10:10:36.493Z] GC before operation: completed in 5.357 ms, heap usage 51.275 MB -> 5.365 MB. [2026-01-31T10:10:37.257Z] Camera thread performed 122 scans. [2026-01-31T10:10:37.257Z] ====== philosophers (scala) [default], iteration 23 completed (442.302 ms) ====== [2026-01-31T10:10:37.257Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-31T10:10:37.257Z] GC before operation: completed in 5.186 ms, heap usage 8.020 MB -> 5.365 MB. [2026-01-31T10:10:37.612Z] Camera thread performed 122 scans. [2026-01-31T10:10:37.612Z] ====== philosophers (scala) [default], iteration 24 completed (453.643 ms) ====== [2026-01-31T10:10:37.612Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-31T10:10:37.612Z] GC before operation: completed in 5.201 ms, heap usage 43.060 MB -> 5.365 MB. [2026-01-31T10:10:37.968Z] Camera thread performed 122 scans. [2026-01-31T10:10:37.968Z] ====== philosophers (scala) [default], iteration 25 completed (437.557 ms) ====== [2026-01-31T10:10:37.969Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-31T10:10:37.969Z] GC before operation: completed in 5.712 ms, heap usage 28.916 MB -> 5.365 MB. [2026-01-31T10:10:38.733Z] Camera thread performed 122 scans. [2026-01-31T10:10:38.733Z] ====== philosophers (scala) [default], iteration 26 completed (592.628 ms) ====== [2026-01-31T10:10:38.733Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-31T10:10:38.733Z] GC before operation: completed in 5.699 ms, heap usage 26.952 MB -> 5.365 MB. [2026-01-31T10:10:39.092Z] Camera thread performed 122 scans. [2026-01-31T10:10:39.092Z] ====== philosophers (scala) [default], iteration 27 completed (611.825 ms) ====== [2026-01-31T10:10:39.092Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-31T10:10:39.092Z] GC before operation: completed in 5.619 ms, heap usage 54.553 MB -> 5.365 MB. [2026-01-31T10:10:39.863Z] Camera thread performed 122 scans. [2026-01-31T10:10:39.863Z] ====== philosophers (scala) [default], iteration 28 completed (621.380 ms) ====== [2026-01-31T10:10:39.863Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-31T10:10:39.863Z] GC before operation: completed in 5.702 ms, heap usage 50.859 MB -> 5.366 MB. [2026-01-31T10:10:40.222Z] Camera thread performed 122 scans. [2026-01-31T10:10:40.222Z] ====== philosophers (scala) [default], iteration 29 completed (454.722 ms) ====== [2026-01-31T10:10:40.222Z] ----------------------------------- [2026-01-31T10:10:40.222Z] renaissance-philosophers_0_PASSED [2026-01-31T10:10:40.222Z] ----------------------------------- [2026-01-31T10:10:40.222Z] [2026-01-31T10:10:40.222Z] TEST TEARDOWN: [2026-01-31T10:10:40.222Z] Nothing to be done for teardown. [2026-01-31T10:10:40.222Z] renaissance-philosophers_0 Finish Time: Sat Jan 31 05:10:40 2026 Epoch Time (ms): 1769854240181