[2025-11-07T00:41:10.441Z] Running test renaissance-philosophers_0 ... [2025-11-07T00:41:10.441Z] =============================================== [2025-11-07T00:41:10.752Z] renaissance-philosophers_0 Start Time: Fri Nov 7 00:41:10 2025 Epoch Time (ms): 1762476070519 [2025-11-07T00:41:10.752Z] variation: NoOptions [2025-11-07T00:41:11.049Z] JVM_OPTIONS: [2025-11-07T00:41:11.049Z] { \ [2025-11-07T00:41:11.049Z] echo ""; echo "TEST SETUP:"; \ [2025-11-07T00:41:11.049Z] echo "Nothing to be done for setup."; \ [2025-11-07T00:41:11.049Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17624755938318\\renaissance-philosophers_0"; \ [2025-11-07T00:41:11.049Z] cd "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17624755938318\\renaissance-philosophers_0"; \ [2025-11-07T00:41:11.049Z] echo ""; echo "TESTING:"; \ [2025-11-07T00:41:11.049Z] "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_17624755938318\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2025-11-07T00:41:11.049Z] 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_17624755938318\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-07T00:41:11.049Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-07T00:41:11.049Z] echo "Nothing to be done for teardown."; \ [2025-11-07T00:41:11.049Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk26_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17624755938318\\TestTargetResult"; [2025-11-07T00:41:11.049Z] [2025-11-07T00:41:11.049Z] TEST SETUP: [2025-11-07T00:41:11.049Z] Nothing to be done for setup. [2025-11-07T00:41:11.049Z] [2025-11-07T00:41:11.049Z] TESTING: [2025-11-07T00:41:12.101Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-11-07T00:41:12.101Z] 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_17624755938318/renaissance-philosophers_0/launcher-004111-18432711210392794765/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-11-07T00:41:12.101Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-11-07T00:41:12.101Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-11-07T00:41:12.407Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-11-07T00:41:12.407Z] GC before operation: completed in 15.861 ms, heap usage 11.434 MB -> 4.706 MB. [2025-11-07T00:41:14.559Z] Camera thread performed 122 scans. [2025-11-07T00:41:14.559Z] ====== philosophers (scala) [default], iteration 0 completed (1698.687 ms) ====== [2025-11-07T00:41:14.559Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-11-07T00:41:14.559Z] GC before operation: completed in 14.945 ms, heap usage 141.303 MB -> 5.050 MB. [2025-11-07T00:41:15.239Z] Camera thread performed 122 scans. [2025-11-07T00:41:15.239Z] ====== philosophers (scala) [default], iteration 1 completed (1028.103 ms) ====== [2025-11-07T00:41:15.239Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-11-07T00:41:15.239Z] GC before operation: completed in 11.725 ms, heap usage 90.749 MB -> 5.051 MB. [2025-11-07T00:41:16.294Z] Camera thread performed 122 scans. [2025-11-07T00:41:16.294Z] ====== philosophers (scala) [default], iteration 2 completed (1045.126 ms) ====== [2025-11-07T00:41:16.294Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-11-07T00:41:16.294Z] GC before operation: completed in 10.941 ms, heap usage 49.081 MB -> 5.053 MB. [2025-11-07T00:41:17.349Z] Camera thread performed 122 scans. [2025-11-07T00:41:17.349Z] ====== philosophers (scala) [default], iteration 3 completed (1094.368 ms) ====== [2025-11-07T00:41:17.349Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-11-07T00:41:17.349Z] GC before operation: completed in 10.819 ms, heap usage 82.451 MB -> 5.053 MB. [2025-11-07T00:41:18.402Z] Camera thread performed 122 scans. [2025-11-07T00:41:18.402Z] ====== philosophers (scala) [default], iteration 4 completed (1023.680 ms) ====== [2025-11-07T00:41:18.402Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-11-07T00:41:18.402Z] GC before operation: completed in 10.498 ms, heap usage 130.343 MB -> 5.053 MB. [2025-11-07T00:41:19.453Z] Camera thread performed 122 scans. [2025-11-07T00:41:19.453Z] ====== philosophers (scala) [default], iteration 5 completed (1024.760 ms) ====== [2025-11-07T00:41:19.453Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-11-07T00:41:19.453Z] GC before operation: completed in 10.499 ms, heap usage 87.293 MB -> 5.054 MB. [2025-11-07T00:41:20.505Z] Camera thread performed 122 scans. [2025-11-07T00:41:20.505Z] ====== philosophers (scala) [default], iteration 6 completed (1117.795 ms) ====== [2025-11-07T00:41:20.505Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-11-07T00:41:20.505Z] GC before operation: completed in 10.556 ms, heap usage 29.210 MB -> 5.055 MB. [2025-11-07T00:41:21.563Z] Camera thread performed 122 scans. [2025-11-07T00:41:21.563Z] ====== philosophers (scala) [default], iteration 7 completed (1034.804 ms) ====== [2025-11-07T00:41:21.563Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-11-07T00:41:21.563Z] GC before operation: completed in 11.835 ms, heap usage 135.260 MB -> 5.055 MB. [2025-11-07T00:41:22.616Z] Camera thread performed 122 scans. [2025-11-07T00:41:22.616Z] ====== philosophers (scala) [default], iteration 8 completed (972.804 ms) ====== [2025-11-07T00:41:22.616Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-11-07T00:41:22.616Z] GC before operation: completed in 10.921 ms, heap usage 118.249 MB -> 5.055 MB. [2025-11-07T00:41:23.669Z] Camera thread performed 122 scans. [2025-11-07T00:41:23.669Z] ====== philosophers (scala) [default], iteration 9 completed (867.513 ms) ====== [2025-11-07T00:41:23.669Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-11-07T00:41:23.669Z] GC before operation: completed in 10.876 ms, heap usage 81.226 MB -> 5.055 MB. [2025-11-07T00:41:24.734Z] Camera thread performed 122 scans. [2025-11-07T00:41:24.734Z] ====== philosophers (scala) [default], iteration 10 completed (1054.783 ms) ====== [2025-11-07T00:41:24.734Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-11-07T00:41:24.734Z] GC before operation: completed in 10.564 ms, heap usage 15.199 MB -> 5.056 MB. [2025-11-07T00:41:25.379Z] Camera thread performed 122 scans. [2025-11-07T00:41:25.379Z] ====== philosophers (scala) [default], iteration 11 completed (867.983 ms) ====== [2025-11-07T00:41:25.379Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-11-07T00:41:25.379Z] GC before operation: completed in 10.737 ms, heap usage 53.728 MB -> 5.056 MB. [2025-11-07T00:41:26.434Z] Camera thread performed 122 scans. [2025-11-07T00:41:26.434Z] ====== philosophers (scala) [default], iteration 12 completed (955.233 ms) ====== [2025-11-07T00:41:26.434Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-11-07T00:41:26.434Z] GC before operation: completed in 10.617 ms, heap usage 54.698 MB -> 5.056 MB. [2025-11-07T00:41:27.488Z] Camera thread performed 122 scans. [2025-11-07T00:41:27.488Z] ====== philosophers (scala) [default], iteration 13 completed (1077.016 ms) ====== [2025-11-07T00:41:27.488Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-11-07T00:41:27.488Z] GC before operation: completed in 11.095 ms, heap usage 13.698 MB -> 5.057 MB. [2025-11-07T00:41:28.546Z] Camera thread performed 122 scans. [2025-11-07T00:41:28.546Z] ====== philosophers (scala) [default], iteration 14 completed (1074.598 ms) ====== [2025-11-07T00:41:28.546Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-11-07T00:41:28.546Z] GC before operation: completed in 11.058 ms, heap usage 107.725 MB -> 5.057 MB. [2025-11-07T00:41:29.600Z] Camera thread performed 122 scans. [2025-11-07T00:41:29.600Z] ====== philosophers (scala) [default], iteration 15 completed (971.471 ms) ====== [2025-11-07T00:41:29.600Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-11-07T00:41:29.600Z] GC before operation: completed in 10.965 ms, heap usage 123.750 MB -> 5.057 MB. [2025-11-07T00:41:30.655Z] Camera thread performed 122 scans. [2025-11-07T00:41:30.655Z] ====== philosophers (scala) [default], iteration 16 completed (1056.936 ms) ====== [2025-11-07T00:41:30.655Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-11-07T00:41:30.655Z] GC before operation: completed in 10.506 ms, heap usage 10.203 MB -> 5.057 MB. [2025-11-07T00:41:31.713Z] Camera thread performed 122 scans. [2025-11-07T00:41:31.713Z] ====== philosophers (scala) [default], iteration 17 completed (929.897 ms) ====== [2025-11-07T00:41:31.713Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-11-07T00:41:31.713Z] GC before operation: completed in 10.725 ms, heap usage 104.252 MB -> 5.057 MB. [2025-11-07T00:41:32.766Z] Camera thread performed 122 scans. [2025-11-07T00:41:32.766Z] ====== philosophers (scala) [default], iteration 18 completed (1148.154 ms) ====== [2025-11-07T00:41:32.766Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-11-07T00:41:32.766Z] GC before operation: completed in 10.575 ms, heap usage 27.192 MB -> 5.057 MB. [2025-11-07T00:41:33.817Z] Camera thread performed 122 scans. [2025-11-07T00:41:33.817Z] ====== philosophers (scala) [default], iteration 19 completed (971.010 ms) ====== [2025-11-07T00:41:33.817Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-11-07T00:41:33.817Z] GC before operation: completed in 11.229 ms, heap usage 129.250 MB -> 5.058 MB. [2025-11-07T00:41:34.876Z] Camera thread performed 122 scans. [2025-11-07T00:41:34.876Z] ====== philosophers (scala) [default], iteration 20 completed (1052.021 ms) ====== [2025-11-07T00:41:34.876Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-11-07T00:41:34.876Z] GC before operation: completed in 10.992 ms, heap usage 148.748 MB -> 5.058 MB. [2025-11-07T00:41:35.932Z] Camera thread performed 122 scans. [2025-11-07T00:41:35.932Z] ====== philosophers (scala) [default], iteration 21 completed (1087.072 ms) ====== [2025-11-07T00:41:35.932Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-11-07T00:41:35.932Z] GC before operation: completed in 10.872 ms, heap usage 27.254 MB -> 5.058 MB. [2025-11-07T00:41:36.986Z] Camera thread performed 122 scans. [2025-11-07T00:41:36.986Z] ====== philosophers (scala) [default], iteration 22 completed (960.407 ms) ====== [2025-11-07T00:41:36.986Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-11-07T00:41:36.986Z] GC before operation: completed in 12.242 ms, heap usage 94.258 MB -> 5.058 MB. [2025-11-07T00:41:38.042Z] Camera thread performed 122 scans. [2025-11-07T00:41:38.042Z] ====== philosophers (scala) [default], iteration 23 completed (1025.254 ms) ====== [2025-11-07T00:41:38.042Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-11-07T00:41:38.042Z] GC before operation: completed in 11.995 ms, heap usage 119.253 MB -> 5.058 MB. [2025-11-07T00:41:38.689Z] Camera thread performed 122 scans. [2025-11-07T00:41:38.689Z] ====== philosophers (scala) [default], iteration 24 completed (904.829 ms) ====== [2025-11-07T00:41:38.689Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-11-07T00:41:38.689Z] GC before operation: completed in 11.146 ms, heap usage 127.256 MB -> 5.058 MB. [2025-11-07T00:41:39.744Z] Camera thread performed 122 scans. [2025-11-07T00:41:39.744Z] ====== philosophers (scala) [default], iteration 25 completed (966.285 ms) ====== [2025-11-07T00:41:39.744Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-11-07T00:41:39.744Z] GC before operation: completed in 10.802 ms, heap usage 99.732 MB -> 5.058 MB. [2025-11-07T00:41:40.841Z] Camera thread performed 122 scans. [2025-11-07T00:41:40.841Z] ====== philosophers (scala) [default], iteration 26 completed (965.509 ms) ====== [2025-11-07T00:41:40.841Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-11-07T00:41:40.841Z] GC before operation: completed in 10.563 ms, heap usage 78.226 MB -> 5.058 MB. [2025-11-07T00:41:41.898Z] Camera thread performed 122 scans. [2025-11-07T00:41:41.898Z] ====== philosophers (scala) [default], iteration 27 completed (952.610 ms) ====== [2025-11-07T00:41:41.898Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-11-07T00:41:41.898Z] GC before operation: completed in 10.494 ms, heap usage 97.224 MB -> 5.058 MB. [2025-11-07T00:41:42.952Z] Camera thread performed 122 scans. [2025-11-07T00:41:42.952Z] ====== philosophers (scala) [default], iteration 28 completed (1000.265 ms) ====== [2025-11-07T00:41:42.952Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-11-07T00:41:42.952Z] GC before operation: completed in 10.818 ms, heap usage 138.253 MB -> 5.058 MB. [2025-11-07T00:41:44.004Z] Camera thread performed 122 scans. [2025-11-07T00:41:44.004Z] ====== philosophers (scala) [default], iteration 29 completed (1076.729 ms) ====== [2025-11-07T00:41:44.004Z] ----------------------------------- [2025-11-07T00:41:44.004Z] renaissance-philosophers_0_PASSED [2025-11-07T00:41:44.004Z] ----------------------------------- [2025-11-07T00:41:44.004Z] [2025-11-07T00:41:44.004Z] TEST TEARDOWN: [2025-11-07T00:41:44.004Z] Nothing to be done for teardown. [2025-11-07T00:41:44.301Z] renaissance-philosophers_0 Finish Time: Fri Nov 7 00:41:44 2025 Epoch Time (ms): 1762476104112