[2025-12-20T13:17:03.973Z] Running test renaissance-philosophers_0 ... [2025-12-20T13:17:03.973Z] =============================================== [2025-12-20T13:17:03.973Z] renaissance-philosophers_0 Start Time: Sat Dec 20 08:17:03 2025 Epoch Time (ms): 1766236623772 [2025-12-20T13:17:03.973Z] variation: NoOptions [2025-12-20T13:17:03.973Z] JVM_OPTIONS: [2025-12-20T13:17:03.973Z] { \ [2025-12-20T13:17:03.973Z] echo ""; echo "TEST SETUP:"; \ [2025-12-20T13:17:03.973Z] echo "Nothing to be done for setup."; \ [2025-12-20T13:17:03.973Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17662359595926/renaissance-philosophers_0"; \ [2025-12-20T13:17:03.973Z] cd "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17662359595926/renaissance-philosophers_0"; \ [2025-12-20T13:17:03.973Z] echo ""; echo "TESTING:"; \ [2025-12-20T13:17:03.973Z] "/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_17662359595926/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-12-20T13:17:03.973Z] 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_17662359595926/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-20T13:17:03.973Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-20T13:17:03.973Z] echo "Nothing to be done for teardown."; \ [2025-12-20T13:17:03.973Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17662359595926/TestTargetResult"; [2025-12-20T13:17:03.973Z] [2025-12-20T13:17:03.973Z] TEST SETUP: [2025-12-20T13:17:03.973Z] Nothing to be done for setup. [2025-12-20T13:17:03.973Z] [2025-12-20T13:17:03.973Z] TESTING: [2025-12-20T13:17:04.326Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-20T13:17:04.326Z] 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_17662359595926/renaissance-philosophers_0/launcher-081703-16799567455268017575/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-20T13:17:04.326Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-20T13:17:04.326Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-20T13:17:04.326Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-12-20T13:17:04.326Z] GC before operation: completed in 6.273 ms, heap usage 27.623 MB -> 5.018 MB. [2025-12-20T13:17:05.115Z] Camera thread performed 122 scans. [2025-12-20T13:17:05.115Z] ====== philosophers (scala) [default], iteration 0 completed (926.185 ms) ====== [2025-12-20T13:17:05.115Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-12-20T13:17:05.115Z] GC before operation: completed in 6.012 ms, heap usage 43.147 MB -> 5.364 MB. [2025-12-20T13:17:05.867Z] Camera thread performed 122 scans. [2025-12-20T13:17:05.867Z] ====== philosophers (scala) [default], iteration 1 completed (515.403 ms) ====== [2025-12-20T13:17:05.867Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-12-20T13:17:05.867Z] GC before operation: completed in 4.650 ms, heap usage 26.568 MB -> 5.364 MB. [2025-12-20T13:17:06.217Z] Camera thread performed 122 scans. [2025-12-20T13:17:06.217Z] ====== philosophers (scala) [default], iteration 2 completed (468.812 ms) ====== [2025-12-20T13:17:06.217Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-12-20T13:17:06.217Z] GC before operation: completed in 4.480 ms, heap usage 27.555 MB -> 5.364 MB. [2025-12-20T13:17:06.964Z] Camera thread performed 122 scans. [2025-12-20T13:17:06.964Z] ====== philosophers (scala) [default], iteration 3 completed (509.109 ms) ====== [2025-12-20T13:17:06.964Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-12-20T13:17:06.964Z] GC before operation: completed in 4.379 ms, heap usage 30.563 MB -> 5.365 MB. [2025-12-20T13:17:07.313Z] Camera thread performed 122 scans. [2025-12-20T13:17:07.313Z] ====== philosophers (scala) [default], iteration 4 completed (478.963 ms) ====== [2025-12-20T13:17:07.313Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-12-20T13:17:07.313Z] GC before operation: completed in 4.259 ms, heap usage 93.563 MB -> 5.366 MB. [2025-12-20T13:17:07.670Z] Camera thread performed 122 scans. [2025-12-20T13:17:07.670Z] ====== philosophers (scala) [default], iteration 5 completed (467.415 ms) ====== [2025-12-20T13:17:07.670Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-12-20T13:17:07.670Z] GC before operation: completed in 4.296 ms, heap usage 69.060 MB -> 5.366 MB. [2025-12-20T13:17:08.020Z] Camera thread performed 122 scans. [2025-12-20T13:17:08.020Z] ====== philosophers (scala) [default], iteration 6 completed (459.137 ms) ====== [2025-12-20T13:17:08.020Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-12-20T13:17:08.020Z] GC before operation: completed in 4.218 ms, heap usage 81.033 MB -> 5.367 MB. [2025-12-20T13:17:08.768Z] Camera thread performed 122 scans. [2025-12-20T13:17:08.768Z] ====== philosophers (scala) [default], iteration 7 completed (464.095 ms) ====== [2025-12-20T13:17:08.768Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-12-20T13:17:08.768Z] GC before operation: completed in 4.240 ms, heap usage 68.390 MB -> 5.367 MB. [2025-12-20T13:17:09.120Z] Camera thread performed 122 scans. [2025-12-20T13:17:09.120Z] ====== philosophers (scala) [default], iteration 8 completed (455.022 ms) ====== [2025-12-20T13:17:09.120Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-12-20T13:17:09.120Z] GC before operation: completed in 4.161 ms, heap usage 40.055 MB -> 5.367 MB. [2025-12-20T13:17:09.468Z] Camera thread performed 122 scans. [2025-12-20T13:17:09.469Z] ====== philosophers (scala) [default], iteration 9 completed (455.751 ms) ====== [2025-12-20T13:17:09.469Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-12-20T13:17:09.469Z] GC before operation: completed in 4.191 ms, heap usage 75.043 MB -> 5.367 MB. [2025-12-20T13:17:09.836Z] Camera thread performed 122 scans. [2025-12-20T13:17:09.836Z] ====== philosophers (scala) [default], iteration 10 completed (404.070 ms) ====== [2025-12-20T13:17:09.836Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-12-20T13:17:09.836Z] GC before operation: completed in 4.210 ms, heap usage 68.300 MB -> 5.367 MB. [2025-12-20T13:17:10.581Z] Camera thread performed 122 scans. [2025-12-20T13:17:10.581Z] ====== philosophers (scala) [default], iteration 11 completed (451.021 ms) ====== [2025-12-20T13:17:10.581Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-12-20T13:17:10.581Z] GC before operation: completed in 4.240 ms, heap usage 63.578 MB -> 5.368 MB. [2025-12-20T13:17:10.929Z] Camera thread performed 122 scans. [2025-12-20T13:17:10.929Z] ====== philosophers (scala) [default], iteration 12 completed (495.958 ms) ====== [2025-12-20T13:17:10.929Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-12-20T13:17:10.929Z] GC before operation: completed in 4.262 ms, heap usage 62.436 MB -> 5.368 MB. [2025-12-20T13:17:11.277Z] Camera thread performed 122 scans. [2025-12-20T13:17:11.277Z] ====== philosophers (scala) [default], iteration 13 completed (454.346 ms) ====== [2025-12-20T13:17:11.277Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-12-20T13:17:11.277Z] GC before operation: completed in 4.303 ms, heap usage 74.415 MB -> 5.368 MB. [2025-12-20T13:17:12.037Z] Camera thread performed 122 scans. [2025-12-20T13:17:12.037Z] ====== philosophers (scala) [default], iteration 14 completed (482.012 ms) ====== [2025-12-20T13:17:12.037Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-12-20T13:17:12.037Z] GC before operation: completed in 4.289 ms, heap usage 58.419 MB -> 5.368 MB. [2025-12-20T13:17:12.391Z] Camera thread performed 122 scans. [2025-12-20T13:17:12.391Z] ====== philosophers (scala) [default], iteration 15 completed (507.162 ms) ====== [2025-12-20T13:17:12.391Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-12-20T13:17:12.391Z] GC before operation: completed in 4.157 ms, heap usage 49.567 MB -> 5.368 MB. [2025-12-20T13:17:12.748Z] Camera thread performed 122 scans. [2025-12-20T13:17:12.748Z] ====== philosophers (scala) [default], iteration 16 completed (462.046 ms) ====== [2025-12-20T13:17:12.748Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-12-20T13:17:12.748Z] GC before operation: completed in 4.270 ms, heap usage 87.982 MB -> 5.369 MB. [2025-12-20T13:17:13.508Z] Camera thread performed 122 scans. [2025-12-20T13:17:13.508Z] ====== philosophers (scala) [default], iteration 17 completed (468.975 ms) ====== [2025-12-20T13:17:13.508Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-12-20T13:17:13.508Z] GC before operation: completed in 4.262 ms, heap usage 34.419 MB -> 5.368 MB. [2025-12-20T13:17:13.867Z] Camera thread performed 122 scans. [2025-12-20T13:17:13.867Z] ====== philosophers (scala) [default], iteration 18 completed (419.463 ms) ====== [2025-12-20T13:17:13.867Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-12-20T13:17:13.867Z] GC before operation: completed in 4.104 ms, heap usage 33.020 MB -> 5.368 MB. [2025-12-20T13:17:14.216Z] Camera thread performed 122 scans. [2025-12-20T13:17:14.216Z] ====== philosophers (scala) [default], iteration 19 completed (457.563 ms) ====== [2025-12-20T13:17:14.216Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-12-20T13:17:14.216Z] GC before operation: completed in 4.375 ms, heap usage 80.383 MB -> 5.368 MB. [2025-12-20T13:17:14.564Z] Camera thread performed 122 scans. [2025-12-20T13:17:14.564Z] ====== philosophers (scala) [default], iteration 20 completed (427.703 ms) ====== [2025-12-20T13:17:14.564Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-12-20T13:17:14.564Z] GC before operation: completed in 4.306 ms, heap usage 46.998 MB -> 5.369 MB. [2025-12-20T13:17:15.326Z] Camera thread performed 122 scans. [2025-12-20T13:17:15.326Z] ====== philosophers (scala) [default], iteration 21 completed (463.813 ms) ====== [2025-12-20T13:17:15.326Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-12-20T13:17:15.326Z] GC before operation: completed in 4.352 ms, heap usage 25.058 MB -> 5.369 MB. [2025-12-20T13:17:15.673Z] Camera thread performed 122 scans. [2025-12-20T13:17:15.673Z] ====== philosophers (scala) [default], iteration 22 completed (457.332 ms) ====== [2025-12-20T13:17:15.673Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-12-20T13:17:15.673Z] GC before operation: completed in 4.277 ms, heap usage 7.567 MB -> 5.369 MB. [2025-12-20T13:17:16.021Z] Camera thread performed 122 scans. [2025-12-20T13:17:16.021Z] ====== philosophers (scala) [default], iteration 23 completed (459.139 ms) ====== [2025-12-20T13:17:16.021Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-12-20T13:17:16.021Z] GC before operation: completed in 4.269 ms, heap usage 17.505 MB -> 5.369 MB. [2025-12-20T13:17:16.374Z] Camera thread performed 122 scans. [2025-12-20T13:17:16.374Z] ====== philosophers (scala) [default], iteration 24 completed (469.514 ms) ====== [2025-12-20T13:17:16.374Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-12-20T13:17:16.374Z] GC before operation: completed in 4.237 ms, heap usage 45.566 MB -> 5.369 MB. [2025-12-20T13:17:17.120Z] Camera thread performed 122 scans. [2025-12-20T13:17:17.120Z] ====== philosophers (scala) [default], iteration 25 completed (455.812 ms) ====== [2025-12-20T13:17:17.120Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-12-20T13:17:17.120Z] GC before operation: completed in 4.156 ms, heap usage 72.443 MB -> 5.369 MB. [2025-12-20T13:17:17.468Z] Camera thread performed 122 scans. [2025-12-20T13:17:17.468Z] ====== philosophers (scala) [default], iteration 26 completed (439.290 ms) ====== [2025-12-20T13:17:17.468Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-12-20T13:17:17.468Z] GC before operation: completed in 4.204 ms, heap usage 87.583 MB -> 5.369 MB. [2025-12-20T13:17:17.817Z] Camera thread performed 122 scans. [2025-12-20T13:17:17.817Z] ====== philosophers (scala) [default], iteration 27 completed (491.004 ms) ====== [2025-12-20T13:17:17.817Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-12-20T13:17:17.817Z] GC before operation: completed in 4.294 ms, heap usage 70.443 MB -> 5.369 MB. [2025-12-20T13:17:18.565Z] Camera thread performed 122 scans. [2025-12-20T13:17:18.565Z] ====== philosophers (scala) [default], iteration 28 completed (490.022 ms) ====== [2025-12-20T13:17:18.565Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-12-20T13:17:18.565Z] GC before operation: completed in 4.317 ms, heap usage 68.403 MB -> 5.369 MB. [2025-12-20T13:17:18.916Z] Camera thread performed 122 scans. [2025-12-20T13:17:18.916Z] ====== philosophers (scala) [default], iteration 29 completed (453.214 ms) ====== [2025-12-20T13:17:18.916Z] ----------------------------------- [2025-12-20T13:17:18.916Z] renaissance-philosophers_0_PASSED [2025-12-20T13:17:18.916Z] ----------------------------------- [2025-12-20T13:17:18.916Z] [2025-12-20T13:17:18.916Z] TEST TEARDOWN: [2025-12-20T13:17:18.916Z] Nothing to be done for teardown. [2025-12-20T13:17:18.916Z] renaissance-philosophers_0 Finish Time: Sat Dec 20 08:17:18 2025 Epoch Time (ms): 1766236638737