[2026-02-06T13:22:06.763Z] Running test renaissance-philosophers_0 ... [2026-02-06T13:22:06.763Z] =============================================== [2026-02-06T13:22:06.763Z] renaissance-philosophers_0 Start Time: Fri Feb 6 08:22:06 2026 Epoch Time (ms): 1770384126376 [2026-02-06T13:22:06.763Z] variation: NoOptions [2026-02-06T13:22:06.763Z] JVM_OPTIONS: [2026-02-06T13:22:06.763Z] { \ [2026-02-06T13:22:06.763Z] echo ""; echo "TEST SETUP:"; \ [2026-02-06T13:22:06.763Z] echo "Nothing to be done for setup."; \ [2026-02-06T13:22:06.763Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17703830442449/renaissance-philosophers_0"; \ [2026-02-06T13:22:06.763Z] cd "/Users/admin/workspace/workspace/Test_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17703830442449/renaissance-philosophers_0"; \ [2026-02-06T13:22:06.763Z] echo ""; echo "TESTING:"; \ [2026-02-06T13:22:06.763Z] "/Users/admin/workspace/workspace/Test_openjdk27_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_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17703830442449/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-06T13:22:06.763Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17703830442449/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-06T13:22:06.763Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-06T13:22:06.763Z] echo "Nothing to be done for teardown."; \ [2026-02-06T13:22:06.763Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17703830442449/TestTargetResult"; [2026-02-06T13:22:06.763Z] [2026-02-06T13:22:06.763Z] TEST SETUP: [2026-02-06T13:22:06.763Z] Nothing to be done for setup. [2026-02-06T13:22:06.763Z] [2026-02-06T13:22:06.763Z] TESTING: [2026-02-06T13:22:10.026Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-06T13:22:10.026Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/Users/admin/workspace/workspace/Test_openjdk27_hs_extended.perf_x86-64_mac/aqa-tests/TKG/output_17703830442449/renaissance-philosophers_0/launcher-082208-8371325520839435251/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-06T13:22:10.026Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-06T13:22:10.026Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-06T13:22:11.921Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-06T13:22:12.425Z] GC before operation: completed in 92.546 ms, heap usage 18.125 MB -> 4.650 MB. [2026-02-06T13:22:20.728Z] Camera thread performed 122 scans. [2026-02-06T13:22:20.729Z] ====== philosophers (scala) [default], iteration 0 completed (7971.662 ms) ====== [2026-02-06T13:22:20.729Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-06T13:22:20.729Z] GC before operation: completed in 123.480 ms, heap usage 66.735 MB -> 4.998 MB. [2026-02-06T13:22:24.976Z] Camera thread performed 122 scans. [2026-02-06T13:22:24.976Z] ====== philosophers (scala) [default], iteration 1 completed (4428.779 ms) ====== [2026-02-06T13:22:24.976Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-06T13:22:24.976Z] GC before operation: completed in 80.423 ms, heap usage 253.174 MB -> 5.035 MB. [2026-02-06T13:22:26.888Z] Camera thread performed 122 scans. [2026-02-06T13:22:26.888Z] ====== philosophers (scala) [default], iteration 2 completed (1685.927 ms) ====== [2026-02-06T13:22:26.888Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-06T13:22:26.888Z] GC before operation: completed in 166.957 ms, heap usage 164.816 MB -> 4.999 MB. [2026-02-06T13:22:28.638Z] Camera thread performed 122 scans. [2026-02-06T13:22:28.638Z] ====== philosophers (scala) [default], iteration 3 completed (2193.044 ms) ====== [2026-02-06T13:22:28.638Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-06T13:22:29.183Z] GC before operation: completed in 48.921 ms, heap usage 148.216 MB -> 5.000 MB. [2026-02-06T13:22:30.899Z] Camera thread performed 122 scans. [2026-02-06T13:22:30.899Z] ====== philosophers (scala) [default], iteration 4 completed (2120.528 ms) ====== [2026-02-06T13:22:30.899Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-06T13:22:30.899Z] GC before operation: completed in 33.872 ms, heap usage 199.494 MB -> 5.001 MB. [2026-02-06T13:22:33.341Z] Camera thread performed 122 scans. [2026-02-06T13:22:33.341Z] ====== philosophers (scala) [default], iteration 5 completed (2089.337 ms) ====== [2026-02-06T13:22:33.341Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-06T13:22:33.341Z] GC before operation: completed in 88.448 ms, heap usage 192.932 MB -> 5.001 MB. [2026-02-06T13:22:38.464Z] Camera thread performed 122 scans. [2026-02-06T13:22:38.465Z] ====== philosophers (scala) [default], iteration 6 completed (4714.348 ms) ====== [2026-02-06T13:22:38.465Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-06T13:22:38.465Z] GC before operation: completed in 120.563 ms, heap usage 653.001 MB -> 5.038 MB. [2026-02-06T13:22:40.753Z] Camera thread performed 122 scans. [2026-02-06T13:22:40.753Z] ====== philosophers (scala) [default], iteration 7 completed (2651.866 ms) ====== [2026-02-06T13:22:40.753Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-06T13:22:40.753Z] GC before operation: completed in 41.816 ms, heap usage 727.038 MB -> 5.039 MB. [2026-02-06T13:22:42.306Z] Camera thread performed 122 scans. [2026-02-06T13:22:42.306Z] ====== philosophers (scala) [default], iteration 8 completed (1363.954 ms) ====== [2026-02-06T13:22:42.306Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-06T13:22:42.306Z] GC before operation: completed in 147.709 ms, heap usage 687.039 MB -> 5.040 MB. [2026-02-06T13:22:44.087Z] Camera thread performed 122 scans. [2026-02-06T13:22:44.087Z] ====== philosophers (scala) [default], iteration 9 completed (1779.509 ms) ====== [2026-02-06T13:22:44.087Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-06T13:22:44.087Z] GC before operation: completed in 54.803 ms, heap usage 685.040 MB -> 5.005 MB. [2026-02-06T13:22:46.580Z] Camera thread performed 122 scans. [2026-02-06T13:22:46.580Z] ====== philosophers (scala) [default], iteration 10 completed (2041.966 ms) ====== [2026-02-06T13:22:46.580Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-06T13:22:46.580Z] GC before operation: completed in 98.493 ms, heap usage 691.005 MB -> 5.005 MB. [2026-02-06T13:22:47.585Z] Camera thread performed 122 scans. [2026-02-06T13:22:47.585Z] ====== philosophers (scala) [default], iteration 11 completed (1393.323 ms) ====== [2026-02-06T13:22:47.585Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-06T13:22:48.068Z] GC before operation: completed in 242.099 ms, heap usage 693.005 MB -> 5.005 MB. [2026-02-06T13:22:49.824Z] Camera thread performed 122 scans. [2026-02-06T13:22:49.824Z] ====== philosophers (scala) [default], iteration 12 completed (1836.919 ms) ====== [2026-02-06T13:22:49.824Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-06T13:22:49.824Z] GC before operation: completed in 59.636 ms, heap usage 681.005 MB -> 5.006 MB. [2026-02-06T13:22:52.042Z] Camera thread performed 122 scans. [2026-02-06T13:22:52.042Z] ====== philosophers (scala) [default], iteration 13 completed (2189.861 ms) ====== [2026-02-06T13:22:52.042Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-06T13:22:52.042Z] GC before operation: completed in 55.666 ms, heap usage 699.014 MB -> 5.005 MB. [2026-02-06T13:22:53.898Z] Camera thread performed 122 scans. [2026-02-06T13:22:53.898Z] ====== philosophers (scala) [default], iteration 14 completed (1549.353 ms) ====== [2026-02-06T13:22:53.898Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-06T13:22:53.898Z] GC before operation: completed in 79.861 ms, heap usage 681.005 MB -> 5.041 MB. [2026-02-06T13:22:55.435Z] Camera thread performed 122 scans. [2026-02-06T13:22:55.435Z] ====== philosophers (scala) [default], iteration 15 completed (1907.578 ms) ====== [2026-02-06T13:22:55.435Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-06T13:22:55.435Z] GC before operation: completed in 35.281 ms, heap usage 719.045 MB -> 5.006 MB. [2026-02-06T13:22:57.864Z] Camera thread performed 122 scans. [2026-02-06T13:22:57.864Z] ====== philosophers (scala) [default], iteration 16 completed (1987.725 ms) ====== [2026-02-06T13:22:57.864Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-06T13:22:57.864Z] GC before operation: completed in 95.667 ms, heap usage 691.011 MB -> 5.042 MB. [2026-02-06T13:22:59.523Z] Camera thread performed 122 scans. [2026-02-06T13:22:59.523Z] ====== philosophers (scala) [default], iteration 17 completed (1467.364 ms) ====== [2026-02-06T13:22:59.523Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-06T13:22:59.523Z] GC before operation: completed in 40.497 ms, heap usage 695.047 MB -> 5.006 MB. [2026-02-06T13:23:01.322Z] Camera thread performed 122 scans. [2026-02-06T13:23:01.322Z] ====== philosophers (scala) [default], iteration 18 completed (2022.932 ms) ====== [2026-02-06T13:23:01.322Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-06T13:23:01.322Z] GC before operation: completed in 121.191 ms, heap usage 705.012 MB -> 5.007 MB. [2026-02-06T13:23:03.117Z] Camera thread performed 122 scans. [2026-02-06T13:23:03.117Z] ====== philosophers (scala) [default], iteration 19 completed (1348.938 ms) ====== [2026-02-06T13:23:03.117Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-06T13:23:03.117Z] GC before operation: completed in 180.224 ms, heap usage 687.012 MB -> 5.007 MB. [2026-02-06T13:23:04.742Z] Camera thread performed 122 scans. [2026-02-06T13:23:04.742Z] ====== philosophers (scala) [default], iteration 20 completed (1934.322 ms) ====== [2026-02-06T13:23:04.742Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-06T13:23:05.358Z] GC before operation: completed in 81.581 ms, heap usage 691.012 MB -> 5.042 MB. [2026-02-06T13:23:07.120Z] Camera thread performed 122 scans. [2026-02-06T13:23:07.120Z] ====== philosophers (scala) [default], iteration 21 completed (1895.160 ms) ====== [2026-02-06T13:23:07.120Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-06T13:23:07.120Z] GC before operation: completed in 20.489 ms, heap usage 691.047 MB -> 5.007 MB. [2026-02-06T13:23:08.838Z] Camera thread performed 122 scans. [2026-02-06T13:23:08.838Z] ====== philosophers (scala) [default], iteration 22 completed (1887.408 ms) ====== [2026-02-06T13:23:08.838Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-06T13:23:08.838Z] GC before operation: completed in 196.914 ms, heap usage 699.012 MB -> 5.042 MB. [2026-02-06T13:23:10.529Z] Camera thread performed 122 scans. [2026-02-06T13:23:10.529Z] ====== philosophers (scala) [default], iteration 23 completed (1626.330 ms) ====== [2026-02-06T13:23:10.529Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-06T13:23:10.529Z] GC before operation: completed in 34.553 ms, heap usage 715.048 MB -> 5.007 MB. [2026-02-06T13:23:12.973Z] Camera thread performed 122 scans. [2026-02-06T13:23:12.973Z] ====== philosophers (scala) [default], iteration 24 completed (1970.966 ms) ====== [2026-02-06T13:23:12.973Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-06T13:23:12.973Z] GC before operation: completed in 66.437 ms, heap usage 687.012 MB -> 5.043 MB. [2026-02-06T13:23:14.069Z] Camera thread performed 122 scans. [2026-02-06T13:23:14.069Z] ====== philosophers (scala) [default], iteration 25 completed (1413.692 ms) ====== [2026-02-06T13:23:14.069Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-06T13:23:14.069Z] GC before operation: completed in 49.858 ms, heap usage 727.048 MB -> 5.007 MB. [2026-02-06T13:23:17.509Z] Camera thread performed 122 scans. [2026-02-06T13:23:17.509Z] ====== philosophers (scala) [default], iteration 26 completed (2758.923 ms) ====== [2026-02-06T13:23:17.509Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-06T13:23:17.509Z] GC before operation: completed in 81.066 ms, heap usage 695.012 MB -> 5.008 MB. [2026-02-06T13:23:19.333Z] Camera thread performed 122 scans. [2026-02-06T13:23:19.333Z] ====== philosophers (scala) [default], iteration 27 completed (2257.541 ms) ====== [2026-02-06T13:23:19.333Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-06T13:23:19.333Z] GC before operation: completed in 95.665 ms, heap usage 701.013 MB -> 5.008 MB. [2026-02-06T13:23:21.806Z] Camera thread performed 122 scans. [2026-02-06T13:23:21.806Z] ====== philosophers (scala) [default], iteration 28 completed (2098.340 ms) ====== [2026-02-06T13:23:21.806Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-06T13:23:21.806Z] GC before operation: completed in 24.622 ms, heap usage 725.013 MB -> 5.008 MB. [2026-02-06T13:23:24.179Z] Camera thread performed 122 scans. [2026-02-06T13:23:24.179Z] ====== philosophers (scala) [default], iteration 29 completed (2364.724 ms) ====== [2026-02-06T13:23:24.710Z] ----------------------------------- [2026-02-06T13:23:24.710Z] renaissance-philosophers_0_PASSED [2026-02-06T13:23:24.710Z] ----------------------------------- [2026-02-06T13:23:24.710Z] [2026-02-06T13:23:24.710Z] TEST TEARDOWN: [2026-02-06T13:23:24.710Z] Nothing to be done for teardown. [2026-02-06T13:23:24.710Z] renaissance-philosophers_0 Finish Time: Fri Feb 6 08:23:24 2026 Epoch Time (ms): 1770384204394