[2026-03-06T05:06:07.173Z] Running test renaissance-philosophers_0 ... [2026-03-06T05:06:07.173Z] =============================================== [2026-03-06T05:06:07.173Z] renaissance-philosophers_0 Start Time: Fri Mar 6 05:06:06 2026 Epoch Time (ms): 1772773566415 [2026-03-06T05:06:07.173Z] variation: NoOptions [2026-03-06T05:06:07.173Z] JVM_OPTIONS: [2026-03-06T05:06:07.173Z] { \ [2026-03-06T05:06:07.173Z] echo ""; echo "TEST SETUP:"; \ [2026-03-06T05:06:07.173Z] echo "Nothing to be done for setup."; \ [2026-03-06T05:06:07.173Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727715576995/renaissance-philosophers_0"; \ [2026-03-06T05:06:07.173Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727715576995/renaissance-philosophers_0"; \ [2026-03-06T05:06:07.173Z] echo ""; echo "TESTING:"; \ [2026-03-06T05:06:07.173Z] "/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_17727715576995/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-03-06T05:06:07.173Z] 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_17727715576995/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-06T05:06:07.173Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-06T05:06:07.173Z] echo "Nothing to be done for teardown."; \ [2026-03-06T05:06:07.173Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727715576995/TestTargetResult"; [2026-03-06T05:06:07.173Z] [2026-03-06T05:06:07.173Z] TEST SETUP: [2026-03-06T05:06:07.173Z] Nothing to be done for setup. [2026-03-06T05:06:07.173Z] [2026-03-06T05:06:07.173Z] TESTING: [2026-03-06T05:06:07.948Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-03-06T05:06:07.948Z] 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_17727715576995/renaissance-philosophers_0/launcher-050606-910459704096928627/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-03-06T05:06:07.948Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-03-06T05:06:07.948Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-03-06T05:06:07.948Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-06T05:06:07.948Z] GC before operation: completed in 39.323 ms, heap usage 27.129 MB -> 4.805 MB. [2026-03-06T05:06:11.375Z] Camera thread performed 122 scans. [2026-03-06T05:06:11.375Z] ====== philosophers (scala) [default], iteration 0 completed (3347.465 ms) ====== [2026-03-06T05:06:11.375Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-06T05:06:11.375Z] GC before operation: completed in 45.971 ms, heap usage 63.882 MB -> 5.141 MB. [2026-03-06T05:06:13.832Z] Camera thread performed 122 scans. [2026-03-06T05:06:13.832Z] ====== philosophers (scala) [default], iteration 1 completed (1603.371 ms) ====== [2026-03-06T05:06:13.832Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-06T05:06:13.832Z] GC before operation: completed in 46.428 ms, heap usage 42.326 MB -> 5.142 MB. [2026-03-06T05:06:14.588Z] Camera thread performed 122 scans. [2026-03-06T05:06:14.588Z] ====== philosophers (scala) [default], iteration 2 completed (1401.888 ms) ====== [2026-03-06T05:06:14.588Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-06T05:06:14.588Z] GC before operation: completed in 38.890 ms, heap usage 57.866 MB -> 5.142 MB. [2026-03-06T05:06:16.176Z] Camera thread performed 122 scans. [2026-03-06T05:06:16.176Z] ====== philosophers (scala) [default], iteration 3 completed (1342.063 ms) ====== [2026-03-06T05:06:16.176Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-06T05:06:16.176Z] GC before operation: completed in 35.799 ms, heap usage 62.841 MB -> 5.144 MB. [2026-03-06T05:06:17.763Z] Camera thread performed 122 scans. [2026-03-06T05:06:17.763Z] ====== philosophers (scala) [default], iteration 4 completed (1182.299 ms) ====== [2026-03-06T05:06:17.763Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-06T05:06:17.763Z] GC before operation: completed in 35.300 ms, heap usage 18.850 MB -> 5.144 MB. [2026-03-06T05:06:18.525Z] Camera thread performed 122 scans. [2026-03-06T05:06:18.525Z] ====== philosophers (scala) [default], iteration 5 completed (1172.025 ms) ====== [2026-03-06T05:06:18.525Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-06T05:06:18.525Z] GC before operation: completed in 41.290 ms, heap usage 34.835 MB -> 5.144 MB. [2026-03-06T05:06:20.107Z] Camera thread performed 122 scans. [2026-03-06T05:06:20.107Z] ====== philosophers (scala) [default], iteration 6 completed (1290.983 ms) ====== [2026-03-06T05:06:20.107Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-06T05:06:20.107Z] GC before operation: completed in 36.554 ms, heap usage 85.197 MB -> 5.144 MB. [2026-03-06T05:06:21.669Z] Camera thread performed 122 scans. [2026-03-06T05:06:21.669Z] ====== philosophers (scala) [default], iteration 7 completed (1370.827 ms) ====== [2026-03-06T05:06:21.669Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-06T05:06:21.669Z] GC before operation: completed in 35.060 ms, heap usage 15.343 MB -> 5.144 MB. [2026-03-06T05:06:22.426Z] Camera thread performed 122 scans. [2026-03-06T05:06:22.426Z] ====== philosophers (scala) [default], iteration 8 completed (1207.353 ms) ====== [2026-03-06T05:06:22.426Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-06T05:06:22.426Z] GC before operation: completed in 33.240 ms, heap usage 33.117 MB -> 5.179 MB. [2026-03-06T05:06:23.996Z] Camera thread performed 122 scans. [2026-03-06T05:06:23.996Z] ====== philosophers (scala) [default], iteration 9 completed (1325.659 ms) ====== [2026-03-06T05:06:23.996Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-06T05:06:23.996Z] GC before operation: completed in 19.904 ms, heap usage 47.158 MB -> 5.145 MB. [2026-03-06T05:06:25.572Z] Camera thread performed 122 scans. [2026-03-06T05:06:25.572Z] ====== philosophers (scala) [default], iteration 10 completed (1439.054 ms) ====== [2026-03-06T05:06:25.572Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-06T05:06:25.572Z] GC before operation: completed in 26.322 ms, heap usage 44.645 MB -> 5.146 MB. [2026-03-06T05:06:26.329Z] Camera thread performed 122 scans. [2026-03-06T05:06:26.329Z] ====== philosophers (scala) [default], iteration 11 completed (1250.412 ms) ====== [2026-03-06T05:06:26.329Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-06T05:06:27.094Z] GC before operation: completed in 49.404 ms, heap usage 26.208 MB -> 5.146 MB. [2026-03-06T05:06:27.844Z] Camera thread performed 122 scans. [2026-03-06T05:06:27.844Z] ====== philosophers (scala) [default], iteration 12 completed (1324.228 ms) ====== [2026-03-06T05:06:27.844Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-06T05:06:27.844Z] GC before operation: completed in 27.190 ms, heap usage 83.758 MB -> 5.146 MB. [2026-03-06T05:06:29.411Z] Camera thread performed 122 scans. [2026-03-06T05:06:29.411Z] ====== philosophers (scala) [default], iteration 13 completed (1364.380 ms) ====== [2026-03-06T05:06:29.411Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-06T05:06:29.411Z] GC before operation: completed in 42.539 ms, heap usage 65.132 MB -> 5.146 MB. [2026-03-06T05:06:30.972Z] Camera thread performed 122 scans. [2026-03-06T05:06:30.972Z] ====== philosophers (scala) [default], iteration 14 completed (1322.613 ms) ====== [2026-03-06T05:06:30.972Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-06T05:06:30.972Z] GC before operation: completed in 37.545 ms, heap usage 46.113 MB -> 5.147 MB. [2026-03-06T05:06:32.537Z] Camera thread performed 122 scans. [2026-03-06T05:06:32.537Z] ====== philosophers (scala) [default], iteration 15 completed (1278.653 ms) ====== [2026-03-06T05:06:32.537Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-06T05:06:32.537Z] GC before operation: completed in 35.336 ms, heap usage 62.118 MB -> 5.147 MB. [2026-03-06T05:06:33.296Z] Camera thread performed 122 scans. [2026-03-06T05:06:33.296Z] ====== philosophers (scala) [default], iteration 16 completed (1379.626 ms) ====== [2026-03-06T05:06:33.296Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-06T05:06:33.296Z] GC before operation: completed in 44.819 ms, heap usage 71.770 MB -> 5.147 MB. [2026-03-06T05:06:34.866Z] Camera thread performed 122 scans. [2026-03-06T05:06:34.866Z] ====== philosophers (scala) [default], iteration 17 completed (1175.813 ms) ====== [2026-03-06T05:06:34.866Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-06T05:06:34.866Z] GC before operation: completed in 37.258 ms, heap usage 66.687 MB -> 5.147 MB. [2026-03-06T05:06:36.428Z] Camera thread performed 122 scans. [2026-03-06T05:06:36.428Z] ====== philosophers (scala) [default], iteration 18 completed (1411.479 ms) ====== [2026-03-06T05:06:36.428Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-06T05:06:36.428Z] GC before operation: completed in 36.640 ms, heap usage 62.844 MB -> 5.147 MB. [2026-03-06T05:06:38.009Z] Camera thread performed 122 scans. [2026-03-06T05:06:38.009Z] ====== philosophers (scala) [default], iteration 19 completed (1409.061 ms) ====== [2026-03-06T05:06:38.009Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-06T05:06:38.009Z] GC before operation: completed in 24.248 ms, heap usage 96.314 MB -> 5.147 MB. [2026-03-06T05:06:39.579Z] Camera thread performed 122 scans. [2026-03-06T05:06:39.579Z] ====== philosophers (scala) [default], iteration 20 completed (1502.293 ms) ====== [2026-03-06T05:06:39.579Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-06T05:06:39.579Z] GC before operation: completed in 18.988 ms, heap usage 61.356 MB -> 5.147 MB. [2026-03-06T05:06:40.335Z] Camera thread performed 122 scans. [2026-03-06T05:06:40.335Z] ====== philosophers (scala) [default], iteration 21 completed (1383.891 ms) ====== [2026-03-06T05:06:40.335Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-06T05:06:40.335Z] GC before operation: completed in 37.353 ms, heap usage 58.847 MB -> 5.147 MB. [2026-03-06T05:06:41.908Z] Camera thread performed 122 scans. [2026-03-06T05:06:41.908Z] ====== philosophers (scala) [default], iteration 22 completed (1457.470 ms) ====== [2026-03-06T05:06:41.908Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-06T05:06:41.908Z] GC before operation: completed in 36.663 ms, heap usage 86.348 MB -> 5.147 MB. [2026-03-06T05:06:43.475Z] Camera thread performed 122 scans. [2026-03-06T05:06:43.475Z] ====== philosophers (scala) [default], iteration 23 completed (1545.564 ms) ====== [2026-03-06T05:06:43.475Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-06T05:06:43.475Z] GC before operation: completed in 22.096 ms, heap usage 61.347 MB -> 5.147 MB. [2026-03-06T05:06:45.036Z] Camera thread performed 122 scans. [2026-03-06T05:06:45.036Z] ====== philosophers (scala) [default], iteration 24 completed (1300.002 ms) ====== [2026-03-06T05:06:45.036Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-06T05:06:45.036Z] GC before operation: completed in 24.188 ms, heap usage 29.116 MB -> 5.147 MB. [2026-03-06T05:06:46.625Z] Camera thread performed 122 scans. [2026-03-06T05:06:46.625Z] ====== philosophers (scala) [default], iteration 25 completed (1536.733 ms) ====== [2026-03-06T05:06:46.625Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-06T05:06:46.625Z] GC before operation: completed in 35.942 ms, heap usage 46.277 MB -> 5.147 MB. [2026-03-06T05:06:48.191Z] Camera thread performed 122 scans. [2026-03-06T05:06:48.191Z] ====== philosophers (scala) [default], iteration 26 completed (1379.742 ms) ====== [2026-03-06T05:06:48.191Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-06T05:06:48.191Z] GC before operation: completed in 36.887 ms, heap usage 101.139 MB -> 5.147 MB. [2026-03-06T05:06:49.760Z] Camera thread performed 122 scans. [2026-03-06T05:06:49.760Z] ====== philosophers (scala) [default], iteration 27 completed (1498.053 ms) ====== [2026-03-06T05:06:49.760Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-06T05:06:49.760Z] GC before operation: completed in 27.432 ms, heap usage 8.766 MB -> 5.147 MB. [2026-03-06T05:06:50.786Z] Camera thread performed 122 scans. [2026-03-06T05:06:50.786Z] ====== philosophers (scala) [default], iteration 28 completed (1257.549 ms) ====== [2026-03-06T05:06:50.786Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-06T05:06:50.786Z] GC before operation: completed in 22.018 ms, heap usage 32.817 MB -> 5.182 MB. [2026-03-06T05:06:52.391Z] Camera thread performed 122 scans. [2026-03-06T05:06:52.391Z] ====== philosophers (scala) [default], iteration 29 completed (1195.653 ms) ====== [2026-03-06T05:06:52.391Z] ----------------------------------- [2026-03-06T05:06:52.391Z] renaissance-philosophers_0_PASSED [2026-03-06T05:06:52.391Z] ----------------------------------- [2026-03-06T05:06:52.391Z] [2026-03-06T05:06:52.391Z] TEST TEARDOWN: [2026-03-06T05:06:52.391Z] Nothing to be done for teardown. [2026-03-06T05:06:52.391Z] renaissance-philosophers_0 Finish Time: Fri Mar 6 05:06:51 2026 Epoch Time (ms): 1772773611981