[2025-11-28T05:42:35.244Z] Running test renaissance-philosophers_0 ... [2025-11-28T05:42:35.244Z] =============================================== [2025-11-28T05:42:35.244Z] renaissance-philosophers_0 Start Time: Fri Nov 28 05:42:35 2025 Epoch Time (ms): 1764308555183 [2025-11-28T05:42:35.244Z] variation: NoOptions [2025-11-28T05:42:35.244Z] JVM_OPTIONS: [2025-11-28T05:42:35.244Z] { \ [2025-11-28T05:42:35.244Z] echo ""; echo "TEST SETUP:"; \ [2025-11-28T05:42:35.244Z] echo "Nothing to be done for setup."; \ [2025-11-28T05:42:35.244Z] mkdir -p "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-philosophers_0"; \ [2025-11-28T05:42:35.244Z] cd "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-philosophers_0"; \ [2025-11-28T05:42:35.244Z] echo ""; echo "TESTING:"; \ [2025-11-28T05:42:35.244Z] "/Users/jenkins/workspace/Test_openjdk17_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/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-11-28T05:42:35.244Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/..; rm -f -r "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-28T05:42:35.244Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-28T05:42:35.244Z] echo "Nothing to be done for teardown."; \ [2025-11-28T05:42:35.244Z] } 2>&1 | tee -a "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/TestTargetResult"; [2025-11-28T05:42:35.244Z] [2025-11-28T05:42:35.244Z] TEST SETUP: [2025-11-28T05:42:35.244Z] Nothing to be done for setup. [2025-11-28T05:42:35.244Z] [2025-11-28T05:42:35.244Z] TESTING: [2025-11-28T05:42:36.466Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-11-28T05:42:36.466Z] GC before operation: completed in 11.520 ms, heap usage 7.549 MB -> 4.459 MB. [2025-11-28T05:42:42.601Z] Camera thread performed 122 scans. [2025-11-28T05:42:42.601Z] ====== philosophers (scala) [default], iteration 0 completed (5334.700 ms) ====== [2025-11-28T05:42:42.601Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-11-28T05:42:42.601Z] GC before operation: completed in 10.517 ms, heap usage 38.870 MB -> 4.880 MB. [2025-11-28T05:42:43.358Z] Camera thread performed 122 scans. [2025-11-28T05:42:43.358Z] ====== philosophers (scala) [default], iteration 1 completed (1615.093 ms) ====== [2025-11-28T05:42:43.358Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-11-28T05:42:43.358Z] GC before operation: completed in 10.190 ms, heap usage 15.241 MB -> 4.883 MB. [2025-11-28T05:42:45.115Z] Camera thread performed 122 scans. [2025-11-28T05:42:45.115Z] ====== philosophers (scala) [default], iteration 2 completed (1691.534 ms) ====== [2025-11-28T05:42:45.115Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-11-28T05:42:45.115Z] GC before operation: completed in 9.407 ms, heap usage 7.949 MB -> 4.884 MB. [2025-11-28T05:42:46.873Z] Camera thread performed 122 scans. [2025-11-28T05:42:46.873Z] ====== philosophers (scala) [default], iteration 3 completed (1679.787 ms) ====== [2025-11-28T05:42:46.873Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-11-28T05:42:46.873Z] GC before operation: completed in 9.709 ms, heap usage 36.146 MB -> 4.887 MB. [2025-11-28T05:42:48.627Z] Camera thread performed 122 scans. [2025-11-28T05:42:48.627Z] ====== philosophers (scala) [default], iteration 4 completed (1697.363 ms) ====== [2025-11-28T05:42:48.627Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-11-28T05:42:48.627Z] GC before operation: completed in 9.347 ms, heap usage 22.694 MB -> 4.888 MB. [2025-11-28T05:42:50.384Z] Camera thread performed 122 scans. [2025-11-28T05:42:50.384Z] ====== philosophers (scala) [default], iteration 5 completed (1660.933 ms) ====== [2025-11-28T05:42:50.384Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-11-28T05:42:50.384Z] GC before operation: completed in 9.326 ms, heap usage 83.238 MB -> 4.890 MB. [2025-11-28T05:42:52.143Z] Camera thread performed 122 scans. [2025-11-28T05:42:52.143Z] ====== philosophers (scala) [default], iteration 6 completed (1655.235 ms) ====== [2025-11-28T05:42:52.143Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-11-28T05:42:52.143Z] GC before operation: completed in 10.370 ms, heap usage 9.936 MB -> 4.891 MB. [2025-11-28T05:42:53.367Z] Camera thread performed 122 scans. [2025-11-28T05:42:53.367Z] ====== philosophers (scala) [default], iteration 7 completed (1647.063 ms) ====== [2025-11-28T05:42:53.367Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-11-28T05:42:53.367Z] GC before operation: completed in 11.058 ms, heap usage 33.562 MB -> 4.892 MB. [2025-11-28T05:42:55.126Z] Camera thread performed 122 scans. [2025-11-28T05:42:55.126Z] ====== philosophers (scala) [default], iteration 8 completed (1716.345 ms) ====== [2025-11-28T05:42:55.126Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-11-28T05:42:55.126Z] GC before operation: completed in 9.895 ms, heap usage 20.200 MB -> 4.892 MB. [2025-11-28T05:42:56.889Z] Camera thread performed 122 scans. [2025-11-28T05:42:56.889Z] ====== philosophers (scala) [default], iteration 9 completed (1683.419 ms) ====== [2025-11-28T05:42:56.889Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-11-28T05:42:56.889Z] GC before operation: completed in 9.475 ms, heap usage 87.723 MB -> 4.891 MB. [2025-11-28T05:42:58.648Z] Camera thread performed 122 scans. [2025-11-28T05:42:58.648Z] ====== philosophers (scala) [default], iteration 10 completed (1649.591 ms) ====== [2025-11-28T05:42:58.648Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-11-28T05:42:58.648Z] GC before operation: completed in 9.529 ms, heap usage 20.570 MB -> 4.892 MB. [2025-11-28T05:43:00.405Z] Camera thread performed 122 scans. [2025-11-28T05:43:00.405Z] ====== philosophers (scala) [default], iteration 11 completed (1737.911 ms) ====== [2025-11-28T05:43:00.405Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-11-28T05:43:00.405Z] GC before operation: completed in 10.395 ms, heap usage 9.154 MB -> 4.892 MB. [2025-11-28T05:43:02.157Z] Camera thread performed 122 scans. [2025-11-28T05:43:02.157Z] ====== philosophers (scala) [default], iteration 12 completed (1715.352 ms) ====== [2025-11-28T05:43:02.157Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-11-28T05:43:02.157Z] GC before operation: completed in 10.247 ms, heap usage 67.140 MB -> 4.892 MB. [2025-11-28T05:43:03.910Z] Camera thread performed 122 scans. [2025-11-28T05:43:03.910Z] ====== philosophers (scala) [default], iteration 13 completed (1711.367 ms) ====== [2025-11-28T05:43:03.910Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-11-28T05:43:03.910Z] GC before operation: completed in 9.485 ms, heap usage 70.362 MB -> 4.892 MB. [2025-11-28T05:43:05.671Z] Camera thread performed 122 scans. [2025-11-28T05:43:05.671Z] ====== philosophers (scala) [default], iteration 14 completed (1741.558 ms) ====== [2025-11-28T05:43:05.671Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-11-28T05:43:05.671Z] GC before operation: completed in 10.070 ms, heap usage 85.712 MB -> 4.893 MB. [2025-11-28T05:43:07.429Z] Camera thread performed 122 scans. [2025-11-28T05:43:07.429Z] ====== philosophers (scala) [default], iteration 15 completed (1718.853 ms) ====== [2025-11-28T05:43:07.429Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-11-28T05:43:07.429Z] GC before operation: completed in 9.647 ms, heap usage 75.289 MB -> 4.892 MB. [2025-11-28T05:43:09.184Z] Camera thread performed 122 scans. [2025-11-28T05:43:09.184Z] ====== philosophers (scala) [default], iteration 16 completed (1717.684 ms) ====== [2025-11-28T05:43:09.184Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-11-28T05:43:09.184Z] GC before operation: completed in 9.335 ms, heap usage 89.240 MB -> 4.893 MB. [2025-11-28T05:43:10.940Z] Camera thread performed 122 scans. [2025-11-28T05:43:10.940Z] ====== philosophers (scala) [default], iteration 17 completed (1692.525 ms) ====== [2025-11-28T05:43:10.940Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-11-28T05:43:10.940Z] GC before operation: completed in 10.468 ms, heap usage 49.704 MB -> 4.893 MB. [2025-11-28T05:43:12.478Z] Camera thread performed 122 scans. [2025-11-28T05:43:12.478Z] ====== philosophers (scala) [default], iteration 18 completed (1716.972 ms) ====== [2025-11-28T05:43:12.478Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-11-28T05:43:12.478Z] GC before operation: completed in 9.177 ms, heap usage 9.567 MB -> 4.893 MB. [2025-11-28T05:43:14.237Z] Camera thread performed 122 scans. [2025-11-28T05:43:14.237Z] ====== philosophers (scala) [default], iteration 19 completed (1640.187 ms) ====== [2025-11-28T05:43:14.237Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-11-28T05:43:14.237Z] GC before operation: completed in 9.758 ms, heap usage 21.552 MB -> 4.893 MB. [2025-11-28T05:43:16.003Z] Camera thread performed 122 scans. [2025-11-28T05:43:16.003Z] ====== philosophers (scala) [default], iteration 20 completed (1669.939 ms) ====== [2025-11-28T05:43:16.003Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-11-28T05:43:16.003Z] GC before operation: completed in 9.603 ms, heap usage 86.966 MB -> 4.893 MB. [2025-11-28T05:43:17.759Z] Camera thread performed 122 scans. [2025-11-28T05:43:17.759Z] ====== philosophers (scala) [default], iteration 21 completed (1726.425 ms) ====== [2025-11-28T05:43:17.759Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-11-28T05:43:17.759Z] GC before operation: completed in 10.868 ms, heap usage 20.569 MB -> 4.893 MB. [2025-11-28T05:43:18.979Z] Camera thread performed 122 scans. [2025-11-28T05:43:18.979Z] ====== philosophers (scala) [default], iteration 22 completed (1673.745 ms) ====== [2025-11-28T05:43:18.979Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-11-28T05:43:18.979Z] GC before operation: completed in 11.841 ms, heap usage 28.697 MB -> 4.894 MB. [2025-11-28T05:43:20.736Z] Camera thread performed 122 scans. [2025-11-28T05:43:20.736Z] ====== philosophers (scala) [default], iteration 23 completed (1721.246 ms) ====== [2025-11-28T05:43:20.736Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-11-28T05:43:20.736Z] GC before operation: completed in 9.483 ms, heap usage 28.158 MB -> 4.893 MB. [2025-11-28T05:43:22.491Z] Camera thread performed 122 scans. [2025-11-28T05:43:22.491Z] ====== philosophers (scala) [default], iteration 24 completed (1663.585 ms) ====== [2025-11-28T05:43:22.491Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-11-28T05:43:22.491Z] GC before operation: completed in 11.554 ms, heap usage 58.385 MB -> 4.893 MB. [2025-11-28T05:43:24.251Z] Camera thread performed 122 scans. [2025-11-28T05:43:24.251Z] ====== philosophers (scala) [default], iteration 25 completed (1765.547 ms) ====== [2025-11-28T05:43:24.251Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-11-28T05:43:24.251Z] GC before operation: completed in 10.733 ms, heap usage 80.113 MB -> 4.893 MB. [2025-11-28T05:43:26.010Z] Camera thread performed 122 scans. [2025-11-28T05:43:26.010Z] ====== philosophers (scala) [default], iteration 26 completed (1660.751 ms) ====== [2025-11-28T05:43:26.010Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-11-28T05:43:26.010Z] GC before operation: completed in 10.882 ms, heap usage 61.258 MB -> 4.893 MB. [2025-11-28T05:43:27.771Z] Camera thread performed 122 scans. [2025-11-28T05:43:27.771Z] ====== philosophers (scala) [default], iteration 27 completed (1712.135 ms) ====== [2025-11-28T05:43:27.771Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-11-28T05:43:27.771Z] GC before operation: completed in 10.359 ms, heap usage 16.490 MB -> 4.894 MB. [2025-11-28T05:43:29.528Z] Camera thread performed 122 scans. [2025-11-28T05:43:29.528Z] ====== philosophers (scala) [default], iteration 28 completed (1599.311 ms) ====== [2025-11-28T05:43:29.528Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-11-28T05:43:29.528Z] GC before operation: completed in 9.870 ms, heap usage 34.677 MB -> 4.894 MB. [2025-11-28T05:43:31.289Z] Camera thread performed 122 scans. [2025-11-28T05:43:31.289Z] ====== philosophers (scala) [default], iteration 29 completed (1614.879 ms) ====== [2025-11-28T05:43:31.289Z] ----------------------------------- [2025-11-28T05:43:31.289Z] renaissance-philosophers_0_PASSED [2025-11-28T05:43:31.289Z] ----------------------------------- [2025-11-28T05:43:31.289Z] [2025-11-28T05:43:31.289Z] TEST TEARDOWN: [2025-11-28T05:43:31.289Z] Nothing to be done for teardown. [2025-11-28T05:43:31.289Z] renaissance-philosophers_0 Finish Time: Fri Nov 28 05:43:31 2025 Epoch Time (ms): 1764308611036