[2026-01-10T13:44:29.488Z] Running test renaissance-philosophers_0 ... [2026-01-10T13:44:29.488Z] =============================================== [2026-01-10T13:44:29.488Z] renaissance-philosophers_0 Start Time: Sat Jan 10 13:44:29 2026 Epoch Time (ms): 1768052669144 [2026-01-10T13:44:29.488Z] variation: NoOptions [2026-01-10T13:44:29.488Z] JVM_OPTIONS: [2026-01-10T13:44:29.488Z] { \ [2026-01-10T13:44:29.488Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T13:44:29.488Z] echo "Nothing to be done for setup."; \ [2026-01-10T13:44:29.488Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17680507969033/renaissance-philosophers_0"; \ [2026-01-10T13:44:29.488Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17680507969033/renaissance-philosophers_0"; \ [2026-01-10T13:44:29.488Z] echo ""; echo "TESTING:"; \ [2026-01-10T13:44:29.488Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17680507969033/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-10T13:44:29.488Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17680507969033/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T13:44:29.488Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T13:44:29.488Z] echo "Nothing to be done for teardown."; \ [2026-01-10T13:44:29.488Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17680507969033/TestTargetResult"; [2026-01-10T13:44:29.488Z] [2026-01-10T13:44:29.488Z] TEST SETUP: [2026-01-10T13:44:29.488Z] Nothing to be done for setup. [2026-01-10T13:44:29.488Z] [2026-01-10T13:44:29.488Z] TESTING: [2026-01-10T13:44:30.443Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-10T13:44:30.443Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17680507969033/renaissance-philosophers_0/launcher-134429-16460205258302718369/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-10T13:44:30.443Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-10T13:44:30.443Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-10T13:44:30.443Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-10T13:44:30.443Z] GC before operation: completed in 20.923 ms, heap usage 27.127 MB -> 4.800 MB. [2026-01-10T13:44:35.830Z] Camera thread performed 122 scans. [2026-01-10T13:44:35.830Z] ====== philosophers (scala) [default], iteration 0 completed (5196.630 ms) ====== [2026-01-10T13:44:35.830Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-10T13:44:35.830Z] GC before operation: completed in 12.006 ms, heap usage 19.944 MB -> 5.142 MB. [2026-01-10T13:44:40.001Z] Camera thread performed 122 scans. [2026-01-10T13:44:40.001Z] ====== philosophers (scala) [default], iteration 1 completed (4394.802 ms) ====== [2026-01-10T13:44:40.001Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-10T13:44:40.001Z] GC before operation: completed in 11.389 ms, heap usage 25.759 MB -> 5.143 MB. [2026-01-10T13:44:45.399Z] Camera thread performed 122 scans. [2026-01-10T13:44:45.399Z] ====== philosophers (scala) [default], iteration 2 completed (4594.709 ms) ====== [2026-01-10T13:44:45.399Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-10T13:44:45.399Z] GC before operation: completed in 11.575 ms, heap usage 13.952 MB -> 5.144 MB. [2026-01-10T13:44:50.788Z] Camera thread performed 122 scans. [2026-01-10T13:44:50.788Z] ====== philosophers (scala) [default], iteration 3 completed (6115.040 ms) ====== [2026-01-10T13:44:50.788Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-10T13:44:50.788Z] GC before operation: completed in 11.789 ms, heap usage 12.786 MB -> 5.144 MB. [2026-01-10T13:44:57.503Z] Camera thread performed 122 scans. [2026-01-10T13:44:57.503Z] ====== philosophers (scala) [default], iteration 4 completed (6113.644 ms) ====== [2026-01-10T13:44:57.503Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-10T13:44:57.503Z] GC before operation: completed in 10.849 ms, heap usage 9.324 MB -> 5.144 MB. [2026-01-10T13:45:02.985Z] Camera thread performed 122 scans. [2026-01-10T13:45:02.985Z] ====== philosophers (scala) [default], iteration 5 completed (5346.243 ms) ====== [2026-01-10T13:45:02.985Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-10T13:45:02.985Z] GC before operation: completed in 10.642 ms, heap usage 19.259 MB -> 5.145 MB. [2026-01-10T13:45:08.373Z] Camera thread performed 122 scans. [2026-01-10T13:45:08.373Z] ====== philosophers (scala) [default], iteration 6 completed (5795.885 ms) ====== [2026-01-10T13:45:08.373Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-10T13:45:08.373Z] GC before operation: completed in 10.501 ms, heap usage 27.984 MB -> 5.145 MB. [2026-01-10T13:45:13.375Z] Camera thread performed 122 scans. [2026-01-10T13:45:13.375Z] ====== philosophers (scala) [default], iteration 7 completed (5072.815 ms) ====== [2026-01-10T13:45:13.375Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-10T13:45:13.375Z] GC before operation: completed in 10.214 ms, heap usage 35.713 MB -> 5.145 MB. [2026-01-10T13:45:18.772Z] Camera thread performed 122 scans. [2026-01-10T13:45:18.772Z] ====== philosophers (scala) [default], iteration 8 completed (5544.375 ms) ====== [2026-01-10T13:45:18.772Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-10T13:45:18.772Z] GC before operation: completed in 10.429 ms, heap usage 21.672 MB -> 5.145 MB. [2026-01-10T13:45:24.166Z] Camera thread performed 122 scans. [2026-01-10T13:45:24.166Z] ====== philosophers (scala) [default], iteration 9 completed (5397.150 ms) ====== [2026-01-10T13:45:24.166Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-10T13:45:24.166Z] GC before operation: completed in 10.447 ms, heap usage 38.007 MB -> 5.145 MB. [2026-01-10T13:45:29.562Z] Camera thread performed 122 scans. [2026-01-10T13:45:29.562Z] ====== philosophers (scala) [default], iteration 10 completed (5065.851 ms) ====== [2026-01-10T13:45:29.562Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-10T13:45:29.562Z] GC before operation: completed in 11.171 ms, heap usage 18.599 MB -> 5.146 MB. [2026-01-10T13:45:33.729Z] Camera thread performed 122 scans. [2026-01-10T13:45:33.729Z] ====== philosophers (scala) [default], iteration 11 completed (4767.191 ms) ====== [2026-01-10T13:45:33.729Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-10T13:45:33.729Z] GC before operation: completed in 12.872 ms, heap usage 23.657 MB -> 5.146 MB. [2026-01-10T13:45:39.132Z] Camera thread performed 122 scans. [2026-01-10T13:45:39.132Z] ====== philosophers (scala) [default], iteration 12 completed (5200.817 ms) ====== [2026-01-10T13:45:39.133Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-10T13:45:39.133Z] GC before operation: completed in 11.280 ms, heap usage 16.024 MB -> 5.147 MB. [2026-01-10T13:45:44.542Z] Camera thread performed 122 scans. [2026-01-10T13:45:44.542Z] ====== philosophers (scala) [default], iteration 13 completed (5264.135 ms) ====== [2026-01-10T13:45:44.542Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-10T13:45:44.542Z] GC before operation: completed in 10.802 ms, heap usage 20.717 MB -> 5.147 MB. [2026-01-10T13:45:49.940Z] Camera thread performed 122 scans. [2026-01-10T13:45:49.940Z] ====== philosophers (scala) [default], iteration 14 completed (4881.921 ms) ====== [2026-01-10T13:45:49.940Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-10T13:45:49.940Z] GC before operation: completed in 12.470 ms, heap usage 16.061 MB -> 5.147 MB. [2026-01-10T13:45:54.107Z] Camera thread performed 122 scans. [2026-01-10T13:45:54.107Z] ====== philosophers (scala) [default], iteration 15 completed (4231.182 ms) ====== [2026-01-10T13:45:54.107Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-10T13:45:54.107Z] GC before operation: completed in 10.822 ms, heap usage 33.593 MB -> 5.147 MB. [2026-01-10T13:45:58.281Z] Camera thread performed 122 scans. [2026-01-10T13:45:58.282Z] ====== philosophers (scala) [default], iteration 16 completed (4842.846 ms) ====== [2026-01-10T13:45:58.282Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-10T13:45:58.282Z] GC before operation: completed in 10.004 ms, heap usage 29.166 MB -> 5.147 MB. [2026-01-10T13:46:03.693Z] Camera thread performed 122 scans. [2026-01-10T13:46:03.693Z] ====== philosophers (scala) [default], iteration 17 completed (5089.072 ms) ====== [2026-01-10T13:46:03.693Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-10T13:46:03.693Z] GC before operation: completed in 13.811 ms, heap usage 34.914 MB -> 5.147 MB. [2026-01-10T13:46:09.086Z] Camera thread performed 122 scans. [2026-01-10T13:46:09.086Z] ====== philosophers (scala) [default], iteration 18 completed (4786.362 ms) ====== [2026-01-10T13:46:09.086Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-10T13:46:09.086Z] GC before operation: completed in 11.939 ms, heap usage 35.165 MB -> 5.147 MB. [2026-01-10T13:46:13.262Z] Camera thread performed 122 scans. [2026-01-10T13:46:13.262Z] ====== philosophers (scala) [default], iteration 19 completed (4719.116 ms) ====== [2026-01-10T13:46:13.262Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-10T13:46:13.262Z] GC before operation: completed in 12.498 ms, heap usage 39.950 MB -> 5.147 MB. [2026-01-10T13:46:18.660Z] Camera thread performed 122 scans. [2026-01-10T13:46:18.660Z] ====== philosophers (scala) [default], iteration 20 completed (5309.749 ms) ====== [2026-01-10T13:46:18.660Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-10T13:46:18.660Z] GC before operation: completed in 12.951 ms, heap usage 5.736 MB -> 5.147 MB. [2026-01-10T13:46:23.299Z] Camera thread performed 122 scans. [2026-01-10T13:46:23.299Z] ====== philosophers (scala) [default], iteration 21 completed (5096.990 ms) ====== [2026-01-10T13:46:23.299Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-10T13:46:23.299Z] GC before operation: completed in 11.752 ms, heap usage 55.604 MB -> 5.147 MB. [2026-01-10T13:46:30.034Z] Camera thread performed 122 scans. [2026-01-10T13:46:30.034Z] ====== philosophers (scala) [default], iteration 22 completed (6431.121 ms) ====== [2026-01-10T13:46:30.034Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-10T13:46:30.034Z] GC before operation: completed in 14.234 ms, heap usage 25.107 MB -> 5.148 MB. [2026-01-10T13:46:36.772Z] Camera thread performed 122 scans. [2026-01-10T13:46:36.772Z] ====== philosophers (scala) [default], iteration 23 completed (6399.325 ms) ====== [2026-01-10T13:46:36.772Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-10T13:46:36.772Z] GC before operation: completed in 12.520 ms, heap usage 17.414 MB -> 5.147 MB. [2026-01-10T13:46:43.509Z] Camera thread performed 122 scans. [2026-01-10T13:46:43.509Z] ====== philosophers (scala) [default], iteration 24 completed (6121.778 ms) ====== [2026-01-10T13:46:43.509Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-10T13:46:43.509Z] GC before operation: completed in 15.331 ms, heap usage 22.395 MB -> 5.148 MB. [2026-01-10T13:46:48.906Z] Camera thread performed 122 scans. [2026-01-10T13:46:48.906Z] ====== philosophers (scala) [default], iteration 25 completed (6142.572 ms) ====== [2026-01-10T13:46:48.906Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-10T13:46:48.906Z] GC before operation: completed in 13.368 ms, heap usage 28.122 MB -> 5.148 MB. [2026-01-10T13:46:55.627Z] Camera thread performed 122 scans. [2026-01-10T13:46:55.627Z] ====== philosophers (scala) [default], iteration 26 completed (6171.354 ms) ====== [2026-01-10T13:46:55.627Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-10T13:46:55.627Z] GC before operation: completed in 12.872 ms, heap usage 35.313 MB -> 5.148 MB. [2026-01-10T13:47:01.021Z] Camera thread performed 122 scans. [2026-01-10T13:47:01.021Z] ====== philosophers (scala) [default], iteration 27 completed (6346.665 ms) ====== [2026-01-10T13:47:01.021Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-10T13:47:01.021Z] GC before operation: completed in 11.917 ms, heap usage 20.909 MB -> 5.148 MB. [2026-01-10T13:47:07.757Z] Camera thread performed 122 scans. [2026-01-10T13:47:07.757Z] ====== philosophers (scala) [default], iteration 28 completed (6523.768 ms) ====== [2026-01-10T13:47:07.757Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-10T13:47:07.757Z] GC before operation: completed in 12.620 ms, heap usage 5.620 MB -> 5.148 MB. [2026-01-10T13:47:13.148Z] Camera thread performed 122 scans. [2026-01-10T13:47:13.148Z] ====== philosophers (scala) [default], iteration 29 completed (5482.762 ms) ====== [2026-01-10T13:47:14.106Z] ----------------------------------- [2026-01-10T13:47:14.106Z] renaissance-philosophers_0_PASSED [2026-01-10T13:47:14.106Z] ----------------------------------- [2026-01-10T13:47:14.106Z] [2026-01-10T13:47:14.106Z] TEST TEARDOWN: [2026-01-10T13:47:14.106Z] Nothing to be done for teardown. [2026-01-10T13:47:14.106Z] renaissance-philosophers_0 Finish Time: Sat Jan 10 13:47:13 2026 Epoch Time (ms): 1768052833104