[2025-11-06T03:24:23.050Z] Running test renaissance-philosophers_0 ... [2025-11-06T03:24:23.050Z] =============================================== [2025-11-06T03:24:23.050Z] renaissance-philosophers_0 Start Time: Thu Nov 6 03:24:22 2025 Epoch Time (ms): 1762399462798 [2025-11-06T03:24:23.050Z] variation: NoOptions [2025-11-06T03:24:23.050Z] JVM_OPTIONS: [2025-11-06T03:24:23.050Z] { \ [2025-11-06T03:24:23.050Z] echo ""; echo "TEST SETUP:"; \ [2025-11-06T03:24:23.050Z] echo "Nothing to be done for setup."; \ [2025-11-06T03:24:23.050Z] mkdir -p "/Users/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17623950765061/renaissance-philosophers_0"; \ [2025-11-06T03:24:23.050Z] cd "/Users/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17623950765061/renaissance-philosophers_0"; \ [2025-11-06T03:24:23.050Z] echo ""; echo "TESTING:"; \ [2025-11-06T03:24:23.050Z] "/Users/jenkins/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/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17623950765061/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-11-06T03:24:23.050Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /Users/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/..; rm -f -r "/Users/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17623950765061/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-06T03:24:23.050Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-06T03:24:23.050Z] echo "Nothing to be done for teardown."; \ [2025-11-06T03:24:23.050Z] } 2>&1 | tee -a "/Users/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17623950765061/TestTargetResult"; [2025-11-06T03:24:23.050Z] [2025-11-06T03:24:23.050Z] TEST SETUP: [2025-11-06T03:24:23.050Z] Nothing to be done for setup. [2025-11-06T03:24:23.050Z] [2025-11-06T03:24:23.050Z] TESTING: [2025-11-06T03:24:24.278Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-11-06T03:24:24.278Z] GC before operation: completed in 13.208 ms, heap usage 6.486 MB -> 4.433 MB. [2025-11-06T03:24:30.404Z] Camera thread performed 122 scans. [2025-11-06T03:24:30.404Z] ====== philosophers (scala) [default], iteration 0 completed (5818.679 ms) ====== [2025-11-06T03:24:30.404Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-11-06T03:24:30.404Z] GC before operation: completed in 19.858 ms, heap usage 73.367 MB -> 4.861 MB. [2025-11-06T03:24:32.160Z] Camera thread performed 122 scans. [2025-11-06T03:24:32.160Z] ====== philosophers (scala) [default], iteration 1 completed (1964.766 ms) ====== [2025-11-06T03:24:32.160Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-11-06T03:24:32.160Z] GC before operation: completed in 18.240 ms, heap usage 63.025 MB -> 4.865 MB. [2025-11-06T03:24:33.914Z] Camera thread performed 122 scans. [2025-11-06T03:24:33.914Z] ====== philosophers (scala) [default], iteration 2 completed (1761.595 ms) ====== [2025-11-06T03:24:33.914Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-11-06T03:24:33.914Z] GC before operation: completed in 19.917 ms, heap usage 140.222 MB -> 4.867 MB. [2025-11-06T03:24:35.668Z] Camera thread performed 122 scans. [2025-11-06T03:24:35.668Z] ====== philosophers (scala) [default], iteration 3 completed (1977.189 ms) ====== [2025-11-06T03:24:35.668Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-11-06T03:24:35.668Z] GC before operation: completed in 22.208 ms, heap usage 64.809 MB -> 4.869 MB. [2025-11-06T03:24:37.432Z] Camera thread performed 122 scans. [2025-11-06T03:24:37.432Z] ====== philosophers (scala) [default], iteration 4 completed (1830.510 ms) ====== [2025-11-06T03:24:37.432Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-11-06T03:24:37.432Z] GC before operation: completed in 22.953 ms, heap usage 45.384 MB -> 4.869 MB. [2025-11-06T03:24:39.810Z] Camera thread performed 122 scans. [2025-11-06T03:24:39.810Z] ====== philosophers (scala) [default], iteration 5 completed (1994.395 ms) ====== [2025-11-06T03:24:39.810Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-11-06T03:24:39.810Z] GC before operation: completed in 21.707 ms, heap usage 75.352 MB -> 4.869 MB. [2025-11-06T03:24:41.564Z] Camera thread performed 122 scans. [2025-11-06T03:24:41.565Z] ====== philosophers (scala) [default], iteration 6 completed (1878.338 ms) ====== [2025-11-06T03:24:41.565Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-11-06T03:24:41.565Z] GC before operation: completed in 21.923 ms, heap usage 72.045 MB -> 4.870 MB. [2025-11-06T03:24:43.321Z] Camera thread performed 122 scans. [2025-11-06T03:24:43.321Z] ====== philosophers (scala) [default], iteration 7 completed (1955.739 ms) ====== [2025-11-06T03:24:43.321Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-11-06T03:24:43.321Z] GC before operation: completed in 23.755 ms, heap usage 137.044 MB -> 4.871 MB. [2025-11-06T03:24:45.698Z] Camera thread performed 122 scans. [2025-11-06T03:24:45.698Z] ====== philosophers (scala) [default], iteration 8 completed (1910.566 ms) ====== [2025-11-06T03:24:45.698Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-11-06T03:24:45.698Z] GC before operation: completed in 22.928 ms, heap usage 80.078 MB -> 4.871 MB. [2025-11-06T03:24:47.449Z] Camera thread performed 122 scans. [2025-11-06T03:24:47.449Z] ====== philosophers (scala) [default], iteration 9 completed (1919.521 ms) ====== [2025-11-06T03:24:47.449Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-11-06T03:24:47.449Z] GC before operation: completed in 21.976 ms, heap usage 74.678 MB -> 4.871 MB. [2025-11-06T03:24:49.203Z] Camera thread performed 122 scans. [2025-11-06T03:24:49.203Z] ====== philosophers (scala) [default], iteration 10 completed (1970.640 ms) ====== [2025-11-06T03:24:49.203Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-11-06T03:24:49.203Z] GC before operation: completed in 26.478 ms, heap usage 80.280 MB -> 4.872 MB. [2025-11-06T03:24:51.579Z] Camera thread performed 122 scans. [2025-11-06T03:24:51.579Z] ====== philosophers (scala) [default], iteration 11 completed (1926.299 ms) ====== [2025-11-06T03:24:51.579Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-11-06T03:24:51.579Z] GC before operation: completed in 22.607 ms, heap usage 61.281 MB -> 4.872 MB. [2025-11-06T03:24:53.374Z] Camera thread performed 122 scans. [2025-11-06T03:24:53.374Z] ====== philosophers (scala) [default], iteration 12 completed (1785.202 ms) ====== [2025-11-06T03:24:53.374Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-11-06T03:24:53.374Z] GC before operation: completed in 23.804 ms, heap usage 94.003 MB -> 4.872 MB. [2025-11-06T03:24:55.134Z] Camera thread performed 122 scans. [2025-11-06T03:24:55.134Z] ====== philosophers (scala) [default], iteration 13 completed (1880.191 ms) ====== [2025-11-06T03:24:55.134Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-11-06T03:24:55.134Z] GC before operation: completed in 28.700 ms, heap usage 63.006 MB -> 4.872 MB. [2025-11-06T03:24:56.889Z] Camera thread performed 122 scans. [2025-11-06T03:24:56.889Z] ====== philosophers (scala) [default], iteration 14 completed (1875.893 ms) ====== [2025-11-06T03:24:56.889Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-11-06T03:24:56.889Z] GC before operation: completed in 23.489 ms, heap usage 19.684 MB -> 4.872 MB. [2025-11-06T03:24:59.264Z] Camera thread performed 122 scans. [2025-11-06T03:24:59.264Z] ====== philosophers (scala) [default], iteration 15 completed (1926.748 ms) ====== [2025-11-06T03:24:59.264Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-11-06T03:24:59.264Z] GC before operation: completed in 22.719 ms, heap usage 68.651 MB -> 4.872 MB. [2025-11-06T03:25:01.020Z] Camera thread performed 122 scans. [2025-11-06T03:25:01.020Z] ====== philosophers (scala) [default], iteration 16 completed (1948.328 ms) ====== [2025-11-06T03:25:01.020Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-11-06T03:25:01.020Z] GC before operation: completed in 23.078 ms, heap usage 22.264 MB -> 4.873 MB. [2025-11-06T03:25:02.778Z] Camera thread performed 122 scans. [2025-11-06T03:25:02.778Z] ====== philosophers (scala) [default], iteration 17 completed (2022.715 ms) ====== [2025-11-06T03:25:02.778Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-11-06T03:25:02.778Z] GC before operation: completed in 20.755 ms, heap usage 96.021 MB -> 4.873 MB. [2025-11-06T03:25:05.251Z] Camera thread performed 122 scans. [2025-11-06T03:25:05.251Z] ====== philosophers (scala) [default], iteration 18 completed (1986.582 ms) ====== [2025-11-06T03:25:05.251Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-11-06T03:25:05.251Z] GC before operation: completed in 26.015 ms, heap usage 49.109 MB -> 4.873 MB. [2025-11-06T03:25:07.004Z] Camera thread performed 122 scans. [2025-11-06T03:25:07.004Z] ====== philosophers (scala) [default], iteration 19 completed (1868.736 ms) ====== [2025-11-06T03:25:07.005Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-11-06T03:25:07.005Z] GC before operation: completed in 17.009 ms, heap usage 129.650 MB -> 4.873 MB. [2025-11-06T03:25:08.759Z] Camera thread performed 122 scans. [2025-11-06T03:25:08.759Z] ====== philosophers (scala) [default], iteration 20 completed (1935.525 ms) ====== [2025-11-06T03:25:08.759Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-11-06T03:25:08.759Z] GC before operation: completed in 30.428 ms, heap usage 98.970 MB -> 4.873 MB. [2025-11-06T03:25:10.514Z] Camera thread performed 122 scans. [2025-11-06T03:25:10.514Z] ====== philosophers (scala) [default], iteration 21 completed (1909.672 ms) ====== [2025-11-06T03:25:10.514Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-11-06T03:25:10.867Z] GC before operation: completed in 23.040 ms, heap usage 153.651 MB -> 4.873 MB. [2025-11-06T03:25:12.618Z] Camera thread performed 122 scans. [2025-11-06T03:25:12.618Z] ====== philosophers (scala) [default], iteration 22 completed (1940.031 ms) ====== [2025-11-06T03:25:12.618Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-11-06T03:25:12.619Z] GC before operation: completed in 26.954 ms, heap usage 49.042 MB -> 4.873 MB. [2025-11-06T03:25:14.997Z] Camera thread performed 122 scans. [2025-11-06T03:25:14.997Z] ====== philosophers (scala) [default], iteration 23 completed (1937.352 ms) ====== [2025-11-06T03:25:14.997Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-11-06T03:25:14.997Z] GC before operation: completed in 23.198 ms, heap usage 51.680 MB -> 4.873 MB. [2025-11-06T03:25:16.752Z] Camera thread performed 122 scans. [2025-11-06T03:25:16.752Z] ====== philosophers (scala) [default], iteration 24 completed (1998.357 ms) ====== [2025-11-06T03:25:16.752Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-11-06T03:25:16.752Z] GC before operation: completed in 21.271 ms, heap usage 47.676 MB -> 4.873 MB. [2025-11-06T03:25:18.530Z] Camera thread performed 122 scans. [2025-11-06T03:25:18.530Z] ====== philosophers (scala) [default], iteration 25 completed (1824.059 ms) ====== [2025-11-06T03:25:18.530Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-11-06T03:25:18.530Z] GC before operation: completed in 29.851 ms, heap usage 7.791 MB -> 4.873 MB. [2025-11-06T03:25:20.909Z] Camera thread performed 122 scans. [2025-11-06T03:25:20.909Z] ====== philosophers (scala) [default], iteration 26 completed (2004.320 ms) ====== [2025-11-06T03:25:20.909Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-11-06T03:25:20.909Z] GC before operation: completed in 20.682 ms, heap usage 89.663 MB -> 4.874 MB. [2025-11-06T03:25:22.671Z] Camera thread performed 122 scans. [2025-11-06T03:25:22.671Z] ====== philosophers (scala) [default], iteration 27 completed (1900.484 ms) ====== [2025-11-06T03:25:22.671Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-11-06T03:25:22.671Z] GC before operation: completed in 29.484 ms, heap usage 104.648 MB -> 4.873 MB. [2025-11-06T03:25:24.448Z] Camera thread performed 122 scans. [2025-11-06T03:25:24.448Z] ====== philosophers (scala) [default], iteration 28 completed (1823.421 ms) ====== [2025-11-06T03:25:24.448Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-11-06T03:25:24.448Z] GC before operation: completed in 20.905 ms, heap usage 133.045 MB -> 4.874 MB. [2025-11-06T03:25:26.232Z] Camera thread performed 122 scans. [2025-11-06T03:25:26.232Z] ====== philosophers (scala) [default], iteration 29 completed (1989.398 ms) ====== [2025-11-06T03:25:26.587Z] ----------------------------------- [2025-11-06T03:25:26.587Z] renaissance-philosophers_0_PASSED [2025-11-06T03:25:26.587Z] ----------------------------------- [2025-11-06T03:25:26.587Z] [2025-11-06T03:25:26.587Z] TEST TEARDOWN: [2025-11-06T03:25:26.587Z] Nothing to be done for teardown. [2025-11-06T03:25:26.587Z] renaissance-philosophers_0 Finish Time: Thu Nov 6 03:25:26 2025 Epoch Time (ms): 1762399526369