[2026-03-04T23:50:15.305Z] Running test renaissance-philosophers_0 ... [2026-03-04T23:50:15.305Z] =============================================== [2026-03-04T23:50:15.305Z] renaissance-philosophers_0 Start Time: Wed Mar 4 23:50:15 2026 Epoch Time (ms): 1772668215048 [2026-03-04T23:50:15.305Z] variation: NoOptions [2026-03-04T23:50:15.305Z] JVM_OPTIONS: [2026-03-04T23:50:15.305Z] { \ [2026-03-04T23:50:15.305Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T23:50:15.305Z] echo "Nothing to be done for setup."; \ [2026-03-04T23:50:15.305Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17726666307044/renaissance-philosophers_0"; \ [2026-03-04T23:50:15.305Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17726666307044/renaissance-philosophers_0"; \ [2026-03-04T23:50:15.305Z] echo ""; echo "TESTING:"; \ [2026-03-04T23:50:15.305Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17726666307044/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-03-04T23:50:15.305Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17726666307044/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T23:50:15.305Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T23:50:15.305Z] echo "Nothing to be done for teardown."; \ [2026-03-04T23:50:15.305Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17726666307044/TestTargetResult"; [2026-03-04T23:50:15.305Z] [2026-03-04T23:50:15.305Z] TEST SETUP: [2026-03-04T23:50:15.305Z] Nothing to be done for setup. [2026-03-04T23:50:15.305Z] [2026-03-04T23:50:15.305Z] TESTING: [2026-03-04T23:50:15.926Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-04T23:50:15.926Z] GC before operation: completed in 18.514 ms, heap usage 8.089 MB -> 4.393 MB. [2026-03-04T23:50:17.917Z] Camera thread performed 122 scans. [2026-03-04T23:50:17.917Z] ====== philosophers (scala) [default], iteration 0 completed (1463.688 ms) ====== [2026-03-04T23:50:17.917Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-04T23:50:17.917Z] GC before operation: completed in 14.854 ms, heap usage 20.788 MB -> 4.805 MB. [2026-03-04T23:50:18.525Z] Camera thread performed 122 scans. [2026-03-04T23:50:18.525Z] ====== philosophers (scala) [default], iteration 1 completed (962.552 ms) ====== [2026-03-04T23:50:18.525Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-04T23:50:18.525Z] GC before operation: completed in 12.958 ms, heap usage 9.935 MB -> 4.808 MB. [2026-03-04T23:50:19.846Z] Camera thread performed 122 scans. [2026-03-04T23:50:19.846Z] ====== philosophers (scala) [default], iteration 2 completed (847.854 ms) ====== [2026-03-04T23:50:19.846Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-04T23:50:19.846Z] GC before operation: completed in 12.509 ms, heap usage 19.491 MB -> 4.808 MB. [2026-03-04T23:50:19.846Z] Camera thread performed 122 scans. [2026-03-04T23:50:19.846Z] ====== philosophers (scala) [default], iteration 3 completed (601.910 ms) ====== [2026-03-04T23:50:19.846Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-04T23:50:19.846Z] GC before operation: completed in 15.329 ms, heap usage 47.091 MB -> 4.808 MB. [2026-03-04T23:50:21.121Z] Camera thread performed 122 scans. [2026-03-04T23:50:21.121Z] ====== philosophers (scala) [default], iteration 4 completed (874.323 ms) ====== [2026-03-04T23:50:21.121Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-04T23:50:21.121Z] GC before operation: completed in 16.718 ms, heap usage 25.998 MB -> 4.812 MB. [2026-03-04T23:50:22.395Z] Camera thread performed 122 scans. [2026-03-04T23:50:22.395Z] ====== philosophers (scala) [default], iteration 5 completed (1125.971 ms) ====== [2026-03-04T23:50:22.395Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-04T23:50:22.395Z] GC before operation: completed in 15.756 ms, heap usage 22.657 MB -> 4.812 MB. [2026-03-04T23:50:23.001Z] Camera thread performed 122 scans. [2026-03-04T23:50:23.001Z] ====== philosophers (scala) [default], iteration 6 completed (989.152 ms) ====== [2026-03-04T23:50:23.001Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-04T23:50:23.001Z] GC before operation: completed in 16.367 ms, heap usage 17.976 MB -> 4.813 MB. [2026-03-04T23:50:24.272Z] Camera thread performed 122 scans. [2026-03-04T23:50:24.272Z] ====== philosophers (scala) [default], iteration 7 completed (1096.188 ms) ====== [2026-03-04T23:50:24.272Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-04T23:50:24.272Z] GC before operation: completed in 14.591 ms, heap usage 18.467 MB -> 4.813 MB. [2026-03-04T23:50:25.533Z] Camera thread performed 122 scans. [2026-03-04T23:50:25.533Z] ====== philosophers (scala) [default], iteration 8 completed (1052.760 ms) ====== [2026-03-04T23:50:25.533Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-04T23:50:25.533Z] GC before operation: completed in 14.641 ms, heap usage 14.365 MB -> 4.815 MB. [2026-03-04T23:50:26.795Z] Camera thread performed 122 scans. [2026-03-04T23:50:26.795Z] ====== philosophers (scala) [default], iteration 9 completed (1205.182 ms) ====== [2026-03-04T23:50:26.795Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-04T23:50:26.795Z] GC before operation: completed in 17.940 ms, heap usage 23.547 MB -> 4.816 MB. [2026-03-04T23:50:27.417Z] Camera thread performed 122 scans. [2026-03-04T23:50:27.417Z] ====== philosophers (scala) [default], iteration 10 completed (659.188 ms) ====== [2026-03-04T23:50:27.417Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-04T23:50:27.417Z] GC before operation: completed in 13.859 ms, heap usage 27.371 MB -> 4.815 MB. [2026-03-04T23:50:28.059Z] Camera thread performed 122 scans. [2026-03-04T23:50:28.059Z] ====== philosophers (scala) [default], iteration 11 completed (641.781 ms) ====== [2026-03-04T23:50:28.059Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-04T23:50:28.059Z] GC before operation: completed in 18.671 ms, heap usage 27.458 MB -> 4.817 MB. [2026-03-04T23:50:28.668Z] Camera thread performed 122 scans. [2026-03-04T23:50:28.668Z] ====== philosophers (scala) [default], iteration 12 completed (649.190 ms) ====== [2026-03-04T23:50:28.668Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-04T23:50:28.668Z] GC before operation: completed in 13.488 ms, heap usage 30.327 MB -> 4.817 MB. [2026-03-04T23:50:29.280Z] Camera thread performed 122 scans. [2026-03-04T23:50:29.280Z] ====== philosophers (scala) [default], iteration 13 completed (820.806 ms) ====== [2026-03-04T23:50:29.280Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-04T23:50:29.280Z] GC before operation: completed in 14.216 ms, heap usage 5.443 MB -> 4.817 MB. [2026-03-04T23:50:29.925Z] Camera thread performed 122 scans. [2026-03-04T23:50:29.925Z] ====== philosophers (scala) [default], iteration 14 completed (805.960 ms) ====== [2026-03-04T23:50:29.925Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-04T23:50:29.925Z] GC before operation: completed in 14.784 ms, heap usage 30.425 MB -> 4.817 MB. [2026-03-04T23:50:31.211Z] Camera thread performed 122 scans. [2026-03-04T23:50:31.211Z] ====== philosophers (scala) [default], iteration 15 completed (736.956 ms) ====== [2026-03-04T23:50:31.211Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-04T23:50:31.211Z] GC before operation: completed in 14.982 ms, heap usage 39.357 MB -> 4.818 MB. [2026-03-04T23:50:31.866Z] Camera thread performed 122 scans. [2026-03-04T23:50:31.866Z] ====== philosophers (scala) [default], iteration 16 completed (792.387 ms) ====== [2026-03-04T23:50:31.866Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-04T23:50:31.866Z] GC before operation: completed in 14.809 ms, heap usage 23.374 MB -> 4.817 MB. [2026-03-04T23:50:32.617Z] Camera thread performed 122 scans. [2026-03-04T23:50:32.617Z] ====== philosophers (scala) [default], iteration 17 completed (588.632 ms) ====== [2026-03-04T23:50:32.617Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-04T23:50:32.617Z] GC before operation: completed in 21.762 ms, heap usage 61.450 MB -> 4.817 MB. [2026-03-04T23:50:33.256Z] Camera thread performed 122 scans. [2026-03-04T23:50:33.257Z] ====== philosophers (scala) [default], iteration 18 completed (608.991 ms) ====== [2026-03-04T23:50:33.257Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-04T23:50:33.257Z] GC before operation: completed in 15.564 ms, heap usage 34.444 MB -> 4.817 MB. [2026-03-04T23:50:33.905Z] Camera thread performed 122 scans. [2026-03-04T23:50:33.905Z] ====== philosophers (scala) [default], iteration 19 completed (944.276 ms) ====== [2026-03-04T23:50:33.905Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-04T23:50:33.905Z] GC before operation: completed in 16.893 ms, heap usage 41.848 MB -> 4.817 MB. [2026-03-04T23:50:34.931Z] Camera thread performed 122 scans. [2026-03-04T23:50:34.931Z] ====== philosophers (scala) [default], iteration 20 completed (971.867 ms) ====== [2026-03-04T23:50:34.931Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-04T23:50:34.931Z] GC before operation: completed in 23.288 ms, heap usage 20.774 MB -> 4.817 MB. [2026-03-04T23:50:35.765Z] Camera thread performed 122 scans. [2026-03-04T23:50:35.765Z] ====== philosophers (scala) [default], iteration 21 completed (872.548 ms) ====== [2026-03-04T23:50:35.765Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-04T23:50:35.765Z] GC before operation: completed in 18.869 ms, heap usage 7.415 MB -> 4.818 MB. [2026-03-04T23:50:36.576Z] Camera thread performed 122 scans. [2026-03-04T23:50:36.576Z] ====== philosophers (scala) [default], iteration 22 completed (744.063 ms) ====== [2026-03-04T23:50:36.576Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-04T23:50:36.576Z] GC before operation: completed in 21.885 ms, heap usage 32.830 MB -> 4.818 MB. [2026-03-04T23:50:37.215Z] Camera thread performed 122 scans. [2026-03-04T23:50:37.215Z] ====== philosophers (scala) [default], iteration 23 completed (667.828 ms) ====== [2026-03-04T23:50:37.215Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-04T23:50:37.215Z] GC before operation: completed in 14.263 ms, heap usage 31.853 MB -> 4.818 MB. [2026-03-04T23:50:38.787Z] Camera thread performed 122 scans. [2026-03-04T23:50:38.787Z] ====== philosophers (scala) [default], iteration 24 completed (991.035 ms) ====== [2026-03-04T23:50:38.787Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-04T23:50:38.787Z] GC before operation: completed in 14.973 ms, heap usage 18.954 MB -> 4.819 MB. [2026-03-04T23:50:39.473Z] Camera thread performed 122 scans. [2026-03-04T23:50:39.473Z] ====== philosophers (scala) [default], iteration 25 completed (1104.665 ms) ====== [2026-03-04T23:50:39.473Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-04T23:50:39.473Z] GC before operation: completed in 13.998 ms, heap usage 5.379 MB -> 4.818 MB. [2026-03-04T23:50:41.319Z] Camera thread performed 122 scans. [2026-03-04T23:50:41.319Z] ====== philosophers (scala) [default], iteration 26 completed (1338.613 ms) ====== [2026-03-04T23:50:41.319Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-04T23:50:41.319Z] GC before operation: completed in 17.887 ms, heap usage 31.492 MB -> 4.819 MB. [2026-03-04T23:50:42.446Z] Camera thread performed 122 scans. [2026-03-04T23:50:42.446Z] ====== philosophers (scala) [default], iteration 27 completed (986.940 ms) ====== [2026-03-04T23:50:42.446Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-04T23:50:42.446Z] GC before operation: completed in 14.654 ms, heap usage 40.725 MB -> 4.819 MB. [2026-03-04T23:50:42.446Z] Camera thread performed 122 scans. [2026-03-04T23:50:42.446Z] ====== philosophers (scala) [default], iteration 28 completed (828.100 ms) ====== [2026-03-04T23:50:42.446Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-04T23:50:42.446Z] GC before operation: completed in 14.448 ms, heap usage 35.980 MB -> 4.820 MB. [2026-03-04T23:50:43.357Z] Camera thread performed 122 scans. [2026-03-04T23:50:43.357Z] ====== philosophers (scala) [default], iteration 29 completed (850.347 ms) ====== [2026-03-04T23:50:44.097Z] ----------------------------------- [2026-03-04T23:50:44.097Z] renaissance-philosophers_0_PASSED [2026-03-04T23:50:44.097Z] ----------------------------------- [2026-03-04T23:50:44.097Z] [2026-03-04T23:50:44.097Z] TEST TEARDOWN: [2026-03-04T23:50:44.097Z] Nothing to be done for teardown. [2026-03-04T23:50:44.097Z] renaissance-philosophers_0 Finish Time: Wed Mar 4 23:50:43 2026 Epoch Time (ms): 1772668243350