[2026-02-26T14:48:22.137Z] Running test renaissance-philosophers_0 ... [2026-02-26T14:48:22.137Z] =============================================== [2026-02-26T14:48:22.137Z] renaissance-philosophers_0 Start Time: Thu Feb 26 14:48:21 2026 Epoch Time (ms): 1772117301575 [2026-02-26T14:48:22.137Z] variation: NoOptions [2026-02-26T14:48:22.137Z] JVM_OPTIONS: [2026-02-26T14:48:22.137Z] { \ [2026-02-26T14:48:22.137Z] echo ""; echo "TEST SETUP:"; \ [2026-02-26T14:48:22.137Z] echo "Nothing to be done for setup."; \ [2026-02-26T14:48:22.137Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17721158225899/renaissance-philosophers_0"; \ [2026-02-26T14:48:22.137Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17721158225899/renaissance-philosophers_0"; \ [2026-02-26T14:48:22.137Z] echo ""; echo "TESTING:"; \ [2026-02-26T14:48:22.137Z] "/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_17721158225899/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-26T14:48:22.137Z] 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_17721158225899/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-26T14:48:22.137Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-26T14:48:22.137Z] echo "Nothing to be done for teardown."; \ [2026-02-26T14:48:22.137Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17721158225899/TestTargetResult"; [2026-02-26T14:48:22.137Z] [2026-02-26T14:48:22.137Z] TEST SETUP: [2026-02-26T14:48:22.137Z] Nothing to be done for setup. [2026-02-26T14:48:22.137Z] [2026-02-26T14:48:22.137Z] TESTING: [2026-02-26T14:48:22.762Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-26T14:48:22.762Z] GC before operation: completed in 16.195 ms, heap usage 18.394 MB -> 4.830 MB. [2026-02-26T14:48:24.064Z] Camera thread performed 122 scans. [2026-02-26T14:48:24.064Z] ====== philosophers (scala) [default], iteration 0 completed (1334.262 ms) ====== [2026-02-26T14:48:24.064Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-26T14:48:24.064Z] GC before operation: completed in 11.220 ms, heap usage 23.403 MB -> 5.200 MB. [2026-02-26T14:48:24.689Z] Camera thread performed 122 scans. [2026-02-26T14:48:24.689Z] ====== philosophers (scala) [default], iteration 1 completed (903.628 ms) ====== [2026-02-26T14:48:24.689Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-26T14:48:24.689Z] GC before operation: completed in 11.560 ms, heap usage 24.759 MB -> 5.201 MB. [2026-02-26T14:48:25.998Z] Camera thread performed 122 scans. [2026-02-26T14:48:25.998Z] ====== philosophers (scala) [default], iteration 2 completed (987.766 ms) ====== [2026-02-26T14:48:25.998Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-26T14:48:25.998Z] GC before operation: completed in 11.915 ms, heap usage 20.202 MB -> 5.202 MB. [2026-02-26T14:48:26.624Z] Camera thread performed 122 scans. [2026-02-26T14:48:26.624Z] ====== philosophers (scala) [default], iteration 3 completed (751.619 ms) ====== [2026-02-26T14:48:26.624Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-26T14:48:26.624Z] GC before operation: completed in 9.345 ms, heap usage 14.751 MB -> 5.202 MB. [2026-02-26T14:48:27.248Z] Camera thread performed 122 scans. [2026-02-26T14:48:27.248Z] ====== philosophers (scala) [default], iteration 4 completed (716.364 ms) ====== [2026-02-26T14:48:27.248Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-26T14:48:27.248Z] GC before operation: completed in 11.024 ms, heap usage 12.207 MB -> 5.202 MB. [2026-02-26T14:48:27.873Z] Camera thread performed 122 scans. [2026-02-26T14:48:27.873Z] ====== philosophers (scala) [default], iteration 5 completed (894.523 ms) ====== [2026-02-26T14:48:27.873Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-26T14:48:27.873Z] GC before operation: completed in 15.193 ms, heap usage 39.046 MB -> 5.203 MB. [2026-02-26T14:48:29.313Z] Camera thread performed 122 scans. [2026-02-26T14:48:29.313Z] ====== philosophers (scala) [default], iteration 6 completed (1131.338 ms) ====== [2026-02-26T14:48:29.313Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-26T14:48:29.313Z] GC before operation: completed in 13.262 ms, heap usage 27.287 MB -> 5.203 MB. [2026-02-26T14:48:30.718Z] Camera thread performed 122 scans. [2026-02-26T14:48:30.718Z] ====== philosophers (scala) [default], iteration 7 completed (1031.494 ms) ====== [2026-02-26T14:48:30.718Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-26T14:48:30.718Z] GC before operation: completed in 8.972 ms, heap usage 23.026 MB -> 5.203 MB. [2026-02-26T14:48:31.360Z] Camera thread performed 122 scans. [2026-02-26T14:48:31.360Z] ====== philosophers (scala) [default], iteration 8 completed (900.792 ms) ====== [2026-02-26T14:48:31.360Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-26T14:48:31.360Z] GC before operation: completed in 9.967 ms, heap usage 19.859 MB -> 5.203 MB. [2026-02-26T14:48:32.749Z] Camera thread performed 122 scans. [2026-02-26T14:48:32.749Z] ====== philosophers (scala) [default], iteration 9 completed (1176.648 ms) ====== [2026-02-26T14:48:32.749Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-26T14:48:32.749Z] GC before operation: completed in 10.067 ms, heap usage 17.926 MB -> 5.203 MB. [2026-02-26T14:48:33.373Z] Camera thread performed 122 scans. [2026-02-26T14:48:33.373Z] ====== philosophers (scala) [default], iteration 10 completed (1102.042 ms) ====== [2026-02-26T14:48:33.373Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-26T14:48:33.373Z] GC before operation: completed in 13.898 ms, heap usage 8.619 MB -> 5.203 MB. [2026-02-26T14:48:34.674Z] Camera thread performed 122 scans. [2026-02-26T14:48:34.674Z] ====== philosophers (scala) [default], iteration 11 completed (997.600 ms) ====== [2026-02-26T14:48:34.674Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-26T14:48:34.674Z] GC before operation: completed in 10.121 ms, heap usage 29.558 MB -> 5.203 MB. [2026-02-26T14:48:36.007Z] Camera thread performed 122 scans. [2026-02-26T14:48:36.007Z] ====== philosophers (scala) [default], iteration 12 completed (1136.902 ms) ====== [2026-02-26T14:48:36.007Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-26T14:48:36.007Z] GC before operation: completed in 11.942 ms, heap usage 20.855 MB -> 5.203 MB. [2026-02-26T14:48:36.635Z] Camera thread performed 122 scans. [2026-02-26T14:48:36.635Z] ====== philosophers (scala) [default], iteration 13 completed (832.765 ms) ====== [2026-02-26T14:48:36.635Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-26T14:48:36.635Z] GC before operation: completed in 9.581 ms, heap usage 16.618 MB -> 5.204 MB. [2026-02-26T14:48:37.266Z] Camera thread performed 122 scans. [2026-02-26T14:48:37.266Z] ====== philosophers (scala) [default], iteration 14 completed (1018.511 ms) ====== [2026-02-26T14:48:37.266Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-26T14:48:37.266Z] GC before operation: completed in 12.879 ms, heap usage 27.052 MB -> 5.204 MB. [2026-02-26T14:48:38.571Z] Camera thread performed 122 scans. [2026-02-26T14:48:38.571Z] ====== philosophers (scala) [default], iteration 15 completed (938.851 ms) ====== [2026-02-26T14:48:38.571Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-26T14:48:38.571Z] GC before operation: completed in 10.512 ms, heap usage 26.277 MB -> 5.204 MB. [2026-02-26T14:48:39.196Z] Camera thread performed 122 scans. [2026-02-26T14:48:39.196Z] ====== philosophers (scala) [default], iteration 16 completed (900.003 ms) ====== [2026-02-26T14:48:39.196Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-26T14:48:39.196Z] GC before operation: completed in 10.026 ms, heap usage 36.884 MB -> 5.205 MB. [2026-02-26T14:48:40.500Z] Camera thread performed 122 scans. [2026-02-26T14:48:40.500Z] ====== philosophers (scala) [default], iteration 17 completed (1259.646 ms) ====== [2026-02-26T14:48:40.500Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-26T14:48:40.500Z] GC before operation: completed in 11.387 ms, heap usage 12.663 MB -> 5.205 MB. [2026-02-26T14:48:41.812Z] Camera thread performed 122 scans. [2026-02-26T14:48:41.812Z] ====== philosophers (scala) [default], iteration 18 completed (978.218 ms) ====== [2026-02-26T14:48:41.812Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-26T14:48:41.812Z] GC before operation: completed in 10.229 ms, heap usage 13.000 MB -> 5.205 MB. [2026-02-26T14:48:42.435Z] Camera thread performed 122 scans. [2026-02-26T14:48:42.435Z] ====== philosophers (scala) [default], iteration 19 completed (882.787 ms) ====== [2026-02-26T14:48:42.435Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-26T14:48:42.435Z] GC before operation: completed in 10.810 ms, heap usage 13.630 MB -> 5.205 MB. [2026-02-26T14:48:43.743Z] Camera thread performed 122 scans. [2026-02-26T14:48:43.743Z] ====== philosophers (scala) [default], iteration 20 completed (959.781 ms) ====== [2026-02-26T14:48:43.743Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-26T14:48:43.743Z] GC before operation: completed in 11.242 ms, heap usage 27.269 MB -> 5.205 MB. [2026-02-26T14:48:44.384Z] Camera thread performed 122 scans. [2026-02-26T14:48:44.384Z] ====== philosophers (scala) [default], iteration 21 completed (722.337 ms) ====== [2026-02-26T14:48:44.384Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-26T14:48:44.384Z] GC before operation: completed in 10.091 ms, heap usage 32.081 MB -> 5.205 MB. [2026-02-26T14:48:45.104Z] Camera thread performed 122 scans. [2026-02-26T14:48:45.104Z] ====== philosophers (scala) [default], iteration 22 completed (646.824 ms) ====== [2026-02-26T14:48:45.104Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-26T14:48:45.104Z] GC before operation: completed in 9.038 ms, heap usage 22.660 MB -> 5.205 MB. [2026-02-26T14:48:45.730Z] Camera thread performed 122 scans. [2026-02-26T14:48:45.730Z] ====== philosophers (scala) [default], iteration 23 completed (714.728 ms) ====== [2026-02-26T14:48:45.730Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-26T14:48:45.730Z] GC before operation: completed in 9.400 ms, heap usage 15.577 MB -> 5.205 MB. [2026-02-26T14:48:46.460Z] Camera thread performed 122 scans. [2026-02-26T14:48:46.460Z] ====== philosophers (scala) [default], iteration 24 completed (725.729 ms) ====== [2026-02-26T14:48:46.460Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-26T14:48:46.460Z] GC before operation: completed in 10.025 ms, heap usage 12.207 MB -> 5.205 MB. [2026-02-26T14:48:47.084Z] Camera thread performed 122 scans. [2026-02-26T14:48:47.084Z] ====== philosophers (scala) [default], iteration 25 completed (787.618 ms) ====== [2026-02-26T14:48:47.084Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-26T14:48:47.084Z] GC before operation: completed in 11.844 ms, heap usage 38.701 MB -> 5.205 MB. [2026-02-26T14:48:47.709Z] Camera thread performed 122 scans. [2026-02-26T14:48:47.709Z] ====== philosophers (scala) [default], iteration 26 completed (741.910 ms) ====== [2026-02-26T14:48:47.709Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-26T14:48:47.709Z] GC before operation: completed in 10.162 ms, heap usage 22.918 MB -> 5.206 MB. [2026-02-26T14:48:49.010Z] Camera thread performed 122 scans. [2026-02-26T14:48:49.010Z] ====== philosophers (scala) [default], iteration 27 completed (795.179 ms) ====== [2026-02-26T14:48:49.010Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-26T14:48:49.010Z] GC before operation: completed in 9.847 ms, heap usage 16.329 MB -> 5.206 MB. [2026-02-26T14:48:49.636Z] Camera thread performed 122 scans. [2026-02-26T14:48:49.636Z] ====== philosophers (scala) [default], iteration 28 completed (1137.364 ms) ====== [2026-02-26T14:48:49.636Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-26T14:48:49.636Z] GC before operation: completed in 10.598 ms, heap usage 27.674 MB -> 5.206 MB. [2026-02-26T14:48:50.938Z] Camera thread performed 122 scans. [2026-02-26T14:48:50.938Z] ====== philosophers (scala) [default], iteration 29 completed (970.792 ms) ====== [2026-02-26T14:48:50.938Z] ----------------------------------- [2026-02-26T14:48:50.938Z] renaissance-philosophers_0_PASSED [2026-02-26T14:48:50.938Z] ----------------------------------- [2026-02-26T14:48:50.938Z] [2026-02-26T14:48:50.938Z] TEST TEARDOWN: [2026-02-26T14:48:50.938Z] Nothing to be done for teardown. [2026-02-26T14:48:50.938Z] renaissance-philosophers_0 Finish Time: Thu Feb 26 14:48:50 2026 Epoch Time (ms): 1772117330724