[2025-11-06T18:20:46.379Z] Running test renaissance-philosophers_0 ... [2025-11-06T18:20:46.379Z] =============================================== [2025-11-06T18:20:46.379Z] renaissance-philosophers_0 Start Time: Thu Nov 6 18:20:45 2025 Epoch Time (ms): 1762453245769 [2025-11-06T18:20:46.379Z] variation: NoOptions [2025-11-06T18:20:46.379Z] JVM_OPTIONS: [2025-11-06T18:20:46.379Z] { \ [2025-11-06T18:20:46.379Z] echo ""; echo "TEST SETUP:"; \ [2025-11-06T18:20:46.379Z] echo "Nothing to be done for setup."; \ [2025-11-06T18:20:46.379Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624526648508/renaissance-philosophers_0"; \ [2025-11-06T18:20:46.379Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624526648508/renaissance-philosophers_0"; \ [2025-11-06T18:20:46.379Z] echo ""; echo "TESTING:"; \ [2025-11-06T18:20:46.379Z] "/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_17624526648508/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-11-06T18:20:46.379Z] 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_17624526648508/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-06T18:20:46.379Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-06T18:20:46.379Z] echo "Nothing to be done for teardown."; \ [2025-11-06T18:20:46.379Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624526648508/TestTargetResult"; [2025-11-06T18:20:46.379Z] [2025-11-06T18:20:46.379Z] TEST SETUP: [2025-11-06T18:20:46.379Z] Nothing to be done for setup. [2025-11-06T18:20:46.379Z] [2025-11-06T18:20:46.379Z] TESTING: [2025-11-06T18:20:47.106Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-11-06T18:20:47.106Z] GC before operation: completed in 16.117 ms, heap usage 15.066 MB -> 4.206 MB. [2025-11-06T18:20:53.643Z] Camera thread performed 122 scans. [2025-11-06T18:20:53.643Z] ====== philosophers (scala) [default], iteration 0 completed (6717.177 ms) ====== [2025-11-06T18:20:53.643Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-11-06T18:20:53.643Z] GC before operation: completed in 36.866 ms, heap usage 14.147 MB -> 4.616 MB. [2025-11-06T18:20:55.137Z] Camera thread performed 122 scans. [2025-11-06T18:20:55.137Z] ====== philosophers (scala) [default], iteration 1 completed (1527.651 ms) ====== [2025-11-06T18:20:55.137Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-11-06T18:20:55.137Z] GC before operation: completed in 15.661 ms, heap usage 39.596 MB -> 4.618 MB. [2025-11-06T18:20:57.461Z] Camera thread performed 122 scans. [2025-11-06T18:20:57.461Z] ====== philosophers (scala) [default], iteration 2 completed (1656.791 ms) ====== [2025-11-06T18:20:57.461Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-11-06T18:20:57.461Z] GC before operation: completed in 15.043 ms, heap usage 11.606 MB -> 4.618 MB. [2025-11-06T18:20:58.954Z] Camera thread performed 122 scans. [2025-11-06T18:20:58.954Z] ====== philosophers (scala) [default], iteration 3 completed (1736.221 ms) ====== [2025-11-06T18:20:58.954Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-11-06T18:20:58.954Z] GC before operation: completed in 17.701 ms, heap usage 34.782 MB -> 4.622 MB. [2025-11-06T18:21:00.447Z] Camera thread performed 122 scans. [2025-11-06T18:21:00.447Z] ====== philosophers (scala) [default], iteration 4 completed (1828.442 ms) ====== [2025-11-06T18:21:00.447Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-11-06T18:21:00.447Z] GC before operation: completed in 19.955 ms, heap usage 20.421 MB -> 4.624 MB. [2025-11-06T18:21:02.771Z] Camera thread performed 122 scans. [2025-11-06T18:21:02.771Z] ====== philosophers (scala) [default], iteration 5 completed (1699.196 ms) ====== [2025-11-06T18:21:02.771Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-11-06T18:21:02.771Z] GC before operation: completed in 19.377 ms, heap usage 31.255 MB -> 4.624 MB. [2025-11-06T18:21:04.267Z] Camera thread performed 122 scans. [2025-11-06T18:21:04.267Z] ====== philosophers (scala) [default], iteration 6 completed (1811.070 ms) ====== [2025-11-06T18:21:04.267Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-11-06T18:21:04.268Z] GC before operation: completed in 19.135 ms, heap usage 21.550 MB -> 4.625 MB. [2025-11-06T18:21:05.764Z] Camera thread performed 122 scans. [2025-11-06T18:21:05.764Z] ====== philosophers (scala) [default], iteration 7 completed (1826.528 ms) ====== [2025-11-06T18:21:05.764Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-11-06T18:21:05.764Z] GC before operation: completed in 20.898 ms, heap usage 21.902 MB -> 4.626 MB. [2025-11-06T18:21:08.205Z] Camera thread performed 122 scans. [2025-11-06T18:21:08.205Z] ====== philosophers (scala) [default], iteration 8 completed (1696.654 ms) ====== [2025-11-06T18:21:08.205Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-11-06T18:21:08.205Z] GC before operation: completed in 22.295 ms, heap usage 74.247 MB -> 4.627 MB. [2025-11-06T18:21:09.697Z] Camera thread performed 122 scans. [2025-11-06T18:21:09.697Z] ====== philosophers (scala) [default], iteration 9 completed (1822.121 ms) ====== [2025-11-06T18:21:09.697Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-11-06T18:21:09.697Z] GC before operation: completed in 19.868 ms, heap usage 5.733 MB -> 4.627 MB. [2025-11-06T18:21:11.191Z] Camera thread performed 122 scans. [2025-11-06T18:21:11.191Z] ====== philosophers (scala) [default], iteration 10 completed (1683.139 ms) ====== [2025-11-06T18:21:11.191Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-11-06T18:21:11.191Z] GC before operation: completed in 20.860 ms, heap usage 34.875 MB -> 4.627 MB. [2025-11-06T18:21:13.515Z] Camera thread performed 122 scans. [2025-11-06T18:21:13.515Z] ====== philosophers (scala) [default], iteration 11 completed (1839.759 ms) ====== [2025-11-06T18:21:13.515Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-11-06T18:21:13.515Z] GC before operation: completed in 21.711 ms, heap usage 56.205 MB -> 4.627 MB. [2025-11-06T18:21:15.012Z] Camera thread performed 122 scans. [2025-11-06T18:21:15.012Z] ====== philosophers (scala) [default], iteration 12 completed (1440.620 ms) ====== [2025-11-06T18:21:15.012Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-11-06T18:21:15.012Z] GC before operation: completed in 20.465 ms, heap usage 62.492 MB -> 4.627 MB. [2025-11-06T18:21:16.507Z] Camera thread performed 122 scans. [2025-11-06T18:21:16.507Z] ====== philosophers (scala) [default], iteration 13 completed (1649.111 ms) ====== [2025-11-06T18:21:16.507Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-11-06T18:21:16.507Z] GC before operation: completed in 22.411 ms, heap usage 23.301 MB -> 4.627 MB. [2025-11-06T18:21:17.999Z] Camera thread performed 122 scans. [2025-11-06T18:21:17.999Z] ====== philosophers (scala) [default], iteration 14 completed (1914.107 ms) ====== [2025-11-06T18:21:17.999Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-11-06T18:21:17.999Z] GC before operation: completed in 21.395 ms, heap usage 56.168 MB -> 4.628 MB. [2025-11-06T18:21:20.333Z] Camera thread performed 122 scans. [2025-11-06T18:21:20.333Z] ====== philosophers (scala) [default], iteration 15 completed (2030.497 ms) ====== [2025-11-06T18:21:20.333Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-11-06T18:21:20.333Z] GC before operation: completed in 21.574 ms, heap usage 36.870 MB -> 4.628 MB. [2025-11-06T18:21:21.827Z] Camera thread performed 122 scans. [2025-11-06T18:21:21.827Z] ====== philosophers (scala) [default], iteration 16 completed (1774.306 ms) ====== [2025-11-06T18:21:21.827Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-11-06T18:21:21.827Z] GC before operation: completed in 21.001 ms, heap usage 59.462 MB -> 4.628 MB. [2025-11-06T18:21:24.152Z] Camera thread performed 122 scans. [2025-11-06T18:21:24.152Z] ====== philosophers (scala) [default], iteration 17 completed (1837.859 ms) ====== [2025-11-06T18:21:24.152Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-11-06T18:21:24.152Z] GC before operation: completed in 23.966 ms, heap usage 47.412 MB -> 4.628 MB. [2025-11-06T18:21:25.647Z] Camera thread performed 122 scans. [2025-11-06T18:21:25.647Z] ====== philosophers (scala) [default], iteration 18 completed (1788.785 ms) ====== [2025-11-06T18:21:25.647Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-11-06T18:21:25.647Z] GC before operation: completed in 19.129 ms, heap usage 39.715 MB -> 4.629 MB. [2025-11-06T18:21:27.973Z] Camera thread performed 122 scans. [2025-11-06T18:21:27.973Z] ====== philosophers (scala) [default], iteration 19 completed (1825.801 ms) ====== [2025-11-06T18:21:27.973Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-11-06T18:21:27.973Z] GC before operation: completed in 20.731 ms, heap usage 18.635 MB -> 4.629 MB. [2025-11-06T18:21:29.467Z] Camera thread performed 122 scans. [2025-11-06T18:21:29.467Z] ====== philosophers (scala) [default], iteration 20 completed (1713.618 ms) ====== [2025-11-06T18:21:29.467Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-11-06T18:21:29.467Z] GC before operation: completed in 13.228 ms, heap usage 10.293 MB -> 4.629 MB. [2025-11-06T18:21:30.962Z] Camera thread performed 122 scans. [2025-11-06T18:21:30.962Z] ====== philosophers (scala) [default], iteration 21 completed (1747.772 ms) ====== [2025-11-06T18:21:30.962Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-11-06T18:21:30.962Z] GC before operation: completed in 17.272 ms, heap usage 26.194 MB -> 4.629 MB. [2025-11-06T18:21:33.288Z] Camera thread performed 122 scans. [2025-11-06T18:21:33.288Z] ====== philosophers (scala) [default], iteration 22 completed (1763.936 ms) ====== [2025-11-06T18:21:33.288Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-11-06T18:21:33.288Z] GC before operation: completed in 15.687 ms, heap usage 8.648 MB -> 4.629 MB. [2025-11-06T18:21:34.782Z] Camera thread performed 122 scans. [2025-11-06T18:21:34.782Z] ====== philosophers (scala) [default], iteration 23 completed (1984.379 ms) ====== [2025-11-06T18:21:34.782Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-11-06T18:21:34.782Z] GC before operation: completed in 17.424 ms, heap usage 39.781 MB -> 4.629 MB. [2025-11-06T18:21:36.641Z] Camera thread performed 122 scans. [2025-11-06T18:21:36.641Z] ====== philosophers (scala) [default], iteration 24 completed (1833.684 ms) ====== [2025-11-06T18:21:36.641Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-11-06T18:21:36.641Z] GC before operation: completed in 17.022 ms, heap usage 34.195 MB -> 4.629 MB. [2025-11-06T18:21:38.135Z] Camera thread performed 122 scans. [2025-11-06T18:21:38.135Z] ====== philosophers (scala) [default], iteration 25 completed (1699.087 ms) ====== [2025-11-06T18:21:38.135Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-11-06T18:21:38.857Z] GC before operation: completed in 17.977 ms, heap usage 7.872 MB -> 4.629 MB. [2025-11-06T18:21:40.352Z] Camera thread performed 122 scans. [2025-11-06T18:21:40.352Z] ====== philosophers (scala) [default], iteration 26 completed (1850.397 ms) ====== [2025-11-06T18:21:40.352Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-11-06T18:21:40.352Z] GC before operation: completed in 17.835 ms, heap usage 58.465 MB -> 4.630 MB. [2025-11-06T18:21:41.851Z] Camera thread performed 122 scans. [2025-11-06T18:21:41.851Z] ====== philosophers (scala) [default], iteration 27 completed (1650.924 ms) ====== [2025-11-06T18:21:41.851Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-11-06T18:21:41.851Z] GC before operation: completed in 19.092 ms, heap usage 51.487 MB -> 4.629 MB. [2025-11-06T18:21:43.345Z] Camera thread performed 122 scans. [2025-11-06T18:21:43.345Z] ====== philosophers (scala) [default], iteration 28 completed (1544.351 ms) ====== [2025-11-06T18:21:43.345Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-11-06T18:21:43.345Z] GC before operation: completed in 17.140 ms, heap usage 7.311 MB -> 4.630 MB. [2025-11-06T18:21:45.668Z] Camera thread performed 122 scans. [2025-11-06T18:21:45.668Z] ====== philosophers (scala) [default], iteration 29 completed (1689.664 ms) ====== [2025-11-06T18:21:45.668Z] ----------------------------------- [2025-11-06T18:21:45.668Z] renaissance-philosophers_0_PASSED [2025-11-06T18:21:45.668Z] ----------------------------------- [2025-11-06T18:21:45.668Z] [2025-11-06T18:21:45.668Z] TEST TEARDOWN: [2025-11-06T18:21:45.668Z] Nothing to be done for teardown. [2025-11-06T18:21:45.668Z] renaissance-philosophers_0 Finish Time: Thu Nov 6 18:21:45 2025 Epoch Time (ms): 1762453305052