[2026-01-21T05:18:12.221Z] Running test renaissance-philosophers_0 ... [2026-01-21T05:18:12.221Z] =============================================== [2026-01-21T05:18:12.582Z] renaissance-philosophers_0 Start Time: Wed Jan 21 05:18:12 2026 Epoch Time (ms): 1768972692220 [2026-01-21T05:18:12.582Z] variation: NoOptions [2026-01-21T05:18:12.582Z] JVM_OPTIONS: [2026-01-21T05:18:12.582Z] { \ [2026-01-21T05:18:12.582Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T05:18:12.582Z] echo "Nothing to be done for setup."; \ [2026-01-21T05:18:12.582Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17689702115571\\renaissance-philosophers_0"; \ [2026-01-21T05:18:12.582Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17689702115571\\renaissance-philosophers_0"; \ [2026-01-21T05:18:12.582Z] echo ""; echo "TESTING:"; \ [2026-01-21T05:18:12.582Z] "c:/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17689702115571\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-01-21T05:18:12.582Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17689702115571\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T05:18:12.582Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T05:18:12.582Z] echo "Nothing to be done for teardown."; \ [2026-01-21T05:18:12.582Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17689702115571\\TestTargetResult"; [2026-01-21T05:18:12.582Z] [2026-01-21T05:18:12.582Z] TEST SETUP: [2026-01-21T05:18:12.582Z] Nothing to be done for setup. [2026-01-21T05:18:12.582Z] [2026-01-21T05:18:12.582Z] TESTING: [2026-01-21T05:18:13.771Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-21T05:18:13.771Z] GC before operation: completed in 12.447 ms, heap usage 15.935 MB -> 4.619 MB. [2026-01-21T05:18:15.686Z] Camera thread performed 122 scans. [2026-01-21T05:18:15.686Z] ====== philosophers (scala) [default], iteration 0 completed (1829.776 ms) ====== [2026-01-21T05:18:15.686Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-21T05:18:15.686Z] GC before operation: completed in 15.265 ms, heap usage 62.125 MB -> 4.992 MB. [2026-01-21T05:18:16.886Z] Camera thread performed 122 scans. [2026-01-21T05:18:16.886Z] ====== philosophers (scala) [default], iteration 1 completed (1235.451 ms) ====== [2026-01-21T05:18:16.886Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-21T05:18:16.886Z] GC before operation: completed in 10.590 ms, heap usage 69.181 MB -> 4.993 MB. [2026-01-21T05:18:18.089Z] Camera thread performed 122 scans. [2026-01-21T05:18:18.089Z] ====== philosophers (scala) [default], iteration 2 completed (1322.529 ms) ====== [2026-01-21T05:18:18.089Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-21T05:18:18.089Z] GC before operation: completed in 10.014 ms, heap usage 22.093 MB -> 4.994 MB. [2026-01-21T05:18:19.802Z] Camera thread performed 122 scans. [2026-01-21T05:18:19.802Z] ====== philosophers (scala) [default], iteration 3 completed (1310.501 ms) ====== [2026-01-21T05:18:19.802Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-21T05:18:19.802Z] GC before operation: completed in 9.999 ms, heap usage 96.190 MB -> 4.994 MB. [2026-01-21T05:18:21.000Z] Camera thread performed 122 scans. [2026-01-21T05:18:21.000Z] ====== philosophers (scala) [default], iteration 4 completed (1364.481 ms) ====== [2026-01-21T05:18:21.000Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-21T05:18:21.000Z] GC before operation: completed in 10.238 ms, heap usage 37.993 MB -> 4.994 MB. [2026-01-21T05:18:22.193Z] Camera thread performed 122 scans. [2026-01-21T05:18:22.193Z] ====== philosophers (scala) [default], iteration 5 completed (1410.912 ms) ====== [2026-01-21T05:18:22.193Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-21T05:18:22.193Z] GC before operation: completed in 9.860 ms, heap usage 26.086 MB -> 4.998 MB. [2026-01-21T05:18:23.910Z] Camera thread performed 122 scans. [2026-01-21T05:18:23.910Z] ====== philosophers (scala) [default], iteration 6 completed (1325.879 ms) ====== [2026-01-21T05:18:23.910Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-21T05:18:23.910Z] GC before operation: completed in 9.675 ms, heap usage 37.233 MB -> 4.999 MB. [2026-01-21T05:18:25.113Z] Camera thread performed 122 scans. [2026-01-21T05:18:25.113Z] ====== philosophers (scala) [default], iteration 7 completed (1409.359 ms) ====== [2026-01-21T05:18:25.113Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-21T05:18:25.113Z] GC before operation: completed in 10.145 ms, heap usage 36.199 MB -> 4.999 MB. [2026-01-21T05:18:26.313Z] Camera thread performed 122 scans. [2026-01-21T05:18:26.313Z] ====== philosophers (scala) [default], iteration 8 completed (1385.869 ms) ====== [2026-01-21T05:18:26.313Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-21T05:18:26.682Z] GC before operation: completed in 9.827 ms, heap usage 63.074 MB -> 5.000 MB. [2026-01-21T05:18:27.881Z] Camera thread performed 122 scans. [2026-01-21T05:18:27.881Z] ====== philosophers (scala) [default], iteration 9 completed (1327.987 ms) ====== [2026-01-21T05:18:27.881Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-21T05:18:27.881Z] GC before operation: completed in 9.994 ms, heap usage 72.213 MB -> 5.000 MB. [2026-01-21T05:18:29.080Z] Camera thread performed 122 scans. [2026-01-21T05:18:29.080Z] ====== philosophers (scala) [default], iteration 10 completed (1372.272 ms) ====== [2026-01-21T05:18:29.080Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-21T05:18:29.080Z] GC before operation: completed in 9.895 ms, heap usage 44.642 MB -> 5.000 MB. [2026-01-21T05:18:30.798Z] Camera thread performed 122 scans. [2026-01-21T05:18:30.798Z] ====== philosophers (scala) [default], iteration 11 completed (1382.958 ms) ====== [2026-01-21T05:18:30.798Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-21T05:18:30.798Z] GC before operation: completed in 10.190 ms, heap usage 48.679 MB -> 5.000 MB. [2026-01-21T05:18:32.004Z] Camera thread performed 122 scans. [2026-01-21T05:18:32.004Z] ====== philosophers (scala) [default], iteration 12 completed (1467.157 ms) ====== [2026-01-21T05:18:32.004Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-21T05:18:32.004Z] GC before operation: completed in 9.765 ms, heap usage 75.214 MB -> 5.001 MB. [2026-01-21T05:18:33.719Z] Camera thread performed 122 scans. [2026-01-21T05:18:33.719Z] ====== philosophers (scala) [default], iteration 13 completed (1369.543 ms) ====== [2026-01-21T05:18:33.719Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-21T05:18:33.719Z] GC before operation: completed in 10.790 ms, heap usage 48.061 MB -> 5.000 MB. [2026-01-21T05:18:34.925Z] Camera thread performed 122 scans. [2026-01-21T05:18:34.925Z] ====== philosophers (scala) [default], iteration 14 completed (1423.689 ms) ====== [2026-01-21T05:18:34.925Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-21T05:18:34.925Z] GC before operation: completed in 9.660 ms, heap usage 17.618 MB -> 5.001 MB. [2026-01-21T05:18:36.120Z] Camera thread performed 122 scans. [2026-01-21T05:18:36.120Z] ====== philosophers (scala) [default], iteration 15 completed (1366.354 ms) ====== [2026-01-21T05:18:36.120Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-21T05:18:36.120Z] GC before operation: completed in 9.479 ms, heap usage 43.998 MB -> 5.001 MB. [2026-01-21T05:18:37.799Z] Camera thread performed 122 scans. [2026-01-21T05:18:37.799Z] ====== philosophers (scala) [default], iteration 16 completed (1363.287 ms) ====== [2026-01-21T05:18:37.799Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-21T05:18:37.799Z] GC before operation: completed in 10.920 ms, heap usage 57.671 MB -> 5.001 MB. [2026-01-21T05:18:38.995Z] Camera thread performed 122 scans. [2026-01-21T05:18:38.995Z] ====== philosophers (scala) [default], iteration 17 completed (1416.421 ms) ====== [2026-01-21T05:18:38.995Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-21T05:18:38.995Z] GC before operation: completed in 9.800 ms, heap usage 33.032 MB -> 5.001 MB. [2026-01-21T05:18:40.673Z] Camera thread performed 122 scans. [2026-01-21T05:18:40.673Z] ====== philosophers (scala) [default], iteration 18 completed (1428.177 ms) ====== [2026-01-21T05:18:40.673Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-21T05:18:40.673Z] GC before operation: completed in 9.565 ms, heap usage 17.219 MB -> 5.001 MB. [2026-01-21T05:18:41.868Z] Camera thread performed 122 scans. [2026-01-21T05:18:41.868Z] ====== philosophers (scala) [default], iteration 19 completed (1350.712 ms) ====== [2026-01-21T05:18:41.868Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-21T05:18:41.868Z] GC before operation: completed in 9.916 ms, heap usage 24.678 MB -> 5.001 MB. [2026-01-21T05:18:43.582Z] Camera thread performed 122 scans. [2026-01-21T05:18:43.582Z] ====== philosophers (scala) [default], iteration 20 completed (1397.159 ms) ====== [2026-01-21T05:18:43.582Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-21T05:18:43.582Z] GC before operation: completed in 10.217 ms, heap usage 76.081 MB -> 5.001 MB. [2026-01-21T05:18:44.779Z] Camera thread performed 122 scans. [2026-01-21T05:18:44.779Z] ====== philosophers (scala) [default], iteration 21 completed (1377.257 ms) ====== [2026-01-21T05:18:44.779Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-21T05:18:44.779Z] GC before operation: completed in 9.589 ms, heap usage 76.219 MB -> 5.001 MB. [2026-01-21T05:18:45.978Z] Camera thread performed 122 scans. [2026-01-21T05:18:45.978Z] ====== philosophers (scala) [default], iteration 22 completed (1377.970 ms) ====== [2026-01-21T05:18:45.978Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-21T05:18:45.978Z] GC before operation: completed in 9.876 ms, heap usage 23.715 MB -> 5.002 MB. [2026-01-21T05:18:47.721Z] Camera thread performed 122 scans. [2026-01-21T05:18:47.721Z] ====== philosophers (scala) [default], iteration 23 completed (1367.965 ms) ====== [2026-01-21T05:18:47.721Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-21T05:18:47.721Z] GC before operation: completed in 9.592 ms, heap usage 32.954 MB -> 5.001 MB. [2026-01-21T05:18:48.920Z] Camera thread performed 122 scans. [2026-01-21T05:18:48.920Z] ====== philosophers (scala) [default], iteration 24 completed (1423.345 ms) ====== [2026-01-21T05:18:48.920Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-21T05:18:48.920Z] GC before operation: completed in 9.692 ms, heap usage 47.221 MB -> 5.002 MB. [2026-01-21T05:18:50.136Z] Camera thread performed 122 scans. [2026-01-21T05:18:50.136Z] ====== philosophers (scala) [default], iteration 25 completed (1365.685 ms) ====== [2026-01-21T05:18:50.136Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-21T05:18:50.136Z] GC before operation: completed in 10.180 ms, heap usage 59.626 MB -> 5.001 MB. [2026-01-21T05:18:51.850Z] Camera thread performed 122 scans. [2026-01-21T05:18:51.850Z] ====== philosophers (scala) [default], iteration 26 completed (1350.351 ms) ====== [2026-01-21T05:18:51.850Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-21T05:18:51.850Z] GC before operation: completed in 10.492 ms, heap usage 83.053 MB -> 5.002 MB. [2026-01-21T05:18:53.016Z] Camera thread performed 122 scans. [2026-01-21T05:18:53.016Z] ====== philosophers (scala) [default], iteration 27 completed (1364.114 ms) ====== [2026-01-21T05:18:53.016Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-21T05:18:53.016Z] GC before operation: completed in 11.161 ms, heap usage 79.119 MB -> 5.002 MB. [2026-01-21T05:18:54.216Z] Camera thread performed 122 scans. [2026-01-21T05:18:54.216Z] ====== philosophers (scala) [default], iteration 28 completed (1400.847 ms) ====== [2026-01-21T05:18:54.216Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-21T05:18:54.585Z] GC before operation: completed in 10.515 ms, heap usage 53.616 MB -> 5.002 MB. [2026-01-21T05:18:55.751Z] Camera thread performed 122 scans. [2026-01-21T05:18:55.751Z] ====== philosophers (scala) [default], iteration 29 completed (1286.824 ms) ====== [2026-01-21T05:18:55.751Z] ----------------------------------- [2026-01-21T05:18:55.751Z] renaissance-philosophers_0_PASSED [2026-01-21T05:18:55.751Z] ----------------------------------- [2026-01-21T05:18:55.751Z] [2026-01-21T05:18:55.751Z] TEST TEARDOWN: [2026-01-21T05:18:55.751Z] Nothing to be done for teardown. [2026-01-21T05:18:56.085Z] renaissance-philosophers_0 Finish Time: Wed Jan 21 05:18:55 2026 Epoch Time (ms): 1768972735777