[2025-10-31T17:15:20.502Z] Running test renaissance-philosophers_0 ... [2025-10-31T17:15:20.502Z] =============================================== [2025-10-31T17:15:20.814Z] renaissance-philosophers_0 Start Time: Fri Oct 31 17:15:20 2025 Epoch Time (ms): 1761930920602 [2025-10-31T17:15:20.814Z] variation: NoOptions [2025-10-31T17:15:21.127Z] JVM_OPTIONS: [2025-10-31T17:15:21.127Z] { \ [2025-10-31T17:15:21.127Z] echo ""; echo "TEST SETUP:"; \ [2025-10-31T17:15:21.127Z] echo "Nothing to be done for setup."; \ [2025-10-31T17:15:21.127Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17619304408481\\renaissance-philosophers_0"; \ [2025-10-31T17:15:21.127Z] cd "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17619304408481\\renaissance-philosophers_0"; \ [2025-10-31T17:15:21.127Z] echo ""; echo "TESTING:"; \ [2025-10-31T17:15:21.127Z] "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_17619304408481\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2025-10-31T17:15:21.127Z] 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_17619304408481\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-31T17:15:21.127Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-31T17:15:21.127Z] echo "Nothing to be done for teardown."; \ [2025-10-31T17:15:21.127Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17619304408481\\TestTargetResult"; [2025-10-31T17:15:21.439Z] [2025-10-31T17:15:21.439Z] TEST SETUP: [2025-10-31T17:15:21.439Z] Nothing to be done for setup. [2025-10-31T17:15:21.439Z] [2025-10-31T17:15:21.439Z] TESTING: [2025-10-31T17:15:22.111Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-10-31T17:15:22.111Z] 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_17619304408481/renaissance-philosophers_0/launcher-171521-1614351439070870466/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-10-31T17:15:22.111Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-10-31T17:15:22.111Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-10-31T17:15:22.423Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-10-31T17:15:22.423Z] GC before operation: completed in 19.075 ms, heap usage 13.084 MB -> 4.705 MB. [2025-10-31T17:15:24.618Z] Camera thread performed 122 scans. [2025-10-31T17:15:24.618Z] ====== philosophers (scala) [default], iteration 0 completed (1695.260 ms) ====== [2025-10-31T17:15:24.618Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-10-31T17:15:24.618Z] GC before operation: completed in 18.596 ms, heap usage 263.268 MB -> 5.044 MB. [2025-10-31T17:15:25.294Z] Camera thread performed 122 scans. [2025-10-31T17:15:25.294Z] ====== philosophers (scala) [default], iteration 1 completed (1152.772 ms) ====== [2025-10-31T17:15:25.294Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-10-31T17:15:25.294Z] GC before operation: completed in 12.584 ms, heap usage 60.661 MB -> 5.044 MB. [2025-10-31T17:15:26.393Z] Camera thread performed 122 scans. [2025-10-31T17:15:26.393Z] ====== philosophers (scala) [default], iteration 2 completed (1028.877 ms) ====== [2025-10-31T17:15:26.393Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-10-31T17:15:26.393Z] GC before operation: completed in 11.847 ms, heap usage 55.975 MB -> 5.045 MB. [2025-10-31T17:15:27.495Z] Camera thread performed 122 scans. [2025-10-31T17:15:27.495Z] ====== philosophers (scala) [default], iteration 3 completed (1155.367 ms) ====== [2025-10-31T17:15:27.495Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-10-31T17:15:27.495Z] GC before operation: completed in 11.381 ms, heap usage 59.908 MB -> 5.046 MB. [2025-10-31T17:15:28.595Z] Camera thread performed 122 scans. [2025-10-31T17:15:28.595Z] ====== philosophers (scala) [default], iteration 4 completed (1110.326 ms) ====== [2025-10-31T17:15:28.595Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-10-31T17:15:28.595Z] GC before operation: completed in 11.678 ms, heap usage 42.765 MB -> 5.046 MB. [2025-10-31T17:15:30.188Z] Camera thread performed 122 scans. [2025-10-31T17:15:30.188Z] ====== philosophers (scala) [default], iteration 5 completed (1162.601 ms) ====== [2025-10-31T17:15:30.188Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-10-31T17:15:30.188Z] GC before operation: completed in 11.630 ms, heap usage 58.357 MB -> 5.048 MB. [2025-10-31T17:15:31.287Z] Camera thread performed 122 scans. [2025-10-31T17:15:31.287Z] ====== philosophers (scala) [default], iteration 6 completed (1222.451 ms) ====== [2025-10-31T17:15:31.287Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-10-31T17:15:31.287Z] GC before operation: completed in 11.583 ms, heap usage 25.840 MB -> 5.049 MB. [2025-10-31T17:15:32.384Z] Camera thread performed 122 scans. [2025-10-31T17:15:32.384Z] ====== philosophers (scala) [default], iteration 7 completed (1150.386 ms) ====== [2025-10-31T17:15:32.384Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-10-31T17:15:32.384Z] GC before operation: completed in 11.468 ms, heap usage 21.583 MB -> 5.049 MB. [2025-10-31T17:15:33.482Z] Camera thread performed 122 scans. [2025-10-31T17:15:33.482Z] ====== philosophers (scala) [default], iteration 8 completed (1107.691 ms) ====== [2025-10-31T17:15:33.482Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-10-31T17:15:33.482Z] GC before operation: completed in 11.770 ms, heap usage 6.816 MB -> 5.049 MB. [2025-10-31T17:15:34.580Z] Camera thread performed 122 scans. [2025-10-31T17:15:34.580Z] ====== philosophers (scala) [default], iteration 9 completed (1084.079 ms) ====== [2025-10-31T17:15:34.580Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-10-31T17:15:34.580Z] GC before operation: completed in 11.420 ms, heap usage 62.172 MB -> 5.049 MB. [2025-10-31T17:15:35.679Z] Camera thread performed 122 scans. [2025-10-31T17:15:35.679Z] ====== philosophers (scala) [default], iteration 10 completed (1260.037 ms) ====== [2025-10-31T17:15:35.679Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-10-31T17:15:35.679Z] GC before operation: completed in 11.483 ms, heap usage 53.212 MB -> 5.050 MB. [2025-10-31T17:15:37.275Z] Camera thread performed 122 scans. [2025-10-31T17:15:37.275Z] ====== philosophers (scala) [default], iteration 11 completed (1305.388 ms) ====== [2025-10-31T17:15:37.275Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-10-31T17:15:37.275Z] GC before operation: completed in 12.591 ms, heap usage 22.107 MB -> 5.050 MB. [2025-10-31T17:15:38.370Z] Camera thread performed 122 scans. [2025-10-31T17:15:38.370Z] ====== philosophers (scala) [default], iteration 12 completed (1219.284 ms) ====== [2025-10-31T17:15:38.370Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-10-31T17:15:38.370Z] GC before operation: completed in 11.020 ms, heap usage 34.118 MB -> 5.050 MB. [2025-10-31T17:15:39.466Z] Camera thread performed 122 scans. [2025-10-31T17:15:39.466Z] ====== philosophers (scala) [default], iteration 13 completed (1228.792 ms) ====== [2025-10-31T17:15:39.466Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-10-31T17:15:39.466Z] GC before operation: completed in 11.349 ms, heap usage 47.824 MB -> 5.052 MB. [2025-10-31T17:15:40.562Z] Camera thread performed 122 scans. [2025-10-31T17:15:40.562Z] ====== philosophers (scala) [default], iteration 14 completed (1088.664 ms) ====== [2025-10-31T17:15:40.562Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-10-31T17:15:40.562Z] GC before operation: completed in 11.638 ms, heap usage 38.158 MB -> 5.052 MB. [2025-10-31T17:15:41.662Z] Camera thread performed 122 scans. [2025-10-31T17:15:41.662Z] ====== philosophers (scala) [default], iteration 15 completed (1106.266 ms) ====== [2025-10-31T17:15:41.662Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-10-31T17:15:41.662Z] GC before operation: completed in 12.561 ms, heap usage 82.448 MB -> 5.052 MB. [2025-10-31T17:15:43.256Z] Camera thread performed 122 scans. [2025-10-31T17:15:43.256Z] ====== philosophers (scala) [default], iteration 16 completed (1191.001 ms) ====== [2025-10-31T17:15:43.256Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-10-31T17:15:43.256Z] GC before operation: completed in 11.894 ms, heap usage 79.006 MB -> 5.052 MB. [2025-10-31T17:15:44.352Z] Camera thread performed 122 scans. [2025-10-31T17:15:44.352Z] ====== philosophers (scala) [default], iteration 17 completed (1220.710 ms) ====== [2025-10-31T17:15:44.352Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-10-31T17:15:44.352Z] GC before operation: completed in 11.639 ms, heap usage 20.095 MB -> 5.052 MB. [2025-10-31T17:15:45.447Z] Camera thread performed 122 scans. [2025-10-31T17:15:45.447Z] ====== philosophers (scala) [default], iteration 18 completed (1100.995 ms) ====== [2025-10-31T17:15:45.447Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-10-31T17:15:45.447Z] GC before operation: completed in 11.172 ms, heap usage 59.132 MB -> 5.053 MB. [2025-10-31T17:15:46.543Z] Camera thread performed 122 scans. [2025-10-31T17:15:46.543Z] ====== philosophers (scala) [default], iteration 19 completed (1246.964 ms) ====== [2025-10-31T17:15:46.543Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-10-31T17:15:46.543Z] GC before operation: completed in 11.100 ms, heap usage 41.002 MB -> 5.053 MB. [2025-10-31T17:15:48.134Z] Camera thread performed 122 scans. [2025-10-31T17:15:48.134Z] ====== philosophers (scala) [default], iteration 20 completed (1239.170 ms) ====== [2025-10-31T17:15:48.134Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-10-31T17:15:48.134Z] GC before operation: completed in 13.019 ms, heap usage 162.263 MB -> 5.053 MB. [2025-10-31T17:15:49.231Z] Camera thread performed 122 scans. [2025-10-31T17:15:49.231Z] ====== philosophers (scala) [default], iteration 21 completed (1330.955 ms) ====== [2025-10-31T17:15:49.231Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-10-31T17:15:49.231Z] GC before operation: completed in 12.094 ms, heap usage 113.884 MB -> 5.053 MB. [2025-10-31T17:15:50.822Z] Camera thread performed 122 scans. [2025-10-31T17:15:50.822Z] ====== philosophers (scala) [default], iteration 22 completed (1301.186 ms) ====== [2025-10-31T17:15:50.822Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-10-31T17:15:50.822Z] GC before operation: completed in 12.477 ms, heap usage 41.939 MB -> 5.053 MB. [2025-10-31T17:15:51.919Z] Camera thread performed 122 scans. [2025-10-31T17:15:51.919Z] ====== philosophers (scala) [default], iteration 23 completed (1221.343 ms) ====== [2025-10-31T17:15:51.919Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-10-31T17:15:51.919Z] GC before operation: completed in 11.877 ms, heap usage 41.251 MB -> 5.053 MB. [2025-10-31T17:15:53.015Z] Camera thread performed 122 scans. [2025-10-31T17:15:53.015Z] ====== philosophers (scala) [default], iteration 24 completed (1152.941 ms) ====== [2025-10-31T17:15:53.015Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-10-31T17:15:53.015Z] GC before operation: completed in 12.676 ms, heap usage 84.217 MB -> 5.053 MB. [2025-10-31T17:15:54.131Z] Camera thread performed 122 scans. [2025-10-31T17:15:54.131Z] ====== philosophers (scala) [default], iteration 25 completed (1209.232 ms) ====== [2025-10-31T17:15:54.131Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-10-31T17:15:54.131Z] GC before operation: completed in 12.869 ms, heap usage 183.854 MB -> 5.053 MB. [2025-10-31T17:15:55.232Z] Camera thread performed 122 scans. [2025-10-31T17:15:55.232Z] ====== philosophers (scala) [default], iteration 26 completed (1211.380 ms) ====== [2025-10-31T17:15:55.232Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-10-31T17:15:55.232Z] GC before operation: completed in 11.835 ms, heap usage 25.224 MB -> 5.053 MB. [2025-10-31T17:15:56.823Z] Camera thread performed 122 scans. [2025-10-31T17:15:56.823Z] ====== philosophers (scala) [default], iteration 27 completed (1262.916 ms) ====== [2025-10-31T17:15:56.823Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-10-31T17:15:56.823Z] GC before operation: completed in 12.123 ms, heap usage 14.302 MB -> 5.053 MB. [2025-10-31T17:15:57.921Z] Camera thread performed 122 scans. [2025-10-31T17:15:57.921Z] ====== philosophers (scala) [default], iteration 28 completed (1300.579 ms) ====== [2025-10-31T17:15:57.921Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-10-31T17:15:57.921Z] GC before operation: completed in 11.720 ms, heap usage 26.958 MB -> 5.054 MB. [2025-10-31T17:15:59.511Z] Camera thread performed 122 scans. [2025-10-31T17:15:59.511Z] ====== philosophers (scala) [default], iteration 29 completed (1210.479 ms) ====== [2025-10-31T17:15:59.511Z] ----------------------------------- [2025-10-31T17:15:59.511Z] renaissance-philosophers_0_PASSED [2025-10-31T17:15:59.511Z] ----------------------------------- [2025-10-31T17:15:59.511Z] [2025-10-31T17:15:59.511Z] TEST TEARDOWN: [2025-10-31T17:15:59.511Z] Nothing to be done for teardown. [2025-10-31T17:15:59.511Z] renaissance-philosophers_0 Finish Time: Fri Oct 31 17:15:59 2025 Epoch Time (ms): 1761930959471