[2026-04-22T15:02:24.774Z] Running test renaissance-philosophers_0 ... [2026-04-22T15:02:24.774Z] =============================================== [2026-04-22T15:02:24.774Z] renaissance-philosophers_0 Start Time: Wed Apr 22 15:02:24 2026 Epoch Time (ms): 1776870144719 [2026-04-22T15:02:25.138Z] variation: NoOptions [2026-04-22T15:02:25.138Z] JVM_OPTIONS: [2026-04-22T15:02:25.138Z] { \ [2026-04-22T15:02:25.138Z] echo ""; echo "TEST SETUP:"; \ [2026-04-22T15:02:25.138Z] echo "Nothing to be done for setup."; \ [2026-04-22T15:02:25.138Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-philosophers_0"; \ [2026-04-22T15:02:25.138Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-philosophers_0"; \ [2026-04-22T15:02:25.138Z] echo ""; echo "TESTING:"; \ [2026-04-22T15:02:25.138Z] "c:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/jdkbinary/j2sdk-image\\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 "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-04-22T15:02:25.138Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-22T15:02:25.138Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-22T15:02:25.138Z] echo "Nothing to be done for teardown."; \ [2026-04-22T15:02:25.138Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\TestTargetResult"; [2026-04-22T15:02:25.138Z] [2026-04-22T15:02:25.138Z] TEST SETUP: [2026-04-22T15:02:25.138Z] Nothing to be done for setup. [2026-04-22T15:02:25.138Z] [2026-04-22T15:02:25.138Z] TESTING: [2026-04-22T15:02:26.374Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-04-22T15:02:26.374Z] GC before operation: completed in 9.603 ms, heap usage 15.584 MB -> 4.478 MB. [2026-04-22T15:02:28.245Z] Camera thread performed 122 scans. [2026-04-22T15:02:28.245Z] ====== philosophers (scala) [default], iteration 0 completed (1896.162 ms) ====== [2026-04-22T15:02:28.245Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-04-22T15:02:28.245Z] GC before operation: completed in 11.870 ms, heap usage 44.141 MB -> 4.877 MB. [2026-04-22T15:02:29.443Z] Camera thread performed 122 scans. [2026-04-22T15:02:29.443Z] ====== philosophers (scala) [default], iteration 1 completed (1492.970 ms) ====== [2026-04-22T15:02:29.443Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-04-22T15:02:29.443Z] GC before operation: completed in 9.778 ms, heap usage 30.525 MB -> 4.878 MB. [2026-04-22T15:02:31.167Z] Camera thread performed 122 scans. [2026-04-22T15:02:31.167Z] ====== philosophers (scala) [default], iteration 2 completed (1413.484 ms) ====== [2026-04-22T15:02:31.167Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-04-22T15:02:31.167Z] GC before operation: completed in 10.157 ms, heap usage 54.798 MB -> 4.883 MB. [2026-04-22T15:02:32.366Z] Camera thread performed 122 scans. [2026-04-22T15:02:32.366Z] ====== philosophers (scala) [default], iteration 3 completed (1410.849 ms) ====== [2026-04-22T15:02:32.366Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-04-22T15:02:32.366Z] GC before operation: completed in 9.938 ms, heap usage 26.204 MB -> 4.884 MB. [2026-04-22T15:02:34.102Z] Camera thread performed 122 scans. [2026-04-22T15:02:34.102Z] ====== philosophers (scala) [default], iteration 4 completed (1480.910 ms) ====== [2026-04-22T15:02:34.102Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-04-22T15:02:34.102Z] GC before operation: completed in 10.008 ms, heap usage 16.087 MB -> 4.884 MB. [2026-04-22T15:02:35.307Z] Camera thread performed 122 scans. [2026-04-22T15:02:35.307Z] ====== philosophers (scala) [default], iteration 5 completed (1444.699 ms) ====== [2026-04-22T15:02:35.307Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-04-22T15:02:35.307Z] GC before operation: completed in 9.424 ms, heap usage 19.148 MB -> 4.885 MB. [2026-04-22T15:02:37.027Z] Camera thread performed 122 scans. [2026-04-22T15:02:37.027Z] ====== philosophers (scala) [default], iteration 6 completed (1474.779 ms) ====== [2026-04-22T15:02:37.027Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-04-22T15:02:37.027Z] GC before operation: completed in 11.826 ms, heap usage 67.860 MB -> 4.887 MB. [2026-04-22T15:02:38.226Z] Camera thread performed 122 scans. [2026-04-22T15:02:38.226Z] ====== philosophers (scala) [default], iteration 7 completed (1428.609 ms) ====== [2026-04-22T15:02:38.226Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-04-22T15:02:38.226Z] GC before operation: completed in 10.263 ms, heap usage 47.986 MB -> 4.887 MB. [2026-04-22T15:02:39.917Z] Camera thread performed 122 scans. [2026-04-22T15:02:39.917Z] ====== philosophers (scala) [default], iteration 8 completed (1580.355 ms) ====== [2026-04-22T15:02:39.917Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-04-22T15:02:39.917Z] GC before operation: completed in 10.636 ms, heap usage 54.117 MB -> 4.887 MB. [2026-04-22T15:02:41.635Z] Camera thread performed 122 scans. [2026-04-22T15:02:41.635Z] ====== philosophers (scala) [default], iteration 9 completed (1544.120 ms) ====== [2026-04-22T15:02:41.635Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-04-22T15:02:41.635Z] GC before operation: completed in 10.043 ms, heap usage 28.972 MB -> 4.887 MB. [2026-04-22T15:02:42.830Z] Camera thread performed 122 scans. [2026-04-22T15:02:42.831Z] ====== philosophers (scala) [default], iteration 10 completed (1470.403 ms) ====== [2026-04-22T15:02:42.831Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-04-22T15:02:42.831Z] GC before operation: completed in 10.382 ms, heap usage 27.107 MB -> 4.888 MB. [2026-04-22T15:02:44.583Z] Camera thread performed 122 scans. [2026-04-22T15:02:44.583Z] ====== philosophers (scala) [default], iteration 11 completed (1513.640 ms) ====== [2026-04-22T15:02:44.583Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-04-22T15:02:44.583Z] GC before operation: completed in 10.256 ms, heap usage 20.493 MB -> 4.888 MB. [2026-04-22T15:02:46.274Z] Camera thread performed 122 scans. [2026-04-22T15:02:46.274Z] ====== philosophers (scala) [default], iteration 12 completed (1509.184 ms) ====== [2026-04-22T15:02:46.274Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-04-22T15:02:46.274Z] GC before operation: completed in 9.979 ms, heap usage 12.004 MB -> 4.889 MB. [2026-04-22T15:02:47.478Z] Camera thread performed 122 scans. [2026-04-22T15:02:47.478Z] ====== philosophers (scala) [default], iteration 13 completed (1464.335 ms) ====== [2026-04-22T15:02:47.478Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-04-22T15:02:47.478Z] GC before operation: completed in 10.064 ms, heap usage 10.527 MB -> 4.890 MB. [2026-04-22T15:02:48.673Z] Camera thread performed 122 scans. [2026-04-22T15:02:48.673Z] ====== philosophers (scala) [default], iteration 14 completed (1366.161 ms) ====== [2026-04-22T15:02:48.673Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-04-22T15:02:49.027Z] GC before operation: completed in 10.868 ms, heap usage 19.076 MB -> 4.890 MB. [2026-04-22T15:02:50.222Z] Camera thread performed 122 scans. [2026-04-22T15:02:50.222Z] ====== philosophers (scala) [default], iteration 15 completed (1462.285 ms) ====== [2026-04-22T15:02:50.222Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-04-22T15:02:50.222Z] GC before operation: completed in 10.422 ms, heap usage 26.108 MB -> 4.890 MB. [2026-04-22T15:02:51.937Z] Camera thread performed 122 scans. [2026-04-22T15:02:51.937Z] ====== philosophers (scala) [default], iteration 16 completed (1493.018 ms) ====== [2026-04-22T15:02:51.937Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-04-22T15:02:51.937Z] GC before operation: completed in 10.560 ms, heap usage 62.892 MB -> 4.891 MB. [2026-04-22T15:02:53.650Z] Camera thread performed 122 scans. [2026-04-22T15:02:53.650Z] ====== philosophers (scala) [default], iteration 17 completed (1505.973 ms) ====== [2026-04-22T15:02:53.650Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-04-22T15:02:53.650Z] GC before operation: completed in 10.813 ms, heap usage 67.801 MB -> 4.891 MB. [2026-04-22T15:02:54.844Z] Camera thread performed 122 scans. [2026-04-22T15:02:54.844Z] ====== philosophers (scala) [default], iteration 18 completed (1589.249 ms) ====== [2026-04-22T15:02:54.844Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-04-22T15:02:54.844Z] GC before operation: completed in 10.539 ms, heap usage 55.099 MB -> 4.891 MB. [2026-04-22T15:02:56.583Z] Camera thread performed 122 scans. [2026-04-22T15:02:56.583Z] ====== philosophers (scala) [default], iteration 19 completed (1470.328 ms) ====== [2026-04-22T15:02:56.583Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-04-22T15:02:56.583Z] GC before operation: completed in 10.845 ms, heap usage 83.043 MB -> 4.891 MB. [2026-04-22T15:02:57.805Z] Camera thread performed 122 scans. [2026-04-22T15:02:57.805Z] ====== philosophers (scala) [default], iteration 20 completed (1461.117 ms) ====== [2026-04-22T15:02:57.805Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-04-22T15:02:57.805Z] GC before operation: completed in 10.208 ms, heap usage 19.019 MB -> 4.891 MB. [2026-04-22T15:02:59.519Z] Camera thread performed 122 scans. [2026-04-22T15:02:59.519Z] ====== philosophers (scala) [default], iteration 21 completed (1497.678 ms) ====== [2026-04-22T15:02:59.519Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-04-22T15:02:59.519Z] GC before operation: completed in 10.654 ms, heap usage 79.525 MB -> 4.891 MB. [2026-04-22T15:03:01.272Z] Camera thread performed 122 scans. [2026-04-22T15:03:01.272Z] ====== philosophers (scala) [default], iteration 22 completed (1508.401 ms) ====== [2026-04-22T15:03:01.272Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-04-22T15:03:01.272Z] GC before operation: completed in 11.302 ms, heap usage 15.554 MB -> 4.892 MB. [2026-04-22T15:03:02.470Z] Camera thread performed 122 scans. [2026-04-22T15:03:02.470Z] ====== philosophers (scala) [default], iteration 23 completed (1431.873 ms) ====== [2026-04-22T15:03:02.470Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-04-22T15:03:02.470Z] GC before operation: completed in 10.395 ms, heap usage 8.860 MB -> 4.891 MB. [2026-04-22T15:03:04.180Z] Camera thread performed 122 scans. [2026-04-22T15:03:04.180Z] ====== philosophers (scala) [default], iteration 24 completed (1512.176 ms) ====== [2026-04-22T15:03:04.180Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-04-22T15:03:04.180Z] GC before operation: completed in 10.669 ms, heap usage 47.528 MB -> 4.891 MB. [2026-04-22T15:03:05.380Z] Camera thread performed 122 scans. [2026-04-22T15:03:05.380Z] ====== philosophers (scala) [default], iteration 25 completed (1385.147 ms) ====== [2026-04-22T15:03:05.380Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-04-22T15:03:05.380Z] GC before operation: completed in 10.363 ms, heap usage 54.118 MB -> 4.891 MB. [2026-04-22T15:03:07.091Z] Camera thread performed 122 scans. [2026-04-22T15:03:07.091Z] ====== philosophers (scala) [default], iteration 26 completed (1528.761 ms) ====== [2026-04-22T15:03:07.091Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-04-22T15:03:07.091Z] GC before operation: completed in 10.209 ms, heap usage 14.954 MB -> 4.892 MB. [2026-04-22T15:03:08.290Z] Camera thread performed 122 scans. [2026-04-22T15:03:08.290Z] ====== philosophers (scala) [default], iteration 27 completed (1479.023 ms) ====== [2026-04-22T15:03:08.290Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-04-22T15:03:08.290Z] GC before operation: completed in 10.125 ms, heap usage 20.951 MB -> 4.891 MB. [2026-04-22T15:03:10.022Z] Camera thread performed 122 scans. [2026-04-22T15:03:10.022Z] ====== philosophers (scala) [default], iteration 28 completed (1503.370 ms) ====== [2026-04-22T15:03:10.022Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-04-22T15:03:10.022Z] GC before operation: completed in 10.486 ms, heap usage 26.030 MB -> 4.892 MB. [2026-04-22T15:03:11.217Z] Camera thread performed 122 scans. [2026-04-22T15:03:11.217Z] ====== philosophers (scala) [default], iteration 29 completed (1395.205 ms) ====== [2026-04-22T15:03:11.217Z] ----------------------------------- [2026-04-22T15:03:11.217Z] renaissance-philosophers_0_PASSED [2026-04-22T15:03:11.217Z] ----------------------------------- [2026-04-22T15:03:11.554Z] [2026-04-22T15:03:11.555Z] TEST TEARDOWN: [2026-04-22T15:03:11.555Z] Nothing to be done for teardown. [2026-04-22T15:03:11.555Z] renaissance-philosophers_0 Finish Time: Wed Apr 22 15:03:11 2026 Epoch Time (ms): 1776870191308