[2025-12-10T00:42:51.861Z] Running test renaissance-philosophers_0 ... [2025-12-10T00:42:51.861Z] =============================================== [2025-12-10T00:42:52.187Z] renaissance-philosophers_0 Start Time: Wed Dec 10 00:42:51 2025 Epoch Time (ms): 1765327371894 [2025-12-10T00:42:52.187Z] variation: NoOptions [2025-12-10T00:42:52.187Z] JVM_OPTIONS: [2025-12-10T00:42:52.187Z] { \ [2025-12-10T00:42:52.187Z] echo ""; echo "TEST SETUP:"; \ [2025-12-10T00:42:52.187Z] echo "Nothing to be done for setup."; \ [2025-12-10T00:42:52.187Z] mkdir -p "C:/jenkins/workspace/Test_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17653267051876\\renaissance-philosophers_0"; \ [2025-12-10T00:42:52.187Z] cd "C:/jenkins/workspace/Test_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17653267051876\\renaissance-philosophers_0"; \ [2025-12-10T00:42:52.187Z] echo ""; echo "TESTING:"; \ [2025-12-10T00:42:52.187Z] "c:/jenkins/workspace/Test_openjdk26_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_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17653267051876\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2025-12-10T00:42:52.187Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17653267051876\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-10T00:42:52.187Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-10T00:42:52.187Z] echo "Nothing to be done for teardown."; \ [2025-12-10T00:42:52.187Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17653267051876\\TestTargetResult"; [2025-12-10T00:42:52.539Z] [2025-12-10T00:42:52.539Z] TEST SETUP: [2025-12-10T00:42:52.539Z] Nothing to be done for setup. [2025-12-10T00:42:52.539Z] [2025-12-10T00:42:52.539Z] TESTING: [2025-12-10T00:42:53.340Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-10T00:42:53.340Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/C:/jenkins/workspace/Test_openjdk26_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17653267051876/renaissance-philosophers_0/launcher-004252-14915075283708918556/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-10T00:42:53.340Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-10T00:42:53.340Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-10T00:42:53.679Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-12-10T00:42:53.679Z] GC before operation: completed in 17.555 ms, heap usage 9.783 MB -> 5.050 MB. [2025-12-10T00:42:55.692Z] Camera thread performed 122 scans. [2025-12-10T00:42:55.692Z] ====== philosophers (scala) [default], iteration 0 completed (1631.792 ms) ====== [2025-12-10T00:42:55.692Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-12-10T00:42:55.692Z] GC before operation: completed in 29.198 ms, heap usage 25.007 MB -> 5.387 MB. [2025-12-10T00:42:56.538Z] Camera thread performed 122 scans. [2025-12-10T00:42:56.538Z] ====== philosophers (scala) [default], iteration 1 completed (886.945 ms) ====== [2025-12-10T00:42:56.538Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-12-10T00:42:56.538Z] GC before operation: completed in 14.977 ms, heap usage 22.286 MB -> 5.389 MB. [2025-12-10T00:42:57.240Z] Camera thread performed 122 scans. [2025-12-10T00:42:57.240Z] ====== philosophers (scala) [default], iteration 2 completed (799.390 ms) ====== [2025-12-10T00:42:57.240Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-12-10T00:42:57.240Z] GC before operation: completed in 13.987 ms, heap usage 34.502 MB -> 5.390 MB. [2025-12-10T00:42:57.940Z] Camera thread performed 122 scans. [2025-12-10T00:42:57.940Z] ====== philosophers (scala) [default], iteration 3 completed (818.744 ms) ====== [2025-12-10T00:42:57.940Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-12-10T00:42:57.940Z] GC before operation: completed in 13.762 ms, heap usage 33.010 MB -> 5.390 MB. [2025-12-10T00:42:59.065Z] Camera thread performed 122 scans. [2025-12-10T00:42:59.065Z] ====== philosophers (scala) [default], iteration 4 completed (840.324 ms) ====== [2025-12-10T00:42:59.065Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-12-10T00:42:59.065Z] GC before operation: completed in 15.609 ms, heap usage 26.543 MB -> 5.391 MB. [2025-12-10T00:42:59.817Z] Camera thread performed 122 scans. [2025-12-10T00:42:59.817Z] ====== philosophers (scala) [default], iteration 5 completed (836.220 ms) ====== [2025-12-10T00:42:59.817Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-12-10T00:42:59.817Z] GC before operation: completed in 13.736 ms, heap usage 34.970 MB -> 5.391 MB. [2025-12-10T00:43:00.521Z] Camera thread performed 122 scans. [2025-12-10T00:43:00.521Z] ====== philosophers (scala) [default], iteration 6 completed (741.858 ms) ====== [2025-12-10T00:43:00.521Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-12-10T00:43:00.521Z] GC before operation: completed in 14.131 ms, heap usage 32.982 MB -> 5.391 MB. [2025-12-10T00:43:01.221Z] Camera thread performed 122 scans. [2025-12-10T00:43:01.221Z] ====== philosophers (scala) [default], iteration 7 completed (849.768 ms) ====== [2025-12-10T00:43:01.221Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-12-10T00:43:01.221Z] GC before operation: completed in 13.804 ms, heap usage 43.931 MB -> 5.391 MB. [2025-12-10T00:43:02.361Z] Camera thread performed 122 scans. [2025-12-10T00:43:02.361Z] ====== philosophers (scala) [default], iteration 8 completed (833.241 ms) ====== [2025-12-10T00:43:02.361Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-12-10T00:43:02.361Z] GC before operation: completed in 14.145 ms, heap usage 38.929 MB -> 5.391 MB. [2025-12-10T00:43:03.061Z] Camera thread performed 122 scans. [2025-12-10T00:43:03.061Z] ====== philosophers (scala) [default], iteration 9 completed (838.840 ms) ====== [2025-12-10T00:43:03.061Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-12-10T00:43:03.061Z] GC before operation: completed in 13.532 ms, heap usage 8.326 MB -> 5.392 MB. [2025-12-10T00:43:03.807Z] Camera thread performed 122 scans. [2025-12-10T00:43:03.807Z] ====== philosophers (scala) [default], iteration 10 completed (834.107 ms) ====== [2025-12-10T00:43:03.807Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-12-10T00:43:03.807Z] GC before operation: completed in 15.208 ms, heap usage 38.918 MB -> 5.392 MB. [2025-12-10T00:43:04.546Z] Camera thread performed 122 scans. [2025-12-10T00:43:04.546Z] ====== philosophers (scala) [default], iteration 11 completed (756.065 ms) ====== [2025-12-10T00:43:04.546Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-12-10T00:43:04.546Z] GC before operation: completed in 13.998 ms, heap usage 28.984 MB -> 5.393 MB. [2025-12-10T00:43:05.682Z] Camera thread performed 122 scans. [2025-12-10T00:43:05.682Z] ====== philosophers (scala) [default], iteration 12 completed (830.573 ms) ====== [2025-12-10T00:43:05.682Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-12-10T00:43:05.682Z] GC before operation: completed in 13.883 ms, heap usage 38.924 MB -> 5.393 MB. [2025-12-10T00:43:06.384Z] Camera thread performed 122 scans. [2025-12-10T00:43:06.384Z] ====== philosophers (scala) [default], iteration 13 completed (782.369 ms) ====== [2025-12-10T00:43:06.384Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-12-10T00:43:06.384Z] GC before operation: completed in 14.020 ms, heap usage 30.891 MB -> 5.393 MB. [2025-12-10T00:43:07.085Z] Camera thread performed 122 scans. [2025-12-10T00:43:07.085Z] ====== philosophers (scala) [default], iteration 14 completed (847.858 ms) ====== [2025-12-10T00:43:07.085Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-12-10T00:43:07.085Z] GC before operation: completed in 14.186 ms, heap usage 46.930 MB -> 5.393 MB. [2025-12-10T00:43:07.788Z] Camera thread performed 122 scans. [2025-12-10T00:43:07.788Z] ====== philosophers (scala) [default], iteration 15 completed (744.625 ms) ====== [2025-12-10T00:43:07.788Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-12-10T00:43:07.788Z] GC before operation: completed in 13.706 ms, heap usage 42.915 MB -> 5.393 MB. [2025-12-10T00:43:08.919Z] Camera thread performed 122 scans. [2025-12-10T00:43:08.919Z] ====== philosophers (scala) [default], iteration 16 completed (793.675 ms) ====== [2025-12-10T00:43:08.919Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-12-10T00:43:08.919Z] GC before operation: completed in 13.840 ms, heap usage 22.915 MB -> 5.394 MB. [2025-12-10T00:43:09.619Z] Camera thread performed 122 scans. [2025-12-10T00:43:09.619Z] ====== philosophers (scala) [default], iteration 17 completed (849.409 ms) ====== [2025-12-10T00:43:09.619Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-12-10T00:43:09.619Z] GC before operation: completed in 13.689 ms, heap usage 9.342 MB -> 5.394 MB. [2025-12-10T00:43:10.345Z] Camera thread performed 122 scans. [2025-12-10T00:43:10.345Z] ====== philosophers (scala) [default], iteration 18 completed (838.253 ms) ====== [2025-12-10T00:43:10.345Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-12-10T00:43:10.345Z] GC before operation: completed in 13.703 ms, heap usage 43.930 MB -> 5.394 MB. [2025-12-10T00:43:11.466Z] Camera thread performed 122 scans. [2025-12-10T00:43:11.466Z] ====== philosophers (scala) [default], iteration 19 completed (785.239 ms) ====== [2025-12-10T00:43:11.466Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-12-10T00:43:11.466Z] GC before operation: completed in 15.937 ms, heap usage 6.983 MB -> 5.394 MB. [2025-12-10T00:43:12.168Z] Camera thread performed 122 scans. [2025-12-10T00:43:12.168Z] ====== philosophers (scala) [default], iteration 20 completed (831.146 ms) ====== [2025-12-10T00:43:12.168Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-12-10T00:43:12.168Z] GC before operation: completed in 13.752 ms, heap usage 23.347 MB -> 5.394 MB. [2025-12-10T00:43:12.888Z] Camera thread performed 122 scans. [2025-12-10T00:43:12.888Z] ====== philosophers (scala) [default], iteration 21 completed (827.147 ms) ====== [2025-12-10T00:43:12.888Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-12-10T00:43:12.888Z] GC before operation: completed in 13.806 ms, heap usage 23.478 MB -> 5.394 MB. [2025-12-10T00:43:13.589Z] Camera thread performed 122 scans. [2025-12-10T00:43:13.589Z] ====== philosophers (scala) [default], iteration 22 completed (808.194 ms) ====== [2025-12-10T00:43:13.589Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-12-10T00:43:13.923Z] GC before operation: completed in 14.875 ms, heap usage 23.429 MB -> 5.394 MB. [2025-12-10T00:43:14.625Z] Camera thread performed 122 scans. [2025-12-10T00:43:14.625Z] ====== philosophers (scala) [default], iteration 23 completed (799.315 ms) ====== [2025-12-10T00:43:14.625Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-12-10T00:43:14.625Z] GC before operation: completed in 13.734 ms, heap usage 35.913 MB -> 5.394 MB. [2025-12-10T00:43:15.325Z] Camera thread performed 122 scans. [2025-12-10T00:43:15.325Z] ====== philosophers (scala) [default], iteration 24 completed (831.692 ms) ====== [2025-12-10T00:43:15.325Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-12-10T00:43:15.325Z] GC before operation: completed in 14.481 ms, heap usage 37.358 MB -> 5.394 MB. [2025-12-10T00:43:16.458Z] Camera thread performed 122 scans. [2025-12-10T00:43:16.458Z] ====== philosophers (scala) [default], iteration 25 completed (842.861 ms) ====== [2025-12-10T00:43:16.458Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-12-10T00:43:16.458Z] GC before operation: completed in 14.578 ms, heap usage 43.351 MB -> 5.394 MB. [2025-12-10T00:43:17.157Z] Camera thread performed 122 scans. [2025-12-10T00:43:17.157Z] ====== philosophers (scala) [default], iteration 26 completed (818.886 ms) ====== [2025-12-10T00:43:17.157Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-12-10T00:43:17.157Z] GC before operation: completed in 16.640 ms, heap usage 30.896 MB -> 5.395 MB. [2025-12-10T00:43:17.861Z] Camera thread performed 122 scans. [2025-12-10T00:43:17.861Z] ====== philosophers (scala) [default], iteration 27 completed (842.707 ms) ====== [2025-12-10T00:43:17.861Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-12-10T00:43:17.861Z] GC before operation: completed in 13.671 ms, heap usage 29.350 MB -> 5.394 MB. [2025-12-10T00:43:18.988Z] Camera thread performed 122 scans. [2025-12-10T00:43:18.988Z] ====== philosophers (scala) [default], iteration 28 completed (832.981 ms) ====== [2025-12-10T00:43:18.988Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-12-10T00:43:18.988Z] GC before operation: completed in 14.586 ms, heap usage 33.924 MB -> 5.395 MB. [2025-12-10T00:43:19.750Z] Camera thread performed 122 scans. [2025-12-10T00:43:19.750Z] ====== philosophers (scala) [default], iteration 29 completed (854.702 ms) ====== [2025-12-10T00:43:20.082Z] ----------------------------------- [2025-12-10T00:43:20.082Z] renaissance-philosophers_0_PASSED [2025-12-10T00:43:20.082Z] ----------------------------------- [2025-12-10T00:43:20.082Z] [2025-12-10T00:43:20.082Z] TEST TEARDOWN: [2025-12-10T00:43:20.082Z] Nothing to be done for teardown. [2025-12-10T00:43:20.082Z] renaissance-philosophers_0 Finish Time: Wed Dec 10 00:43:19 2025 Epoch Time (ms): 1765327399927