[2026-01-10T08:03:04.891Z] Running test renaissance-philosophers_0 ... [2026-01-10T08:03:04.891Z] =============================================== [2026-01-10T08:03:05.277Z] renaissance-philosophers_0 Start Time: Sat Jan 10 08:03:05 2026 Epoch Time (ms): 1768032185024 [2026-01-10T08:03:05.277Z] variation: NoOptions [2026-01-10T08:03:05.277Z] JVM_OPTIONS: [2026-01-10T08:03:05.277Z] { \ [2026-01-10T08:03:05.277Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T08:03:05.277Z] echo "Nothing to be done for setup."; \ [2026-01-10T08:03:05.277Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680290144173\\renaissance-philosophers_0"; \ [2026-01-10T08:03:05.277Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680290144173\\renaissance-philosophers_0"; \ [2026-01-10T08:03:05.277Z] echo ""; echo "TESTING:"; \ [2026-01-10T08:03:05.277Z] "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_17680290144173\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-01-10T08:03:05.277Z] 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_17680290144173\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T08:03:05.277Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T08:03:05.277Z] echo "Nothing to be done for teardown."; \ [2026-01-10T08:03:05.277Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680290144173\\TestTargetResult"; [2026-01-10T08:03:05.640Z] [2026-01-10T08:03:05.640Z] TEST SETUP: [2026-01-10T08:03:05.640Z] Nothing to be done for setup. [2026-01-10T08:03:05.640Z] [2026-01-10T08:03:05.640Z] TESTING: [2026-01-10T08:03:06.394Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-10T08:03:06.394Z] GC before operation: completed in 12.063 ms, heap usage 15.588 MB -> 4.477 MB. [2026-01-10T08:03:08.863Z] Camera thread performed 122 scans. [2026-01-10T08:03:08.863Z] ====== philosophers (scala) [default], iteration 0 completed (2157.803 ms) ====== [2026-01-10T08:03:08.863Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-10T08:03:08.863Z] GC before operation: completed in 12.149 ms, heap usage 28.671 MB -> 4.872 MB. [2026-01-10T08:03:10.075Z] Camera thread performed 122 scans. [2026-01-10T08:03:10.075Z] ====== philosophers (scala) [default], iteration 1 completed (1497.635 ms) ====== [2026-01-10T08:03:10.075Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-10T08:03:10.075Z] GC before operation: completed in 10.326 ms, heap usage 61.918 MB -> 4.873 MB. [2026-01-10T08:03:11.800Z] Camera thread performed 122 scans. [2026-01-10T08:03:11.800Z] ====== philosophers (scala) [default], iteration 2 completed (1774.444 ms) ====== [2026-01-10T08:03:11.800Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-10T08:03:11.800Z] GC before operation: completed in 10.303 ms, heap usage 57.842 MB -> 4.878 MB. [2026-01-10T08:03:14.122Z] Camera thread performed 122 scans. [2026-01-10T08:03:14.122Z] ====== philosophers (scala) [default], iteration 3 completed (1843.703 ms) ====== [2026-01-10T08:03:14.122Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-10T08:03:14.122Z] GC before operation: completed in 10.112 ms, heap usage 52.561 MB -> 4.879 MB. [2026-01-10T08:03:15.816Z] Camera thread performed 122 scans. [2026-01-10T08:03:15.816Z] ====== philosophers (scala) [default], iteration 4 completed (1703.400 ms) ====== [2026-01-10T08:03:15.816Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-10T08:03:15.816Z] GC before operation: completed in 10.412 ms, heap usage 41.590 MB -> 4.879 MB. [2026-01-10T08:03:17.017Z] Camera thread performed 122 scans. [2026-01-10T08:03:17.017Z] ====== philosophers (scala) [default], iteration 5 completed (1634.400 ms) ====== [2026-01-10T08:03:17.017Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-10T08:03:17.017Z] GC before operation: completed in 10.707 ms, heap usage 36.796 MB -> 4.880 MB. [2026-01-10T08:03:19.335Z] Camera thread performed 122 scans. [2026-01-10T08:03:19.335Z] ====== philosophers (scala) [default], iteration 6 completed (1882.670 ms) ====== [2026-01-10T08:03:19.335Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-10T08:03:19.335Z] GC before operation: completed in 9.794 ms, heap usage 22.498 MB -> 4.880 MB. [2026-01-10T08:03:21.052Z] Camera thread performed 122 scans. [2026-01-10T08:03:21.052Z] ====== philosophers (scala) [default], iteration 7 completed (1860.977 ms) ====== [2026-01-10T08:03:21.052Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-10T08:03:21.052Z] GC before operation: completed in 14.320 ms, heap usage 70.911 MB -> 4.881 MB. [2026-01-10T08:03:22.767Z] Camera thread performed 122 scans. [2026-01-10T08:03:22.767Z] ====== philosophers (scala) [default], iteration 8 completed (1852.632 ms) ====== [2026-01-10T08:03:22.767Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-10T08:03:22.767Z] GC before operation: completed in 9.930 ms, heap usage 23.939 MB -> 4.882 MB. [2026-01-10T08:03:25.065Z] Camera thread performed 122 scans. [2026-01-10T08:03:25.065Z] ====== philosophers (scala) [default], iteration 9 completed (1904.181 ms) ====== [2026-01-10T08:03:25.065Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-10T08:03:25.065Z] GC before operation: completed in 10.604 ms, heap usage 36.124 MB -> 4.881 MB. [2026-01-10T08:03:26.785Z] Camera thread performed 122 scans. [2026-01-10T08:03:26.785Z] ====== philosophers (scala) [default], iteration 10 completed (1923.421 ms) ====== [2026-01-10T08:03:26.785Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-10T08:03:26.785Z] GC before operation: completed in 10.643 ms, heap usage 63.764 MB -> 4.882 MB. [2026-01-10T08:03:28.506Z] Camera thread performed 122 scans. [2026-01-10T08:03:28.506Z] ====== philosophers (scala) [default], iteration 11 completed (1811.657 ms) ====== [2026-01-10T08:03:28.506Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-10T08:03:28.506Z] GC before operation: completed in 10.232 ms, heap usage 13.604 MB -> 4.882 MB. [2026-01-10T08:03:30.229Z] Camera thread performed 122 scans. [2026-01-10T08:03:30.229Z] ====== philosophers (scala) [default], iteration 12 completed (1754.390 ms) ====== [2026-01-10T08:03:30.229Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-10T08:03:30.229Z] GC before operation: completed in 10.818 ms, heap usage 26.519 MB -> 4.882 MB. [2026-01-10T08:03:31.950Z] Camera thread performed 122 scans. [2026-01-10T08:03:31.950Z] ====== philosophers (scala) [default], iteration 13 completed (1707.367 ms) ====== [2026-01-10T08:03:31.950Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-10T08:03:31.950Z] GC before operation: completed in 10.133 ms, heap usage 8.102 MB -> 4.884 MB. [2026-01-10T08:03:33.671Z] Camera thread performed 122 scans. [2026-01-10T08:03:33.671Z] ====== philosophers (scala) [default], iteration 14 completed (1739.068 ms) ====== [2026-01-10T08:03:33.671Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-10T08:03:33.671Z] GC before operation: completed in 9.748 ms, heap usage 5.458 MB -> 4.884 MB. [2026-01-10T08:03:35.387Z] Camera thread performed 122 scans. [2026-01-10T08:03:35.388Z] ====== philosophers (scala) [default], iteration 15 completed (1617.323 ms) ====== [2026-01-10T08:03:35.388Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-10T08:03:35.388Z] GC before operation: completed in 10.520 ms, heap usage 38.098 MB -> 4.884 MB. [2026-01-10T08:03:37.119Z] Camera thread performed 122 scans. [2026-01-10T08:03:37.119Z] ====== philosophers (scala) [default], iteration 16 completed (1833.681 ms) ====== [2026-01-10T08:03:37.119Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-10T08:03:37.119Z] GC before operation: completed in 10.414 ms, heap usage 28.471 MB -> 4.884 MB. [2026-01-10T08:03:38.837Z] Camera thread performed 122 scans. [2026-01-10T08:03:38.837Z] ====== philosophers (scala) [default], iteration 17 completed (1789.828 ms) ====== [2026-01-10T08:03:38.837Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-10T08:03:38.837Z] GC before operation: completed in 10.616 ms, heap usage 61.456 MB -> 4.884 MB. [2026-01-10T08:03:40.587Z] Camera thread performed 122 scans. [2026-01-10T08:03:40.587Z] ====== philosophers (scala) [default], iteration 18 completed (1727.583 ms) ====== [2026-01-10T08:03:40.587Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-10T08:03:40.587Z] GC before operation: completed in 10.300 ms, heap usage 14.003 MB -> 4.884 MB. [2026-01-10T08:03:42.303Z] Camera thread performed 122 scans. [2026-01-10T08:03:42.303Z] ====== philosophers (scala) [default], iteration 19 completed (1752.927 ms) ====== [2026-01-10T08:03:42.303Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-10T08:03:42.665Z] GC before operation: completed in 11.468 ms, heap usage 58.886 MB -> 4.885 MB. [2026-01-10T08:03:44.382Z] Camera thread performed 122 scans. [2026-01-10T08:03:44.382Z] ====== philosophers (scala) [default], iteration 20 completed (1719.990 ms) ====== [2026-01-10T08:03:44.382Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-10T08:03:44.382Z] GC before operation: completed in 10.686 ms, heap usage 42.988 MB -> 4.885 MB. [2026-01-10T08:03:46.078Z] Camera thread performed 122 scans. [2026-01-10T08:03:46.078Z] ====== philosophers (scala) [default], iteration 21 completed (1744.741 ms) ====== [2026-01-10T08:03:46.078Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-10T08:03:46.079Z] GC before operation: completed in 10.817 ms, heap usage 51.515 MB -> 4.884 MB. [2026-01-10T08:03:47.798Z] Camera thread performed 122 scans. [2026-01-10T08:03:47.798Z] ====== philosophers (scala) [default], iteration 22 completed (1774.862 ms) ====== [2026-01-10T08:03:47.798Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-10T08:03:47.798Z] GC before operation: completed in 10.933 ms, heap usage 42.106 MB -> 4.885 MB. [2026-01-10T08:03:49.517Z] Camera thread performed 122 scans. [2026-01-10T08:03:49.517Z] ====== philosophers (scala) [default], iteration 23 completed (1696.425 ms) ====== [2026-01-10T08:03:49.517Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-10T08:03:49.517Z] GC before operation: completed in 10.952 ms, heap usage 50.796 MB -> 4.885 MB. [2026-01-10T08:03:51.234Z] Camera thread performed 122 scans. [2026-01-10T08:03:51.234Z] ====== philosophers (scala) [default], iteration 24 completed (1507.636 ms) ====== [2026-01-10T08:03:51.234Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-10T08:03:51.234Z] GC before operation: completed in 10.039 ms, heap usage 42.472 MB -> 4.886 MB. [2026-01-10T08:03:52.953Z] Camera thread performed 122 scans. [2026-01-10T08:03:52.953Z] ====== philosophers (scala) [default], iteration 25 completed (1746.369 ms) ====== [2026-01-10T08:03:52.953Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-10T08:03:52.953Z] GC before operation: completed in 10.570 ms, heap usage 50.468 MB -> 4.886 MB. [2026-01-10T08:03:54.700Z] Camera thread performed 122 scans. [2026-01-10T08:03:54.700Z] ====== philosophers (scala) [default], iteration 26 completed (1780.932 ms) ====== [2026-01-10T08:03:54.700Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-10T08:03:54.700Z] GC before operation: completed in 10.498 ms, heap usage 47.115 MB -> 4.886 MB. [2026-01-10T08:03:56.418Z] Camera thread performed 122 scans. [2026-01-10T08:03:56.418Z] ====== philosophers (scala) [default], iteration 27 completed (1722.566 ms) ====== [2026-01-10T08:03:56.418Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-10T08:03:56.418Z] GC before operation: completed in 11.186 ms, heap usage 15.931 MB -> 4.886 MB. [2026-01-10T08:03:58.136Z] Camera thread performed 122 scans. [2026-01-10T08:03:58.136Z] ====== philosophers (scala) [default], iteration 28 completed (1768.723 ms) ====== [2026-01-10T08:03:58.136Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-10T08:03:58.136Z] GC before operation: completed in 10.753 ms, heap usage 66.112 MB -> 4.886 MB. [2026-01-10T08:03:59.831Z] Camera thread performed 122 scans. [2026-01-10T08:03:59.831Z] ====== philosophers (scala) [default], iteration 29 completed (1723.214 ms) ====== [2026-01-10T08:03:59.831Z] ----------------------------------- [2026-01-10T08:03:59.831Z] renaissance-philosophers_0_PASSED [2026-01-10T08:03:59.831Z] ----------------------------------- [2026-01-10T08:03:59.831Z] [2026-01-10T08:03:59.831Z] TEST TEARDOWN: [2026-01-10T08:03:59.831Z] Nothing to be done for teardown. [2026-01-10T08:04:00.189Z] renaissance-philosophers_0 Finish Time: Sat Jan 10 08:03:59 2026 Epoch Time (ms): 1768032239870