[2026-01-17T14:03:37.989Z] Running test renaissance-philosophers_0 ... [2026-01-17T14:03:37.989Z] =============================================== [2026-01-17T14:03:37.989Z] renaissance-philosophers_0 Start Time: Sat Jan 17 14:03:37 2026 Epoch Time (ms): 1768658617350 [2026-01-17T14:03:37.989Z] variation: NoOptions [2026-01-17T14:03:37.989Z] JVM_OPTIONS: [2026-01-17T14:03:37.989Z] { \ [2026-01-17T14:03:37.989Z] echo ""; echo "TEST SETUP:"; \ [2026-01-17T14:03:37.989Z] echo "Nothing to be done for setup."; \ [2026-01-17T14:03:37.989Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17686563945539/renaissance-philosophers_0"; \ [2026-01-17T14:03:37.989Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17686563945539/renaissance-philosophers_0"; \ [2026-01-17T14:03:37.989Z] echo ""; echo "TESTING:"; \ [2026-01-17T14:03:37.989Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-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_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17686563945539/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-17T14:03:37.989Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17686563945539/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-17T14:03:37.989Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-17T14:03:37.989Z] echo "Nothing to be done for teardown."; \ [2026-01-17T14:03:37.989Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17686563945539/TestTargetResult"; [2026-01-17T14:03:37.989Z] [2026-01-17T14:03:37.989Z] TEST SETUP: [2026-01-17T14:03:37.989Z] Nothing to be done for setup. [2026-01-17T14:03:37.989Z] [2026-01-17T14:03:37.989Z] TESTING: [2026-01-17T14:03:38.750Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-17T14:03:38.751Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17686563945539/renaissance-philosophers_0/launcher-140337-862344292996918853/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-17T14:03:38.751Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-17T14:03:38.751Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-17T14:03:39.520Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-17T14:03:39.520Z] GC before operation: completed in 42.325 ms, heap usage 27.129 MB -> 4.802 MB. [2026-01-17T14:03:45.159Z] Camera thread performed 122 scans. [2026-01-17T14:03:45.159Z] ====== philosophers (scala) [default], iteration 0 completed (5282.772 ms) ====== [2026-01-17T14:03:45.159Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-17T14:03:45.159Z] GC before operation: completed in 34.260 ms, heap usage 6.878 MB -> 5.135 MB. [2026-01-17T14:03:46.741Z] Camera thread performed 122 scans. [2026-01-17T14:03:46.741Z] ====== philosophers (scala) [default], iteration 1 completed (2293.827 ms) ====== [2026-01-17T14:03:46.741Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-17T14:03:46.741Z] GC before operation: completed in 23.503 ms, heap usage 58.306 MB -> 5.136 MB. [2026-01-17T14:03:48.322Z] Camera thread performed 122 scans. [2026-01-17T14:03:48.322Z] ====== philosophers (scala) [default], iteration 2 completed (1570.375 ms) ====== [2026-01-17T14:03:48.322Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-17T14:03:48.322Z] GC before operation: completed in 32.916 ms, heap usage 36.323 MB -> 5.136 MB. [2026-01-17T14:03:50.410Z] Camera thread performed 122 scans. [2026-01-17T14:03:50.410Z] ====== philosophers (scala) [default], iteration 3 completed (1422.334 ms) ====== [2026-01-17T14:03:50.410Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-17T14:03:50.410Z] GC before operation: completed in 37.766 ms, heap usage 22.119 MB -> 5.137 MB. [2026-01-17T14:03:51.173Z] Camera thread performed 122 scans. [2026-01-17T14:03:51.173Z] ====== philosophers (scala) [default], iteration 4 completed (1439.039 ms) ====== [2026-01-17T14:03:51.173Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-17T14:03:51.173Z] GC before operation: completed in 23.262 ms, heap usage 82.789 MB -> 5.138 MB. [2026-01-17T14:03:52.756Z] Camera thread performed 122 scans. [2026-01-17T14:03:52.756Z] ====== philosophers (scala) [default], iteration 5 completed (1390.981 ms) ====== [2026-01-17T14:03:52.756Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-17T14:03:52.756Z] GC before operation: completed in 26.335 ms, heap usage 47.774 MB -> 5.173 MB. [2026-01-17T14:03:54.331Z] Camera thread performed 122 scans. [2026-01-17T14:03:54.332Z] ====== philosophers (scala) [default], iteration 6 completed (1728.740 ms) ====== [2026-01-17T14:03:54.332Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-17T14:03:54.332Z] GC before operation: completed in 21.945 ms, heap usage 31.358 MB -> 5.138 MB. [2026-01-17T14:03:55.918Z] Camera thread performed 122 scans. [2026-01-17T14:03:55.918Z] ====== philosophers (scala) [default], iteration 7 completed (1476.267 ms) ====== [2026-01-17T14:03:55.918Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-17T14:03:55.918Z] GC before operation: completed in 35.677 ms, heap usage 14.704 MB -> 5.138 MB. [2026-01-17T14:03:57.491Z] Camera thread performed 122 scans. [2026-01-17T14:03:57.491Z] ====== philosophers (scala) [default], iteration 8 completed (1405.893 ms) ====== [2026-01-17T14:03:57.491Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-17T14:03:57.491Z] GC before operation: completed in 23.407 ms, heap usage 59.344 MB -> 5.140 MB. [2026-01-17T14:03:59.062Z] Camera thread performed 122 scans. [2026-01-17T14:03:59.062Z] ====== philosophers (scala) [default], iteration 9 completed (1404.062 ms) ====== [2026-01-17T14:03:59.062Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-17T14:03:59.062Z] GC before operation: completed in 23.147 ms, heap usage 77.048 MB -> 5.139 MB. [2026-01-17T14:04:00.645Z] Camera thread performed 122 scans. [2026-01-17T14:04:00.645Z] ====== philosophers (scala) [default], iteration 10 completed (1582.735 ms) ====== [2026-01-17T14:04:00.645Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-17T14:04:00.645Z] GC before operation: completed in 28.729 ms, heap usage 20.685 MB -> 5.140 MB. [2026-01-17T14:04:02.217Z] Camera thread performed 122 scans. [2026-01-17T14:04:02.217Z] ====== philosophers (scala) [default], iteration 11 completed (1520.640 ms) ====== [2026-01-17T14:04:02.217Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-17T14:04:02.217Z] GC before operation: completed in 29.497 ms, heap usage 21.290 MB -> 5.140 MB. [2026-01-17T14:04:03.798Z] Camera thread performed 122 scans. [2026-01-17T14:04:03.798Z] ====== philosophers (scala) [default], iteration 12 completed (1622.821 ms) ====== [2026-01-17T14:04:03.798Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-17T14:04:03.798Z] GC before operation: completed in 49.203 ms, heap usage 75.022 MB -> 5.140 MB. [2026-01-17T14:04:05.369Z] Camera thread performed 122 scans. [2026-01-17T14:04:05.369Z] ====== philosophers (scala) [default], iteration 13 completed (1559.495 ms) ====== [2026-01-17T14:04:05.369Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-17T14:04:05.369Z] GC before operation: completed in 27.303 ms, heap usage 52.718 MB -> 5.140 MB. [2026-01-17T14:04:06.975Z] Camera thread performed 122 scans. [2026-01-17T14:04:06.975Z] ====== philosophers (scala) [default], iteration 14 completed (1466.641 ms) ====== [2026-01-17T14:04:06.975Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-17T14:04:06.975Z] GC before operation: completed in 37.651 ms, heap usage 26.739 MB -> 5.140 MB. [2026-01-17T14:04:08.555Z] Camera thread performed 122 scans. [2026-01-17T14:04:08.555Z] ====== philosophers (scala) [default], iteration 15 completed (1332.113 ms) ====== [2026-01-17T14:04:08.555Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-17T14:04:08.555Z] GC before operation: completed in 42.966 ms, heap usage 67.733 MB -> 5.175 MB. [2026-01-17T14:04:10.126Z] Camera thread performed 122 scans. [2026-01-17T14:04:10.127Z] ====== philosophers (scala) [default], iteration 16 completed (1438.873 ms) ====== [2026-01-17T14:04:10.127Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-17T14:04:10.127Z] GC before operation: completed in 38.586 ms, heap usage 48.698 MB -> 5.176 MB. [2026-01-17T14:04:11.698Z] Camera thread performed 122 scans. [2026-01-17T14:04:11.698Z] ====== philosophers (scala) [default], iteration 17 completed (1500.815 ms) ====== [2026-01-17T14:04:11.698Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-17T14:04:11.698Z] GC before operation: completed in 29.745 ms, heap usage 37.224 MB -> 5.141 MB. [2026-01-17T14:04:13.279Z] Camera thread performed 122 scans. [2026-01-17T14:04:13.279Z] ====== philosophers (scala) [default], iteration 18 completed (1614.037 ms) ====== [2026-01-17T14:04:13.279Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-17T14:04:13.279Z] GC before operation: completed in 29.224 ms, heap usage 10.244 MB -> 5.141 MB. [2026-01-17T14:04:14.050Z] Camera thread performed 122 scans. [2026-01-17T14:04:14.050Z] ====== philosophers (scala) [default], iteration 19 completed (1406.323 ms) ====== [2026-01-17T14:04:14.050Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-17T14:04:14.050Z] GC before operation: completed in 22.035 ms, heap usage 82.811 MB -> 5.141 MB. [2026-01-17T14:04:15.628Z] Camera thread performed 122 scans. [2026-01-17T14:04:15.628Z] ====== philosophers (scala) [default], iteration 20 completed (1449.440 ms) ====== [2026-01-17T14:04:15.628Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-17T14:04:15.628Z] GC before operation: completed in 29.781 ms, heap usage 35.693 MB -> 5.141 MB. [2026-01-17T14:04:17.213Z] Camera thread performed 122 scans. [2026-01-17T14:04:17.213Z] ====== philosophers (scala) [default], iteration 21 completed (1365.115 ms) ====== [2026-01-17T14:04:17.213Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-17T14:04:17.213Z] GC before operation: completed in 36.135 ms, heap usage 73.341 MB -> 5.141 MB. [2026-01-17T14:04:18.801Z] Camera thread performed 122 scans. [2026-01-17T14:04:18.801Z] ====== philosophers (scala) [default], iteration 22 completed (1408.140 ms) ====== [2026-01-17T14:04:18.801Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-17T14:04:18.801Z] GC before operation: completed in 29.643 ms, heap usage 79.032 MB -> 5.141 MB. [2026-01-17T14:04:20.380Z] Camera thread performed 122 scans. [2026-01-17T14:04:20.380Z] ====== philosophers (scala) [default], iteration 23 completed (1553.919 ms) ====== [2026-01-17T14:04:20.380Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-17T14:04:20.380Z] GC before operation: completed in 30.455 ms, heap usage 71.248 MB -> 5.141 MB. [2026-01-17T14:04:21.955Z] Camera thread performed 122 scans. [2026-01-17T14:04:21.955Z] ====== philosophers (scala) [default], iteration 24 completed (1551.966 ms) ====== [2026-01-17T14:04:21.955Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-17T14:04:21.955Z] GC before operation: completed in 23.078 ms, heap usage 19.133 MB -> 5.142 MB. [2026-01-17T14:04:23.539Z] Camera thread performed 122 scans. [2026-01-17T14:04:23.539Z] ====== philosophers (scala) [default], iteration 25 completed (1532.364 ms) ====== [2026-01-17T14:04:23.539Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-17T14:04:23.539Z] GC before operation: completed in 32.866 ms, heap usage 28.749 MB -> 5.141 MB. [2026-01-17T14:04:25.116Z] Camera thread performed 122 scans. [2026-01-17T14:04:25.116Z] ====== philosophers (scala) [default], iteration 26 completed (1548.086 ms) ====== [2026-01-17T14:04:25.116Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-17T14:04:25.116Z] GC before operation: completed in 29.646 ms, heap usage 63.303 MB -> 5.177 MB. [2026-01-17T14:04:26.698Z] Camera thread performed 122 scans. [2026-01-17T14:04:26.698Z] ====== philosophers (scala) [default], iteration 27 completed (1621.013 ms) ====== [2026-01-17T14:04:26.698Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-17T14:04:26.698Z] GC before operation: completed in 29.386 ms, heap usage 65.669 MB -> 5.142 MB. [2026-01-17T14:04:28.273Z] Camera thread performed 122 scans. [2026-01-17T14:04:28.273Z] ====== philosophers (scala) [default], iteration 28 completed (1650.214 ms) ====== [2026-01-17T14:04:28.273Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-17T14:04:28.273Z] GC before operation: completed in 29.460 ms, heap usage 56.289 MB -> 5.142 MB. [2026-01-17T14:04:29.843Z] Camera thread performed 122 scans. [2026-01-17T14:04:29.843Z] ====== philosophers (scala) [default], iteration 29 completed (1517.234 ms) ====== [2026-01-17T14:04:29.843Z] ----------------------------------- [2026-01-17T14:04:29.843Z] renaissance-philosophers_0_PASSED [2026-01-17T14:04:29.843Z] ----------------------------------- [2026-01-17T14:04:29.843Z] [2026-01-17T14:04:29.843Z] TEST TEARDOWN: [2026-01-17T14:04:29.843Z] Nothing to be done for teardown. [2026-01-17T14:04:30.609Z] renaissance-philosophers_0 Finish Time: Sat Jan 17 14:04:29 2026 Epoch Time (ms): 1768658669804