[2026-03-06T03:25:41.272Z] Running test renaissance-philosophers_0 ... [2026-03-06T03:25:41.272Z] =============================================== [2026-03-06T03:25:41.272Z] renaissance-philosophers_0 Start Time: Fri Mar 6 03:25:40 2026 Epoch Time (ms): 1772767540634 [2026-03-06T03:25:41.272Z] variation: NoOptions [2026-03-06T03:25:41.272Z] JVM_OPTIONS: [2026-03-06T03:25:41.272Z] { \ [2026-03-06T03:25:41.272Z] echo ""; echo "TEST SETUP:"; \ [2026-03-06T03:25:41.272Z] echo "Nothing to be done for setup."; \ [2026-03-06T03:25:41.272Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727653036924/renaissance-philosophers_0"; \ [2026-03-06T03:25:41.272Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727653036924/renaissance-philosophers_0"; \ [2026-03-06T03:25:41.272Z] echo ""; echo "TESTING:"; \ [2026-03-06T03:25:41.272Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/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 "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727653036924/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-03-06T03:25:41.272Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727653036924/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-06T03:25:41.272Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-06T03:25:41.272Z] echo "Nothing to be done for teardown."; \ [2026-03-06T03:25:41.272Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17727653036924/TestTargetResult"; [2026-03-06T03:25:41.272Z] [2026-03-06T03:25:41.272Z] TEST SETUP: [2026-03-06T03:25:41.272Z] Nothing to be done for setup. [2026-03-06T03:25:41.272Z] [2026-03-06T03:25:41.272Z] TESTING: [2026-03-06T03:25:42.016Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-03-06T03:25:42.016Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17727653036924/renaissance-philosophers_0/launcher-032540-17977550728704290049/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-03-06T03:25:42.016Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-03-06T03:25:42.016Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-03-06T03:25:42.763Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-06T03:25:42.763Z] GC before operation: completed in 43.004 ms, heap usage 27.129 MB -> 4.805 MB. [2026-03-06T03:25:46.091Z] Camera thread performed 122 scans. [2026-03-06T03:25:46.091Z] ====== philosophers (scala) [default], iteration 0 completed (3492.226 ms) ====== [2026-03-06T03:25:46.091Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-06T03:25:46.091Z] GC before operation: completed in 49.770 ms, heap usage 6.868 MB -> 5.140 MB. [2026-03-06T03:25:48.535Z] Camera thread performed 122 scans. [2026-03-06T03:25:48.535Z] ====== philosophers (scala) [default], iteration 1 completed (2149.673 ms) ====== [2026-03-06T03:25:48.535Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-06T03:25:48.535Z] GC before operation: completed in 26.801 ms, heap usage 51.330 MB -> 5.141 MB. [2026-03-06T03:25:50.091Z] Camera thread performed 122 scans. [2026-03-06T03:25:50.091Z] ====== philosophers (scala) [default], iteration 2 completed (1367.578 ms) ====== [2026-03-06T03:25:50.091Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-06T03:25:50.091Z] GC before operation: completed in 30.332 ms, heap usage 48.328 MB -> 5.141 MB. [2026-03-06T03:25:50.837Z] Camera thread performed 122 scans. [2026-03-06T03:25:50.838Z] ====== philosophers (scala) [default], iteration 3 completed (1507.419 ms) ====== [2026-03-06T03:25:50.838Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-06T03:25:51.580Z] GC before operation: completed in 34.491 ms, heap usage 38.463 MB -> 5.142 MB. [2026-03-06T03:25:52.320Z] Camera thread performed 122 scans. [2026-03-06T03:25:52.320Z] ====== philosophers (scala) [default], iteration 4 completed (1439.902 ms) ====== [2026-03-06T03:25:52.320Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-06T03:25:53.070Z] GC before operation: completed in 25.399 ms, heap usage 37.886 MB -> 5.142 MB. [2026-03-06T03:25:53.870Z] Camera thread performed 122 scans. [2026-03-06T03:25:53.870Z] ====== philosophers (scala) [default], iteration 5 completed (1362.977 ms) ====== [2026-03-06T03:25:53.870Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-06T03:25:53.870Z] GC before operation: completed in 38.768 ms, heap usage 82.279 MB -> 5.142 MB. [2026-03-06T03:25:55.414Z] Camera thread performed 122 scans. [2026-03-06T03:25:55.414Z] ====== philosophers (scala) [default], iteration 6 completed (1326.669 ms) ====== [2026-03-06T03:25:55.414Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-06T03:25:55.414Z] GC before operation: completed in 22.351 ms, heap usage 76.360 MB -> 5.142 MB. [2026-03-06T03:25:56.944Z] Camera thread performed 122 scans. [2026-03-06T03:25:56.945Z] ====== philosophers (scala) [default], iteration 7 completed (1458.034 ms) ====== [2026-03-06T03:25:56.945Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-06T03:25:56.945Z] GC before operation: completed in 36.677 ms, heap usage 33.769 MB -> 5.143 MB. [2026-03-06T03:25:58.496Z] Camera thread performed 122 scans. [2026-03-06T03:25:58.496Z] ====== philosophers (scala) [default], iteration 8 completed (1401.737 ms) ====== [2026-03-06T03:25:58.496Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-06T03:25:58.496Z] GC before operation: completed in 33.882 ms, heap usage 30.271 MB -> 5.143 MB. [2026-03-06T03:26:00.039Z] Camera thread performed 122 scans. [2026-03-06T03:26:00.039Z] ====== philosophers (scala) [default], iteration 9 completed (1231.471 ms) ====== [2026-03-06T03:26:00.039Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-06T03:26:00.039Z] GC before operation: completed in 23.164 ms, heap usage 93.816 MB -> 5.143 MB. [2026-03-06T03:26:00.787Z] Camera thread performed 122 scans. [2026-03-06T03:26:00.787Z] ====== philosophers (scala) [default], iteration 10 completed (1475.853 ms) ====== [2026-03-06T03:26:00.787Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-06T03:26:01.530Z] GC before operation: completed in 40.387 ms, heap usage 105.841 MB -> 5.143 MB. [2026-03-06T03:26:02.273Z] Camera thread performed 122 scans. [2026-03-06T03:26:02.273Z] ====== philosophers (scala) [default], iteration 11 completed (1385.991 ms) ====== [2026-03-06T03:26:02.273Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-06T03:26:02.273Z] GC before operation: completed in 43.207 ms, heap usage 65.255 MB -> 5.143 MB. [2026-03-06T03:26:03.810Z] Camera thread performed 122 scans. [2026-03-06T03:26:03.810Z] ====== philosophers (scala) [default], iteration 12 completed (1386.012 ms) ====== [2026-03-06T03:26:03.810Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-06T03:26:03.810Z] GC before operation: completed in 19.342 ms, heap usage 53.344 MB -> 5.143 MB. [2026-03-06T03:26:05.340Z] Camera thread performed 122 scans. [2026-03-06T03:26:05.340Z] ====== philosophers (scala) [default], iteration 13 completed (1416.398 ms) ====== [2026-03-06T03:26:05.340Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-06T03:26:05.340Z] GC before operation: completed in 33.548 ms, heap usage 56.661 MB -> 5.144 MB. [2026-03-06T03:26:06.872Z] Camera thread performed 122 scans. [2026-03-06T03:26:06.872Z] ====== philosophers (scala) [default], iteration 14 completed (1322.249 ms) ====== [2026-03-06T03:26:06.872Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-06T03:26:06.872Z] GC before operation: completed in 23.506 ms, heap usage 65.261 MB -> 5.144 MB. [2026-03-06T03:26:08.414Z] Camera thread performed 122 scans. [2026-03-06T03:26:08.414Z] ====== philosophers (scala) [default], iteration 15 completed (1302.266 ms) ====== [2026-03-06T03:26:08.414Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-06T03:26:08.414Z] GC before operation: completed in 35.346 ms, heap usage 68.179 MB -> 5.144 MB. [2026-03-06T03:26:09.392Z] Camera thread performed 122 scans. [2026-03-06T03:26:09.392Z] ====== philosophers (scala) [default], iteration 16 completed (1455.833 ms) ====== [2026-03-06T03:26:09.392Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-06T03:26:09.392Z] GC before operation: completed in 19.660 ms, heap usage 77.240 MB -> 5.144 MB. [2026-03-06T03:26:10.932Z] Camera thread performed 122 scans. [2026-03-06T03:26:10.932Z] ====== philosophers (scala) [default], iteration 17 completed (1431.754 ms) ====== [2026-03-06T03:26:10.932Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-06T03:26:10.932Z] GC before operation: completed in 26.633 ms, heap usage 25.312 MB -> 5.144 MB. [2026-03-06T03:26:12.466Z] Camera thread performed 122 scans. [2026-03-06T03:26:12.466Z] ====== philosophers (scala) [default], iteration 18 completed (1370.008 ms) ====== [2026-03-06T03:26:12.466Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-06T03:26:12.466Z] GC before operation: completed in 25.874 ms, heap usage 64.269 MB -> 5.144 MB. [2026-03-06T03:26:14.001Z] Camera thread performed 122 scans. [2026-03-06T03:26:14.001Z] ====== philosophers (scala) [default], iteration 19 completed (1587.577 ms) ====== [2026-03-06T03:26:14.001Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-06T03:26:14.001Z] GC before operation: completed in 39.734 ms, heap usage 55.833 MB -> 5.144 MB. [2026-03-06T03:26:15.553Z] Camera thread performed 122 scans. [2026-03-06T03:26:15.553Z] ====== philosophers (scala) [default], iteration 20 completed (1457.123 ms) ====== [2026-03-06T03:26:15.553Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-06T03:26:15.553Z] GC before operation: completed in 27.386 ms, heap usage 32.847 MB -> 5.145 MB. [2026-03-06T03:26:17.089Z] Camera thread performed 122 scans. [2026-03-06T03:26:17.089Z] ====== philosophers (scala) [default], iteration 21 completed (1322.445 ms) ====== [2026-03-06T03:26:17.089Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-06T03:26:17.089Z] GC before operation: completed in 29.271 ms, heap usage 15.756 MB -> 5.179 MB. [2026-03-06T03:26:18.627Z] Camera thread performed 122 scans. [2026-03-06T03:26:18.627Z] ====== philosophers (scala) [default], iteration 22 completed (1441.424 ms) ====== [2026-03-06T03:26:18.627Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-06T03:26:18.627Z] GC before operation: completed in 29.168 ms, heap usage 55.379 MB -> 5.145 MB. [2026-03-06T03:26:20.159Z] Camera thread performed 122 scans. [2026-03-06T03:26:20.159Z] ====== philosophers (scala) [default], iteration 23 completed (1372.310 ms) ====== [2026-03-06T03:26:20.159Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-06T03:26:20.159Z] GC before operation: completed in 30.582 ms, heap usage 31.349 MB -> 5.145 MB. [2026-03-06T03:26:20.902Z] Camera thread performed 122 scans. [2026-03-06T03:26:20.902Z] ====== philosophers (scala) [default], iteration 24 completed (1358.890 ms) ====== [2026-03-06T03:26:20.902Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-06T03:26:20.902Z] GC before operation: completed in 35.412 ms, heap usage 55.181 MB -> 5.145 MB. [2026-03-06T03:26:22.443Z] Camera thread performed 122 scans. [2026-03-06T03:26:22.443Z] ====== philosophers (scala) [default], iteration 25 completed (1339.077 ms) ====== [2026-03-06T03:26:22.443Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-06T03:26:22.443Z] GC before operation: completed in 30.380 ms, heap usage 77.767 MB -> 5.145 MB. [2026-03-06T03:26:23.979Z] Camera thread performed 122 scans. [2026-03-06T03:26:23.979Z] ====== philosophers (scala) [default], iteration 26 completed (1422.461 ms) ====== [2026-03-06T03:26:23.980Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-06T03:26:23.980Z] GC before operation: completed in 29.710 ms, heap usage 11.795 MB -> 5.145 MB. [2026-03-06T03:26:25.517Z] Camera thread performed 122 scans. [2026-03-06T03:26:25.517Z] ====== philosophers (scala) [default], iteration 27 completed (1405.836 ms) ====== [2026-03-06T03:26:25.517Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-06T03:26:25.517Z] GC before operation: completed in 21.047 ms, heap usage 20.214 MB -> 5.145 MB. [2026-03-06T03:26:27.054Z] Camera thread performed 122 scans. [2026-03-06T03:26:27.054Z] ====== philosophers (scala) [default], iteration 28 completed (1440.049 ms) ====== [2026-03-06T03:26:27.054Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-06T03:26:27.054Z] GC before operation: completed in 28.787 ms, heap usage 37.818 MB -> 5.145 MB. [2026-03-06T03:26:28.590Z] Camera thread performed 122 scans. [2026-03-06T03:26:28.590Z] ====== philosophers (scala) [default], iteration 29 completed (1457.369 ms) ====== [2026-03-06T03:26:28.590Z] ----------------------------------- [2026-03-06T03:26:28.590Z] renaissance-philosophers_0_PASSED [2026-03-06T03:26:28.590Z] ----------------------------------- [2026-03-06T03:26:28.590Z] [2026-03-06T03:26:28.590Z] TEST TEARDOWN: [2026-03-06T03:26:28.590Z] Nothing to be done for teardown. [2026-03-06T03:26:28.590Z] renaissance-philosophers_0 Finish Time: Fri Mar 6 03:26:28 2026 Epoch Time (ms): 1772767588312