[2025-12-13T15:51:18.372Z] Running test renaissance-philosophers_0 ... [2025-12-13T15:51:18.372Z] =============================================== [2025-12-13T15:51:18.711Z] renaissance-philosophers_0 Start Time: Sat Dec 13 15:51:18 2025 Epoch Time (ms): 1765641078379 [2025-12-13T15:51:18.711Z] variation: NoOptions [2025-12-13T15:51:18.711Z] JVM_OPTIONS: [2025-12-13T15:51:18.711Z] { \ [2025-12-13T15:51:18.711Z] echo ""; echo "TEST SETUP:"; \ [2025-12-13T15:51:18.711Z] echo "Nothing to be done for setup."; \ [2025-12-13T15:51:18.711Z] mkdir -p "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17656378184047\\renaissance-philosophers_0"; \ [2025-12-13T15:51:18.711Z] cd "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17656378184047\\renaissance-philosophers_0"; \ [2025-12-13T15:51:18.711Z] echo ""; echo "TESTING:"; \ [2025-12-13T15:51:18.711Z] "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_17656378184047\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2025-12-13T15:51:18.711Z] 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_17656378184047\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-13T15:51:18.711Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-13T15:51:18.711Z] echo "Nothing to be done for teardown."; \ [2025-12-13T15:51:18.711Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17656378184047\\TestTargetResult"; [2025-12-13T15:51:18.711Z] [2025-12-13T15:51:18.711Z] TEST SETUP: [2025-12-13T15:51:18.711Z] Nothing to be done for setup. [2025-12-13T15:51:18.711Z] [2025-12-13T15:51:18.711Z] TESTING: [2025-12-13T15:51:19.452Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-13T15:51:19.452Z] 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_17656378184047/renaissance-philosophers_0/launcher-155118-1851380891104353886/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-13T15:51:19.452Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-13T15:51:19.452Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-13T15:51:19.801Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-12-13T15:51:19.801Z] GC before operation: completed in 16.872 ms, heap usage 16.608 MB -> 5.079 MB. [2025-12-13T15:51:21.361Z] Camera thread performed 122 scans. [2025-12-13T15:51:21.361Z] ====== philosophers (scala) [default], iteration 0 completed (1327.058 ms) ====== [2025-12-13T15:51:21.361Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-12-13T15:51:21.361Z] GC before operation: completed in 13.048 ms, heap usage 16.537 MB -> 5.409 MB. [2025-12-13T15:51:22.126Z] Camera thread performed 122 scans. [2025-12-13T15:51:22.126Z] ====== philosophers (scala) [default], iteration 1 completed (735.164 ms) ====== [2025-12-13T15:51:22.126Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-12-13T15:51:22.126Z] GC before operation: completed in 10.851 ms, heap usage 19.934 MB -> 5.410 MB. [2025-12-13T15:51:22.473Z] Camera thread performed 122 scans. [2025-12-13T15:51:22.473Z] ====== philosophers (scala) [default], iteration 2 completed (529.573 ms) ====== [2025-12-13T15:51:22.473Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-12-13T15:51:22.473Z] GC before operation: completed in 11.435 ms, heap usage 8.273 MB -> 5.410 MB. [2025-12-13T15:51:23.242Z] Camera thread performed 122 scans. [2025-12-13T15:51:23.242Z] ====== philosophers (scala) [default], iteration 3 completed (697.624 ms) ====== [2025-12-13T15:51:23.242Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-12-13T15:51:23.242Z] GC before operation: completed in 11.862 ms, heap usage 46.748 MB -> 5.411 MB. [2025-12-13T15:51:23.961Z] Camera thread performed 122 scans. [2025-12-13T15:51:23.961Z] ====== philosophers (scala) [default], iteration 4 completed (696.149 ms) ====== [2025-12-13T15:51:23.961Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-12-13T15:51:23.961Z] GC before operation: completed in 11.434 ms, heap usage 45.121 MB -> 5.411 MB. [2025-12-13T15:51:24.693Z] Camera thread performed 122 scans. [2025-12-13T15:51:24.693Z] ====== philosophers (scala) [default], iteration 5 completed (658.971 ms) ====== [2025-12-13T15:51:24.693Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-12-13T15:51:24.693Z] GC before operation: completed in 11.001 ms, heap usage 18.979 MB -> 5.412 MB. [2025-12-13T15:51:25.407Z] Camera thread performed 122 scans. [2025-12-13T15:51:25.407Z] ====== philosophers (scala) [default], iteration 6 completed (575.173 ms) ====== [2025-12-13T15:51:25.407Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-12-13T15:51:25.407Z] GC before operation: completed in 11.436 ms, heap usage 32.527 MB -> 5.412 MB. [2025-12-13T15:51:26.122Z] Camera thread performed 122 scans. [2025-12-13T15:51:26.122Z] ====== philosophers (scala) [default], iteration 7 completed (661.253 ms) ====== [2025-12-13T15:51:26.122Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-12-13T15:51:26.122Z] GC before operation: completed in 11.420 ms, heap usage 16.010 MB -> 5.412 MB. [2025-12-13T15:51:26.460Z] Camera thread performed 122 scans. [2025-12-13T15:51:26.460Z] ====== philosophers (scala) [default], iteration 8 completed (638.798 ms) ====== [2025-12-13T15:51:26.460Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-12-13T15:51:26.460Z] GC before operation: completed in 11.191 ms, heap usage 22.004 MB -> 5.412 MB. [2025-12-13T15:51:27.178Z] Camera thread performed 122 scans. [2025-12-13T15:51:27.178Z] ====== philosophers (scala) [default], iteration 9 completed (664.286 ms) ====== [2025-12-13T15:51:27.178Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-12-13T15:51:27.178Z] GC before operation: completed in 11.275 ms, heap usage 11.007 MB -> 5.412 MB. [2025-12-13T15:51:27.958Z] Camera thread performed 122 scans. [2025-12-13T15:51:27.958Z] ====== philosophers (scala) [default], iteration 10 completed (688.975 ms) ====== [2025-12-13T15:51:27.958Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-12-13T15:51:27.958Z] GC before operation: completed in 11.354 ms, heap usage 41.535 MB -> 5.412 MB. [2025-12-13T15:51:28.674Z] Camera thread performed 122 scans. [2025-12-13T15:51:28.674Z] ====== philosophers (scala) [default], iteration 11 completed (556.495 ms) ====== [2025-12-13T15:51:28.674Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-12-13T15:51:28.674Z] GC before operation: completed in 11.058 ms, heap usage 44.433 MB -> 5.413 MB. [2025-12-13T15:51:29.387Z] Camera thread performed 122 scans. [2025-12-13T15:51:29.387Z] ====== philosophers (scala) [default], iteration 12 completed (689.504 ms) ====== [2025-12-13T15:51:29.387Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-12-13T15:51:29.387Z] GC before operation: completed in 11.173 ms, heap usage 17.534 MB -> 5.413 MB. [2025-12-13T15:51:30.104Z] Camera thread performed 122 scans. [2025-12-13T15:51:30.104Z] ====== philosophers (scala) [default], iteration 13 completed (690.662 ms) ====== [2025-12-13T15:51:30.104Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-12-13T15:51:30.104Z] GC before operation: completed in 11.346 ms, heap usage 17.538 MB -> 5.413 MB. [2025-12-13T15:51:30.821Z] Camera thread performed 122 scans. [2025-12-13T15:51:30.821Z] ====== philosophers (scala) [default], iteration 14 completed (683.796 ms) ====== [2025-12-13T15:51:30.821Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-12-13T15:51:30.821Z] GC before operation: completed in 11.095 ms, heap usage 12.005 MB -> 5.414 MB. [2025-12-13T15:51:31.168Z] Camera thread performed 122 scans. [2025-12-13T15:51:31.168Z] ====== philosophers (scala) [default], iteration 15 completed (653.734 ms) ====== [2025-12-13T15:51:31.168Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-12-13T15:51:31.168Z] GC before operation: completed in 14.835 ms, heap usage 31.033 MB -> 5.414 MB. [2025-12-13T15:51:31.886Z] Camera thread performed 122 scans. [2025-12-13T15:51:31.886Z] ====== philosophers (scala) [default], iteration 16 completed (639.047 ms) ====== [2025-12-13T15:51:31.886Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-12-13T15:51:31.886Z] GC before operation: completed in 11.391 ms, heap usage 23.007 MB -> 5.414 MB. [2025-12-13T15:51:32.607Z] Camera thread performed 122 scans. [2025-12-13T15:51:32.607Z] ====== philosophers (scala) [default], iteration 17 completed (674.384 ms) ====== [2025-12-13T15:51:32.607Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-12-13T15:51:32.607Z] GC before operation: completed in 11.464 ms, heap usage 31.527 MB -> 5.414 MB. [2025-12-13T15:51:33.330Z] Camera thread performed 122 scans. [2025-12-13T15:51:33.330Z] ====== philosophers (scala) [default], iteration 18 completed (695.983 ms) ====== [2025-12-13T15:51:33.330Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-12-13T15:51:33.330Z] GC before operation: completed in 11.211 ms, heap usage 45.535 MB -> 5.414 MB. [2025-12-13T15:51:34.044Z] Camera thread performed 122 scans. [2025-12-13T15:51:34.044Z] ====== philosophers (scala) [default], iteration 19 completed (673.457 ms) ====== [2025-12-13T15:51:34.044Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-12-13T15:51:34.044Z] GC before operation: completed in 11.201 ms, heap usage 25.040 MB -> 5.414 MB. [2025-12-13T15:51:34.826Z] Camera thread performed 122 scans. [2025-12-13T15:51:34.826Z] ====== philosophers (scala) [default], iteration 20 completed (679.126 ms) ====== [2025-12-13T15:51:34.826Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-12-13T15:51:34.826Z] GC before operation: completed in 11.388 ms, heap usage 17.040 MB -> 5.414 MB. [2025-12-13T15:51:35.543Z] Camera thread performed 122 scans. [2025-12-13T15:51:35.543Z] ====== philosophers (scala) [default], iteration 21 completed (649.658 ms) ====== [2025-12-13T15:51:35.543Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-12-13T15:51:35.543Z] GC before operation: completed in 11.217 ms, heap usage 35.486 MB -> 5.414 MB. [2025-12-13T15:51:35.885Z] Camera thread performed 122 scans. [2025-12-13T15:51:35.885Z] ====== philosophers (scala) [default], iteration 22 completed (617.547 ms) ====== [2025-12-13T15:51:35.885Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-12-13T15:51:35.885Z] GC before operation: completed in 11.731 ms, heap usage 6.008 MB -> 5.414 MB. [2025-12-13T15:51:36.599Z] Camera thread performed 122 scans. [2025-12-13T15:51:36.599Z] ====== philosophers (scala) [default], iteration 23 completed (606.112 ms) ====== [2025-12-13T15:51:36.599Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-12-13T15:51:36.599Z] GC before operation: completed in 11.673 ms, heap usage 24.509 MB -> 5.414 MB. [2025-12-13T15:51:37.301Z] Camera thread performed 122 scans. [2025-12-13T15:51:37.301Z] ====== philosophers (scala) [default], iteration 24 completed (686.282 ms) ====== [2025-12-13T15:51:37.301Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-12-13T15:51:37.301Z] GC before operation: completed in 11.466 ms, heap usage 40.034 MB -> 5.414 MB. [2025-12-13T15:51:38.033Z] Camera thread performed 122 scans. [2025-12-13T15:51:38.033Z] ====== philosophers (scala) [default], iteration 25 completed (607.568 ms) ====== [2025-12-13T15:51:38.033Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-12-13T15:51:38.033Z] GC before operation: completed in 11.780 ms, heap usage 42.539 MB -> 5.414 MB. [2025-12-13T15:51:38.748Z] Camera thread performed 122 scans. [2025-12-13T15:51:38.748Z] ====== philosophers (scala) [default], iteration 26 completed (664.830 ms) ====== [2025-12-13T15:51:38.748Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-12-13T15:51:38.748Z] GC before operation: completed in 11.722 ms, heap usage 32.037 MB -> 5.414 MB. [2025-12-13T15:51:39.466Z] Camera thread performed 122 scans. [2025-12-13T15:51:39.466Z] ====== philosophers (scala) [default], iteration 27 completed (710.026 ms) ====== [2025-12-13T15:51:39.466Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-12-13T15:51:39.466Z] GC before operation: completed in 11.922 ms, heap usage 53.538 MB -> 5.414 MB. [2025-12-13T15:51:40.184Z] Camera thread performed 122 scans. [2025-12-13T15:51:40.184Z] ====== philosophers (scala) [default], iteration 28 completed (683.318 ms) ====== [2025-12-13T15:51:40.184Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-12-13T15:51:40.184Z] GC before operation: completed in 11.394 ms, heap usage 23.534 MB -> 5.415 MB. [2025-12-13T15:51:40.995Z] Camera thread performed 122 scans. [2025-12-13T15:51:40.995Z] ====== philosophers (scala) [default], iteration 29 completed (660.171 ms) ====== [2025-12-13T15:51:40.995Z] ----------------------------------- [2025-12-13T15:51:40.995Z] renaissance-philosophers_0_PASSED [2025-12-13T15:51:40.995Z] ----------------------------------- [2025-12-13T15:51:40.995Z] [2025-12-13T15:51:40.995Z] TEST TEARDOWN: [2025-12-13T15:51:40.995Z] Nothing to be done for teardown. [2025-12-13T15:51:40.995Z] renaissance-philosophers_0 Finish Time: Sat Dec 13 15:51:40 2025 Epoch Time (ms): 1765641100859