[2026-02-05T00:56:47.515Z] Running test renaissance-philosophers_0 ... [2026-02-05T00:56:47.515Z] =============================================== [2026-02-05T00:56:47.515Z] renaissance-philosophers_0 Start Time: Wed Feb 4 19:56:47 2026 Epoch Time (ms): 1770253007192 [2026-02-05T00:56:47.515Z] variation: NoOptions [2026-02-05T00:56:47.515Z] JVM_OPTIONS: [2026-02-05T00:56:47.515Z] { \ [2026-02-05T00:56:47.515Z] echo ""; echo "TEST SETUP:"; \ [2026-02-05T00:56:47.515Z] echo "Nothing to be done for setup."; \ [2026-02-05T00:56:47.515Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17702469811197/renaissance-philosophers_0"; \ [2026-02-05T00:56:47.515Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17702469811197/renaissance-philosophers_0"; \ [2026-02-05T00:56:47.515Z] echo ""; echo "TESTING:"; \ [2026-02-05T00:56:47.515Z] "/Users/admin/workspace/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17702469811197/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-05T00:56:47.515Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17702469811197/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-05T00:56:47.515Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-05T00:56:47.515Z] echo "Nothing to be done for teardown."; \ [2026-02-05T00:56:47.515Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17702469811197/TestTargetResult"; [2026-02-05T00:56:47.515Z] [2026-02-05T00:56:47.515Z] TEST SETUP: [2026-02-05T00:56:47.515Z] Nothing to be done for setup. [2026-02-05T00:56:47.515Z] [2026-02-05T00:56:47.515Z] TESTING: [2026-02-05T00:56:50.598Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-05T00:56:50.598Z] GC before operation: completed in 79.484 ms, heap usage 8.358 MB -> 4.496 MB. [2026-02-05T00:56:58.753Z] Camera thread performed 122 scans. [2026-02-05T00:56:58.753Z] ====== philosophers (scala) [default], iteration 0 completed (7725.897 ms) ====== [2026-02-05T00:56:58.753Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-05T00:56:58.753Z] GC before operation: completed in 133.171 ms, heap usage 75.772 MB -> 4.867 MB. [2026-02-05T00:57:02.804Z] Camera thread performed 122 scans. [2026-02-05T00:57:02.804Z] ====== philosophers (scala) [default], iteration 1 completed (3678.853 ms) ====== [2026-02-05T00:57:02.804Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-05T00:57:02.804Z] GC before operation: completed in 79.971 ms, heap usage 100.992 MB -> 4.905 MB. [2026-02-05T00:57:05.909Z] Camera thread performed 122 scans. [2026-02-05T00:57:05.909Z] ====== philosophers (scala) [default], iteration 2 completed (3172.080 ms) ====== [2026-02-05T00:57:05.909Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-05T00:57:05.909Z] GC before operation: completed in 89.717 ms, heap usage 9.718 MB -> 4.870 MB. [2026-02-05T00:57:08.404Z] Camera thread performed 122 scans. [2026-02-05T00:57:08.404Z] ====== philosophers (scala) [default], iteration 3 completed (3059.488 ms) ====== [2026-02-05T00:57:08.404Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-05T00:57:08.857Z] GC before operation: completed in 38.818 ms, heap usage 44.950 MB -> 4.870 MB. [2026-02-05T00:57:11.238Z] Camera thread performed 122 scans. [2026-02-05T00:57:11.238Z] ====== philosophers (scala) [default], iteration 4 completed (2687.281 ms) ====== [2026-02-05T00:57:11.238Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-05T00:57:11.238Z] GC before operation: completed in 48.972 ms, heap usage 62.960 MB -> 4.872 MB. [2026-02-05T00:57:14.445Z] Camera thread performed 122 scans. [2026-02-05T00:57:14.445Z] ====== philosophers (scala) [default], iteration 5 completed (3006.419 ms) ====== [2026-02-05T00:57:14.445Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-05T00:57:14.445Z] GC before operation: completed in 86.385 ms, heap usage 148.101 MB -> 4.875 MB. [2026-02-05T00:57:17.740Z] Camera thread performed 122 scans. [2026-02-05T00:57:17.740Z] ====== philosophers (scala) [default], iteration 6 completed (3404.838 ms) ====== [2026-02-05T00:57:17.740Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-05T00:57:17.740Z] GC before operation: completed in 13.738 ms, heap usage 59.291 MB -> 4.912 MB. [2026-02-05T00:57:20.974Z] Camera thread performed 122 scans. [2026-02-05T00:57:20.974Z] ====== philosophers (scala) [default], iteration 7 completed (3084.028 ms) ====== [2026-02-05T00:57:20.974Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-05T00:57:20.974Z] GC before operation: completed in 149.301 ms, heap usage 49.999 MB -> 4.876 MB. [2026-02-05T00:57:23.965Z] Camera thread performed 122 scans. [2026-02-05T00:57:23.965Z] ====== philosophers (scala) [default], iteration 8 completed (2726.799 ms) ====== [2026-02-05T00:57:23.965Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-05T00:57:23.965Z] GC before operation: completed in 55.688 ms, heap usage 42.211 MB -> 4.877 MB. [2026-02-05T00:57:26.220Z] Camera thread performed 122 scans. [2026-02-05T00:57:26.220Z] ====== philosophers (scala) [default], iteration 9 completed (2420.344 ms) ====== [2026-02-05T00:57:26.220Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-05T00:57:26.650Z] GC before operation: completed in 89.055 ms, heap usage 145.613 MB -> 4.912 MB. [2026-02-05T00:57:29.103Z] Camera thread performed 122 scans. [2026-02-05T00:57:29.103Z] ====== philosophers (scala) [default], iteration 10 completed (2752.180 ms) ====== [2026-02-05T00:57:29.103Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-05T00:57:29.103Z] GC before operation: completed in 56.136 ms, heap usage 51.552 MB -> 4.877 MB. [2026-02-05T00:57:32.296Z] Camera thread performed 122 scans. [2026-02-05T00:57:32.296Z] ====== philosophers (scala) [default], iteration 11 completed (2585.657 ms) ====== [2026-02-05T00:57:32.296Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-05T00:57:32.296Z] GC before operation: completed in 45.619 ms, heap usage 36.909 MB -> 4.878 MB. [2026-02-05T00:57:35.722Z] Camera thread performed 122 scans. [2026-02-05T00:57:35.722Z] ====== philosophers (scala) [default], iteration 12 completed (3898.598 ms) ====== [2026-02-05T00:57:35.722Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-05T00:57:35.722Z] GC before operation: completed in 61.003 ms, heap usage 7.427 MB -> 4.878 MB. [2026-02-05T00:57:38.107Z] Camera thread performed 122 scans. [2026-02-05T00:57:38.107Z] ====== philosophers (scala) [default], iteration 13 completed (2420.007 ms) ====== [2026-02-05T00:57:38.107Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-05T00:57:38.520Z] GC before operation: completed in 68.519 ms, heap usage 210.701 MB -> 4.914 MB. [2026-02-05T00:57:42.589Z] Camera thread performed 122 scans. [2026-02-05T00:57:42.589Z] ====== philosophers (scala) [default], iteration 14 completed (3683.934 ms) ====== [2026-02-05T00:57:42.589Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-05T00:57:42.589Z] GC before operation: completed in 68.618 ms, heap usage 156.053 MB -> 4.878 MB. [2026-02-05T00:57:45.181Z] Camera thread performed 122 scans. [2026-02-05T00:57:45.181Z] ====== philosophers (scala) [default], iteration 15 completed (2811.318 ms) ====== [2026-02-05T00:57:45.181Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-05T00:57:45.181Z] GC before operation: completed in 51.690 ms, heap usage 41.982 MB -> 4.878 MB. [2026-02-05T00:57:49.111Z] Camera thread performed 122 scans. [2026-02-05T00:57:49.111Z] ====== philosophers (scala) [default], iteration 16 completed (3916.629 ms) ====== [2026-02-05T00:57:49.111Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-05T00:57:49.111Z] GC before operation: completed in 43.771 ms, heap usage 154.684 MB -> 4.914 MB. [2026-02-05T00:57:51.570Z] Camera thread performed 122 scans. [2026-02-05T00:57:51.570Z] ====== philosophers (scala) [default], iteration 17 completed (2836.073 ms) ====== [2026-02-05T00:57:51.570Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-05T00:57:52.013Z] GC before operation: completed in 39.041 ms, heap usage 34.217 MB -> 4.878 MB. [2026-02-05T00:57:54.517Z] Camera thread performed 122 scans. [2026-02-05T00:57:54.517Z] ====== philosophers (scala) [default], iteration 18 completed (2509.909 ms) ====== [2026-02-05T00:57:54.517Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-05T00:57:54.517Z] GC before operation: completed in 119.627 ms, heap usage 183.431 MB -> 4.879 MB. [2026-02-05T00:57:57.638Z] Camera thread performed 122 scans. [2026-02-05T00:57:57.638Z] ====== philosophers (scala) [default], iteration 19 completed (2800.630 ms) ====== [2026-02-05T00:57:57.638Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-05T00:57:57.638Z] GC before operation: completed in 55.525 ms, heap usage 40.669 MB -> 4.914 MB. [2026-02-05T00:57:59.822Z] Camera thread performed 122 scans. [2026-02-05T00:57:59.823Z] ====== philosophers (scala) [default], iteration 20 completed (2520.888 ms) ====== [2026-02-05T00:57:59.823Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-05T00:57:59.823Z] GC before operation: completed in 99.720 ms, heap usage 42.875 MB -> 4.914 MB. [2026-02-05T00:58:03.077Z] Camera thread performed 122 scans. [2026-02-05T00:58:03.077Z] ====== philosophers (scala) [default], iteration 21 completed (3307.949 ms) ====== [2026-02-05T00:58:03.077Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-05T00:58:03.077Z] GC before operation: completed in 58.170 ms, heap usage 58.128 MB -> 4.879 MB. [2026-02-05T00:58:07.396Z] Camera thread performed 122 scans. [2026-02-05T00:58:07.397Z] ====== philosophers (scala) [default], iteration 22 completed (3366.549 ms) ====== [2026-02-05T00:58:07.397Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-05T00:58:07.397Z] GC before operation: completed in 46.950 ms, heap usage 164.612 MB -> 4.879 MB. [2026-02-05T00:58:09.778Z] Camera thread performed 122 scans. [2026-02-05T00:58:09.778Z] ====== philosophers (scala) [default], iteration 23 completed (3204.903 ms) ====== [2026-02-05T00:58:09.778Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-05T00:58:09.778Z] GC before operation: completed in 82.186 ms, heap usage 70.920 MB -> 4.879 MB. [2026-02-05T00:58:14.132Z] Camera thread performed 122 scans. [2026-02-05T00:58:14.132Z] ====== philosophers (scala) [default], iteration 24 completed (4309.881 ms) ====== [2026-02-05T00:58:14.132Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-05T00:58:14.610Z] GC before operation: completed in 161.441 ms, heap usage 15.452 MB -> 4.879 MB. [2026-02-05T00:58:17.781Z] Camera thread performed 122 scans. [2026-02-05T00:58:17.781Z] ====== philosophers (scala) [default], iteration 25 completed (2982.823 ms) ====== [2026-02-05T00:58:17.781Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-05T00:58:17.781Z] GC before operation: completed in 89.870 ms, heap usage 176.912 MB -> 4.915 MB. [2026-02-05T00:58:20.709Z] Camera thread performed 122 scans. [2026-02-05T00:58:20.709Z] ====== philosophers (scala) [default], iteration 26 completed (2828.388 ms) ====== [2026-02-05T00:58:20.709Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-05T00:58:20.709Z] GC before operation: completed in 65.950 ms, heap usage 134.587 MB -> 4.915 MB. [2026-02-05T00:58:23.915Z] Camera thread performed 122 scans. [2026-02-05T00:58:23.915Z] ====== philosophers (scala) [default], iteration 27 completed (3062.728 ms) ====== [2026-02-05T00:58:23.915Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-05T00:58:23.915Z] GC before operation: completed in 60.042 ms, heap usage 64.960 MB -> 4.879 MB. [2026-02-05T00:58:27.833Z] Camera thread performed 122 scans. [2026-02-05T00:58:27.833Z] ====== philosophers (scala) [default], iteration 28 completed (3767.648 ms) ====== [2026-02-05T00:58:27.833Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-05T00:58:27.833Z] GC before operation: completed in 79.236 ms, heap usage 153.029 MB -> 4.879 MB. [2026-02-05T00:58:31.963Z] Camera thread performed 122 scans. [2026-02-05T00:58:31.963Z] ====== philosophers (scala) [default], iteration 29 completed (4251.000 ms) ====== [2026-02-05T00:58:32.455Z] ----------------------------------- [2026-02-05T00:58:32.455Z] renaissance-philosophers_0_PASSED [2026-02-05T00:58:32.455Z] ----------------------------------- [2026-02-05T00:58:32.455Z] [2026-02-05T00:58:32.455Z] TEST TEARDOWN: [2026-02-05T00:58:32.455Z] Nothing to be done for teardown. [2026-02-05T00:58:32.455Z] renaissance-philosophers_0 Finish Time: Wed Feb 4 19:58:32 2026 Epoch Time (ms): 1770253112087