[2025-12-13T16:27:21.328Z] Running test renaissance-philosophers_0 ... [2025-12-13T16:27:21.329Z] =============================================== [2025-12-13T16:27:21.638Z] renaissance-philosophers_0 Start Time: Sat Dec 13 16:27:21 2025 Epoch Time (ms): 1765643241465 [2025-12-13T16:27:21.638Z] variation: NoOptions [2025-12-13T16:27:21.952Z] JVM_OPTIONS: [2025-12-13T16:27:21.952Z] { \ [2025-12-13T16:27:21.952Z] echo ""; echo "TEST SETUP:"; \ [2025-12-13T16:27:21.952Z] echo "Nothing to be done for setup."; \ [2025-12-13T16:27:21.952Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17656426243573\\renaissance-philosophers_0"; \ [2025-12-13T16:27:21.952Z] cd "C:/Users/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17656426243573\\renaissance-philosophers_0"; \ [2025-12-13T16:27:21.952Z] echo ""; echo "TESTING:"; \ [2025-12-13T16:27:21.952Z] "C:/Users/jenkins/workspace/Test_openjdk25_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_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/Users/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17656426243573\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2025-12-13T16:27:21.952Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/Users/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests/; rm -f -r "C:/Users/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17656426243573\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-13T16:27:21.952Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-13T16:27:21.952Z] echo "Nothing to be done for teardown."; \ [2025-12-13T16:27:21.952Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17656426243573\\TestTargetResult"; [2025-12-13T16:27:22.261Z] [2025-12-13T16:27:22.261Z] TEST SETUP: [2025-12-13T16:27:22.261Z] Nothing to be done for setup. [2025-12-13T16:27:22.261Z] [2025-12-13T16:27:22.261Z] TESTING: [2025-12-13T16:27:22.938Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-13T16:27:22.939Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/C:/Users/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_windows/aqa-tests/TKG/output_17656426243573/renaissance-philosophers_0/launcher-162722-3103832066659907576/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-13T16:27:22.939Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-13T16:27:22.939Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-13T16:27:23.248Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-12-13T16:27:23.558Z] GC before operation: completed in 9.105 ms, heap usage 5.188 MB -> 4.703 MB. [2025-12-13T16:27:25.754Z] Camera thread performed 122 scans. [2025-12-13T16:27:25.754Z] ====== philosophers (scala) [default], iteration 0 completed (2061.566 ms) ====== [2025-12-13T16:27:25.754Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-12-13T16:27:25.754Z] GC before operation: completed in 11.935 ms, heap usage 84.928 MB -> 5.051 MB. [2025-12-13T16:27:26.523Z] Camera thread performed 122 scans. [2025-12-13T16:27:26.523Z] ====== philosophers (scala) [default], iteration 1 completed (1160.747 ms) ====== [2025-12-13T16:27:26.523Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-12-13T16:27:26.523Z] GC before operation: completed in 10.406 ms, heap usage 70.568 MB -> 5.051 MB. [2025-12-13T16:27:28.108Z] Camera thread performed 122 scans. [2025-12-13T16:27:28.108Z] ====== philosophers (scala) [default], iteration 2 completed (1233.415 ms) ====== [2025-12-13T16:27:28.108Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-12-13T16:27:28.108Z] GC before operation: completed in 9.111 ms, heap usage 66.643 MB -> 5.052 MB. [2025-12-13T16:27:29.196Z] Camera thread performed 122 scans. [2025-12-13T16:27:29.196Z] ====== philosophers (scala) [default], iteration 3 completed (1207.429 ms) ====== [2025-12-13T16:27:29.196Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-12-13T16:27:29.196Z] GC before operation: completed in 9.223 ms, heap usage 77.332 MB -> 5.053 MB. [2025-12-13T16:27:30.291Z] Camera thread performed 122 scans. [2025-12-13T16:27:30.291Z] ====== philosophers (scala) [default], iteration 4 completed (1245.317 ms) ====== [2025-12-13T16:27:30.291Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-12-13T16:27:30.291Z] GC before operation: completed in 9.076 ms, heap usage 27.664 MB -> 5.053 MB. [2025-12-13T16:27:31.871Z] Camera thread performed 122 scans. [2025-12-13T16:27:31.871Z] ====== philosophers (scala) [default], iteration 5 completed (1203.495 ms) ====== [2025-12-13T16:27:31.871Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-12-13T16:27:31.871Z] GC before operation: completed in 9.296 ms, heap usage 79.691 MB -> 5.057 MB. [2025-12-13T16:27:32.545Z] Camera thread performed 122 scans. [2025-12-13T16:27:32.545Z] ====== philosophers (scala) [default], iteration 6 completed (1102.222 ms) ====== [2025-12-13T16:27:32.545Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-12-13T16:27:32.545Z] GC before operation: completed in 9.038 ms, heap usage 5.602 MB -> 5.057 MB. [2025-12-13T16:27:34.132Z] Camera thread performed 122 scans. [2025-12-13T16:27:34.132Z] ====== philosophers (scala) [default], iteration 7 completed (1199.571 ms) ====== [2025-12-13T16:27:34.132Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-12-13T16:27:34.132Z] GC before operation: completed in 9.123 ms, heap usage 61.623 MB -> 5.057 MB. [2025-12-13T16:27:35.230Z] Camera thread performed 122 scans. [2025-12-13T16:27:35.230Z] ====== philosophers (scala) [default], iteration 8 completed (1249.311 ms) ====== [2025-12-13T16:27:35.230Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-12-13T16:27:35.230Z] GC before operation: completed in 9.203 ms, heap usage 31.647 MB -> 5.058 MB. [2025-12-13T16:27:36.316Z] Camera thread performed 122 scans. [2025-12-13T16:27:36.316Z] ====== philosophers (scala) [default], iteration 9 completed (1249.845 ms) ====== [2025-12-13T16:27:36.316Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-12-13T16:27:36.316Z] GC before operation: completed in 9.182 ms, heap usage 83.159 MB -> 5.058 MB. [2025-12-13T16:27:37.561Z] Camera thread performed 122 scans. [2025-12-13T16:27:37.561Z] ====== philosophers (scala) [default], iteration 10 completed (1216.731 ms) ====== [2025-12-13T16:27:37.561Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-12-13T16:27:37.561Z] GC before operation: completed in 9.372 ms, heap usage 24.863 MB -> 5.058 MB. [2025-12-13T16:27:38.670Z] Camera thread performed 122 scans. [2025-12-13T16:27:38.670Z] ====== philosophers (scala) [default], iteration 11 completed (1093.303 ms) ====== [2025-12-13T16:27:38.670Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-12-13T16:27:38.670Z] GC before operation: completed in 8.969 ms, heap usage 7.143 MB -> 5.058 MB. [2025-12-13T16:27:39.761Z] Camera thread performed 122 scans. [2025-12-13T16:27:39.761Z] ====== philosophers (scala) [default], iteration 12 completed (1127.329 ms) ====== [2025-12-13T16:27:39.761Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-12-13T16:27:39.761Z] GC before operation: completed in 8.806 ms, heap usage 12.752 MB -> 5.059 MB. [2025-12-13T16:27:41.343Z] Camera thread performed 122 scans. [2025-12-13T16:27:41.343Z] ====== philosophers (scala) [default], iteration 13 completed (1188.413 ms) ====== [2025-12-13T16:27:41.343Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-12-13T16:27:41.343Z] GC before operation: completed in 9.905 ms, heap usage 6.078 MB -> 5.058 MB. [2025-12-13T16:27:42.431Z] Camera thread performed 122 scans. [2025-12-13T16:27:42.431Z] ====== philosophers (scala) [default], iteration 14 completed (1207.834 ms) ====== [2025-12-13T16:27:42.431Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-12-13T16:27:42.431Z] GC before operation: completed in 8.837 ms, heap usage 16.096 MB -> 5.059 MB. [2025-12-13T16:27:43.519Z] Camera thread performed 122 scans. [2025-12-13T16:27:43.519Z] ====== philosophers (scala) [default], iteration 15 completed (1157.854 ms) ====== [2025-12-13T16:27:43.519Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-12-13T16:27:43.519Z] GC before operation: completed in 8.659 ms, heap usage 69.641 MB -> 5.058 MB. [2025-12-13T16:27:44.605Z] Camera thread performed 122 scans. [2025-12-13T16:27:44.605Z] ====== philosophers (scala) [default], iteration 16 completed (1121.059 ms) ====== [2025-12-13T16:27:44.605Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-12-13T16:27:44.605Z] GC before operation: completed in 9.409 ms, heap usage 22.015 MB -> 5.059 MB. [2025-12-13T16:27:45.695Z] Camera thread performed 122 scans. [2025-12-13T16:27:45.695Z] ====== philosophers (scala) [default], iteration 17 completed (1214.190 ms) ====== [2025-12-13T16:27:45.695Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-12-13T16:27:45.695Z] GC before operation: completed in 9.877 ms, heap usage 80.023 MB -> 5.058 MB. [2025-12-13T16:27:47.280Z] Camera thread performed 122 scans. [2025-12-13T16:27:47.280Z] ====== philosophers (scala) [default], iteration 18 completed (1320.902 ms) ====== [2025-12-13T16:27:47.280Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-12-13T16:27:47.280Z] GC before operation: completed in 9.163 ms, heap usage 53.023 MB -> 5.059 MB. [2025-12-13T16:27:48.367Z] Camera thread performed 122 scans. [2025-12-13T16:27:48.367Z] ====== philosophers (scala) [default], iteration 19 completed (1101.204 ms) ====== [2025-12-13T16:27:48.367Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-12-13T16:27:48.367Z] GC before operation: completed in 9.327 ms, heap usage 43.232 MB -> 5.059 MB. [2025-12-13T16:27:49.454Z] Camera thread performed 122 scans. [2025-12-13T16:27:49.454Z] ====== philosophers (scala) [default], iteration 20 completed (1145.412 ms) ====== [2025-12-13T16:27:49.454Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-12-13T16:27:49.454Z] GC before operation: completed in 8.760 ms, heap usage 37.662 MB -> 5.059 MB. [2025-12-13T16:27:50.540Z] Camera thread performed 122 scans. [2025-12-13T16:27:50.541Z] ====== philosophers (scala) [default], iteration 21 completed (1123.916 ms) ====== [2025-12-13T16:27:50.541Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-12-13T16:27:50.541Z] GC before operation: completed in 9.035 ms, heap usage 61.260 MB -> 5.059 MB. [2025-12-13T16:27:51.629Z] Camera thread performed 122 scans. [2025-12-13T16:27:51.629Z] ====== philosophers (scala) [default], iteration 22 completed (1201.268 ms) ====== [2025-12-13T16:27:51.629Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-12-13T16:27:51.629Z] GC before operation: completed in 9.007 ms, heap usage 38.931 MB -> 5.059 MB. [2025-12-13T16:27:53.207Z] Camera thread performed 122 scans. [2025-12-13T16:27:53.207Z] ====== philosophers (scala) [default], iteration 23 completed (1138.150 ms) ====== [2025-12-13T16:27:53.207Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-12-13T16:27:53.207Z] GC before operation: completed in 9.032 ms, heap usage 73.593 MB -> 5.059 MB. [2025-12-13T16:27:54.294Z] Camera thread performed 122 scans. [2025-12-13T16:27:54.294Z] ====== philosophers (scala) [default], iteration 24 completed (1156.998 ms) ====== [2025-12-13T16:27:54.294Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-12-13T16:27:54.294Z] GC before operation: completed in 9.717 ms, heap usage 21.191 MB -> 5.059 MB. [2025-12-13T16:27:55.487Z] Camera thread performed 122 scans. [2025-12-13T16:27:55.487Z] ====== philosophers (scala) [default], iteration 25 completed (1233.143 ms) ====== [2025-12-13T16:27:55.487Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-12-13T16:27:55.487Z] GC before operation: completed in 9.654 ms, heap usage 60.024 MB -> 5.059 MB. [2025-12-13T16:27:56.581Z] Camera thread performed 122 scans. [2025-12-13T16:27:56.581Z] ====== philosophers (scala) [default], iteration 26 completed (1147.513 ms) ====== [2025-12-13T16:27:56.581Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-12-13T16:27:56.581Z] GC before operation: completed in 8.940 ms, heap usage 43.648 MB -> 5.060 MB. [2025-12-13T16:27:57.674Z] Camera thread performed 122 scans. [2025-12-13T16:27:57.674Z] ====== philosophers (scala) [default], iteration 27 completed (1140.433 ms) ====== [2025-12-13T16:27:57.674Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-12-13T16:27:57.674Z] GC before operation: completed in 8.932 ms, heap usage 46.084 MB -> 5.060 MB. [2025-12-13T16:27:58.772Z] Camera thread performed 122 scans. [2025-12-13T16:27:58.772Z] ====== philosophers (scala) [default], iteration 28 completed (1235.891 ms) ====== [2025-12-13T16:27:58.772Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-12-13T16:27:58.772Z] GC before operation: completed in 8.813 ms, heap usage 40.523 MB -> 5.060 MB. [2025-12-13T16:27:59.868Z] Camera thread performed 122 scans. [2025-12-13T16:27:59.868Z] ====== philosophers (scala) [default], iteration 29 completed (1103.636 ms) ====== [2025-12-13T16:28:00.178Z] ----------------------------------- [2025-12-13T16:28:00.178Z] renaissance-philosophers_0_PASSED [2025-12-13T16:28:00.178Z] ----------------------------------- [2025-12-13T16:28:00.178Z] [2025-12-13T16:28:00.178Z] TEST TEARDOWN: [2025-12-13T16:28:00.178Z] Nothing to be done for teardown. [2025-12-13T16:28:00.504Z] renaissance-philosophers_0 Finish Time: Sat Dec 13 16:28:00 2025 Epoch Time (ms): 1765643280278