[2026-03-04T23:30:51.049Z] Running test renaissance-philosophers_0 ... [2026-03-04T23:30:51.049Z] =============================================== [2026-03-04T23:30:51.049Z] renaissance-philosophers_0 Start Time: Wed Mar 4 23:30:50 2026 Epoch Time (ms): 1772667050900 [2026-03-04T23:30:51.049Z] variation: NoOptions [2026-03-04T23:30:51.049Z] JVM_OPTIONS: [2026-03-04T23:30:51.049Z] { \ [2026-03-04T23:30:51.049Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T23:30:51.049Z] echo "Nothing to be done for setup."; \ [2026-03-04T23:30:51.049Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/renaissance-philosophers_0"; \ [2026-03-04T23:30:51.049Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/renaissance-philosophers_0"; \ [2026-03-04T23:30:51.049Z] echo ""; echo "TESTING:"; \ [2026-03-04T23:30:51.049Z] "/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_17726649278792/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-03-04T23:30:51.049Z] 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_17726649278792/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T23:30:51.049Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T23:30:51.049Z] echo "Nothing to be done for teardown."; \ [2026-03-04T23:30:51.049Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/TestTargetResult"; [2026-03-04T23:30:51.049Z] [2026-03-04T23:30:51.049Z] TEST SETUP: [2026-03-04T23:30:51.049Z] Nothing to be done for setup. [2026-03-04T23:30:51.049Z] [2026-03-04T23:30:51.049Z] TESTING: [2026-03-04T23:30:52.224Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-04T23:30:52.224Z] GC before operation: completed in 19.727 ms, heap usage 16.908 MB -> 4.213 MB. [2026-03-04T23:30:54.598Z] Camera thread performed 122 scans. [2026-03-04T23:30:54.598Z] ====== philosophers (scala) [default], iteration 0 completed (2173.654 ms) ====== [2026-03-04T23:30:54.598Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-04T23:30:54.598Z] GC before operation: completed in 23.020 ms, heap usage 48.537 MB -> 4.620 MB. [2026-03-04T23:30:55.340Z] Camera thread performed 122 scans. [2026-03-04T23:30:55.340Z] ====== philosophers (scala) [default], iteration 1 completed (1052.957 ms) ====== [2026-03-04T23:30:55.340Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-04T23:30:55.340Z] GC before operation: completed in 16.594 ms, heap usage 33.409 MB -> 4.621 MB. [2026-03-04T23:30:56.072Z] Camera thread performed 122 scans. [2026-03-04T23:30:56.072Z] ====== philosophers (scala) [default], iteration 2 completed (829.808 ms) ====== [2026-03-04T23:30:56.072Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-04T23:30:56.072Z] GC before operation: completed in 14.955 ms, heap usage 17.731 MB -> 4.622 MB. [2026-03-04T23:30:56.805Z] Camera thread performed 122 scans. [2026-03-04T23:30:56.806Z] ====== philosophers (scala) [default], iteration 3 completed (831.936 ms) ====== [2026-03-04T23:30:56.806Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-04T23:30:56.806Z] GC before operation: completed in 15.229 ms, heap usage 21.363 MB -> 4.621 MB. [2026-03-04T23:30:57.990Z] Camera thread performed 122 scans. [2026-03-04T23:30:57.990Z] ====== philosophers (scala) [default], iteration 4 completed (826.932 ms) ====== [2026-03-04T23:30:57.990Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-04T23:30:57.990Z] GC before operation: completed in 16.036 ms, heap usage 36.831 MB -> 4.622 MB. [2026-03-04T23:30:58.718Z] Camera thread performed 122 scans. [2026-03-04T23:30:58.719Z] ====== philosophers (scala) [default], iteration 5 completed (830.527 ms) ====== [2026-03-04T23:30:58.719Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-04T23:30:58.719Z] GC before operation: completed in 16.820 ms, heap usage 32.802 MB -> 4.625 MB. [2026-03-04T23:30:59.449Z] Camera thread performed 122 scans. [2026-03-04T23:30:59.449Z] ====== philosophers (scala) [default], iteration 6 completed (826.451 ms) ====== [2026-03-04T23:30:59.449Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-04T23:30:59.449Z] GC before operation: completed in 15.804 ms, heap usage 12.788 MB -> 4.626 MB. [2026-03-04T23:31:00.182Z] Camera thread performed 122 scans. [2026-03-04T23:31:00.182Z] ====== philosophers (scala) [default], iteration 7 completed (839.686 ms) ====== [2026-03-04T23:31:00.182Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-04T23:31:00.521Z] GC before operation: completed in 17.023 ms, heap usage 51.780 MB -> 4.626 MB. [2026-03-04T23:31:01.355Z] Camera thread performed 122 scans. [2026-03-04T23:31:01.355Z] ====== philosophers (scala) [default], iteration 8 completed (846.031 ms) ====== [2026-03-04T23:31:01.355Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-04T23:31:01.355Z] GC before operation: completed in 17.084 ms, heap usage 38.764 MB -> 4.626 MB. [2026-03-04T23:31:02.097Z] Camera thread performed 122 scans. [2026-03-04T23:31:02.097Z] ====== philosophers (scala) [default], iteration 9 completed (831.469 ms) ====== [2026-03-04T23:31:02.097Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-04T23:31:02.097Z] GC before operation: completed in 16.511 ms, heap usage 34.251 MB -> 4.626 MB. [2026-03-04T23:31:02.828Z] Camera thread performed 122 scans. [2026-03-04T23:31:02.828Z] ====== philosophers (scala) [default], iteration 10 completed (804.947 ms) ====== [2026-03-04T23:31:02.828Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-04T23:31:02.828Z] GC before operation: completed in 16.382 ms, heap usage 52.252 MB -> 4.627 MB. [2026-03-04T23:31:04.049Z] Camera thread performed 122 scans. [2026-03-04T23:31:04.049Z] ====== philosophers (scala) [default], iteration 11 completed (833.731 ms) ====== [2026-03-04T23:31:04.049Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-04T23:31:04.049Z] GC before operation: completed in 18.056 ms, heap usage 66.256 MB -> 4.627 MB. [2026-03-04T23:31:04.778Z] Camera thread performed 122 scans. [2026-03-04T23:31:04.779Z] ====== philosophers (scala) [default], iteration 12 completed (832.086 ms) ====== [2026-03-04T23:31:04.779Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-04T23:31:04.779Z] GC before operation: completed in 17.430 ms, heap usage 55.755 MB -> 4.629 MB. [2026-03-04T23:31:05.510Z] Camera thread performed 122 scans. [2026-03-04T23:31:05.510Z] ====== philosophers (scala) [default], iteration 13 completed (848.086 ms) ====== [2026-03-04T23:31:05.510Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-04T23:31:05.510Z] GC before operation: completed in 16.595 ms, heap usage 45.755 MB -> 4.628 MB. [2026-03-04T23:31:06.240Z] Camera thread performed 122 scans. [2026-03-04T23:31:06.240Z] ====== philosophers (scala) [default], iteration 14 completed (864.691 ms) ====== [2026-03-04T23:31:06.240Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-04T23:31:06.240Z] GC before operation: completed in 15.670 ms, heap usage 16.265 MB -> 4.629 MB. [2026-03-04T23:31:07.447Z] Camera thread performed 122 scans. [2026-03-04T23:31:07.447Z] ====== philosophers (scala) [default], iteration 15 completed (832.768 ms) ====== [2026-03-04T23:31:07.447Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-04T23:31:07.447Z] GC before operation: completed in 17.747 ms, heap usage 37.260 MB -> 4.629 MB. [2026-03-04T23:31:08.173Z] Camera thread performed 122 scans. [2026-03-04T23:31:08.173Z] ====== philosophers (scala) [default], iteration 16 completed (836.347 ms) ====== [2026-03-04T23:31:08.173Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-04T23:31:08.173Z] GC before operation: completed in 17.782 ms, heap usage 71.756 MB -> 4.630 MB. [2026-03-04T23:31:08.902Z] Camera thread performed 122 scans. [2026-03-04T23:31:08.902Z] ====== philosophers (scala) [default], iteration 17 completed (841.610 ms) ====== [2026-03-04T23:31:08.902Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-04T23:31:08.902Z] GC before operation: completed in 16.575 ms, heap usage 38.762 MB -> 4.630 MB. [2026-03-04T23:31:09.631Z] Camera thread performed 122 scans. [2026-03-04T23:31:09.631Z] ====== philosophers (scala) [default], iteration 18 completed (832.545 ms) ====== [2026-03-04T23:31:09.631Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-04T23:31:09.631Z] GC before operation: completed in 17.670 ms, heap usage 35.260 MB -> 4.630 MB. [2026-03-04T23:31:10.811Z] Camera thread performed 122 scans. [2026-03-04T23:31:10.811Z] ====== philosophers (scala) [default], iteration 19 completed (853.675 ms) ====== [2026-03-04T23:31:10.811Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-04T23:31:10.811Z] GC before operation: completed in 17.015 ms, heap usage 56.264 MB -> 4.630 MB. [2026-03-04T23:31:11.542Z] Camera thread performed 122 scans. [2026-03-04T23:31:11.542Z] ====== philosophers (scala) [default], iteration 20 completed (843.792 ms) ====== [2026-03-04T23:31:11.542Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-04T23:31:11.542Z] GC before operation: completed in 16.720 ms, heap usage 8.765 MB -> 4.630 MB. [2026-03-04T23:31:12.275Z] Camera thread performed 122 scans. [2026-03-04T23:31:12.275Z] ====== philosophers (scala) [default], iteration 21 completed (824.251 ms) ====== [2026-03-04T23:31:12.275Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-04T23:31:12.275Z] GC before operation: completed in 17.494 ms, heap usage 66.260 MB -> 4.631 MB. [2026-03-04T23:31:13.041Z] Camera thread performed 122 scans. [2026-03-04T23:31:13.041Z] ====== philosophers (scala) [default], iteration 22 completed (839.714 ms) ====== [2026-03-04T23:31:13.041Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-04T23:31:13.041Z] GC before operation: completed in 17.172 ms, heap usage 57.760 MB -> 4.631 MB. [2026-03-04T23:31:14.300Z] Camera thread performed 122 scans. [2026-03-04T23:31:14.300Z] ====== philosophers (scala) [default], iteration 23 completed (839.747 ms) ====== [2026-03-04T23:31:14.300Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-04T23:31:14.300Z] GC before operation: completed in 18.556 ms, heap usage 75.750 MB -> 4.631 MB. [2026-03-04T23:31:15.155Z] Camera thread performed 122 scans. [2026-03-04T23:31:15.155Z] ====== philosophers (scala) [default], iteration 24 completed (838.763 ms) ====== [2026-03-04T23:31:15.155Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-04T23:31:15.155Z] GC before operation: completed in 17.273 ms, heap usage 61.758 MB -> 4.631 MB. [2026-03-04T23:31:15.964Z] Camera thread performed 122 scans. [2026-03-04T23:31:15.964Z] ====== philosophers (scala) [default], iteration 25 completed (837.152 ms) ====== [2026-03-04T23:31:15.964Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-04T23:31:15.964Z] GC before operation: completed in 16.930 ms, heap usage 40.260 MB -> 4.631 MB. [2026-03-04T23:31:16.691Z] Camera thread performed 122 scans. [2026-03-04T23:31:16.691Z] ====== philosophers (scala) [default], iteration 26 completed (827.197 ms) ====== [2026-03-04T23:31:16.691Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-04T23:31:16.691Z] GC before operation: completed in 19.863 ms, heap usage 44.751 MB -> 4.631 MB. [2026-03-04T23:31:17.510Z] Camera thread performed 122 scans. [2026-03-04T23:31:17.510Z] ====== philosophers (scala) [default], iteration 27 completed (821.255 ms) ====== [2026-03-04T23:31:17.510Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-04T23:31:17.510Z] GC before operation: completed in 16.501 ms, heap usage 25.259 MB -> 4.631 MB. [2026-03-04T23:31:18.240Z] Camera thread performed 122 scans. [2026-03-04T23:31:18.240Z] ====== philosophers (scala) [default], iteration 28 completed (818.932 ms) ====== [2026-03-04T23:31:18.241Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-04T23:31:18.241Z] GC before operation: completed in 17.006 ms, heap usage 17.232 MB -> 4.631 MB. [2026-03-04T23:31:18.968Z] Camera thread performed 122 scans. [2026-03-04T23:31:18.968Z] ====== philosophers (scala) [default], iteration 29 completed (822.897 ms) ====== [2026-03-04T23:31:19.305Z] ----------------------------------- [2026-03-04T23:31:19.305Z] renaissance-philosophers_0_PASSED [2026-03-04T23:31:19.305Z] ----------------------------------- [2026-03-04T23:31:19.305Z] [2026-03-04T23:31:19.305Z] TEST TEARDOWN: [2026-03-04T23:31:19.305Z] Nothing to be done for teardown. [2026-03-04T23:31:19.305Z] renaissance-philosophers_0 Finish Time: Wed Mar 4 23:31:19 2026 Epoch Time (ms): 1772667079176