[2026-01-18T15:44:25.160Z] Running test renaissance-philosophers_0 ... [2026-01-18T15:44:25.160Z] =============================================== [2026-01-18T15:44:25.160Z] renaissance-philosophers_0 Start Time: Sun Jan 18 10:44:23 2026 Epoch Time (ms): 1768751063355 [2026-01-18T15:44:25.160Z] variation: NoOptions [2026-01-18T15:44:25.160Z] JVM_OPTIONS: [2026-01-18T15:44:25.160Z] { \ [2026-01-18T15:44:25.160Z] echo ""; echo "TEST SETUP:"; \ [2026-01-18T15:44:25.160Z] echo "Nothing to be done for setup."; \ [2026-01-18T15:44:25.160Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_1768745760253/renaissance-philosophers_0"; \ [2026-01-18T15:44:25.160Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_1768745760253/renaissance-philosophers_0"; \ [2026-01-18T15:44:25.160Z] echo ""; echo "TESTING:"; \ [2026-01-18T15:44:25.160Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/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_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_1768745760253/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-18T15:44:25.160Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_1768745760253/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-18T15:44:25.160Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-18T15:44:25.160Z] echo "Nothing to be done for teardown."; \ [2026-01-18T15:44:25.160Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_1768745760253/TestTargetResult"; [2026-01-18T15:44:25.160Z] [2026-01-18T15:44:25.160Z] TEST SETUP: [2026-01-18T15:44:25.160Z] Nothing to be done for setup. [2026-01-18T15:44:25.160Z] [2026-01-18T15:44:25.160Z] TESTING: [2026-01-18T15:44:26.771Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-18T15:44:26.771Z] GC before operation: completed in 51.118 ms, heap usage 14.816 MB -> 4.420 MB. [2026-01-18T15:44:34.353Z] Camera thread performed 122 scans. [2026-01-18T15:44:34.353Z] ====== philosophers (scala) [default], iteration 0 completed (7917.453 ms) ====== [2026-01-18T15:44:34.353Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-18T15:44:34.862Z] GC before operation: completed in 60.531 ms, heap usage 94.763 MB -> 4.831 MB. [2026-01-18T15:44:37.080Z] Camera thread performed 122 scans. [2026-01-18T15:44:37.080Z] ====== philosophers (scala) [default], iteration 1 completed (2411.627 ms) ====== [2026-01-18T15:44:37.080Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-18T15:44:37.080Z] GC before operation: completed in 40.232 ms, heap usage 41.485 MB -> 4.830 MB. [2026-01-18T15:44:39.186Z] Camera thread performed 122 scans. [2026-01-18T15:44:39.186Z] ====== philosophers (scala) [default], iteration 2 completed (2060.137 ms) ====== [2026-01-18T15:44:39.186Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-18T15:44:39.186Z] GC before operation: completed in 105.505 ms, heap usage 49.506 MB -> 4.835 MB. [2026-01-18T15:44:41.310Z] Camera thread performed 122 scans. [2026-01-18T15:44:41.310Z] ====== philosophers (scala) [default], iteration 3 completed (2140.047 ms) ====== [2026-01-18T15:44:41.310Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-18T15:44:41.310Z] GC before operation: completed in 68.196 ms, heap usage 38.413 MB -> 4.835 MB. [2026-01-18T15:44:45.079Z] Camera thread performed 122 scans. [2026-01-18T15:44:45.079Z] ====== philosophers (scala) [default], iteration 4 completed (3119.091 ms) ====== [2026-01-18T15:44:45.079Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-18T15:44:45.079Z] GC before operation: completed in 65.648 ms, heap usage 145.447 MB -> 4.836 MB. [2026-01-18T15:44:47.237Z] Camera thread performed 122 scans. [2026-01-18T15:44:47.237Z] ====== philosophers (scala) [default], iteration 5 completed (2245.922 ms) ====== [2026-01-18T15:44:47.237Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-18T15:44:47.237Z] GC before operation: completed in 58.496 ms, heap usage 146.648 MB -> 4.836 MB. [2026-01-18T15:44:49.432Z] Camera thread performed 122 scans. [2026-01-18T15:44:49.432Z] ====== philosophers (scala) [default], iteration 6 completed (2241.286 ms) ====== [2026-01-18T15:44:49.432Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-18T15:44:49.432Z] GC before operation: completed in 46.451 ms, heap usage 123.518 MB -> 4.837 MB. [2026-01-18T15:44:52.360Z] Camera thread performed 122 scans. [2026-01-18T15:44:52.360Z] ====== philosophers (scala) [default], iteration 7 completed (2718.505 ms) ====== [2026-01-18T15:44:52.360Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-18T15:44:52.360Z] GC before operation: completed in 49.147 ms, heap usage 188.056 MB -> 4.837 MB. [2026-01-18T15:44:53.285Z] Camera thread performed 122 scans. [2026-01-18T15:44:53.285Z] ====== philosophers (scala) [default], iteration 8 completed (1521.469 ms) ====== [2026-01-18T15:44:53.285Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-18T15:44:53.797Z] GC before operation: completed in 33.757 ms, heap usage 96.775 MB -> 4.837 MB. [2026-01-18T15:44:55.931Z] Camera thread performed 122 scans. [2026-01-18T15:44:55.931Z] ====== philosophers (scala) [default], iteration 9 completed (2045.498 ms) ====== [2026-01-18T15:44:55.931Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-18T15:44:55.931Z] GC before operation: completed in 34.651 ms, heap usage 41.969 MB -> 4.837 MB. [2026-01-18T15:44:58.112Z] Camera thread performed 122 scans. [2026-01-18T15:44:58.112Z] ====== philosophers (scala) [default], iteration 10 completed (2153.818 ms) ====== [2026-01-18T15:44:58.112Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-18T15:44:58.112Z] GC before operation: completed in 138.516 ms, heap usage 60.512 MB -> 4.838 MB. [2026-01-18T15:45:00.471Z] Camera thread performed 122 scans. [2026-01-18T15:45:00.471Z] ====== philosophers (scala) [default], iteration 11 completed (2441.118 ms) ====== [2026-01-18T15:45:00.471Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-18T15:45:00.471Z] GC before operation: completed in 29.684 ms, heap usage 12.442 MB -> 4.839 MB. [2026-01-18T15:45:02.662Z] Camera thread performed 122 scans. [2026-01-18T15:45:02.662Z] ====== philosophers (scala) [default], iteration 12 completed (2137.076 ms) ====== [2026-01-18T15:45:02.662Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-18T15:45:02.662Z] GC before operation: completed in 89.392 ms, heap usage 103.063 MB -> 4.839 MB. [2026-01-18T15:45:05.008Z] Camera thread performed 122 scans. [2026-01-18T15:45:05.008Z] ====== philosophers (scala) [default], iteration 13 completed (2324.291 ms) ====== [2026-01-18T15:45:05.008Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-18T15:45:05.008Z] GC before operation: completed in 85.490 ms, heap usage 65.471 MB -> 4.840 MB. [2026-01-18T15:45:07.329Z] Camera thread performed 122 scans. [2026-01-18T15:45:07.329Z] ====== philosophers (scala) [default], iteration 14 completed (2372.350 ms) ====== [2026-01-18T15:45:07.329Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-18T15:45:07.329Z] GC before operation: completed in 85.234 ms, heap usage 148.547 MB -> 4.840 MB. [2026-01-18T15:45:09.458Z] Camera thread performed 122 scans. [2026-01-18T15:45:09.458Z] ====== philosophers (scala) [default], iteration 15 completed (2133.316 ms) ====== [2026-01-18T15:45:09.458Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-18T15:45:09.928Z] GC before operation: completed in 101.983 ms, heap usage 72.548 MB -> 4.840 MB. [2026-01-18T15:45:12.027Z] Camera thread performed 122 scans. [2026-01-18T15:45:12.027Z] ====== philosophers (scala) [default], iteration 16 completed (2536.912 ms) ====== [2026-01-18T15:45:12.027Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-18T15:45:12.469Z] GC before operation: completed in 80.779 ms, heap usage 133.038 MB -> 4.841 MB. [2026-01-18T15:45:14.680Z] Camera thread performed 122 scans. [2026-01-18T15:45:14.680Z] ====== philosophers (scala) [default], iteration 17 completed (2252.578 ms) ====== [2026-01-18T15:45:14.680Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-18T15:45:14.680Z] GC before operation: completed in 89.910 ms, heap usage 32.999 MB -> 4.841 MB. [2026-01-18T15:45:16.940Z] Camera thread performed 122 scans. [2026-01-18T15:45:16.940Z] ====== philosophers (scala) [default], iteration 18 completed (2377.327 ms) ====== [2026-01-18T15:45:16.940Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-18T15:45:16.940Z] GC before operation: completed in 61.708 ms, heap usage 162.552 MB -> 4.841 MB. [2026-01-18T15:45:19.225Z] Camera thread performed 122 scans. [2026-01-18T15:45:19.225Z] ====== philosophers (scala) [default], iteration 19 completed (2064.827 ms) ====== [2026-01-18T15:45:19.225Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-18T15:45:19.225Z] GC before operation: completed in 86.296 ms, heap usage 179.033 MB -> 4.841 MB. [2026-01-18T15:45:21.473Z] Camera thread performed 122 scans. [2026-01-18T15:45:21.473Z] ====== philosophers (scala) [default], iteration 20 completed (2297.988 ms) ====== [2026-01-18T15:45:21.473Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-18T15:45:21.947Z] GC before operation: completed in 167.351 ms, heap usage 7.984 MB -> 4.841 MB. [2026-01-18T15:45:24.209Z] Camera thread performed 122 scans. [2026-01-18T15:45:24.209Z] ====== philosophers (scala) [default], iteration 21 completed (2094.023 ms) ====== [2026-01-18T15:45:24.209Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-18T15:45:24.209Z] GC before operation: completed in 29.776 ms, heap usage 49.500 MB -> 4.842 MB. [2026-01-18T15:45:26.398Z] Camera thread performed 122 scans. [2026-01-18T15:45:26.398Z] ====== philosophers (scala) [default], iteration 22 completed (2532.032 ms) ====== [2026-01-18T15:45:26.398Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-18T15:45:26.398Z] GC before operation: completed in 100.428 ms, heap usage 93.499 MB -> 4.842 MB. [2026-01-18T15:45:28.549Z] Camera thread performed 122 scans. [2026-01-18T15:45:28.549Z] ====== philosophers (scala) [default], iteration 23 completed (2300.390 ms) ====== [2026-01-18T15:45:28.549Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-18T15:45:28.968Z] GC before operation: completed in 73.245 ms, heap usage 24.001 MB -> 4.842 MB. [2026-01-18T15:45:31.187Z] Camera thread performed 122 scans. [2026-01-18T15:45:31.187Z] ====== philosophers (scala) [default], iteration 24 completed (2525.042 ms) ====== [2026-01-18T15:45:31.187Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-18T15:45:31.663Z] GC before operation: completed in 98.788 ms, heap usage 47.570 MB -> 4.842 MB. [2026-01-18T15:45:33.875Z] Camera thread performed 122 scans. [2026-01-18T15:45:33.875Z] ====== philosophers (scala) [default], iteration 25 completed (2346.569 ms) ====== [2026-01-18T15:45:33.875Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-18T15:45:33.875Z] GC before operation: completed in 59.047 ms, heap usage 82.501 MB -> 4.842 MB. [2026-01-18T15:45:36.082Z] Camera thread performed 122 scans. [2026-01-18T15:45:36.082Z] ====== philosophers (scala) [default], iteration 26 completed (2340.840 ms) ====== [2026-01-18T15:45:36.082Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-18T15:45:36.082Z] GC before operation: completed in 21.895 ms, heap usage 75.517 MB -> 4.842 MB. [2026-01-18T15:45:38.955Z] Camera thread performed 122 scans. [2026-01-18T15:45:38.955Z] ====== philosophers (scala) [default], iteration 27 completed (2243.894 ms) ====== [2026-01-18T15:45:38.955Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-18T15:45:38.955Z] GC before operation: completed in 37.351 ms, heap usage 27.359 MB -> 4.842 MB. [2026-01-18T15:45:40.511Z] Camera thread performed 122 scans. [2026-01-18T15:45:40.512Z] ====== philosophers (scala) [default], iteration 28 completed (1995.778 ms) ====== [2026-01-18T15:45:40.512Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-18T15:45:40.512Z] GC before operation: completed in 92.985 ms, heap usage 110.539 MB -> 4.879 MB. [2026-01-18T15:45:42.786Z] Camera thread performed 122 scans. [2026-01-18T15:45:42.786Z] ====== philosophers (scala) [default], iteration 29 completed (2364.340 ms) ====== [2026-01-18T15:45:43.691Z] ----------------------------------- [2026-01-18T15:45:43.691Z] renaissance-philosophers_0_PASSED [2026-01-18T15:45:43.691Z] ----------------------------------- [2026-01-18T15:45:43.691Z] [2026-01-18T15:45:43.691Z] TEST TEARDOWN: [2026-01-18T15:45:43.691Z] Nothing to be done for teardown. [2026-01-18T15:45:43.691Z] renaissance-philosophers_0 Finish Time: Sun Jan 18 10:45:43 2026 Epoch Time (ms): 1768751143159