[2026-01-09T00:08:19.206Z] Running test renaissance-philosophers_0 ... [2026-01-09T00:08:19.206Z] =============================================== [2026-01-09T00:08:19.665Z] renaissance-philosophers_0 Start Time: Thu Jan 8 16:08:19 2026 Epoch Time (ms): 1767917299128 [2026-01-09T00:08:19.665Z] variation: NoOptions [2026-01-09T00:08:19.665Z] JVM_OPTIONS: [2026-01-09T00:08:19.665Z] { \ [2026-01-09T00:08:19.665Z] echo ""; echo "TEST SETUP:"; \ [2026-01-09T00:08:19.665Z] echo "Nothing to be done for setup."; \ [2026-01-09T00:08:19.665Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17679166673789/renaissance-philosophers_0"; \ [2026-01-09T00:08:19.665Z] cd "/Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17679166673789/renaissance-philosophers_0"; \ [2026-01-09T00:08:19.665Z] echo ""; echo "TESTING:"; \ [2026-01-09T00:08:19.665Z] "/Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_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_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17679166673789/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-09T00:08:19.665Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17679166673789/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-09T00:08:19.665Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-09T00:08:19.665Z] echo "Nothing to be done for teardown."; \ [2026-01-09T00:08:19.665Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17679166673789/TestTargetResult"; [2026-01-09T00:08:19.665Z] [2026-01-09T00:08:19.665Z] TEST SETUP: [2026-01-09T00:08:19.665Z] Nothing to be done for setup. [2026-01-09T00:08:19.665Z] [2026-01-09T00:08:19.665Z] TESTING: [2026-01-09T00:08:20.605Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-09T00:08:20.605Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/Users/admin/workspace/workspace/Test_openjdk26_hs_extended.perf_x86-64_mac/aqa-tests/TKG/output_17679166673789/renaissance-philosophers_0/launcher-160819-7493213278746924034/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-09T00:08:20.605Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-09T00:08:20.605Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-09T00:08:21.122Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-09T00:08:21.122Z] GC before operation: completed in 56.246 ms, heap usage 18.025 MB -> 4.648 MB. [2026-01-09T00:08:26.122Z] Camera thread performed 122 scans. [2026-01-09T00:08:26.122Z] ====== philosophers (scala) [default], iteration 0 completed (5035.117 ms) ====== [2026-01-09T00:08:26.122Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-09T00:08:26.122Z] GC before operation: completed in 13.558 ms, heap usage 11.974 MB -> 4.996 MB. [2026-01-09T00:08:28.448Z] Camera thread performed 122 scans. [2026-01-09T00:08:28.448Z] ====== philosophers (scala) [default], iteration 1 completed (2341.190 ms) ====== [2026-01-09T00:08:28.448Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-09T00:08:28.448Z] GC before operation: completed in 64.535 ms, heap usage 179.174 MB -> 4.997 MB. [2026-01-09T00:08:31.470Z] Camera thread performed 122 scans. [2026-01-09T00:08:31.470Z] ====== philosophers (scala) [default], iteration 2 completed (2511.300 ms) ====== [2026-01-09T00:08:31.470Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-09T00:08:31.470Z] GC before operation: completed in 48.774 ms, heap usage 202.581 MB -> 5.034 MB. [2026-01-09T00:08:33.566Z] Camera thread performed 122 scans. [2026-01-09T00:08:33.566Z] ====== philosophers (scala) [default], iteration 3 completed (2414.919 ms) ====== [2026-01-09T00:08:33.566Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-09T00:08:33.566Z] GC before operation: completed in 33.216 ms, heap usage 68.752 MB -> 4.998 MB. [2026-01-09T00:08:35.032Z] Camera thread performed 122 scans. [2026-01-09T00:08:35.032Z] ====== philosophers (scala) [default], iteration 4 completed (1549.921 ms) ====== [2026-01-09T00:08:35.032Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-09T00:08:35.032Z] GC before operation: completed in 54.689 ms, heap usage 81.123 MB -> 5.034 MB. [2026-01-09T00:08:37.305Z] Camera thread performed 122 scans. [2026-01-09T00:08:37.305Z] ====== philosophers (scala) [default], iteration 5 completed (2335.389 ms) ====== [2026-01-09T00:08:37.305Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-09T00:08:37.708Z] GC before operation: completed in 59.363 ms, heap usage 61.073 MB -> 5.035 MB. [2026-01-09T00:08:39.784Z] Camera thread performed 122 scans. [2026-01-09T00:08:39.784Z] ====== philosophers (scala) [default], iteration 6 completed (2187.344 ms) ====== [2026-01-09T00:08:39.784Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-09T00:08:39.784Z] GC before operation: completed in 46.006 ms, heap usage 97.731 MB -> 5.000 MB. [2026-01-09T00:08:41.237Z] Camera thread performed 122 scans. [2026-01-09T00:08:41.237Z] ====== philosophers (scala) [default], iteration 7 completed (1656.925 ms) ====== [2026-01-09T00:08:41.237Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-09T00:08:41.676Z] GC before operation: completed in 38.147 ms, heap usage 73.768 MB -> 5.001 MB. [2026-01-09T00:08:44.496Z] Camera thread performed 122 scans. [2026-01-09T00:08:44.496Z] ====== philosophers (scala) [default], iteration 8 completed (2850.093 ms) ====== [2026-01-09T00:08:44.496Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-09T00:08:44.496Z] GC before operation: completed in 41.065 ms, heap usage 73.183 MB -> 5.002 MB. [2026-01-09T00:08:46.559Z] Camera thread performed 122 scans. [2026-01-09T00:08:46.559Z] ====== philosophers (scala) [default], iteration 9 completed (1877.460 ms) ====== [2026-01-09T00:08:46.559Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-09T00:08:46.559Z] GC before operation: completed in 73.125 ms, heap usage 90.193 MB -> 5.002 MB. [2026-01-09T00:08:47.783Z] Camera thread performed 122 scans. [2026-01-09T00:08:47.783Z] ====== philosophers (scala) [default], iteration 10 completed (1318.718 ms) ====== [2026-01-09T00:08:47.783Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-09T00:08:47.783Z] GC before operation: completed in 45.650 ms, heap usage 66.850 MB -> 5.037 MB. [2026-01-09T00:08:50.654Z] Camera thread performed 122 scans. [2026-01-09T00:08:50.654Z] ====== philosophers (scala) [default], iteration 11 completed (2500.374 ms) ====== [2026-01-09T00:08:50.654Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-09T00:08:50.654Z] GC before operation: completed in 65.476 ms, heap usage 108.161 MB -> 5.002 MB. [2026-01-09T00:08:52.192Z] Camera thread performed 122 scans. [2026-01-09T00:08:52.192Z] ====== philosophers (scala) [default], iteration 12 completed (2123.766 ms) ====== [2026-01-09T00:08:52.192Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-09T00:08:52.595Z] GC before operation: completed in 31.550 ms, heap usage 120.068 MB -> 5.002 MB. [2026-01-09T00:08:54.885Z] Camera thread performed 122 scans. [2026-01-09T00:08:54.885Z] ====== philosophers (scala) [default], iteration 13 completed (2344.706 ms) ====== [2026-01-09T00:08:54.885Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-09T00:08:54.885Z] GC before operation: completed in 47.673 ms, heap usage 107.799 MB -> 5.002 MB. [2026-01-09T00:08:56.342Z] Camera thread performed 122 scans. [2026-01-09T00:08:56.342Z] ====== philosophers (scala) [default], iteration 14 completed (1698.930 ms) ====== [2026-01-09T00:08:56.342Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-09T00:08:56.810Z] GC before operation: completed in 214.967 ms, heap usage 88.416 MB -> 5.002 MB. [2026-01-09T00:08:58.888Z] Camera thread performed 122 scans. [2026-01-09T00:08:58.888Z] ====== philosophers (scala) [default], iteration 15 completed (2055.930 ms) ====== [2026-01-09T00:08:58.888Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-09T00:08:58.888Z] GC before operation: completed in 37.728 ms, heap usage 101.993 MB -> 5.002 MB. [2026-01-09T00:09:00.287Z] Camera thread performed 122 scans. [2026-01-09T00:09:00.287Z] ====== philosophers (scala) [default], iteration 16 completed (1444.766 ms) ====== [2026-01-09T00:09:00.287Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-09T00:09:00.287Z] GC before operation: completed in 68.854 ms, heap usage 115.155 MB -> 5.003 MB. [2026-01-09T00:09:02.336Z] Camera thread performed 122 scans. [2026-01-09T00:09:02.336Z] ====== philosophers (scala) [default], iteration 17 completed (2088.961 ms) ====== [2026-01-09T00:09:02.336Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-09T00:09:02.336Z] GC before operation: completed in 42.178 ms, heap usage 119.483 MB -> 5.003 MB. [2026-01-09T00:09:04.435Z] Camera thread performed 122 scans. [2026-01-09T00:09:04.435Z] ====== philosophers (scala) [default], iteration 18 completed (2000.072 ms) ====== [2026-01-09T00:09:04.435Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-09T00:09:04.435Z] GC before operation: completed in 41.065 ms, heap usage 79.390 MB -> 5.003 MB. [2026-01-09T00:09:05.818Z] Camera thread performed 122 scans. [2026-01-09T00:09:05.818Z] ====== philosophers (scala) [default], iteration 19 completed (1149.203 ms) ====== [2026-01-09T00:09:05.818Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-09T00:09:05.818Z] GC before operation: completed in 72.951 ms, heap usage 111.773 MB -> 5.003 MB. [2026-01-09T00:09:07.921Z] Camera thread performed 122 scans. [2026-01-09T00:09:07.921Z] ====== philosophers (scala) [default], iteration 20 completed (2233.238 ms) ====== [2026-01-09T00:09:07.921Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-09T00:09:07.921Z] GC before operation: completed in 54.819 ms, heap usage 168.498 MB -> 5.039 MB. [2026-01-09T00:09:10.785Z] Camera thread performed 122 scans. [2026-01-09T00:09:10.785Z] ====== philosophers (scala) [default], iteration 21 completed (2231.505 ms) ====== [2026-01-09T00:09:10.785Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-09T00:09:10.785Z] GC before operation: completed in 55.662 ms, heap usage 99.905 MB -> 5.003 MB. [2026-01-09T00:09:13.163Z] Camera thread performed 122 scans. [2026-01-09T00:09:13.163Z] ====== philosophers (scala) [default], iteration 22 completed (2485.818 ms) ====== [2026-01-09T00:09:13.163Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-09T00:09:13.163Z] GC before operation: completed in 54.110 ms, heap usage 73.993 MB -> 5.004 MB. [2026-01-09T00:09:15.326Z] Camera thread performed 122 scans. [2026-01-09T00:09:15.326Z] ====== philosophers (scala) [default], iteration 23 completed (2300.555 ms) ====== [2026-01-09T00:09:15.326Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-09T00:09:15.326Z] GC before operation: completed in 175.018 ms, heap usage 118.199 MB -> 5.004 MB. [2026-01-09T00:09:17.556Z] Camera thread performed 122 scans. [2026-01-09T00:09:17.556Z] ====== philosophers (scala) [default], iteration 24 completed (1814.553 ms) ====== [2026-01-09T00:09:17.556Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-09T00:09:17.556Z] GC before operation: completed in 75.625 ms, heap usage 82.308 MB -> 5.004 MB. [2026-01-09T00:09:20.448Z] Camera thread performed 122 scans. [2026-01-09T00:09:20.448Z] ====== philosophers (scala) [default], iteration 25 completed (2733.478 ms) ====== [2026-01-09T00:09:20.448Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-09T00:09:20.448Z] GC before operation: completed in 41.499 ms, heap usage 96.171 MB -> 5.004 MB. [2026-01-09T00:09:22.576Z] Camera thread performed 122 scans. [2026-01-09T00:09:22.576Z] ====== philosophers (scala) [default], iteration 26 completed (2439.484 ms) ====== [2026-01-09T00:09:22.576Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-09T00:09:22.576Z] GC before operation: completed in 33.449 ms, heap usage 118.139 MB -> 5.004 MB. [2026-01-09T00:09:24.801Z] Camera thread performed 122 scans. [2026-01-09T00:09:24.801Z] ====== philosophers (scala) [default], iteration 27 completed (2188.505 ms) ====== [2026-01-09T00:09:24.801Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-09T00:09:24.801Z] GC before operation: completed in 35.389 ms, heap usage 115.929 MB -> 5.004 MB. [2026-01-09T00:09:26.243Z] Camera thread performed 122 scans. [2026-01-09T00:09:26.243Z] ====== philosophers (scala) [default], iteration 28 completed (1605.154 ms) ====== [2026-01-09T00:09:26.243Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-09T00:09:26.243Z] GC before operation: completed in 30.637 ms, heap usage 138.194 MB -> 5.004 MB. [2026-01-09T00:09:28.257Z] Camera thread performed 122 scans. [2026-01-09T00:09:28.257Z] ====== philosophers (scala) [default], iteration 29 completed (1838.166 ms) ====== [2026-01-09T00:09:28.257Z] ----------------------------------- [2026-01-09T00:09:28.257Z] renaissance-philosophers_0_PASSED [2026-01-09T00:09:28.257Z] ----------------------------------- [2026-01-09T00:09:28.257Z] [2026-01-09T00:09:28.257Z] TEST TEARDOWN: [2026-01-09T00:09:28.257Z] Nothing to be done for teardown. [2026-01-09T00:09:28.657Z] renaissance-philosophers_0 Finish Time: Thu Jan 8 16:09:28 2026 Epoch Time (ms): 1767917368212