[2026-03-05T05:42:29.833Z] Running test renaissance-philosophers_0 ... [2026-03-05T05:42:29.833Z] =============================================== [2026-03-05T05:42:30.187Z] renaissance-philosophers_0 Start Time: Thu Mar 5 05:42:29 2026 Epoch Time (ms): 1772689349829 [2026-03-05T05:42:30.187Z] variation: NoOptions [2026-03-05T05:42:30.187Z] JVM_OPTIONS: [2026-03-05T05:42:30.187Z] { \ [2026-03-05T05:42:30.187Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T05:42:30.187Z] echo "Nothing to be done for setup."; \ [2026-03-05T05:42:30.187Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\renaissance-philosophers_0"; \ [2026-03-05T05:42:30.187Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\renaissance-philosophers_0"; \ [2026-03-05T05:42:30.187Z] echo ""; echo "TESTING:"; \ [2026-03-05T05:42:30.187Z] "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_17726871194443\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-03-05T05:42:30.187Z] 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_17726871194443\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T05:42:30.187Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T05:42:30.187Z] echo "Nothing to be done for teardown."; \ [2026-03-05T05:42:30.187Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\TestTargetResult"; [2026-03-05T05:42:30.187Z] [2026-03-05T05:42:30.187Z] TEST SETUP: [2026-03-05T05:42:30.187Z] Nothing to be done for setup. [2026-03-05T05:42:30.187Z] [2026-03-05T05:42:30.187Z] TESTING: [2026-03-05T05:42:31.404Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-05T05:42:31.404Z] GC before operation: completed in 10.824 ms, heap usage 7.385 MB -> 4.482 MB. [2026-03-05T05:42:32.470Z] Camera thread performed 122 scans. [2026-03-05T05:42:32.470Z] ====== philosophers (scala) [default], iteration 0 completed (1306.970 ms) ====== [2026-03-05T05:42:32.470Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-05T05:42:32.470Z] GC before operation: completed in 21.906 ms, heap usage 16.034 MB -> 4.885 MB. [2026-03-05T05:42:33.693Z] Camera thread performed 122 scans. [2026-03-05T05:42:33.693Z] ====== philosophers (scala) [default], iteration 1 completed (713.549 ms) ====== [2026-03-05T05:42:33.693Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-05T05:42:33.693Z] GC before operation: completed in 21.324 ms, heap usage 44.991 MB -> 4.885 MB. [2026-03-05T05:42:34.291Z] Camera thread performed 122 scans. [2026-03-05T05:42:34.291Z] ====== philosophers (scala) [default], iteration 2 completed (754.094 ms) ====== [2026-03-05T05:42:34.291Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-05T05:42:34.291Z] GC before operation: completed in 9.808 ms, heap usage 22.195 MB -> 4.886 MB. [2026-03-05T05:42:34.713Z] Camera thread performed 122 scans. [2026-03-05T05:42:34.714Z] ====== philosophers (scala) [default], iteration 3 completed (528.951 ms) ====== [2026-03-05T05:42:34.714Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-05T05:42:34.714Z] GC before operation: completed in 14.373 ms, heap usage 32.994 MB -> 4.887 MB. [2026-03-05T05:42:35.066Z] Camera thread performed 122 scans. [2026-03-05T05:42:35.066Z] ====== philosophers (scala) [default], iteration 4 completed (539.598 ms) ====== [2026-03-05T05:42:35.066Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-05T05:42:35.066Z] GC before operation: completed in 10.185 ms, heap usage 38.032 MB -> 4.891 MB. [2026-03-05T05:42:35.875Z] Camera thread performed 122 scans. [2026-03-05T05:42:35.875Z] ====== philosophers (scala) [default], iteration 5 completed (527.797 ms) ====== [2026-03-05T05:42:35.875Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-05T05:42:35.875Z] GC before operation: completed in 9.346 ms, heap usage 28.508 MB -> 4.892 MB. [2026-03-05T05:42:36.228Z] Camera thread performed 122 scans. [2026-03-05T05:42:36.228Z] ====== philosophers (scala) [default], iteration 6 completed (488.888 ms) ====== [2026-03-05T05:42:36.228Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-05T05:42:36.228Z] GC before operation: completed in 9.080 ms, heap usage 16.493 MB -> 4.892 MB. [2026-03-05T05:42:36.948Z] Camera thread performed 122 scans. [2026-03-05T05:42:36.948Z] ====== philosophers (scala) [default], iteration 7 completed (618.170 ms) ====== [2026-03-05T05:42:36.948Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-05T05:42:36.948Z] GC before operation: completed in 8.867 ms, heap usage 24.449 MB -> 4.893 MB. [2026-03-05T05:42:37.306Z] Camera thread performed 122 scans. [2026-03-05T05:42:37.306Z] ====== philosophers (scala) [default], iteration 8 completed (590.206 ms) ====== [2026-03-05T05:42:37.306Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-05T05:42:37.306Z] GC before operation: completed in 9.528 ms, heap usage 37.020 MB -> 4.893 MB. [2026-03-05T05:42:38.046Z] Camera thread performed 122 scans. [2026-03-05T05:42:38.046Z] ====== philosophers (scala) [default], iteration 9 completed (589.178 ms) ====== [2026-03-05T05:42:38.046Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-05T05:42:38.046Z] GC before operation: completed in 9.212 ms, heap usage 45.851 MB -> 4.893 MB. [2026-03-05T05:42:38.818Z] Camera thread performed 122 scans. [2026-03-05T05:42:38.818Z] ====== philosophers (scala) [default], iteration 10 completed (625.026 ms) ====== [2026-03-05T05:42:38.818Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-05T05:42:38.818Z] GC before operation: completed in 10.208 ms, heap usage 24.877 MB -> 4.893 MB. [2026-03-05T05:42:39.168Z] Camera thread performed 122 scans. [2026-03-05T05:42:39.168Z] ====== philosophers (scala) [default], iteration 11 completed (448.598 ms) ====== [2026-03-05T05:42:39.168Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-05T05:42:39.168Z] GC before operation: completed in 9.168 ms, heap usage 21.993 MB -> 4.895 MB. [2026-03-05T05:42:39.931Z] Camera thread performed 122 scans. [2026-03-05T05:42:39.931Z] ====== philosophers (scala) [default], iteration 12 completed (628.419 ms) ====== [2026-03-05T05:42:39.931Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-05T05:42:39.931Z] GC before operation: completed in 10.137 ms, heap usage 28.015 MB -> 4.896 MB. [2026-03-05T05:42:40.282Z] Camera thread performed 122 scans. [2026-03-05T05:42:40.282Z] ====== philosophers (scala) [default], iteration 13 completed (585.173 ms) ====== [2026-03-05T05:42:40.282Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-05T05:42:40.282Z] GC before operation: completed in 9.917 ms, heap usage 46.478 MB -> 4.896 MB. [2026-03-05T05:42:41.052Z] Camera thread performed 122 scans. [2026-03-05T05:42:41.052Z] ====== philosophers (scala) [default], iteration 14 completed (615.057 ms) ====== [2026-03-05T05:42:41.052Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-05T05:42:41.052Z] GC before operation: completed in 9.724 ms, heap usage 35.445 MB -> 4.896 MB. [2026-03-05T05:42:41.796Z] Camera thread performed 122 scans. [2026-03-05T05:42:41.796Z] ====== philosophers (scala) [default], iteration 15 completed (621.505 ms) ====== [2026-03-05T05:42:41.796Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-05T05:42:41.796Z] GC before operation: completed in 9.297 ms, heap usage 40.445 MB -> 4.896 MB. [2026-03-05T05:42:42.146Z] Camera thread performed 122 scans. [2026-03-05T05:42:42.146Z] ====== philosophers (scala) [default], iteration 16 completed (632.117 ms) ====== [2026-03-05T05:42:42.146Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-05T05:42:42.146Z] GC before operation: completed in 9.489 ms, heap usage 42.860 MB -> 4.897 MB. [2026-03-05T05:42:42.885Z] Camera thread performed 122 scans. [2026-03-05T05:42:42.885Z] ====== philosophers (scala) [default], iteration 17 completed (608.396 ms) ====== [2026-03-05T05:42:42.885Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-05T05:42:42.885Z] GC before operation: completed in 9.156 ms, heap usage 33.852 MB -> 4.896 MB. [2026-03-05T05:42:43.622Z] Camera thread performed 122 scans. [2026-03-05T05:42:43.622Z] ====== philosophers (scala) [default], iteration 18 completed (591.091 ms) ====== [2026-03-05T05:42:43.622Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-05T05:42:43.622Z] GC before operation: completed in 10.003 ms, heap usage 14.436 MB -> 4.897 MB. [2026-03-05T05:42:43.976Z] Camera thread performed 122 scans. [2026-03-05T05:42:43.976Z] ====== philosophers (scala) [default], iteration 19 completed (596.808 ms) ====== [2026-03-05T05:42:43.976Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-05T05:42:43.976Z] GC before operation: completed in 9.733 ms, heap usage 26.986 MB -> 4.897 MB. [2026-03-05T05:42:44.716Z] Camera thread performed 122 scans. [2026-03-05T05:42:44.716Z] ====== philosophers (scala) [default], iteration 20 completed (626.878 ms) ====== [2026-03-05T05:42:44.717Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-05T05:42:44.717Z] GC before operation: completed in 10.107 ms, heap usage 40.873 MB -> 4.897 MB. [2026-03-05T05:42:45.545Z] Camera thread performed 122 scans. [2026-03-05T05:42:45.545Z] ====== philosophers (scala) [default], iteration 21 completed (557.799 ms) ====== [2026-03-05T05:42:45.545Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-05T05:42:45.545Z] GC before operation: completed in 9.575 ms, heap usage 41.383 MB -> 4.897 MB. [2026-03-05T05:42:45.957Z] Camera thread performed 122 scans. [2026-03-05T05:42:45.957Z] ====== philosophers (scala) [default], iteration 22 completed (594.962 ms) ====== [2026-03-05T05:42:45.957Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-05T05:42:45.957Z] GC before operation: completed in 9.788 ms, heap usage 7.845 MB -> 4.898 MB. [2026-03-05T05:42:46.309Z] Camera thread performed 122 scans. [2026-03-05T05:42:46.309Z] ====== philosophers (scala) [default], iteration 23 completed (558.401 ms) ====== [2026-03-05T05:42:46.309Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-05T05:42:46.659Z] GC before operation: completed in 10.320 ms, heap usage 35.956 MB -> 4.897 MB. [2026-03-05T05:42:47.021Z] Camera thread performed 122 scans. [2026-03-05T05:42:47.021Z] ====== philosophers (scala) [default], iteration 24 completed (600.408 ms) ====== [2026-03-05T05:42:47.021Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-05T05:42:47.021Z] GC before operation: completed in 9.980 ms, heap usage 4.932 MB -> 4.899 MB. [2026-03-05T05:42:47.804Z] Camera thread performed 122 scans. [2026-03-05T05:42:47.804Z] ====== philosophers (scala) [default], iteration 25 completed (587.265 ms) ====== [2026-03-05T05:42:47.804Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-05T05:42:47.804Z] GC before operation: completed in 9.279 ms, heap usage 20.448 MB -> 4.899 MB. [2026-03-05T05:42:48.155Z] Camera thread performed 122 scans. [2026-03-05T05:42:48.155Z] ====== philosophers (scala) [default], iteration 26 completed (576.578 ms) ====== [2026-03-05T05:42:48.155Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-05T05:42:48.155Z] GC before operation: completed in 9.642 ms, heap usage 30.919 MB -> 4.899 MB. [2026-03-05T05:42:48.899Z] Camera thread performed 122 scans. [2026-03-05T05:42:48.899Z] ====== philosophers (scala) [default], iteration 27 completed (626.369 ms) ====== [2026-03-05T05:42:48.899Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-05T05:42:48.899Z] GC before operation: completed in 9.458 ms, heap usage 32.453 MB -> 4.899 MB. [2026-03-05T05:42:49.645Z] Camera thread performed 122 scans. [2026-03-05T05:42:49.645Z] ====== philosophers (scala) [default], iteration 28 completed (613.639 ms) ====== [2026-03-05T05:42:49.645Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-05T05:42:49.645Z] GC before operation: completed in 12.321 ms, heap usage 21.480 MB -> 4.900 MB. [2026-03-05T05:42:50.038Z] Camera thread performed 122 scans. [2026-03-05T05:42:50.038Z] ====== philosophers (scala) [default], iteration 29 completed (582.347 ms) ====== [2026-03-05T05:42:50.380Z] ----------------------------------- [2026-03-05T05:42:50.380Z] renaissance-philosophers_0_PASSED [2026-03-05T05:42:50.380Z] ----------------------------------- [2026-03-05T05:42:50.380Z] [2026-03-05T05:42:50.380Z] TEST TEARDOWN: [2026-03-05T05:42:50.380Z] Nothing to be done for teardown. [2026-03-05T05:42:50.380Z] renaissance-philosophers_0 Finish Time: Thu Mar 5 05:42:50 2026 Epoch Time (ms): 1772689370266