[2026-02-18T22:17:44.578Z] Running test renaissance-philosophers_0 ... [2026-02-18T22:17:44.578Z] =============================================== [2026-02-18T22:17:44.578Z] renaissance-philosophers_0 Start Time: Wed Feb 18 22:17:44 2026 Epoch Time (ms): 1771453064321 [2026-02-18T22:17:44.578Z] variation: NoOptions [2026-02-18T22:17:44.578Z] JVM_OPTIONS: [2026-02-18T22:17:44.578Z] { \ [2026-02-18T22:17:44.578Z] echo ""; echo "TEST SETUP:"; \ [2026-02-18T22:17:44.578Z] echo "Nothing to be done for setup."; \ [2026-02-18T22:17:44.578Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1771451341353/renaissance-philosophers_0"; \ [2026-02-18T22:17:44.578Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1771451341353/renaissance-philosophers_0"; \ [2026-02-18T22:17:44.578Z] echo ""; echo "TESTING:"; \ [2026-02-18T22:17:44.578Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1771451341353/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-18T22:17:44.578Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1771451341353/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-18T22:17:44.578Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-18T22:17:44.578Z] echo "Nothing to be done for teardown."; \ [2026-02-18T22:17:44.578Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1771451341353/TestTargetResult"; [2026-02-18T22:17:44.578Z] [2026-02-18T22:17:44.578Z] TEST SETUP: [2026-02-18T22:17:44.578Z] Nothing to be done for setup. [2026-02-18T22:17:44.578Z] [2026-02-18T22:17:44.578Z] TESTING: [2026-02-18T22:17:45.671Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-18T22:17:45.671Z] GC before operation: completed in 20.318 ms, heap usage 7.025 MB -> 4.826 MB. [2026-02-18T22:17:47.059Z] Camera thread performed 122 scans. [2026-02-18T22:17:47.060Z] ====== philosophers (scala) [default], iteration 0 completed (1736.787 ms) ====== [2026-02-18T22:17:47.060Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-18T22:17:47.672Z] GC before operation: completed in 17.202 ms, heap usage 56.376 MB -> 5.193 MB. [2026-02-18T22:17:49.091Z] Camera thread performed 122 scans. [2026-02-18T22:17:49.091Z] ====== philosophers (scala) [default], iteration 1 completed (1331.459 ms) ====== [2026-02-18T22:17:49.091Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-18T22:17:49.091Z] GC before operation: completed in 18.981 ms, heap usage 22.274 MB -> 5.193 MB. [2026-02-18T22:17:49.091Z] Camera thread performed 122 scans. [2026-02-18T22:17:49.091Z] ====== philosophers (scala) [default], iteration 2 completed (631.577 ms) ====== [2026-02-18T22:17:49.091Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-18T22:17:49.091Z] GC before operation: completed in 17.274 ms, heap usage 24.457 MB -> 5.194 MB. [2026-02-18T22:17:50.432Z] Camera thread performed 122 scans. [2026-02-18T22:17:50.432Z] ====== philosophers (scala) [default], iteration 3 completed (672.378 ms) ====== [2026-02-18T22:17:50.432Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-18T22:17:50.432Z] GC before operation: completed in 21.577 ms, heap usage 41.439 MB -> 5.193 MB. [2026-02-18T22:17:51.073Z] Camera thread performed 122 scans. [2026-02-18T22:17:51.073Z] ====== philosophers (scala) [default], iteration 4 completed (723.043 ms) ====== [2026-02-18T22:17:51.073Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-18T22:17:51.073Z] GC before operation: completed in 14.365 ms, heap usage 34.123 MB -> 5.194 MB. [2026-02-18T22:17:51.708Z] Camera thread performed 122 scans. [2026-02-18T22:17:51.708Z] ====== philosophers (scala) [default], iteration 5 completed (614.299 ms) ====== [2026-02-18T22:17:51.708Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-18T22:17:51.708Z] GC before operation: completed in 15.242 ms, heap usage 26.343 MB -> 5.193 MB. [2026-02-18T22:17:52.363Z] Camera thread performed 122 scans. [2026-02-18T22:17:52.363Z] ====== philosophers (scala) [default], iteration 6 completed (682.415 ms) ====== [2026-02-18T22:17:52.363Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-18T22:17:52.363Z] GC before operation: completed in 11.348 ms, heap usage 31.830 MB -> 5.194 MB. [2026-02-18T22:17:53.012Z] Camera thread performed 122 scans. [2026-02-18T22:17:53.012Z] ====== philosophers (scala) [default], iteration 7 completed (673.239 ms) ====== [2026-02-18T22:17:53.012Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-18T22:17:53.012Z] GC before operation: completed in 10.208 ms, heap usage 5.799 MB -> 5.194 MB. [2026-02-18T22:17:53.666Z] Camera thread performed 122 scans. [2026-02-18T22:17:53.666Z] ====== philosophers (scala) [default], iteration 8 completed (676.117 ms) ====== [2026-02-18T22:17:53.666Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-18T22:17:53.666Z] GC before operation: completed in 22.349 ms, heap usage 44.294 MB -> 5.194 MB. [2026-02-18T22:17:54.283Z] Camera thread performed 122 scans. [2026-02-18T22:17:54.283Z] ====== philosophers (scala) [default], iteration 9 completed (848.868 ms) ====== [2026-02-18T22:17:54.283Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-18T22:17:54.283Z] GC before operation: completed in 10.020 ms, heap usage 31.320 MB -> 5.195 MB. [2026-02-18T22:17:54.960Z] Camera thread performed 122 scans. [2026-02-18T22:17:54.960Z] ====== philosophers (scala) [default], iteration 10 completed (685.090 ms) ====== [2026-02-18T22:17:54.960Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-18T22:17:54.960Z] GC before operation: completed in 11.289 ms, heap usage 5.288 MB -> 5.195 MB. [2026-02-18T22:17:55.627Z] Camera thread performed 122 scans. [2026-02-18T22:17:55.627Z] ====== philosophers (scala) [default], iteration 11 completed (717.073 ms) ====== [2026-02-18T22:17:55.627Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-18T22:17:55.627Z] GC before operation: completed in 12.458 ms, heap usage 48.825 MB -> 5.195 MB. [2026-02-18T22:17:56.380Z] Camera thread performed 122 scans. [2026-02-18T22:17:56.380Z] ====== philosophers (scala) [default], iteration 12 completed (637.087 ms) ====== [2026-02-18T22:17:56.380Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-18T22:17:56.380Z] GC before operation: completed in 11.651 ms, heap usage 41.792 MB -> 5.195 MB. [2026-02-18T22:17:57.049Z] Camera thread performed 122 scans. [2026-02-18T22:17:57.049Z] ====== philosophers (scala) [default], iteration 13 completed (635.756 ms) ====== [2026-02-18T22:17:57.049Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-18T22:17:57.049Z] GC before operation: completed in 22.121 ms, heap usage 49.812 MB -> 5.195 MB. [2026-02-18T22:17:57.717Z] Camera thread performed 122 scans. [2026-02-18T22:17:57.717Z] ====== philosophers (scala) [default], iteration 14 completed (724.316 ms) ====== [2026-02-18T22:17:57.717Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-18T22:17:57.717Z] GC before operation: completed in 13.089 ms, heap usage 10.797 MB -> 5.196 MB. [2026-02-18T22:17:58.364Z] Camera thread performed 122 scans. [2026-02-18T22:17:58.364Z] ====== philosophers (scala) [default], iteration 15 completed (738.091 ms) ====== [2026-02-18T22:17:58.364Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-18T22:17:58.364Z] GC before operation: completed in 10.420 ms, heap usage 8.801 MB -> 5.218 MB. [2026-02-18T22:17:59.000Z] Camera thread performed 122 scans. [2026-02-18T22:17:59.000Z] ====== philosophers (scala) [default], iteration 16 completed (691.120 ms) ====== [2026-02-18T22:17:59.000Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-18T22:17:59.655Z] GC before operation: completed in 20.361 ms, heap usage 62.355 MB -> 5.196 MB. [2026-02-18T22:17:59.655Z] Camera thread performed 122 scans. [2026-02-18T22:17:59.655Z] ====== philosophers (scala) [default], iteration 17 completed (583.982 ms) ====== [2026-02-18T22:17:59.655Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-18T22:17:59.655Z] GC before operation: completed in 11.502 ms, heap usage 21.202 MB -> 5.196 MB. [2026-02-18T22:18:01.067Z] Camera thread performed 122 scans. [2026-02-18T22:18:01.067Z] ====== philosophers (scala) [default], iteration 18 completed (706.659 ms) ====== [2026-02-18T22:18:01.067Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-18T22:18:01.067Z] GC before operation: completed in 31.356 ms, heap usage 8.797 MB -> 5.196 MB. [2026-02-18T22:18:01.067Z] Camera thread performed 122 scans. [2026-02-18T22:18:01.067Z] ====== philosophers (scala) [default], iteration 19 completed (609.016 ms) ====== [2026-02-18T22:18:01.067Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-18T22:18:01.067Z] GC before operation: completed in 22.972 ms, heap usage 27.840 MB -> 5.196 MB. [2026-02-18T22:18:01.719Z] Camera thread performed 122 scans. [2026-02-18T22:18:01.719Z] ====== philosophers (scala) [default], iteration 20 completed (749.259 ms) ====== [2026-02-18T22:18:01.719Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-18T22:18:02.346Z] GC before operation: completed in 30.660 ms, heap usage 16.803 MB -> 5.197 MB. [2026-02-18T22:18:02.996Z] Camera thread performed 122 scans. [2026-02-18T22:18:02.996Z] ====== philosophers (scala) [default], iteration 21 completed (641.048 ms) ====== [2026-02-18T22:18:02.996Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-18T22:18:02.996Z] GC before operation: completed in 28.721 ms, heap usage 31.304 MB -> 5.197 MB. [2026-02-18T22:18:03.664Z] Camera thread performed 122 scans. [2026-02-18T22:18:03.664Z] ====== philosophers (scala) [default], iteration 22 completed (652.380 ms) ====== [2026-02-18T22:18:03.664Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-18T22:18:03.664Z] GC before operation: completed in 12.269 ms, heap usage 39.288 MB -> 5.197 MB. [2026-02-18T22:18:04.300Z] Camera thread performed 122 scans. [2026-02-18T22:18:04.300Z] ====== philosophers (scala) [default], iteration 23 completed (639.186 ms) ====== [2026-02-18T22:18:04.300Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-18T22:18:04.300Z] GC before operation: completed in 14.101 ms, heap usage 48.838 MB -> 5.196 MB. [2026-02-18T22:18:04.948Z] Camera thread performed 122 scans. [2026-02-18T22:18:04.948Z] ====== philosophers (scala) [default], iteration 24 completed (597.283 ms) ====== [2026-02-18T22:18:04.948Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-18T22:18:04.948Z] GC before operation: completed in 20.781 ms, heap usage 17.303 MB -> 5.197 MB. [2026-02-18T22:18:05.575Z] Camera thread performed 122 scans. [2026-02-18T22:18:05.575Z] ====== philosophers (scala) [default], iteration 25 completed (623.202 ms) ====== [2026-02-18T22:18:05.575Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-18T22:18:05.575Z] GC before operation: completed in 12.723 ms, heap usage 21.779 MB -> 5.197 MB. [2026-02-18T22:18:06.265Z] Camera thread performed 122 scans. [2026-02-18T22:18:06.265Z] ====== philosophers (scala) [default], iteration 26 completed (624.186 ms) ====== [2026-02-18T22:18:06.265Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-18T22:18:06.265Z] GC before operation: completed in 11.957 ms, heap usage 17.301 MB -> 5.197 MB. [2026-02-18T22:18:06.929Z] Camera thread performed 122 scans. [2026-02-18T22:18:06.929Z] ====== philosophers (scala) [default], iteration 27 completed (656.484 ms) ====== [2026-02-18T22:18:06.929Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-18T22:18:06.929Z] GC before operation: completed in 31.327 ms, heap usage 50.794 MB -> 5.197 MB. [2026-02-18T22:18:07.618Z] Camera thread performed 122 scans. [2026-02-18T22:18:07.618Z] ====== philosophers (scala) [default], iteration 28 completed (633.997 ms) ====== [2026-02-18T22:18:07.618Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-18T22:18:07.618Z] GC before operation: completed in 13.472 ms, heap usage 13.303 MB -> 5.198 MB. [2026-02-18T22:18:07.618Z] Camera thread performed 122 scans. [2026-02-18T22:18:07.618Z] ====== philosophers (scala) [default], iteration 29 completed (617.358 ms) ====== [2026-02-18T22:18:08.256Z] ----------------------------------- [2026-02-18T22:18:08.256Z] renaissance-philosophers_0_PASSED [2026-02-18T22:18:08.256Z] ----------------------------------- [2026-02-18T22:18:08.256Z] [2026-02-18T22:18:08.256Z] TEST TEARDOWN: [2026-02-18T22:18:08.256Z] Nothing to be done for teardown. [2026-02-18T22:18:08.256Z] renaissance-philosophers_0 Finish Time: Wed Feb 18 22:18:07 2026 Epoch Time (ms): 1771453087784