[2025-10-02T23:57:40.461Z] Running test renaissance-philosophers_0 ... [2025-10-02T23:57:40.461Z] =============================================== [2025-10-02T23:57:40.461Z] renaissance-philosophers_0 Start Time: Thu Oct 2 23:57:40 2025 Epoch Time (ms): 1759449460321 [2025-10-02T23:57:40.461Z] variation: NoOptions [2025-10-02T23:57:40.461Z] JVM_OPTIONS: [2025-10-02T23:57:40.461Z] { \ [2025-10-02T23:57:40.461Z] echo ""; echo "TEST SETUP:"; \ [2025-10-02T23:57:40.461Z] echo "Nothing to be done for setup."; \ [2025-10-02T23:57:40.461Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17594463949376/renaissance-philosophers_0"; \ [2025-10-02T23:57:40.461Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17594463949376/renaissance-philosophers_0"; \ [2025-10-02T23:57:40.461Z] echo ""; echo "TESTING:"; \ [2025-10-02T23:57:40.461Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/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_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17594463949376/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-10-02T23:57:40.461Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17594463949376/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-02T23:57:40.461Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-02T23:57:40.461Z] echo "Nothing to be done for teardown."; \ [2025-10-02T23:57:40.461Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17594463949376/TestTargetResult"; [2025-10-02T23:57:40.461Z] [2025-10-02T23:57:40.461Z] TEST SETUP: [2025-10-02T23:57:40.461Z] Nothing to be done for setup. [2025-10-02T23:57:40.461Z] [2025-10-02T23:57:40.461Z] TESTING: [2025-10-02T23:57:42.745Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-10-02T23:57:42.746Z] GC before operation: completed in 50.439 ms, heap usage 14.567 MB -> 4.204 MB. [2025-10-02T23:57:46.937Z] Camera thread performed 122 scans. [2025-10-02T23:57:46.937Z] ====== philosophers (scala) [default], iteration 0 completed (4701.736 ms) ====== [2025-10-02T23:57:46.937Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-10-02T23:57:47.654Z] GC before operation: completed in 47.519 ms, heap usage 16.588 MB -> 4.615 MB. [2025-10-02T23:57:49.134Z] Camera thread performed 122 scans. [2025-10-02T23:57:49.134Z] ====== philosophers (scala) [default], iteration 1 completed (1597.800 ms) ====== [2025-10-02T23:57:49.134Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-10-02T23:57:49.134Z] GC before operation: completed in 40.262 ms, heap usage 24.312 MB -> 4.615 MB. [2025-10-02T23:57:50.620Z] Camera thread performed 122 scans. [2025-10-02T23:57:50.620Z] ====== philosophers (scala) [default], iteration 2 completed (1500.321 ms) ====== [2025-10-02T23:57:50.620Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-10-02T23:57:50.620Z] GC before operation: completed in 42.791 ms, heap usage 21.313 MB -> 4.655 MB. [2025-10-02T23:57:52.105Z] Camera thread performed 122 scans. [2025-10-02T23:57:52.105Z] ====== philosophers (scala) [default], iteration 3 completed (1520.149 ms) ====== [2025-10-02T23:57:52.105Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-10-02T23:57:52.105Z] GC before operation: completed in 38.940 ms, heap usage 51.839 MB -> 4.656 MB. [2025-10-02T23:57:53.610Z] Camera thread performed 122 scans. [2025-10-02T23:57:53.610Z] ====== philosophers (scala) [default], iteration 4 completed (1654.343 ms) ====== [2025-10-02T23:57:53.610Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-10-02T23:57:53.610Z] GC before operation: completed in 40.404 ms, heap usage 40.577 MB -> 4.622 MB. [2025-10-02T23:57:55.944Z] Camera thread performed 122 scans. [2025-10-02T23:57:55.944Z] ====== philosophers (scala) [default], iteration 5 completed (1787.426 ms) ====== [2025-10-02T23:57:55.944Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-10-02T23:57:55.944Z] GC before operation: completed in 46.256 ms, heap usage 28.343 MB -> 4.622 MB. [2025-10-02T23:57:57.423Z] Camera thread performed 122 scans. [2025-10-02T23:57:57.423Z] ====== philosophers (scala) [default], iteration 6 completed (1630.948 ms) ====== [2025-10-02T23:57:57.423Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-10-02T23:57:57.423Z] GC before operation: completed in 47.762 ms, heap usage 83.290 MB -> 4.622 MB. [2025-10-02T23:57:58.923Z] Camera thread performed 122 scans. [2025-10-02T23:57:58.923Z] ====== philosophers (scala) [default], iteration 7 completed (1683.910 ms) ====== [2025-10-02T23:57:58.923Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-10-02T23:57:58.923Z] GC before operation: completed in 40.513 ms, heap usage 47.139 MB -> 4.623 MB. [2025-10-02T23:58:00.392Z] Camera thread performed 122 scans. [2025-10-02T23:58:00.392Z] ====== philosophers (scala) [default], iteration 8 completed (1514.120 ms) ====== [2025-10-02T23:58:00.392Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-10-02T23:58:00.392Z] GC before operation: completed in 48.942 ms, heap usage 70.824 MB -> 4.624 MB. [2025-10-02T23:58:01.868Z] Camera thread performed 122 scans. [2025-10-02T23:58:01.868Z] ====== philosophers (scala) [default], iteration 9 completed (1387.717 ms) ====== [2025-10-02T23:58:01.868Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-10-02T23:58:01.868Z] GC before operation: completed in 47.752 ms, heap usage 61.771 MB -> 4.624 MB. [2025-10-02T23:58:03.347Z] Camera thread performed 122 scans. [2025-10-02T23:58:03.348Z] ====== philosophers (scala) [default], iteration 10 completed (1349.433 ms) ====== [2025-10-02T23:58:03.348Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-10-02T23:58:03.348Z] GC before operation: completed in 42.404 ms, heap usage 65.813 MB -> 4.624 MB. [2025-10-02T23:58:04.822Z] Camera thread performed 122 scans. [2025-10-02T23:58:04.822Z] ====== philosophers (scala) [default], iteration 11 completed (1550.712 ms) ====== [2025-10-02T23:58:04.822Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-10-02T23:58:04.822Z] GC before operation: completed in 32.833 ms, heap usage 59.455 MB -> 4.625 MB. [2025-10-02T23:58:06.307Z] Camera thread performed 122 scans. [2025-10-02T23:58:06.307Z] ====== philosophers (scala) [default], iteration 12 completed (1458.497 ms) ====== [2025-10-02T23:58:06.307Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-10-02T23:58:06.307Z] GC before operation: completed in 30.237 ms, heap usage 24.194 MB -> 4.625 MB. [2025-10-02T23:58:07.768Z] Camera thread performed 122 scans. [2025-10-02T23:58:07.768Z] ====== philosophers (scala) [default], iteration 13 completed (1504.548 ms) ====== [2025-10-02T23:58:07.768Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-10-02T23:58:07.768Z] GC before operation: completed in 47.773 ms, heap usage 15.826 MB -> 4.625 MB. [2025-10-02T23:58:09.236Z] Camera thread performed 122 scans. [2025-10-02T23:58:09.236Z] ====== philosophers (scala) [default], iteration 14 completed (1566.474 ms) ====== [2025-10-02T23:58:09.236Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-10-02T23:58:09.950Z] GC before operation: completed in 43.117 ms, heap usage 16.164 MB -> 4.626 MB. [2025-10-02T23:58:11.416Z] Camera thread performed 122 scans. [2025-10-02T23:58:11.416Z] ====== philosophers (scala) [default], iteration 15 completed (1476.748 ms) ====== [2025-10-02T23:58:11.416Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-10-02T23:58:11.416Z] GC before operation: completed in 37.721 ms, heap usage 72.555 MB -> 4.625 MB. [2025-10-02T23:58:13.330Z] Camera thread performed 122 scans. [2025-10-02T23:58:13.330Z] ====== philosophers (scala) [default], iteration 16 completed (1445.813 ms) ====== [2025-10-02T23:58:13.330Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-10-02T23:58:13.330Z] GC before operation: completed in 52.271 ms, heap usage 22.332 MB -> 4.626 MB. [2025-10-02T23:58:14.058Z] Camera thread performed 122 scans. [2025-10-02T23:58:14.058Z] ====== philosophers (scala) [default], iteration 17 completed (1317.750 ms) ====== [2025-10-02T23:58:14.058Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-10-02T23:58:14.058Z] GC before operation: completed in 47.967 ms, heap usage 28.215 MB -> 4.626 MB. [2025-10-02T23:58:15.550Z] Camera thread performed 122 scans. [2025-10-02T23:58:15.550Z] ====== philosophers (scala) [default], iteration 18 completed (1387.307 ms) ====== [2025-10-02T23:58:15.550Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-10-02T23:58:15.550Z] GC before operation: completed in 38.016 ms, heap usage 30.818 MB -> 4.626 MB. [2025-10-02T23:58:17.017Z] Camera thread performed 122 scans. [2025-10-02T23:58:17.017Z] ====== philosophers (scala) [default], iteration 19 completed (1290.591 ms) ====== [2025-10-02T23:58:17.017Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-10-02T23:58:17.017Z] GC before operation: completed in 46.930 ms, heap usage 29.334 MB -> 4.626 MB. [2025-10-02T23:58:19.421Z] Camera thread performed 122 scans. [2025-10-02T23:58:19.421Z] ====== philosophers (scala) [default], iteration 20 completed (1426.638 ms) ====== [2025-10-02T23:58:19.421Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-10-02T23:58:19.421Z] GC before operation: completed in 49.090 ms, heap usage 72.063 MB -> 4.626 MB. [2025-10-02T23:58:19.421Z] Camera thread performed 122 scans. [2025-10-02T23:58:19.421Z] ====== philosophers (scala) [default], iteration 21 completed (1235.535 ms) ====== [2025-10-02T23:58:19.421Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-10-02T23:58:19.421Z] GC before operation: completed in 46.513 ms, heap usage 37.200 MB -> 4.627 MB. [2025-10-02T23:58:20.904Z] Camera thread performed 122 scans. [2025-10-02T23:58:20.904Z] ====== philosophers (scala) [default], iteration 22 completed (1299.438 ms) ====== [2025-10-02T23:58:20.904Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-10-02T23:58:20.904Z] GC before operation: completed in 39.006 ms, heap usage 9.195 MB -> 4.627 MB. [2025-10-02T23:58:22.385Z] Camera thread performed 122 scans. [2025-10-02T23:58:22.385Z] ====== philosophers (scala) [default], iteration 23 completed (1423.481 ms) ====== [2025-10-02T23:58:22.385Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-10-02T23:58:22.385Z] GC before operation: completed in 49.731 ms, heap usage 76.493 MB -> 4.627 MB. [2025-10-02T23:58:23.860Z] Camera thread performed 122 scans. [2025-10-02T23:58:23.860Z] ====== philosophers (scala) [default], iteration 24 completed (1664.002 ms) ====== [2025-10-02T23:58:23.860Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-10-02T23:58:23.860Z] GC before operation: completed in 49.950 ms, heap usage 74.198 MB -> 4.627 MB. [2025-10-02T23:58:25.327Z] Camera thread performed 122 scans. [2025-10-02T23:58:25.327Z] ====== philosophers (scala) [default], iteration 25 completed (1307.445 ms) ====== [2025-10-02T23:58:25.327Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-10-02T23:58:25.327Z] GC before operation: completed in 46.918 ms, heap usage 56.141 MB -> 4.627 MB. [2025-10-02T23:58:26.804Z] Camera thread performed 122 scans. [2025-10-02T23:58:26.804Z] ====== philosophers (scala) [default], iteration 26 completed (1413.638 ms) ====== [2025-10-02T23:58:26.804Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-10-02T23:58:26.804Z] GC before operation: completed in 44.027 ms, heap usage 45.792 MB -> 4.627 MB. [2025-10-02T23:58:28.276Z] Camera thread performed 122 scans. [2025-10-02T23:58:28.276Z] ====== philosophers (scala) [default], iteration 27 completed (1278.420 ms) ====== [2025-10-02T23:58:28.276Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-10-02T23:58:28.276Z] GC before operation: completed in 36.167 ms, heap usage 28.251 MB -> 4.627 MB. [2025-10-02T23:58:29.751Z] Camera thread performed 122 scans. [2025-10-02T23:58:29.751Z] ====== philosophers (scala) [default], iteration 28 completed (1635.077 ms) ====== [2025-10-02T23:58:29.751Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-10-02T23:58:29.751Z] GC before operation: completed in 44.390 ms, heap usage 75.192 MB -> 4.627 MB. [2025-10-02T23:58:33.863Z] Camera thread performed 122 scans. [2025-10-02T23:58:33.863Z] ====== philosophers (scala) [default], iteration 29 completed (1547.023 ms) ====== [2025-10-02T23:58:33.863Z] ----------------------------------- [2025-10-02T23:58:33.863Z] renaissance-philosophers_0_PASSED [2025-10-02T23:58:33.863Z] ----------------------------------- [2025-10-02T23:58:33.863Z] [2025-10-02T23:58:33.863Z] TEST TEARDOWN: [2025-10-02T23:58:33.863Z] Nothing to be done for teardown. [2025-10-02T23:58:33.863Z] renaissance-philosophers_0 Finish Time: Thu Oct 2 23:58:31 2025 Epoch Time (ms): 1759449511390