[2026-01-21T21:15:04.855Z] Running test renaissance-philosophers_0 ... [2026-01-21T21:15:04.855Z] =============================================== [2026-01-21T21:15:05.226Z] renaissance-philosophers_0 Start Time: Wed Jan 21 21:15:04 2026 Epoch Time (ms): 1769030104887 [2026-01-21T21:15:05.226Z] variation: NoOptions [2026-01-21T21:15:05.226Z] JVM_OPTIONS: [2026-01-21T21:15:05.226Z] { \ [2026-01-21T21:15:05.226Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T21:15:05.226Z] echo "Nothing to be done for setup."; \ [2026-01-21T21:15:05.226Z] mkdir -p "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17690278031673\\renaissance-philosophers_0"; \ [2026-01-21T21:15:05.226Z] cd "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17690278031673\\renaissance-philosophers_0"; \ [2026-01-21T21:15:05.226Z] echo ""; echo "TESTING:"; \ [2026-01-21T21:15:05.226Z] "c:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17690278031673\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-01-21T21:15:05.226Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17690278031673\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T21:15:05.226Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T21:15:05.226Z] echo "Nothing to be done for teardown."; \ [2026-01-21T21:15:05.226Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17690278031673\\TestTargetResult"; [2026-01-21T21:15:05.226Z] [2026-01-21T21:15:05.226Z] TEST SETUP: [2026-01-21T21:15:05.226Z] Nothing to be done for setup. [2026-01-21T21:15:05.226Z] [2026-01-21T21:15:05.226Z] TESTING: [2026-01-21T21:15:06.004Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-21T21:15:06.004Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17690278031673/renaissance-philosophers_0/launcher-211505-12884266617295504876/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-21T21:15:06.004Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-21T21:15:06.004Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-21T21:15:06.390Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-21T21:15:06.390Z] GC before operation: completed in 15.760 ms, heap usage 16.579 MB -> 5.070 MB. [2026-01-21T21:15:07.901Z] Camera thread performed 122 scans. [2026-01-21T21:15:07.901Z] ====== philosophers (scala) [default], iteration 0 completed (1212.099 ms) ====== [2026-01-21T21:15:07.901Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-21T21:15:07.901Z] GC before operation: completed in 11.742 ms, heap usage 7.506 MB -> 5.399 MB. [2026-01-21T21:15:08.334Z] Camera thread performed 122 scans. [2026-01-21T21:15:08.334Z] ====== philosophers (scala) [default], iteration 1 completed (613.147 ms) ====== [2026-01-21T21:15:08.334Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-21T21:15:08.334Z] GC before operation: completed in 10.498 ms, heap usage 7.356 MB -> 5.400 MB. [2026-01-21T21:15:08.735Z] Camera thread performed 122 scans. [2026-01-21T21:15:08.735Z] ====== philosophers (scala) [default], iteration 2 completed (522.334 ms) ====== [2026-01-21T21:15:08.735Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-21T21:15:08.735Z] GC before operation: completed in 10.837 ms, heap usage 20.783 MB -> 5.401 MB. [2026-01-21T21:15:09.503Z] Camera thread performed 122 scans. [2026-01-21T21:15:09.504Z] ====== philosophers (scala) [default], iteration 3 completed (536.035 ms) ====== [2026-01-21T21:15:09.504Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-21T21:15:09.504Z] GC before operation: completed in 10.526 ms, heap usage 31.659 MB -> 5.402 MB. [2026-01-21T21:15:09.874Z] Camera thread performed 122 scans. [2026-01-21T21:15:09.874Z] ====== philosophers (scala) [default], iteration 4 completed (610.249 ms) ====== [2026-01-21T21:15:09.874Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-21T21:15:09.874Z] GC before operation: completed in 10.576 ms, heap usage 38.042 MB -> 5.402 MB. [2026-01-21T21:15:10.649Z] Camera thread performed 122 scans. [2026-01-21T21:15:10.650Z] ====== philosophers (scala) [default], iteration 5 completed (611.092 ms) ====== [2026-01-21T21:15:10.650Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-21T21:15:10.650Z] GC before operation: completed in 10.490 ms, heap usage 34.029 MB -> 5.403 MB. [2026-01-21T21:15:11.400Z] Camera thread performed 122 scans. [2026-01-21T21:15:11.400Z] ====== philosophers (scala) [default], iteration 6 completed (649.531 ms) ====== [2026-01-21T21:15:11.400Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-21T21:15:11.400Z] GC before operation: completed in 11.648 ms, heap usage 38.529 MB -> 5.403 MB. [2026-01-21T21:15:11.765Z] Camera thread performed 122 scans. [2026-01-21T21:15:11.765Z] ====== philosophers (scala) [default], iteration 7 completed (621.202 ms) ====== [2026-01-21T21:15:11.765Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-21T21:15:11.765Z] GC before operation: completed in 11.116 ms, heap usage 44.525 MB -> 5.403 MB. [2026-01-21T21:15:12.518Z] Camera thread performed 122 scans. [2026-01-21T21:15:12.518Z] ====== philosophers (scala) [default], iteration 8 completed (604.065 ms) ====== [2026-01-21T21:15:12.518Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-21T21:15:12.518Z] GC before operation: completed in 10.363 ms, heap usage 12.963 MB -> 5.403 MB. [2026-01-21T21:15:13.279Z] Camera thread performed 122 scans. [2026-01-21T21:15:13.279Z] ====== philosophers (scala) [default], iteration 9 completed (627.767 ms) ====== [2026-01-21T21:15:13.279Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-21T21:15:13.279Z] GC before operation: completed in 12.316 ms, heap usage 48.043 MB -> 5.403 MB. [2026-01-21T21:15:13.645Z] Camera thread performed 122 scans. [2026-01-21T21:15:13.645Z] ====== philosophers (scala) [default], iteration 10 completed (567.431 ms) ====== [2026-01-21T21:15:13.645Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-21T21:15:13.645Z] GC before operation: completed in 10.733 ms, heap usage 16.500 MB -> 5.404 MB. [2026-01-21T21:15:14.361Z] Camera thread performed 122 scans. [2026-01-21T21:15:14.361Z] ====== philosophers (scala) [default], iteration 11 completed (522.763 ms) ====== [2026-01-21T21:15:14.361Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-21T21:15:14.361Z] GC before operation: completed in 10.438 ms, heap usage 23.497 MB -> 5.405 MB. [2026-01-21T21:15:14.725Z] Camera thread performed 122 scans. [2026-01-21T21:15:14.725Z] ====== philosophers (scala) [default], iteration 12 completed (575.912 ms) ====== [2026-01-21T21:15:14.725Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-21T21:15:14.725Z] GC before operation: completed in 10.469 ms, heap usage 25.497 MB -> 5.405 MB. [2026-01-21T21:15:15.481Z] Camera thread performed 122 scans. [2026-01-21T21:15:15.481Z] ====== philosophers (scala) [default], iteration 13 completed (562.341 ms) ====== [2026-01-21T21:15:15.481Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-21T21:15:15.481Z] GC before operation: completed in 10.718 ms, heap usage 54.901 MB -> 5.405 MB. [2026-01-21T21:15:16.234Z] Camera thread performed 122 scans. [2026-01-21T21:15:16.234Z] ====== philosophers (scala) [default], iteration 14 completed (622.838 ms) ====== [2026-01-21T21:15:16.234Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-21T21:15:16.234Z] GC before operation: completed in 10.764 ms, heap usage 37.026 MB -> 5.405 MB. [2026-01-21T21:15:16.604Z] Camera thread performed 122 scans. [2026-01-21T21:15:16.604Z] ====== philosophers (scala) [default], iteration 15 completed (622.290 ms) ====== [2026-01-21T21:15:16.604Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-21T21:15:16.604Z] GC before operation: completed in 10.498 ms, heap usage 26.497 MB -> 5.405 MB. [2026-01-21T21:15:17.323Z] Camera thread performed 122 scans. [2026-01-21T21:15:17.323Z] ====== philosophers (scala) [default], iteration 16 completed (627.262 ms) ====== [2026-01-21T21:15:17.323Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-21T21:15:17.323Z] GC before operation: completed in 10.656 ms, heap usage 50.029 MB -> 5.405 MB. [2026-01-21T21:15:18.072Z] Camera thread performed 122 scans. [2026-01-21T21:15:18.072Z] ====== philosophers (scala) [default], iteration 17 completed (603.348 ms) ====== [2026-01-21T21:15:18.072Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-21T21:15:18.072Z] GC before operation: completed in 10.550 ms, heap usage 49.523 MB -> 5.405 MB. [2026-01-21T21:15:18.464Z] Camera thread performed 122 scans. [2026-01-21T21:15:18.465Z] ====== philosophers (scala) [default], iteration 18 completed (598.013 ms) ====== [2026-01-21T21:15:18.465Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-21T21:15:18.465Z] GC before operation: completed in 10.654 ms, heap usage 58.018 MB -> 5.405 MB. [2026-01-21T21:15:19.212Z] Camera thread performed 122 scans. [2026-01-21T21:15:19.212Z] ====== philosophers (scala) [default], iteration 19 completed (620.592 ms) ====== [2026-01-21T21:15:19.212Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-21T21:15:19.212Z] GC before operation: completed in 10.391 ms, heap usage 15.998 MB -> 5.405 MB. [2026-01-21T21:15:19.959Z] Camera thread performed 122 scans. [2026-01-21T21:15:19.959Z] ====== philosophers (scala) [default], iteration 20 completed (592.116 ms) ====== [2026-01-21T21:15:19.959Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-21T21:15:19.959Z] GC before operation: completed in 10.773 ms, heap usage 45.327 MB -> 5.405 MB. [2026-01-21T21:15:20.385Z] Camera thread performed 122 scans. [2026-01-21T21:15:20.385Z] ====== philosophers (scala) [default], iteration 21 completed (603.114 ms) ====== [2026-01-21T21:15:20.385Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-21T21:15:20.385Z] GC before operation: completed in 10.281 ms, heap usage 24.529 MB -> 5.405 MB. [2026-01-21T21:15:20.750Z] Camera thread performed 122 scans. [2026-01-21T21:15:20.750Z] ====== philosophers (scala) [default], iteration 22 completed (502.853 ms) ====== [2026-01-21T21:15:20.750Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-21T21:15:20.750Z] GC before operation: completed in 10.375 ms, heap usage 31.964 MB -> 5.406 MB. [2026-01-21T21:15:21.502Z] Camera thread performed 122 scans. [2026-01-21T21:15:21.502Z] ====== philosophers (scala) [default], iteration 23 completed (642.853 ms) ====== [2026-01-21T21:15:21.502Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-21T21:15:21.502Z] GC before operation: completed in 10.566 ms, heap usage 16.500 MB -> 5.406 MB. [2026-01-21T21:15:22.257Z] Camera thread performed 122 scans. [2026-01-21T21:15:22.257Z] ====== philosophers (scala) [default], iteration 24 completed (517.287 ms) ====== [2026-01-21T21:15:22.257Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-21T21:15:22.257Z] GC before operation: completed in 10.366 ms, heap usage 11.498 MB -> 5.406 MB. [2026-01-21T21:15:22.624Z] Camera thread performed 122 scans. [2026-01-21T21:15:22.624Z] ====== philosophers (scala) [default], iteration 25 completed (640.639 ms) ====== [2026-01-21T21:15:22.624Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-21T21:15:22.624Z] GC before operation: completed in 10.884 ms, heap usage 37.528 MB -> 5.406 MB. [2026-01-21T21:15:23.374Z] Camera thread performed 122 scans. [2026-01-21T21:15:23.374Z] ====== philosophers (scala) [default], iteration 26 completed (634.147 ms) ====== [2026-01-21T21:15:23.374Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-21T21:15:23.374Z] GC before operation: completed in 10.840 ms, heap usage 51.526 MB -> 5.406 MB. [2026-01-21T21:15:24.133Z] Camera thread performed 122 scans. [2026-01-21T21:15:24.133Z] ====== philosophers (scala) [default], iteration 27 completed (628.134 ms) ====== [2026-01-21T21:15:24.133Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-21T21:15:24.133Z] GC before operation: completed in 10.994 ms, heap usage 48.524 MB -> 5.406 MB. [2026-01-21T21:15:24.505Z] Camera thread performed 122 scans. [2026-01-21T21:15:24.505Z] ====== philosophers (scala) [default], iteration 28 completed (616.998 ms) ====== [2026-01-21T21:15:24.505Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-21T21:15:24.505Z] GC before operation: completed in 10.815 ms, heap usage 40.522 MB -> 5.406 MB. [2026-01-21T21:15:25.256Z] Camera thread performed 122 scans. [2026-01-21T21:15:25.256Z] ====== philosophers (scala) [default], iteration 29 completed (546.460 ms) ====== [2026-01-21T21:15:25.588Z] ----------------------------------- [2026-01-21T21:15:25.588Z] renaissance-philosophers_0_PASSED [2026-01-21T21:15:25.588Z] ----------------------------------- [2026-01-21T21:15:25.588Z] [2026-01-21T21:15:25.588Z] TEST TEARDOWN: [2026-01-21T21:15:25.588Z] Nothing to be done for teardown. [2026-01-21T21:15:25.588Z] renaissance-philosophers_0 Finish Time: Wed Jan 21 21:15:25 2026 Epoch Time (ms): 1769030125372