[2026-01-21T07:33:04.501Z] Running test renaissance-philosophers_0 ... [2026-01-21T07:33:04.501Z] =============================================== [2026-01-21T07:33:04.501Z] renaissance-philosophers_0 Start Time: Wed Jan 21 07:33:04 2026 Epoch Time (ms): 1768980784152 [2026-01-21T07:33:04.501Z] variation: NoOptions [2026-01-21T07:33:04.501Z] JVM_OPTIONS: [2026-01-21T07:33:04.501Z] { \ [2026-01-21T07:33:04.501Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T07:33:04.501Z] echo "Nothing to be done for setup."; \ [2026-01-21T07:33:04.501Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689786632902/renaissance-philosophers_0"; \ [2026-01-21T07:33:04.501Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689786632902/renaissance-philosophers_0"; \ [2026-01-21T07:33:04.501Z] echo ""; echo "TESTING:"; \ [2026-01-21T07:33:04.501Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/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 "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689786632902/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-21T07:33:04.501Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689786632902/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T07:33:04.501Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T07:33:04.501Z] echo "Nothing to be done for teardown."; \ [2026-01-21T07:33:04.501Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689786632902/TestTargetResult"; [2026-01-21T07:33:04.501Z] [2026-01-21T07:33:04.501Z] TEST SETUP: [2026-01-21T07:33:04.501Z] Nothing to be done for setup. [2026-01-21T07:33:04.501Z] [2026-01-21T07:33:04.501Z] TESTING: [2026-01-21T07:33:05.310Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-21T07:33:05.310Z] GC before operation: completed in 16.291 ms, heap usage 5.597 MB -> 4.197 MB. [2026-01-21T07:33:07.597Z] Camera thread performed 122 scans. [2026-01-21T07:33:07.597Z] ====== philosophers (scala) [default], iteration 0 completed (2322.167 ms) ====== [2026-01-21T07:33:07.597Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-21T07:33:07.597Z] GC before operation: completed in 30.473 ms, heap usage 6.454 MB -> 4.620 MB. [2026-01-21T07:33:08.765Z] Camera thread performed 122 scans. [2026-01-21T07:33:08.765Z] ====== philosophers (scala) [default], iteration 1 completed (1034.298 ms) ====== [2026-01-21T07:33:08.765Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-21T07:33:08.765Z] GC before operation: completed in 28.484 ms, heap usage 41.728 MB -> 4.620 MB. [2026-01-21T07:33:09.489Z] Camera thread performed 122 scans. [2026-01-21T07:33:09.489Z] ====== philosophers (scala) [default], iteration 2 completed (864.034 ms) ====== [2026-01-21T07:33:09.489Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-21T07:33:09.489Z] GC before operation: completed in 27.445 ms, heap usage 23.729 MB -> 4.621 MB. [2026-01-21T07:33:10.658Z] Camera thread performed 122 scans. [2026-01-21T07:33:10.658Z] ====== philosophers (scala) [default], iteration 3 completed (844.400 ms) ====== [2026-01-21T07:33:10.658Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-21T07:33:10.658Z] GC before operation: completed in 15.131 ms, heap usage 7.878 MB -> 4.621 MB. [2026-01-21T07:33:11.376Z] Camera thread performed 122 scans. [2026-01-21T07:33:11.376Z] ====== philosophers (scala) [default], iteration 4 completed (874.527 ms) ====== [2026-01-21T07:33:11.376Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-21T07:33:11.376Z] GC before operation: completed in 15.098 ms, heap usage 21.831 MB -> 4.621 MB. [2026-01-21T07:33:12.162Z] Camera thread performed 122 scans. [2026-01-21T07:33:12.162Z] ====== philosophers (scala) [default], iteration 5 completed (833.302 ms) ====== [2026-01-21T07:33:12.162Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-21T07:33:12.162Z] GC before operation: completed in 17.039 ms, heap usage 60.314 MB -> 4.624 MB. [2026-01-21T07:33:12.879Z] Camera thread performed 122 scans. [2026-01-21T07:33:12.879Z] ====== philosophers (scala) [default], iteration 6 completed (839.442 ms) ====== [2026-01-21T07:33:12.879Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-21T07:33:12.879Z] GC before operation: completed in 17.569 ms, heap usage 58.779 MB -> 4.624 MB. [2026-01-21T07:33:14.060Z] Camera thread performed 122 scans. [2026-01-21T07:33:14.060Z] ====== philosophers (scala) [default], iteration 7 completed (849.133 ms) ====== [2026-01-21T07:33:14.060Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-21T07:33:14.060Z] GC before operation: completed in 24.180 ms, heap usage 42.761 MB -> 4.625 MB. [2026-01-21T07:33:14.780Z] Camera thread performed 122 scans. [2026-01-21T07:33:14.780Z] ====== philosophers (scala) [default], iteration 8 completed (843.578 ms) ====== [2026-01-21T07:33:14.780Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-21T07:33:14.780Z] GC before operation: completed in 18.691 ms, heap usage 69.258 MB -> 4.625 MB. [2026-01-21T07:33:15.508Z] Camera thread performed 122 scans. [2026-01-21T07:33:15.508Z] ====== philosophers (scala) [default], iteration 9 completed (830.624 ms) ====== [2026-01-21T07:33:15.508Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-21T07:33:15.508Z] GC before operation: completed in 16.949 ms, heap usage 27.260 MB -> 4.626 MB. [2026-01-21T07:33:16.672Z] Camera thread performed 122 scans. [2026-01-21T07:33:16.672Z] ====== philosophers (scala) [default], iteration 10 completed (828.637 ms) ====== [2026-01-21T07:33:16.672Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-21T07:33:16.672Z] GC before operation: completed in 17.000 ms, heap usage 19.754 MB -> 4.626 MB. [2026-01-21T07:33:17.394Z] Camera thread performed 122 scans. [2026-01-21T07:33:17.394Z] ====== philosophers (scala) [default], iteration 11 completed (838.331 ms) ====== [2026-01-21T07:33:17.394Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-21T07:33:17.394Z] GC before operation: completed in 18.629 ms, heap usage 58.752 MB -> 4.626 MB. [2026-01-21T07:33:18.118Z] Camera thread performed 122 scans. [2026-01-21T07:33:18.118Z] ====== philosophers (scala) [default], iteration 12 completed (861.518 ms) ====== [2026-01-21T07:33:18.118Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-21T07:33:18.118Z] GC before operation: completed in 16.349 ms, heap usage 38.762 MB -> 4.626 MB. [2026-01-21T07:33:19.316Z] Camera thread performed 122 scans. [2026-01-21T07:33:19.316Z] ====== philosophers (scala) [default], iteration 13 completed (839.884 ms) ====== [2026-01-21T07:33:19.316Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-21T07:33:19.316Z] GC before operation: completed in 17.031 ms, heap usage 17.257 MB -> 4.626 MB. [2026-01-21T07:33:20.037Z] Camera thread performed 122 scans. [2026-01-21T07:33:20.037Z] ====== philosophers (scala) [default], iteration 14 completed (828.152 ms) ====== [2026-01-21T07:33:20.037Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-21T07:33:20.037Z] GC before operation: completed in 16.503 ms, heap usage 34.253 MB -> 4.627 MB. [2026-01-21T07:33:20.756Z] Camera thread performed 122 scans. [2026-01-21T07:33:20.756Z] ====== philosophers (scala) [default], iteration 15 completed (836.569 ms) ====== [2026-01-21T07:33:20.756Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-21T07:33:20.756Z] GC before operation: completed in 16.921 ms, heap usage 44.762 MB -> 4.627 MB. [2026-01-21T07:33:21.475Z] Camera thread performed 122 scans. [2026-01-21T07:33:21.475Z] ====== philosophers (scala) [default], iteration 16 completed (830.561 ms) ====== [2026-01-21T07:33:21.475Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-21T07:33:21.475Z] GC before operation: completed in 18.661 ms, heap usage 50.250 MB -> 4.628 MB. [2026-01-21T07:33:22.644Z] Camera thread performed 122 scans. [2026-01-21T07:33:22.644Z] ====== philosophers (scala) [default], iteration 17 completed (830.333 ms) ====== [2026-01-21T07:33:22.644Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-21T07:33:22.644Z] GC before operation: completed in 17.349 ms, heap usage 52.256 MB -> 4.628 MB. [2026-01-21T07:33:23.451Z] Camera thread performed 122 scans. [2026-01-21T07:33:23.451Z] ====== philosophers (scala) [default], iteration 18 completed (837.674 ms) ====== [2026-01-21T07:33:23.451Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-21T07:33:23.451Z] GC before operation: completed in 17.347 ms, heap usage 42.257 MB -> 4.628 MB. [2026-01-21T07:33:24.179Z] Camera thread performed 122 scans. [2026-01-21T07:33:24.179Z] ====== philosophers (scala) [default], iteration 19 completed (835.207 ms) ====== [2026-01-21T07:33:24.179Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-21T07:33:24.179Z] GC before operation: completed in 17.015 ms, heap usage 55.251 MB -> 4.628 MB. [2026-01-21T07:33:24.901Z] Camera thread performed 122 scans. [2026-01-21T07:33:24.901Z] ====== philosophers (scala) [default], iteration 20 completed (847.049 ms) ====== [2026-01-21T07:33:24.901Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-21T07:33:24.901Z] GC before operation: completed in 18.144 ms, heap usage 29.762 MB -> 4.628 MB. [2026-01-21T07:33:26.069Z] Camera thread performed 122 scans. [2026-01-21T07:33:26.069Z] ====== philosophers (scala) [default], iteration 21 completed (848.515 ms) ====== [2026-01-21T07:33:26.069Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-21T07:33:26.069Z] GC before operation: completed in 18.630 ms, heap usage 14.764 MB -> 4.629 MB. [2026-01-21T07:33:26.792Z] Camera thread performed 122 scans. [2026-01-21T07:33:26.792Z] ====== philosophers (scala) [default], iteration 22 completed (846.105 ms) ====== [2026-01-21T07:33:26.792Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-21T07:33:26.792Z] GC before operation: completed in 18.881 ms, heap usage 72.266 MB -> 4.630 MB. [2026-01-21T07:33:27.518Z] Camera thread performed 122 scans. [2026-01-21T07:33:27.518Z] ====== philosophers (scala) [default], iteration 23 completed (843.617 ms) ====== [2026-01-21T07:33:27.518Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-21T07:33:27.518Z] GC before operation: completed in 16.581 ms, heap usage 12.763 MB -> 4.630 MB. [2026-01-21T07:33:28.682Z] Camera thread performed 122 scans. [2026-01-21T07:33:28.682Z] ====== philosophers (scala) [default], iteration 24 completed (837.857 ms) ====== [2026-01-21T07:33:28.682Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-21T07:33:28.682Z] GC before operation: completed in 17.131 ms, heap usage 56.761 MB -> 4.631 MB. [2026-01-21T07:33:29.405Z] Camera thread performed 122 scans. [2026-01-21T07:33:29.405Z] ====== philosophers (scala) [default], iteration 25 completed (840.325 ms) ====== [2026-01-21T07:33:29.405Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-21T07:33:29.405Z] GC before operation: completed in 17.505 ms, heap usage 57.262 MB -> 4.630 MB. [2026-01-21T07:33:30.132Z] Camera thread performed 122 scans. [2026-01-21T07:33:30.132Z] ====== philosophers (scala) [default], iteration 26 completed (838.456 ms) ====== [2026-01-21T07:33:30.132Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-21T07:33:30.132Z] GC before operation: completed in 17.558 ms, heap usage 14.761 MB -> 4.631 MB. [2026-01-21T07:33:31.294Z] Camera thread performed 122 scans. [2026-01-21T07:33:31.294Z] ====== philosophers (scala) [default], iteration 27 completed (845.135 ms) ====== [2026-01-21T07:33:31.294Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-21T07:33:31.294Z] GC before operation: completed in 17.472 ms, heap usage 33.264 MB -> 4.631 MB. [2026-01-21T07:33:32.015Z] Camera thread performed 122 scans. [2026-01-21T07:33:32.015Z] ====== philosophers (scala) [default], iteration 28 completed (843.037 ms) ====== [2026-01-21T07:33:32.015Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-21T07:33:32.015Z] GC before operation: completed in 34.785 ms, heap usage 62.757 MB -> 4.631 MB. [2026-01-21T07:33:32.741Z] Camera thread performed 122 scans. [2026-01-21T07:33:32.741Z] ====== philosophers (scala) [default], iteration 29 completed (904.519 ms) ====== [2026-01-21T07:33:33.075Z] ----------------------------------- [2026-01-21T07:33:33.075Z] renaissance-philosophers_0_PASSED [2026-01-21T07:33:33.075Z] ----------------------------------- [2026-01-21T07:33:33.075Z] [2026-01-21T07:33:33.075Z] TEST TEARDOWN: [2026-01-21T07:33:33.075Z] Nothing to be done for teardown. [2026-01-21T07:33:33.075Z] renaissance-philosophers_0 Finish Time: Wed Jan 21 07:33:32 2026 Epoch Time (ms): 1768980812897