[2025-06-13T11:26:04.864Z] Running test renaissance-philosophers_0 ... [2025-06-13T11:26:04.864Z] =============================================== [2025-06-13T11:26:04.864Z] renaissance-philosophers_0 Start Time: Fri Jun 13 11:26:04 2025 Epoch Time (ms): 1749813964131 [2025-06-13T11:26:04.864Z] variation: NoOptions [2025-06-13T11:26:04.864Z] JVM_OPTIONS: [2025-06-13T11:26:04.864Z] { \ [2025-06-13T11:26:04.864Z] echo ""; echo "TEST SETUP:"; \ [2025-06-13T11:26:04.864Z] echo "Nothing to be done for setup."; \ [2025-06-13T11:26:04.864Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17498083843889/renaissance-philosophers_0"; \ [2025-06-13T11:26:04.864Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17498083843889/renaissance-philosophers_0"; \ [2025-06-13T11:26:04.864Z] echo ""; echo "TESTING:"; \ [2025-06-13T11:26:04.864Z] "/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_17498083843889/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-06-13T11:26:04.864Z] 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_17498083843889/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-13T11:26:04.864Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-13T11:26:04.864Z] echo "Nothing to be done for teardown."; \ [2025-06-13T11:26:04.864Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17498083843889/TestTargetResult"; [2025-06-13T11:26:04.864Z] [2025-06-13T11:26:04.864Z] TEST SETUP: [2025-06-13T11:26:04.864Z] Nothing to be done for setup. [2025-06-13T11:26:04.864Z] [2025-06-13T11:26:04.864Z] TESTING: [2025-06-13T11:26:08.199Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-06-13T11:26:08.199Z] GC before operation: completed in 101.854 ms, heap usage 15.091 MB -> 4.204 MB. [2025-06-13T11:26:18.150Z] Camera thread performed 122 scans. [2025-06-13T11:26:18.150Z] ====== philosophers (scala) [default], iteration 0 completed (9764.998 ms) ====== [2025-06-13T11:26:18.150Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-06-13T11:26:18.150Z] GC before operation: completed in 84.185 ms, heap usage 41.849 MB -> 4.616 MB. [2025-06-13T11:26:21.944Z] Camera thread performed 122 scans. [2025-06-13T11:26:21.944Z] ====== philosophers (scala) [default], iteration 1 completed (3921.799 ms) ====== [2025-06-13T11:26:21.944Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-06-13T11:26:21.944Z] GC before operation: completed in 74.486 ms, heap usage 31.297 MB -> 4.615 MB. [2025-06-13T11:26:26.556Z] Camera thread performed 122 scans. [2025-06-13T11:26:26.556Z] ====== philosophers (scala) [default], iteration 2 completed (4279.823 ms) ====== [2025-06-13T11:26:26.556Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-06-13T11:26:26.556Z] GC before operation: completed in 78.456 ms, heap usage 10.557 MB -> 4.619 MB. [2025-06-13T11:26:30.033Z] Camera thread performed 122 scans. [2025-06-13T11:26:30.033Z] ====== philosophers (scala) [default], iteration 3 completed (3326.864 ms) ====== [2025-06-13T11:26:30.033Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-06-13T11:26:30.033Z] GC before operation: completed in 33.565 ms, heap usage 7.219 MB -> 4.621 MB. [2025-06-13T11:26:33.949Z] Camera thread performed 122 scans. [2025-06-13T11:26:33.949Z] ====== philosophers (scala) [default], iteration 4 completed (3327.165 ms) ====== [2025-06-13T11:26:33.949Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-06-13T11:26:33.949Z] GC before operation: completed in 99.214 ms, heap usage 21.637 MB -> 4.622 MB. [2025-06-13T11:26:37.436Z] Camera thread performed 122 scans. [2025-06-13T11:26:37.436Z] ====== philosophers (scala) [default], iteration 5 completed (4072.909 ms) ====== [2025-06-13T11:26:37.436Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-06-13T11:26:37.436Z] GC before operation: completed in 69.817 ms, heap usage 6.486 MB -> 4.622 MB. [2025-06-13T11:26:42.018Z] Camera thread performed 122 scans. [2025-06-13T11:26:42.018Z] ====== philosophers (scala) [default], iteration 6 completed (4279.759 ms) ====== [2025-06-13T11:26:42.018Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-06-13T11:26:42.018Z] GC before operation: completed in 85.470 ms, heap usage 48.825 MB -> 4.622 MB. [2025-06-13T11:26:45.439Z] Camera thread performed 122 scans. [2025-06-13T11:26:45.439Z] ====== philosophers (scala) [default], iteration 7 completed (3861.079 ms) ====== [2025-06-13T11:26:45.439Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-06-13T11:26:45.439Z] GC before operation: completed in 54.844 ms, heap usage 37.220 MB -> 4.622 MB. [2025-06-13T11:26:48.842Z] Camera thread performed 122 scans. [2025-06-13T11:26:48.842Z] ====== philosophers (scala) [default], iteration 8 completed (3599.088 ms) ====== [2025-06-13T11:26:48.842Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-06-13T11:26:49.619Z] GC before operation: completed in 62.148 ms, heap usage 43.819 MB -> 4.623 MB. [2025-06-13T11:26:53.021Z] Camera thread performed 122 scans. [2025-06-13T11:26:53.021Z] ====== philosophers (scala) [default], iteration 9 completed (3459.212 ms) ====== [2025-06-13T11:26:53.021Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-06-13T11:26:53.021Z] GC before operation: completed in 71.192 ms, heap usage 18.828 MB -> 4.623 MB. [2025-06-13T11:26:56.578Z] Camera thread performed 122 scans. [2025-06-13T11:26:56.578Z] ====== philosophers (scala) [default], iteration 10 completed (3288.769 ms) ====== [2025-06-13T11:26:56.578Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-06-13T11:26:56.578Z] GC before operation: completed in 76.324 ms, heap usage 19.381 MB -> 4.623 MB. [2025-06-13T11:26:59.972Z] Camera thread performed 122 scans. [2025-06-13T11:26:59.972Z] ====== philosophers (scala) [default], iteration 11 completed (3386.425 ms) ====== [2025-06-13T11:26:59.972Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-06-13T11:26:59.972Z] GC before operation: completed in 56.679 ms, heap usage 9.461 MB -> 4.624 MB. [2025-06-13T11:27:03.365Z] Camera thread performed 122 scans. [2025-06-13T11:27:03.365Z] ====== philosophers (scala) [default], iteration 12 completed (3263.426 ms) ====== [2025-06-13T11:27:03.365Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-06-13T11:27:03.365Z] GC before operation: completed in 76.050 ms, heap usage 67.775 MB -> 4.626 MB. [2025-06-13T11:27:06.758Z] Camera thread performed 122 scans. [2025-06-13T11:27:06.758Z] ====== philosophers (scala) [default], iteration 13 completed (3320.599 ms) ====== [2025-06-13T11:27:06.758Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-06-13T11:27:06.758Z] GC before operation: completed in 66.759 ms, heap usage 29.409 MB -> 4.624 MB. [2025-06-13T11:27:09.216Z] Camera thread performed 122 scans. [2025-06-13T11:27:09.216Z] ====== philosophers (scala) [default], iteration 14 completed (2998.216 ms) ====== [2025-06-13T11:27:09.216Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-06-13T11:27:09.216Z] GC before operation: completed in 65.929 ms, heap usage 6.216 MB -> 4.625 MB. [2025-06-13T11:27:12.634Z] Camera thread performed 122 scans. [2025-06-13T11:27:12.634Z] ====== philosophers (scala) [default], iteration 15 completed (3037.755 ms) ====== [2025-06-13T11:27:12.634Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-06-13T11:27:12.634Z] GC before operation: completed in 52.158 ms, heap usage 32.247 MB -> 4.625 MB. [2025-06-13T11:27:16.009Z] Camera thread performed 122 scans. [2025-06-13T11:27:16.009Z] ====== philosophers (scala) [default], iteration 16 completed (2931.341 ms) ====== [2025-06-13T11:27:16.009Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-06-13T11:27:16.009Z] GC before operation: completed in 57.290 ms, heap usage 58.114 MB -> 4.626 MB. [2025-06-13T11:27:19.464Z] Camera thread performed 122 scans. [2025-06-13T11:27:19.464Z] ====== philosophers (scala) [default], iteration 17 completed (3472.992 ms) ====== [2025-06-13T11:27:19.464Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-06-13T11:27:19.464Z] GC before operation: completed in 63.651 ms, heap usage 43.482 MB -> 4.625 MB. [2025-06-13T11:27:21.907Z] Camera thread performed 122 scans. [2025-06-13T11:27:21.907Z] ====== philosophers (scala) [default], iteration 18 completed (3068.091 ms) ====== [2025-06-13T11:27:21.907Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-06-13T11:27:21.907Z] GC before operation: completed in 70.874 ms, heap usage 5.834 MB -> 4.625 MB. [2025-06-13T11:27:25.303Z] Camera thread performed 122 scans. [2025-06-13T11:27:25.303Z] ====== philosophers (scala) [default], iteration 19 completed (3398.084 ms) ====== [2025-06-13T11:27:25.303Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-06-13T11:27:25.303Z] GC before operation: completed in 70.975 ms, heap usage 6.512 MB -> 4.626 MB. [2025-06-13T11:27:28.779Z] Camera thread performed 122 scans. [2025-06-13T11:27:28.779Z] ====== philosophers (scala) [default], iteration 20 completed (3445.319 ms) ====== [2025-06-13T11:27:28.779Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-06-13T11:27:29.650Z] GC before operation: completed in 91.964 ms, heap usage 10.092 MB -> 4.625 MB. [2025-06-13T11:27:32.136Z] Camera thread performed 122 scans. [2025-06-13T11:27:32.136Z] ====== philosophers (scala) [default], iteration 21 completed (3140.486 ms) ====== [2025-06-13T11:27:32.136Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-06-13T11:27:32.136Z] GC before operation: completed in 86.065 ms, heap usage 35.719 MB -> 4.625 MB. [2025-06-13T11:27:35.542Z] Camera thread performed 122 scans. [2025-06-13T11:27:35.542Z] ====== philosophers (scala) [default], iteration 22 completed (3309.967 ms) ====== [2025-06-13T11:27:35.542Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-06-13T11:27:35.542Z] GC before operation: completed in 74.456 ms, heap usage 36.032 MB -> 4.625 MB. [2025-06-13T11:27:39.489Z] Camera thread performed 122 scans. [2025-06-13T11:27:39.489Z] ====== philosophers (scala) [default], iteration 23 completed (3449.903 ms) ====== [2025-06-13T11:27:39.489Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-06-13T11:27:39.489Z] GC before operation: completed in 84.892 ms, heap usage 17.075 MB -> 4.626 MB. [2025-06-13T11:27:42.942Z] Camera thread performed 122 scans. [2025-06-13T11:27:42.942Z] ====== philosophers (scala) [default], iteration 24 completed (3213.703 ms) ====== [2025-06-13T11:27:42.942Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-06-13T11:27:42.942Z] GC before operation: completed in 70.507 ms, heap usage 43.339 MB -> 4.627 MB. [2025-06-13T11:27:46.487Z] Camera thread performed 122 scans. [2025-06-13T11:27:46.487Z] ====== philosophers (scala) [default], iteration 25 completed (3394.976 ms) ====== [2025-06-13T11:27:46.487Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-06-13T11:27:46.487Z] GC before operation: completed in 80.473 ms, heap usage 44.526 MB -> 4.625 MB. [2025-06-13T11:27:49.059Z] Camera thread performed 122 scans. [2025-06-13T11:27:49.059Z] ====== philosophers (scala) [default], iteration 26 completed (3144.404 ms) ====== [2025-06-13T11:27:49.059Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-06-13T11:27:49.059Z] GC before operation: completed in 64.166 ms, heap usage 28.829 MB -> 4.627 MB. [2025-06-13T11:27:52.501Z] Camera thread performed 122 scans. [2025-06-13T11:27:52.501Z] ====== philosophers (scala) [default], iteration 27 completed (3147.110 ms) ====== [2025-06-13T11:27:52.501Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-06-13T11:27:52.501Z] GC before operation: completed in 58.664 ms, heap usage 30.383 MB -> 4.627 MB. [2025-06-13T11:27:55.918Z] Camera thread performed 122 scans. [2025-06-13T11:27:55.918Z] ====== philosophers (scala) [default], iteration 28 completed (3098.961 ms) ====== [2025-06-13T11:27:55.918Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-06-13T11:27:55.918Z] GC before operation: completed in 88.892 ms, heap usage 40.724 MB -> 4.626 MB. [2025-06-13T11:27:59.371Z] Camera thread performed 122 scans. [2025-06-13T11:27:59.371Z] ====== philosophers (scala) [default], iteration 29 completed (3418.338 ms) ====== [2025-06-13T11:28:00.146Z] ----------------------------------- [2025-06-13T11:28:00.146Z] renaissance-philosophers_0_PASSED [2025-06-13T11:28:00.146Z] ----------------------------------- [2025-06-13T11:28:00.146Z] [2025-06-13T11:28:00.146Z] TEST TEARDOWN: [2025-06-13T11:28:00.146Z] Nothing to be done for teardown. [2025-06-13T11:28:00.146Z] renaissance-philosophers_0 Finish Time: Fri Jun 13 11:27:59 2025 Epoch Time (ms): 1749814079652