[2026-01-21T11:32:16.087Z] Running test renaissance-philosophers_0 ... [2026-01-21T11:32:16.087Z] =============================================== [2026-01-21T11:32:16.087Z] renaissance-philosophers_0 Start Time: Wed Jan 21 11:32:15 2026 Epoch Time (ms): 1768995135420 [2026-01-21T11:32:16.087Z] variation: NoOptions [2026-01-21T11:32:16.087Z] JVM_OPTIONS: [2026-01-21T11:32:16.087Z] { \ [2026-01-21T11:32:16.087Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T11:32:16.087Z] echo "Nothing to be done for setup."; \ [2026-01-21T11:32:16.087Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1768993597924/renaissance-philosophers_0"; \ [2026-01-21T11:32:16.087Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1768993597924/renaissance-philosophers_0"; \ [2026-01-21T11:32:16.087Z] echo ""; echo "TESTING:"; \ [2026-01-21T11:32:16.087Z] "/home/jenkins/workspace/Test_openjdk25_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_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1768993597924/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-21T11:32:16.087Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1768993597924/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T11:32:16.087Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T11:32:16.087Z] echo "Nothing to be done for teardown."; \ [2026-01-21T11:32:16.087Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1768993597924/TestTargetResult"; [2026-01-21T11:32:16.087Z] [2026-01-21T11:32:16.087Z] TEST SETUP: [2026-01-21T11:32:16.087Z] Nothing to be done for setup. [2026-01-21T11:32:16.087Z] [2026-01-21T11:32:16.087Z] TESTING: [2026-01-21T11:32:16.713Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-21T11:32:16.713Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_1768993597924/renaissance-philosophers_0/launcher-113215-7851510261354614966/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-21T11:32:16.713Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-21T11:32:16.713Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-21T11:32:16.713Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-21T11:32:16.713Z] GC before operation: completed in 32.980 ms, heap usage 15.619 MB -> 5.001 MB. [2026-01-21T11:32:18.748Z] Camera thread performed 122 scans. [2026-01-21T11:32:18.748Z] ====== philosophers (scala) [default], iteration 0 completed (1470.775 ms) ====== [2026-01-21T11:32:18.748Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-21T11:32:18.748Z] GC before operation: completed in 14.014 ms, heap usage 27.914 MB -> 5.329 MB. [2026-01-21T11:32:19.373Z] Camera thread performed 122 scans. [2026-01-21T11:32:19.373Z] ====== philosophers (scala) [default], iteration 1 completed (669.127 ms) ====== [2026-01-21T11:32:19.373Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-21T11:32:19.373Z] GC before operation: completed in 12.770 ms, heap usage 20.904 MB -> 5.331 MB. [2026-01-21T11:32:20.008Z] Camera thread performed 122 scans. [2026-01-21T11:32:20.008Z] ====== philosophers (scala) [default], iteration 2 completed (676.002 ms) ====== [2026-01-21T11:32:20.008Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-21T11:32:20.008Z] GC before operation: completed in 12.917 ms, heap usage 33.876 MB -> 5.331 MB. [2026-01-21T11:32:20.635Z] Camera thread performed 122 scans. [2026-01-21T11:32:20.635Z] ====== philosophers (scala) [default], iteration 3 completed (867.819 ms) ====== [2026-01-21T11:32:20.635Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-21T11:32:20.635Z] GC before operation: completed in 11.829 ms, heap usage 30.852 MB -> 5.332 MB. [2026-01-21T11:32:21.261Z] Camera thread performed 122 scans. [2026-01-21T11:32:21.261Z] ====== philosophers (scala) [default], iteration 4 completed (797.949 ms) ====== [2026-01-21T11:32:21.261Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-21T11:32:21.261Z] GC before operation: completed in 10.036 ms, heap usage 12.882 MB -> 5.332 MB. [2026-01-21T11:32:22.562Z] Camera thread performed 122 scans. [2026-01-21T11:32:22.562Z] ====== philosophers (scala) [default], iteration 5 completed (878.323 ms) ====== [2026-01-21T11:32:22.562Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-21T11:32:22.562Z] GC before operation: completed in 12.160 ms, heap usage 15.175 MB -> 5.332 MB. [2026-01-21T11:32:23.187Z] Camera thread performed 122 scans. [2026-01-21T11:32:23.187Z] ====== philosophers (scala) [default], iteration 6 completed (807.689 ms) ====== [2026-01-21T11:32:23.187Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-21T11:32:23.187Z] GC before operation: completed in 12.450 ms, heap usage 29.464 MB -> 5.332 MB. [2026-01-21T11:32:23.812Z] Camera thread performed 122 scans. [2026-01-21T11:32:23.812Z] ====== philosophers (scala) [default], iteration 7 completed (661.511 ms) ====== [2026-01-21T11:32:23.812Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-21T11:32:23.812Z] GC before operation: completed in 13.553 ms, heap usage 25.315 MB -> 5.332 MB. [2026-01-21T11:32:24.570Z] Camera thread performed 122 scans. [2026-01-21T11:32:24.570Z] ====== philosophers (scala) [default], iteration 8 completed (582.929 ms) ====== [2026-01-21T11:32:24.570Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-21T11:32:24.570Z] GC before operation: completed in 11.358 ms, heap usage 34.425 MB -> 5.332 MB. [2026-01-21T11:32:25.205Z] Camera thread performed 122 scans. [2026-01-21T11:32:25.205Z] ====== philosophers (scala) [default], iteration 9 completed (618.807 ms) ====== [2026-01-21T11:32:25.205Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-21T11:32:25.205Z] GC before operation: completed in 11.108 ms, heap usage 14.896 MB -> 5.333 MB. [2026-01-21T11:32:25.836Z] Camera thread performed 122 scans. [2026-01-21T11:32:25.836Z] ====== philosophers (scala) [default], iteration 10 completed (690.458 ms) ====== [2026-01-21T11:32:25.836Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-21T11:32:25.836Z] GC before operation: completed in 14.560 ms, heap usage 21.859 MB -> 5.333 MB. [2026-01-21T11:32:26.461Z] Camera thread performed 122 scans. [2026-01-21T11:32:26.461Z] ====== philosophers (scala) [default], iteration 11 completed (738.072 ms) ====== [2026-01-21T11:32:26.461Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-21T11:32:26.461Z] GC before operation: completed in 9.853 ms, heap usage 15.837 MB -> 5.333 MB. [2026-01-21T11:32:27.086Z] Camera thread performed 122 scans. [2026-01-21T11:32:27.086Z] ====== philosophers (scala) [default], iteration 12 completed (577.298 ms) ====== [2026-01-21T11:32:27.086Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-21T11:32:27.086Z] GC before operation: completed in 11.810 ms, heap usage 25.430 MB -> 5.333 MB. [2026-01-21T11:32:27.710Z] Camera thread performed 122 scans. [2026-01-21T11:32:27.710Z] ====== philosophers (scala) [default], iteration 13 completed (630.971 ms) ====== [2026-01-21T11:32:27.710Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-21T11:32:27.710Z] GC before operation: completed in 13.230 ms, heap usage 23.418 MB -> 5.333 MB. [2026-01-21T11:32:28.342Z] Camera thread performed 122 scans. [2026-01-21T11:32:28.342Z] ====== philosophers (scala) [default], iteration 14 completed (793.844 ms) ====== [2026-01-21T11:32:28.342Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-21T11:32:28.967Z] GC before operation: completed in 17.017 ms, heap usage 31.285 MB -> 5.334 MB. [2026-01-21T11:32:28.967Z] Camera thread performed 122 scans. [2026-01-21T11:32:28.967Z] ====== philosophers (scala) [default], iteration 15 completed (478.701 ms) ====== [2026-01-21T11:32:28.967Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-21T11:32:28.967Z] GC before operation: completed in 13.230 ms, heap usage 17.426 MB -> 5.334 MB. [2026-01-21T11:32:29.593Z] Camera thread performed 122 scans. [2026-01-21T11:32:29.593Z] ====== philosophers (scala) [default], iteration 16 completed (597.621 ms) ====== [2026-01-21T11:32:29.593Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-21T11:32:29.593Z] GC before operation: completed in 13.221 ms, heap usage 49.945 MB -> 5.335 MB. [2026-01-21T11:32:30.217Z] Camera thread performed 122 scans. [2026-01-21T11:32:30.217Z] ====== philosophers (scala) [default], iteration 17 completed (610.806 ms) ====== [2026-01-21T11:32:30.217Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-21T11:32:30.217Z] GC before operation: completed in 12.082 ms, heap usage 16.435 MB -> 5.334 MB. [2026-01-21T11:32:30.841Z] Camera thread performed 122 scans. [2026-01-21T11:32:30.841Z] ====== philosophers (scala) [default], iteration 18 completed (670.958 ms) ====== [2026-01-21T11:32:30.841Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-21T11:32:30.841Z] GC before operation: completed in 11.269 ms, heap usage 45.290 MB -> 5.335 MB. [2026-01-21T11:32:31.466Z] Camera thread performed 122 scans. [2026-01-21T11:32:31.466Z] ====== philosophers (scala) [default], iteration 19 completed (577.110 ms) ====== [2026-01-21T11:32:31.466Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-21T11:32:31.466Z] GC before operation: completed in 16.217 ms, heap usage 19.357 MB -> 5.335 MB. [2026-01-21T11:32:32.090Z] Camera thread performed 122 scans. [2026-01-21T11:32:32.090Z] ====== philosophers (scala) [default], iteration 20 completed (612.126 ms) ====== [2026-01-21T11:32:32.090Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-21T11:32:32.090Z] GC before operation: completed in 11.345 ms, heap usage 18.930 MB -> 5.335 MB. [2026-01-21T11:32:32.716Z] Camera thread performed 122 scans. [2026-01-21T11:32:32.716Z] ====== philosophers (scala) [default], iteration 21 completed (641.837 ms) ====== [2026-01-21T11:32:32.716Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-21T11:32:32.716Z] GC before operation: completed in 13.304 ms, heap usage 12.418 MB -> 5.335 MB. [2026-01-21T11:32:34.016Z] Camera thread performed 122 scans. [2026-01-21T11:32:34.016Z] ====== philosophers (scala) [default], iteration 22 completed (911.478 ms) ====== [2026-01-21T11:32:34.016Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-21T11:32:34.016Z] GC before operation: completed in 11.046 ms, heap usage 32.816 MB -> 5.336 MB. [2026-01-21T11:32:34.640Z] Camera thread performed 122 scans. [2026-01-21T11:32:34.640Z] ====== philosophers (scala) [default], iteration 23 completed (689.355 ms) ====== [2026-01-21T11:32:34.640Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-21T11:32:34.640Z] GC before operation: completed in 11.051 ms, heap usage 15.432 MB -> 5.336 MB. [2026-01-21T11:32:35.265Z] Camera thread performed 122 scans. [2026-01-21T11:32:35.265Z] ====== philosophers (scala) [default], iteration 24 completed (652.275 ms) ====== [2026-01-21T11:32:35.265Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-21T11:32:35.265Z] GC before operation: completed in 12.917 ms, heap usage 42.862 MB -> 5.336 MB. [2026-01-21T11:32:35.894Z] Camera thread performed 122 scans. [2026-01-21T11:32:35.894Z] ====== philosophers (scala) [default], iteration 25 completed (693.793 ms) ====== [2026-01-21T11:32:35.894Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-21T11:32:35.894Z] GC before operation: completed in 11.656 ms, heap usage 43.872 MB -> 5.336 MB. [2026-01-21T11:32:36.519Z] Camera thread performed 122 scans. [2026-01-21T11:32:36.519Z] ====== philosophers (scala) [default], iteration 26 completed (638.147 ms) ====== [2026-01-21T11:32:36.519Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-21T11:32:36.519Z] GC before operation: completed in 12.209 ms, heap usage 25.912 MB -> 5.336 MB. [2026-01-21T11:32:37.145Z] Camera thread performed 122 scans. [2026-01-21T11:32:37.146Z] ====== philosophers (scala) [default], iteration 27 completed (650.411 ms) ====== [2026-01-21T11:32:37.146Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-21T11:32:37.146Z] GC before operation: completed in 11.367 ms, heap usage 18.433 MB -> 5.336 MB. [2026-01-21T11:32:38.462Z] Camera thread performed 122 scans. [2026-01-21T11:32:38.462Z] ====== philosophers (scala) [default], iteration 28 completed (889.165 ms) ====== [2026-01-21T11:32:38.462Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-21T11:32:38.462Z] GC before operation: completed in 12.915 ms, heap usage 19.905 MB -> 5.337 MB. [2026-01-21T11:32:39.087Z] Camera thread performed 122 scans. [2026-01-21T11:32:39.087Z] ====== philosophers (scala) [default], iteration 29 completed (954.389 ms) ====== [2026-01-21T11:32:39.087Z] ----------------------------------- [2026-01-21T11:32:39.087Z] renaissance-philosophers_0_PASSED [2026-01-21T11:32:39.087Z] ----------------------------------- [2026-01-21T11:32:39.087Z] [2026-01-21T11:32:39.087Z] TEST TEARDOWN: [2026-01-21T11:32:39.087Z] Nothing to be done for teardown. [2026-01-21T11:32:39.087Z] renaissance-philosophers_0 Finish Time: Wed Jan 21 11:32:39 2026 Epoch Time (ms): 1768995159003