[2025-11-28T01:58:31.242Z] Running test renaissance-philosophers_0 ... [2025-11-28T01:58:31.242Z] =============================================== [2025-11-28T01:58:31.553Z] renaissance-philosophers_0 Start Time: Fri Nov 28 01:58:31 2025 Epoch Time (ms): 1764295111312 [2025-11-28T01:58:31.553Z] variation: NoOptions [2025-11-28T01:58:31.863Z] JVM_OPTIONS: [2025-11-28T01:58:31.863Z] { \ [2025-11-28T01:58:31.863Z] echo ""; echo "TEST SETUP:"; \ [2025-11-28T01:58:31.863Z] echo "Nothing to be done for setup."; \ [2025-11-28T01:58:31.863Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17642946394545\\renaissance-philosophers_0"; \ [2025-11-28T01:58:31.863Z] cd "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17642946394545\\renaissance-philosophers_0"; \ [2025-11-28T01:58:31.863Z] echo ""; echo "TESTING:"; \ [2025-11-28T01:58:31.863Z] "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_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:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17642946394545\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2025-11-28T01:58:31.863Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/; rm -f -r "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17642946394545\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-28T01:58:31.863Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-28T01:58:31.863Z] echo "Nothing to be done for teardown."; \ [2025-11-28T01:58:31.863Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17642946394545\\TestTargetResult"; [2025-11-28T01:58:32.173Z] [2025-11-28T01:58:32.173Z] TEST SETUP: [2025-11-28T01:58:32.173Z] Nothing to be done for setup. [2025-11-28T01:58:32.173Z] [2025-11-28T01:58:32.173Z] TESTING: [2025-11-28T01:58:32.851Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-11-28T01:58:32.851Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/TKG/output_17642946394545/renaissance-philosophers_0/launcher-015832-9534289132021800090/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-11-28T01:58:32.851Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-11-28T01:58:32.851Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-11-28T01:58:33.161Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-11-28T01:58:33.161Z] GC before operation: completed in 19.735 ms, heap usage 13.625 MB -> 4.713 MB. [2025-11-28T01:58:35.341Z] Camera thread performed 122 scans. [2025-11-28T01:58:35.341Z] ====== philosophers (scala) [default], iteration 0 completed (2059.557 ms) ====== [2025-11-28T01:58:35.341Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-11-28T01:58:35.341Z] GC before operation: completed in 17.642 ms, heap usage 97.411 MB -> 5.054 MB. [2025-11-28T01:58:36.928Z] Camera thread performed 122 scans. [2025-11-28T01:58:36.928Z] ====== philosophers (scala) [default], iteration 1 completed (1341.977 ms) ====== [2025-11-28T01:58:36.928Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-11-28T01:58:36.928Z] GC before operation: completed in 13.202 ms, heap usage 16.089 MB -> 5.055 MB. [2025-11-28T01:58:38.022Z] Camera thread performed 122 scans. [2025-11-28T01:58:38.022Z] ====== philosophers (scala) [default], iteration 2 completed (1267.000 ms) ====== [2025-11-28T01:58:38.022Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-11-28T01:58:38.022Z] GC before operation: completed in 12.095 ms, heap usage 163.236 MB -> 5.056 MB. [2025-11-28T01:58:39.110Z] Camera thread performed 122 scans. [2025-11-28T01:58:39.111Z] ====== philosophers (scala) [default], iteration 3 completed (1172.022 ms) ====== [2025-11-28T01:58:39.111Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-11-28T01:58:39.111Z] GC before operation: completed in 11.185 ms, heap usage 36.511 MB -> 5.056 MB. [2025-11-28T01:58:40.699Z] Camera thread performed 122 scans. [2025-11-28T01:58:40.699Z] ====== philosophers (scala) [default], iteration 4 completed (1207.855 ms) ====== [2025-11-28T01:58:40.699Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-11-28T01:58:40.699Z] GC before operation: completed in 12.245 ms, heap usage 15.349 MB -> 5.057 MB. [2025-11-28T01:58:41.792Z] Camera thread performed 122 scans. [2025-11-28T01:58:41.792Z] ====== philosophers (scala) [default], iteration 5 completed (1114.321 ms) ====== [2025-11-28T01:58:41.792Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-11-28T01:58:41.792Z] GC before operation: completed in 11.322 ms, heap usage 30.812 MB -> 5.058 MB. [2025-11-28T01:58:42.885Z] Camera thread performed 122 scans. [2025-11-28T01:58:42.885Z] ====== philosophers (scala) [default], iteration 6 completed (1188.946 ms) ====== [2025-11-28T01:58:42.885Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-11-28T01:58:42.885Z] GC before operation: completed in 11.484 ms, heap usage 62.401 MB -> 5.059 MB. [2025-11-28T01:58:43.988Z] Camera thread performed 122 scans. [2025-11-28T01:58:43.988Z] ====== philosophers (scala) [default], iteration 7 completed (1215.873 ms) ====== [2025-11-28T01:58:43.988Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-11-28T01:58:43.988Z] GC before operation: completed in 11.269 ms, heap usage 124.226 MB -> 5.059 MB. [2025-11-28T01:58:45.078Z] Camera thread performed 122 scans. [2025-11-28T01:58:45.078Z] ====== philosophers (scala) [default], iteration 8 completed (1193.017 ms) ====== [2025-11-28T01:58:45.078Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-11-28T01:58:45.078Z] GC before operation: completed in 11.787 ms, heap usage 216.302 MB -> 5.060 MB. [2025-11-28T01:58:46.663Z] Camera thread performed 122 scans. [2025-11-28T01:58:46.663Z] ====== philosophers (scala) [default], iteration 9 completed (1234.415 ms) ====== [2025-11-28T01:58:46.663Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-11-28T01:58:46.663Z] GC before operation: completed in 11.132 ms, heap usage 17.196 MB -> 5.060 MB. [2025-11-28T01:58:47.755Z] Camera thread performed 122 scans. [2025-11-28T01:58:47.756Z] ====== philosophers (scala) [default], iteration 10 completed (1269.400 ms) ====== [2025-11-28T01:58:47.756Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-11-28T01:58:47.756Z] GC before operation: completed in 10.711 ms, heap usage 86.396 MB -> 5.060 MB. [2025-11-28T01:58:48.849Z] Camera thread performed 122 scans. [2025-11-28T01:58:48.849Z] ====== philosophers (scala) [default], iteration 11 completed (1284.673 ms) ====== [2025-11-28T01:58:48.849Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-11-28T01:58:48.849Z] GC before operation: completed in 11.775 ms, heap usage 175.109 MB -> 5.060 MB. [2025-11-28T01:58:50.431Z] Camera thread performed 122 scans. [2025-11-28T01:58:50.431Z] ====== philosophers (scala) [default], iteration 12 completed (1274.547 ms) ====== [2025-11-28T01:58:50.431Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-11-28T01:58:50.431Z] GC before operation: completed in 11.468 ms, heap usage 141.258 MB -> 5.061 MB. [2025-11-28T01:58:51.520Z] Camera thread performed 122 scans. [2025-11-28T01:58:51.520Z] ====== philosophers (scala) [default], iteration 13 completed (1346.003 ms) ====== [2025-11-28T01:58:51.520Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-11-28T01:58:51.520Z] GC before operation: completed in 11.626 ms, heap usage 30.201 MB -> 5.061 MB. [2025-11-28T01:58:53.102Z] Camera thread performed 122 scans. [2025-11-28T01:58:53.102Z] ====== philosophers (scala) [default], iteration 14 completed (1128.274 ms) ====== [2025-11-28T01:58:53.102Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-11-28T01:58:53.102Z] GC before operation: completed in 10.871 ms, heap usage 137.602 MB -> 5.061 MB. [2025-11-28T01:58:54.195Z] Camera thread performed 122 scans. [2025-11-28T01:58:54.195Z] ====== philosophers (scala) [default], iteration 15 completed (1330.032 ms) ====== [2025-11-28T01:58:54.195Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-11-28T01:58:54.195Z] GC before operation: completed in 11.484 ms, heap usage 85.258 MB -> 5.061 MB. [2025-11-28T01:58:55.288Z] Camera thread performed 122 scans. [2025-11-28T01:58:55.288Z] ====== philosophers (scala) [default], iteration 16 completed (1272.780 ms) ====== [2025-11-28T01:58:55.288Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-11-28T01:58:55.288Z] GC before operation: completed in 11.808 ms, heap usage 61.162 MB -> 5.061 MB. [2025-11-28T01:58:56.876Z] Camera thread performed 122 scans. [2025-11-28T01:58:56.876Z] ====== philosophers (scala) [default], iteration 17 completed (1304.750 ms) ====== [2025-11-28T01:58:56.876Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-11-28T01:58:56.876Z] GC before operation: completed in 13.342 ms, heap usage 124.134 MB -> 5.061 MB. [2025-11-28T01:58:57.969Z] Camera thread performed 122 scans. [2025-11-28T01:58:57.969Z] ====== philosophers (scala) [default], iteration 18 completed (1132.054 ms) ====== [2025-11-28T01:58:57.969Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-11-28T01:58:57.969Z] GC before operation: completed in 11.661 ms, heap usage 10.206 MB -> 5.061 MB. [2025-11-28T01:58:59.062Z] Camera thread performed 122 scans. [2025-11-28T01:58:59.062Z] ====== philosophers (scala) [default], iteration 19 completed (1300.107 ms) ====== [2025-11-28T01:58:59.062Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-11-28T01:58:59.062Z] GC before operation: completed in 10.195 ms, heap usage 48.273 MB -> 5.061 MB. [2025-11-28T01:59:00.646Z] Camera thread performed 122 scans. [2025-11-28T01:59:00.646Z] ====== philosophers (scala) [default], iteration 20 completed (1210.910 ms) ====== [2025-11-28T01:59:00.646Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-11-28T01:59:00.646Z] GC before operation: completed in 11.093 ms, heap usage 45.229 MB -> 5.061 MB. [2025-11-28T01:59:01.740Z] Camera thread performed 122 scans. [2025-11-28T01:59:01.740Z] ====== philosophers (scala) [default], iteration 21 completed (1212.163 ms) ====== [2025-11-28T01:59:01.740Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-11-28T01:59:01.740Z] GC before operation: completed in 11.706 ms, heap usage 89.247 MB -> 5.061 MB. [2025-11-28T01:59:02.831Z] Camera thread performed 122 scans. [2025-11-28T01:59:02.831Z] ====== philosophers (scala) [default], iteration 22 completed (1195.089 ms) ====== [2025-11-28T01:59:02.831Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-11-28T01:59:02.831Z] GC before operation: completed in 11.380 ms, heap usage 16.231 MB -> 5.061 MB. [2025-11-28T01:59:04.424Z] Camera thread performed 122 scans. [2025-11-28T01:59:04.424Z] ====== philosophers (scala) [default], iteration 23 completed (1260.286 ms) ====== [2025-11-28T01:59:04.424Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-11-28T01:59:04.424Z] GC before operation: completed in 11.494 ms, heap usage 16.200 MB -> 5.062 MB. [2025-11-28T01:59:05.520Z] Camera thread performed 122 scans. [2025-11-28T01:59:05.520Z] ====== philosophers (scala) [default], iteration 24 completed (1252.259 ms) ====== [2025-11-28T01:59:05.520Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-11-28T01:59:05.520Z] GC before operation: completed in 11.584 ms, heap usage 105.254 MB -> 5.062 MB. [2025-11-28T01:59:06.613Z] Camera thread performed 122 scans. [2025-11-28T01:59:06.613Z] ====== philosophers (scala) [default], iteration 25 completed (1281.109 ms) ====== [2025-11-28T01:59:06.613Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-11-28T01:59:06.613Z] GC before operation: completed in 11.451 ms, heap usage 150.203 MB -> 5.062 MB. [2025-11-28T01:59:08.201Z] Camera thread performed 122 scans. [2025-11-28T01:59:08.201Z] ====== philosophers (scala) [default], iteration 26 completed (1254.313 ms) ====== [2025-11-28T01:59:08.201Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-11-28T01:59:08.201Z] GC before operation: completed in 11.729 ms, heap usage 104.225 MB -> 5.062 MB. [2025-11-28T01:59:09.296Z] Camera thread performed 122 scans. [2025-11-28T01:59:09.296Z] ====== philosophers (scala) [default], iteration 27 completed (1192.907 ms) ====== [2025-11-28T01:59:09.296Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-11-28T01:59:09.296Z] GC before operation: completed in 10.324 ms, heap usage 19.779 MB -> 5.062 MB. [2025-11-28T01:59:10.390Z] Camera thread performed 122 scans. [2025-11-28T01:59:10.391Z] ====== philosophers (scala) [default], iteration 28 completed (1190.462 ms) ====== [2025-11-28T01:59:10.391Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-11-28T01:59:10.391Z] GC before operation: completed in 12.153 ms, heap usage 58.319 MB -> 5.062 MB. [2025-11-28T01:59:11.494Z] Camera thread performed 122 scans. [2025-11-28T01:59:11.494Z] ====== philosophers (scala) [default], iteration 29 completed (1262.027 ms) ====== [2025-11-28T01:59:11.806Z] ----------------------------------- [2025-11-28T01:59:11.806Z] renaissance-philosophers_0_PASSED [2025-11-28T01:59:11.806Z] ----------------------------------- [2025-11-28T01:59:11.806Z] [2025-11-28T01:59:11.806Z] TEST TEARDOWN: [2025-11-28T01:59:11.806Z] Nothing to be done for teardown. [2025-11-28T01:59:12.118Z] renaissance-philosophers_0 Finish Time: Fri Nov 28 01:59:11 2025 Epoch Time (ms): 1764295151845