[2026-03-05T06:44:12.024Z] Running test renaissance-philosophers_0 ... [2026-03-05T06:44:12.024Z] =============================================== [2026-03-05T06:44:12.024Z] renaissance-philosophers_0 Start Time: Thu Mar 5 06:44:11 2026 Epoch Time (ms): 1772693051955 [2026-03-05T06:44:12.360Z] variation: NoOptions [2026-03-05T06:44:12.360Z] JVM_OPTIONS: [2026-03-05T06:44:12.360Z] { \ [2026-03-05T06:44:12.360Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T06:44:12.360Z] echo "Nothing to be done for setup."; \ [2026-03-05T06:44:12.360Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726895134936\\renaissance-philosophers_0"; \ [2026-03-05T06:44:12.360Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726895134936\\renaissance-philosophers_0"; \ [2026-03-05T06:44:12.360Z] echo ""; echo "TESTING:"; \ [2026-03-05T06:44:12.360Z] "c:/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726895134936\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-03-05T06:44:12.360Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726895134936\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T06:44:12.360Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T06:44:12.360Z] echo "Nothing to be done for teardown."; \ [2026-03-05T06:44:12.360Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726895134936\\TestTargetResult"; [2026-03-05T06:44:12.360Z] [2026-03-05T06:44:12.360Z] TEST SETUP: [2026-03-05T06:44:12.360Z] Nothing to be done for setup. [2026-03-05T06:44:12.360Z] [2026-03-05T06:44:12.360Z] TESTING: [2026-03-05T06:44:14.751Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-05T06:44:14.751Z] GC before operation: completed in 17.202 ms, heap usage 7.449 MB -> 4.444 MB. [2026-03-05T06:44:16.006Z] Camera thread performed 122 scans. [2026-03-05T06:44:16.006Z] ====== philosophers (scala) [default], iteration 0 completed (1684.687 ms) ====== [2026-03-05T06:44:16.006Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-05T06:44:16.006Z] GC before operation: completed in 26.600 ms, heap usage 24.709 MB -> 4.863 MB. [2026-03-05T06:44:17.055Z] Camera thread performed 122 scans. [2026-03-05T06:44:17.055Z] ====== philosophers (scala) [default], iteration 1 completed (968.995 ms) ====== [2026-03-05T06:44:17.055Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-05T06:44:17.055Z] GC before operation: completed in 40.296 ms, heap usage 18.558 MB -> 4.864 MB. [2026-03-05T06:44:18.091Z] Camera thread performed 122 scans. [2026-03-05T06:44:18.091Z] ====== philosophers (scala) [default], iteration 2 completed (932.481 ms) ====== [2026-03-05T06:44:18.091Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-05T06:44:18.091Z] GC before operation: completed in 28.817 ms, heap usage 22.678 MB -> 4.867 MB. [2026-03-05T06:44:18.964Z] Camera thread performed 122 scans. [2026-03-05T06:44:18.964Z] ====== philosophers (scala) [default], iteration 3 completed (864.810 ms) ====== [2026-03-05T06:44:18.964Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-05T06:44:18.964Z] GC before operation: completed in 22.732 ms, heap usage 37.109 MB -> 4.870 MB. [2026-03-05T06:44:19.672Z] Camera thread performed 122 scans. [2026-03-05T06:44:19.672Z] ====== philosophers (scala) [default], iteration 4 completed (900.506 ms) ====== [2026-03-05T06:44:19.672Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-05T06:44:19.672Z] GC before operation: completed in 20.358 ms, heap usage 18.430 MB -> 4.871 MB. [2026-03-05T06:44:20.832Z] Camera thread performed 122 scans. [2026-03-05T06:44:20.832Z] ====== philosophers (scala) [default], iteration 5 completed (873.270 ms) ====== [2026-03-05T06:44:20.832Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-05T06:44:20.832Z] GC before operation: completed in 21.443 ms, heap usage 15.814 MB -> 4.871 MB. [2026-03-05T06:44:21.663Z] Camera thread performed 122 scans. [2026-03-05T06:44:21.663Z] ====== philosophers (scala) [default], iteration 6 completed (1005.875 ms) ====== [2026-03-05T06:44:21.663Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-05T06:44:21.663Z] GC before operation: completed in 22.331 ms, heap usage 8.906 MB -> 4.871 MB. [2026-03-05T06:44:22.777Z] Camera thread performed 122 scans. [2026-03-05T06:44:22.777Z] ====== philosophers (scala) [default], iteration 7 completed (903.373 ms) ====== [2026-03-05T06:44:22.777Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-05T06:44:22.777Z] GC before operation: completed in 20.863 ms, heap usage 36.412 MB -> 4.872 MB. [2026-03-05T06:44:23.480Z] Camera thread performed 122 scans. [2026-03-05T06:44:23.480Z] ====== philosophers (scala) [default], iteration 8 completed (912.894 ms) ====== [2026-03-05T06:44:23.480Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-05T06:44:23.480Z] GC before operation: completed in 22.953 ms, heap usage 22.424 MB -> 4.872 MB. [2026-03-05T06:44:24.321Z] Camera thread performed 122 scans. [2026-03-05T06:44:24.321Z] ====== philosophers (scala) [default], iteration 9 completed (872.545 ms) ====== [2026-03-05T06:44:24.321Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-05T06:44:24.321Z] GC before operation: completed in 23.643 ms, heap usage 13.872 MB -> 4.872 MB. [2026-03-05T06:44:25.486Z] Camera thread performed 122 scans. [2026-03-05T06:44:25.486Z] ====== philosophers (scala) [default], iteration 10 completed (857.051 ms) ====== [2026-03-05T06:44:25.486Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-05T06:44:25.486Z] GC before operation: completed in 20.805 ms, heap usage 25.470 MB -> 4.873 MB. [2026-03-05T06:44:26.296Z] Camera thread performed 122 scans. [2026-03-05T06:44:26.296Z] ====== philosophers (scala) [default], iteration 11 completed (899.625 ms) ====== [2026-03-05T06:44:26.296Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-05T06:44:26.296Z] GC before operation: completed in 28.323 ms, heap usage 32.373 MB -> 4.875 MB. [2026-03-05T06:44:27.005Z] Camera thread performed 122 scans. [2026-03-05T06:44:27.005Z] ====== philosophers (scala) [default], iteration 12 completed (925.037 ms) ====== [2026-03-05T06:44:27.005Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-05T06:44:27.340Z] GC before operation: completed in 35.312 ms, heap usage 43.840 MB -> 4.875 MB. [2026-03-05T06:44:28.077Z] Camera thread performed 122 scans. [2026-03-05T06:44:28.077Z] ====== philosophers (scala) [default], iteration 13 completed (914.019 ms) ====== [2026-03-05T06:44:28.077Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-05T06:44:28.077Z] GC before operation: completed in 25.632 ms, heap usage 39.391 MB -> 4.875 MB. [2026-03-05T06:44:29.207Z] Camera thread performed 122 scans. [2026-03-05T06:44:29.207Z] ====== philosophers (scala) [default], iteration 14 completed (919.937 ms) ====== [2026-03-05T06:44:29.207Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-05T06:44:29.207Z] GC before operation: completed in 22.040 ms, heap usage 31.997 MB -> 4.875 MB. [2026-03-05T06:44:29.904Z] Camera thread performed 122 scans. [2026-03-05T06:44:29.904Z] ====== philosophers (scala) [default], iteration 15 completed (906.703 ms) ====== [2026-03-05T06:44:29.904Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-05T06:44:29.904Z] GC before operation: completed in 20.411 ms, heap usage 33.816 MB -> 4.875 MB. [2026-03-05T06:44:31.033Z] Camera thread performed 122 scans. [2026-03-05T06:44:31.033Z] ====== philosophers (scala) [default], iteration 16 completed (904.785 ms) ====== [2026-03-05T06:44:31.033Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-05T06:44:31.033Z] GC before operation: completed in 22.305 ms, heap usage 37.719 MB -> 4.876 MB. [2026-03-05T06:44:31.731Z] Camera thread performed 122 scans. [2026-03-05T06:44:31.731Z] ====== philosophers (scala) [default], iteration 17 completed (955.072 ms) ====== [2026-03-05T06:44:31.731Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-05T06:44:32.046Z] GC before operation: completed in 23.553 ms, heap usage 10.406 MB -> 4.875 MB. [2026-03-05T06:44:32.744Z] Camera thread performed 122 scans. [2026-03-05T06:44:32.744Z] ====== philosophers (scala) [default], iteration 18 completed (906.670 ms) ====== [2026-03-05T06:44:32.744Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-05T06:44:32.744Z] GC before operation: completed in 23.125 ms, heap usage 49.507 MB -> 4.876 MB. [2026-03-05T06:44:33.879Z] Camera thread performed 122 scans. [2026-03-05T06:44:33.879Z] ====== philosophers (scala) [default], iteration 19 completed (917.986 ms) ====== [2026-03-05T06:44:33.879Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-05T06:44:33.879Z] GC before operation: completed in 25.984 ms, heap usage 53.005 MB -> 4.876 MB. [2026-03-05T06:44:34.606Z] Camera thread performed 122 scans. [2026-03-05T06:44:34.606Z] ====== philosophers (scala) [default], iteration 20 completed (919.162 ms) ====== [2026-03-05T06:44:34.606Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-05T06:44:34.606Z] GC before operation: completed in 26.158 ms, heap usage 55.511 MB -> 4.876 MB. [2026-03-05T06:44:35.741Z] Camera thread performed 122 scans. [2026-03-05T06:44:35.741Z] ====== philosophers (scala) [default], iteration 21 completed (871.501 ms) ====== [2026-03-05T06:44:35.741Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-05T06:44:35.741Z] GC before operation: completed in 24.003 ms, heap usage 11.475 MB -> 4.877 MB. [2026-03-05T06:44:36.562Z] Camera thread performed 122 scans. [2026-03-05T06:44:36.562Z] ====== philosophers (scala) [default], iteration 22 completed (898.022 ms) ====== [2026-03-05T06:44:36.562Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-05T06:44:36.562Z] GC before operation: completed in 24.220 ms, heap usage 44.901 MB -> 4.877 MB. [2026-03-05T06:44:37.686Z] Camera thread performed 122 scans. [2026-03-05T06:44:37.686Z] ====== philosophers (scala) [default], iteration 23 completed (953.418 ms) ====== [2026-03-05T06:44:37.686Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-05T06:44:37.686Z] GC before operation: completed in 27.147 ms, heap usage 54.005 MB -> 4.877 MB. [2026-03-05T06:44:38.414Z] Camera thread performed 122 scans. [2026-03-05T06:44:38.414Z] ====== philosophers (scala) [default], iteration 24 completed (893.772 ms) ====== [2026-03-05T06:44:38.414Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-05T06:44:38.414Z] GC before operation: completed in 21.950 ms, heap usage 33.798 MB -> 4.877 MB. [2026-03-05T06:44:39.538Z] Camera thread performed 122 scans. [2026-03-05T06:44:39.538Z] ====== philosophers (scala) [default], iteration 25 completed (924.039 ms) ====== [2026-03-05T06:44:39.538Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-05T06:44:39.538Z] GC before operation: completed in 25.475 ms, heap usage 16.506 MB -> 4.877 MB. [2026-03-05T06:44:40.259Z] Camera thread performed 122 scans. [2026-03-05T06:44:40.259Z] ====== philosophers (scala) [default], iteration 26 completed (996.281 ms) ====== [2026-03-05T06:44:40.259Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-05T06:44:40.259Z] GC before operation: completed in 21.783 ms, heap usage 14.383 MB -> 4.877 MB. [2026-03-05T06:44:41.374Z] Camera thread performed 122 scans. [2026-03-05T06:44:41.374Z] ====== philosophers (scala) [default], iteration 27 completed (954.685 ms) ====== [2026-03-05T06:44:41.374Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-05T06:44:41.374Z] GC before operation: completed in 25.133 ms, heap usage 5.822 MB -> 4.877 MB. [2026-03-05T06:44:42.505Z] Camera thread performed 122 scans. [2026-03-05T06:44:42.505Z] ====== philosophers (scala) [default], iteration 28 completed (932.960 ms) ====== [2026-03-05T06:44:42.505Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-05T06:44:42.505Z] GC before operation: completed in 23.072 ms, heap usage 61.005 MB -> 4.877 MB. [2026-03-05T06:44:43.245Z] Camera thread performed 122 scans. [2026-03-05T06:44:43.245Z] ====== philosophers (scala) [default], iteration 29 completed (917.579 ms) ====== [2026-03-05T06:44:43.574Z] ----------------------------------- [2026-03-05T06:44:43.574Z] renaissance-philosophers_0_PASSED [2026-03-05T06:44:43.574Z] ----------------------------------- [2026-03-05T06:44:43.574Z] [2026-03-05T06:44:43.574Z] TEST TEARDOWN: [2026-03-05T06:44:43.574Z] Nothing to be done for teardown. [2026-03-05T06:44:43.574Z] renaissance-philosophers_0 Finish Time: Thu Mar 5 06:44:43 2026 Epoch Time (ms): 1772693083498