[2026-04-23T14:31:55.649Z] Running test renaissance-philosophers_0 ... [2026-04-23T14:31:55.649Z] =============================================== [2026-04-23T14:31:55.649Z] renaissance-philosophers_0 Start Time: Thu Apr 23 14:31:54 2026 Epoch Time (ms): 1776954714695 [2026-04-23T14:31:55.649Z] variation: NoOptions [2026-04-23T14:31:55.649Z] JVM_OPTIONS: [2026-04-23T14:31:55.649Z] { \ [2026-04-23T14:31:55.649Z] echo ""; echo "TEST SETUP:"; \ [2026-04-23T14:31:55.649Z] echo "Nothing to be done for setup."; \ [2026-04-23T14:31:55.649Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-philosophers_0"; \ [2026-04-23T14:31:55.649Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-philosophers_0"; \ [2026-04-23T14:31:55.649Z] echo ""; echo "TESTING:"; \ [2026-04-23T14:31:55.649Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_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_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-04-23T14:31:55.649Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-23T14:31:55.649Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-23T14:31:55.649Z] echo "Nothing to be done for teardown."; \ [2026-04-23T14:31:55.649Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/TestTargetResult"; [2026-04-23T14:31:55.649Z] [2026-04-23T14:31:55.649Z] TEST SETUP: [2026-04-23T14:31:55.649Z] Nothing to be done for setup. [2026-04-23T14:31:55.649Z] [2026-04-23T14:31:55.649Z] TESTING: [2026-04-23T14:31:56.297Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-04-23T14:31:56.297Z] GC before operation: completed in 40.802 ms, heap usage 18.472 MB -> 4.829 MB. [2026-04-23T14:31:58.497Z] Camera thread performed 122 scans. [2026-04-23T14:31:58.497Z] ====== philosophers (scala) [default], iteration 0 completed (1733.392 ms) ====== [2026-04-23T14:31:58.497Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-04-23T14:31:58.497Z] GC before operation: completed in 25.684 ms, heap usage 34.408 MB -> 5.200 MB. [2026-04-23T14:31:59.195Z] Camera thread performed 122 scans. [2026-04-23T14:31:59.195Z] ====== philosophers (scala) [default], iteration 1 completed (961.980 ms) ====== [2026-04-23T14:31:59.195Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-04-23T14:31:59.195Z] GC before operation: completed in 23.510 ms, heap usage 8.082 MB -> 5.201 MB. [2026-04-23T14:31:59.864Z] Camera thread performed 122 scans. [2026-04-23T14:31:59.864Z] ====== philosophers (scala) [default], iteration 2 completed (750.952 ms) ====== [2026-04-23T14:31:59.864Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-04-23T14:31:59.864Z] GC before operation: completed in 29.481 ms, heap usage 42.285 MB -> 5.202 MB. [2026-04-23T14:32:00.507Z] Camera thread performed 122 scans. [2026-04-23T14:32:00.507Z] ====== philosophers (scala) [default], iteration 3 completed (765.053 ms) ====== [2026-04-23T14:32:00.507Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-04-23T14:32:00.507Z] GC before operation: completed in 9.680 ms, heap usage 33.907 MB -> 5.202 MB. [2026-04-23T14:32:01.185Z] Camera thread performed 122 scans. [2026-04-23T14:32:01.186Z] ====== philosophers (scala) [default], iteration 4 completed (693.576 ms) ====== [2026-04-23T14:32:01.186Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-04-23T14:32:01.186Z] GC before operation: completed in 17.051 ms, heap usage 47.114 MB -> 5.202 MB. [2026-04-23T14:32:02.577Z] Camera thread performed 122 scans. [2026-04-23T14:32:02.577Z] ====== philosophers (scala) [default], iteration 5 completed (794.763 ms) ====== [2026-04-23T14:32:02.577Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-04-23T14:32:02.577Z] GC before operation: completed in 23.897 ms, heap usage 15.306 MB -> 5.202 MB. [2026-04-23T14:32:03.226Z] Camera thread performed 122 scans. [2026-04-23T14:32:03.226Z] ====== philosophers (scala) [default], iteration 6 completed (833.654 ms) ====== [2026-04-23T14:32:03.226Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-04-23T14:32:03.226Z] GC before operation: completed in 29.232 ms, heap usage 21.215 MB -> 5.203 MB. [2026-04-23T14:32:03.886Z] Camera thread performed 122 scans. [2026-04-23T14:32:03.886Z] ====== philosophers (scala) [default], iteration 7 completed (718.459 ms) ====== [2026-04-23T14:32:03.886Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-04-23T14:32:03.886Z] GC before operation: completed in 20.657 ms, heap usage 40.328 MB -> 5.203 MB. [2026-04-23T14:32:04.583Z] Camera thread performed 122 scans. [2026-04-23T14:32:04.583Z] ====== philosophers (scala) [default], iteration 8 completed (691.647 ms) ====== [2026-04-23T14:32:04.583Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-04-23T14:32:04.583Z] GC before operation: completed in 19.676 ms, heap usage 47.783 MB -> 5.203 MB. [2026-04-23T14:32:05.244Z] Camera thread performed 122 scans. [2026-04-23T14:32:05.244Z] ====== philosophers (scala) [default], iteration 9 completed (679.316 ms) ====== [2026-04-23T14:32:05.244Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-04-23T14:32:05.244Z] GC before operation: completed in 13.280 ms, heap usage 56.825 MB -> 5.203 MB. [2026-04-23T14:32:06.625Z] Camera thread performed 122 scans. [2026-04-23T14:32:06.626Z] ====== philosophers (scala) [default], iteration 10 completed (1051.135 ms) ====== [2026-04-23T14:32:06.626Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-04-23T14:32:06.626Z] GC before operation: completed in 12.077 ms, heap usage 22.643 MB -> 5.203 MB. [2026-04-23T14:32:06.626Z] Camera thread performed 122 scans. [2026-04-23T14:32:06.626Z] ====== philosophers (scala) [default], iteration 11 completed (687.994 ms) ====== [2026-04-23T14:32:06.626Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-04-23T14:32:07.268Z] GC before operation: completed in 19.930 ms, heap usage 50.277 MB -> 5.203 MB. [2026-04-23T14:32:07.920Z] Camera thread performed 122 scans. [2026-04-23T14:32:07.920Z] ====== philosophers (scala) [default], iteration 12 completed (897.920 ms) ====== [2026-04-23T14:32:07.920Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-04-23T14:32:07.920Z] GC before operation: completed in 15.945 ms, heap usage 58.729 MB -> 5.204 MB. [2026-04-23T14:32:08.596Z] Camera thread performed 122 scans. [2026-04-23T14:32:08.596Z] ====== philosophers (scala) [default], iteration 13 completed (812.118 ms) ====== [2026-04-23T14:32:08.596Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-04-23T14:32:08.596Z] GC before operation: completed in 13.432 ms, heap usage 37.827 MB -> 5.204 MB. [2026-04-23T14:32:09.276Z] Camera thread performed 122 scans. [2026-04-23T14:32:09.276Z] ====== philosophers (scala) [default], iteration 14 completed (837.792 ms) ====== [2026-04-23T14:32:09.276Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-04-23T14:32:09.276Z] GC before operation: completed in 12.569 ms, heap usage 71.038 MB -> 5.204 MB. [2026-04-23T14:32:10.679Z] Camera thread performed 122 scans. [2026-04-23T14:32:10.679Z] ====== philosophers (scala) [default], iteration 15 completed (851.479 ms) ====== [2026-04-23T14:32:10.679Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-04-23T14:32:10.679Z] GC before operation: completed in 11.867 ms, heap usage 21.769 MB -> 5.204 MB. [2026-04-23T14:32:11.371Z] Camera thread performed 122 scans. [2026-04-23T14:32:11.371Z] ====== philosophers (scala) [default], iteration 16 completed (954.648 ms) ====== [2026-04-23T14:32:11.371Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-04-23T14:32:11.371Z] GC before operation: completed in 16.426 ms, heap usage 19.220 MB -> 5.205 MB. [2026-04-23T14:32:12.026Z] Camera thread performed 122 scans. [2026-04-23T14:32:12.026Z] ====== philosophers (scala) [default], iteration 17 completed (707.081 ms) ====== [2026-04-23T14:32:12.026Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-04-23T14:32:12.026Z] GC before operation: completed in 14.059 ms, heap usage 9.802 MB -> 5.205 MB. [2026-04-23T14:32:12.684Z] Camera thread performed 122 scans. [2026-04-23T14:32:12.684Z] ====== philosophers (scala) [default], iteration 18 completed (873.723 ms) ====== [2026-04-23T14:32:12.684Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-04-23T14:32:13.334Z] GC before operation: completed in 24.548 ms, heap usage 25.308 MB -> 5.206 MB. [2026-04-23T14:32:13.996Z] Camera thread performed 122 scans. [2026-04-23T14:32:13.996Z] ====== philosophers (scala) [default], iteration 19 completed (819.671 ms) ====== [2026-04-23T14:32:13.996Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-04-23T14:32:13.996Z] GC before operation: completed in 16.246 ms, heap usage 17.804 MB -> 5.206 MB. [2026-04-23T14:32:14.662Z] Camera thread performed 122 scans. [2026-04-23T14:32:14.662Z] ====== philosophers (scala) [default], iteration 20 completed (851.274 ms) ====== [2026-04-23T14:32:14.662Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-04-23T14:32:14.662Z] GC before operation: completed in 34.045 ms, heap usage 44.138 MB -> 5.206 MB. [2026-04-23T14:32:15.314Z] Camera thread performed 122 scans. [2026-04-23T14:32:15.314Z] ====== philosophers (scala) [default], iteration 21 completed (742.922 ms) ====== [2026-04-23T14:32:15.314Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-04-23T14:32:15.314Z] GC before operation: completed in 13.921 ms, heap usage 32.291 MB -> 5.206 MB. [2026-04-23T14:32:15.959Z] Camera thread performed 122 scans. [2026-04-23T14:32:15.959Z] ====== philosophers (scala) [default], iteration 22 completed (744.154 ms) ====== [2026-04-23T14:32:15.959Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-04-23T14:32:15.959Z] GC before operation: completed in 13.213 ms, heap usage 13.298 MB -> 5.207 MB. [2026-04-23T14:32:17.297Z] Camera thread performed 122 scans. [2026-04-23T14:32:17.297Z] ====== philosophers (scala) [default], iteration 23 completed (692.567 ms) ====== [2026-04-23T14:32:17.297Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-04-23T14:32:17.297Z] GC before operation: completed in 20.748 ms, heap usage 52.324 MB -> 5.206 MB. [2026-04-23T14:32:17.965Z] Camera thread performed 122 scans. [2026-04-23T14:32:17.966Z] ====== philosophers (scala) [default], iteration 24 completed (708.759 ms) ====== [2026-04-23T14:32:17.966Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-04-23T14:32:17.966Z] GC before operation: completed in 13.805 ms, heap usage 34.799 MB -> 5.227 MB. [2026-04-23T14:32:18.602Z] Camera thread performed 122 scans. [2026-04-23T14:32:18.602Z] ====== philosophers (scala) [default], iteration 25 completed (894.265 ms) ====== [2026-04-23T14:32:18.602Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-04-23T14:32:18.602Z] GC before operation: completed in 14.749 ms, heap usage 30.799 MB -> 5.207 MB. [2026-04-23T14:32:19.262Z] Camera thread performed 122 scans. [2026-04-23T14:32:19.262Z] ====== philosophers (scala) [default], iteration 26 completed (883.586 ms) ====== [2026-04-23T14:32:19.262Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-04-23T14:32:19.262Z] GC before operation: completed in 23.952 ms, heap usage 49.821 MB -> 5.207 MB. [2026-04-23T14:32:20.627Z] Camera thread performed 122 scans. [2026-04-23T14:32:20.627Z] ====== philosophers (scala) [default], iteration 27 completed (729.292 ms) ====== [2026-04-23T14:32:20.627Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-04-23T14:32:20.627Z] GC before operation: completed in 12.873 ms, heap usage 22.334 MB -> 5.207 MB. [2026-04-23T14:32:20.627Z] Camera thread performed 122 scans. [2026-04-23T14:32:20.627Z] ====== philosophers (scala) [default], iteration 28 completed (697.635 ms) ====== [2026-04-23T14:32:20.627Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-04-23T14:32:21.258Z] GC before operation: completed in 20.174 ms, heap usage 17.780 MB -> 5.207 MB. [2026-04-23T14:32:21.894Z] Camera thread performed 122 scans. [2026-04-23T14:32:21.894Z] ====== philosophers (scala) [default], iteration 29 completed (700.724 ms) ====== [2026-04-23T14:32:21.894Z] ----------------------------------- [2026-04-23T14:32:21.894Z] renaissance-philosophers_0_PASSED [2026-04-23T14:32:21.894Z] ----------------------------------- [2026-04-23T14:32:21.894Z] [2026-04-23T14:32:21.894Z] TEST TEARDOWN: [2026-04-23T14:32:21.894Z] Nothing to be done for teardown. [2026-04-23T14:32:21.894Z] renaissance-philosophers_0 Finish Time: Thu Apr 23 14:32:21 2026 Epoch Time (ms): 1776954741461