[2026-03-02T15:14:35.811Z] Running test renaissance-philosophers_0 ... [2026-03-02T15:14:35.811Z] =============================================== [2026-03-02T15:14:35.811Z] renaissance-philosophers_0 Start Time: Mon Mar 2 15:14:35 2026 Epoch Time (ms): 1772464475545 [2026-03-02T15:14:35.811Z] variation: NoOptions [2026-03-02T15:14:35.811Z] JVM_OPTIONS: [2026-03-02T15:14:35.811Z] { \ [2026-03-02T15:14:35.811Z] echo ""; echo "TEST SETUP:"; \ [2026-03-02T15:14:35.811Z] echo "Nothing to be done for setup."; \ [2026-03-02T15:14:35.811Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/renaissance-philosophers_0"; \ [2026-03-02T15:14:35.811Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/renaissance-philosophers_0"; \ [2026-03-02T15:14:35.811Z] echo ""; echo "TESTING:"; \ [2026-03-02T15:14:35.811Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_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_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-03-02T15:14:35.811Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-02T15:14:35.811Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-02T15:14:35.811Z] echo "Nothing to be done for teardown."; \ [2026-03-02T15:14:35.811Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/TestTargetResult"; [2026-03-02T15:14:35.811Z] [2026-03-02T15:14:35.811Z] TEST SETUP: [2026-03-02T15:14:35.811Z] Nothing to be done for setup. [2026-03-02T15:14:35.811Z] [2026-03-02T15:14:35.811Z] TESTING: [2026-03-02T15:14:36.762Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-02T15:14:36.762Z] GC before operation: completed in 16.058 ms, heap usage 14.318 MB -> 4.697 MB. [2026-03-02T15:14:43.447Z] Camera thread performed 122 scans. [2026-03-02T15:14:43.447Z] ====== philosophers (scala) [default], iteration 0 completed (5949.806 ms) ====== [2026-03-02T15:14:43.447Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-02T15:14:43.447Z] GC before operation: completed in 17.345 ms, heap usage 5.792 MB -> 5.066 MB. [2026-03-02T15:14:48.806Z] Camera thread performed 122 scans. [2026-03-02T15:14:48.806Z] ====== philosophers (scala) [default], iteration 1 completed (5322.227 ms) ====== [2026-03-02T15:14:48.806Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-02T15:14:48.806Z] GC before operation: completed in 12.781 ms, heap usage 22.112 MB -> 5.066 MB. [2026-03-02T15:14:54.161Z] Camera thread performed 122 scans. [2026-03-02T15:14:54.161Z] ====== philosophers (scala) [default], iteration 2 completed (5779.631 ms) ====== [2026-03-02T15:14:54.161Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-02T15:14:54.161Z] GC before operation: completed in 13.288 ms, heap usage 8.128 MB -> 5.067 MB. [2026-03-02T15:14:59.514Z] Camera thread performed 122 scans. [2026-03-02T15:14:59.514Z] ====== philosophers (scala) [default], iteration 3 completed (5227.103 ms) ====== [2026-03-02T15:14:59.514Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-02T15:14:59.514Z] GC before operation: completed in 10.607 ms, heap usage 26.074 MB -> 5.067 MB. [2026-03-02T15:15:03.663Z] Camera thread performed 122 scans. [2026-03-02T15:15:03.663Z] ====== philosophers (scala) [default], iteration 4 completed (4621.614 ms) ====== [2026-03-02T15:15:03.663Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-02T15:15:03.663Z] GC before operation: completed in 12.526 ms, heap usage 38.769 MB -> 5.067 MB. [2026-03-02T15:15:07.536Z] Camera thread performed 122 scans. [2026-03-02T15:15:07.536Z] ====== philosophers (scala) [default], iteration 5 completed (3495.827 ms) ====== [2026-03-02T15:15:07.536Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-02T15:15:07.536Z] GC before operation: completed in 10.855 ms, heap usage 34.160 MB -> 5.068 MB. [2026-03-02T15:15:10.719Z] Camera thread performed 122 scans. [2026-03-02T15:15:10.719Z] ====== philosophers (scala) [default], iteration 6 completed (3452.343 ms) ====== [2026-03-02T15:15:10.719Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-02T15:15:10.719Z] GC before operation: completed in 12.252 ms, heap usage 17.606 MB -> 5.069 MB. [2026-03-02T15:15:14.853Z] Camera thread performed 122 scans. [2026-03-02T15:15:14.853Z] ====== philosophers (scala) [default], iteration 7 completed (3513.740 ms) ====== [2026-03-02T15:15:14.853Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-02T15:15:14.853Z] GC before operation: completed in 10.219 ms, heap usage 30.940 MB -> 5.069 MB. [2026-03-02T15:15:17.858Z] Camera thread performed 122 scans. [2026-03-02T15:15:17.858Z] ====== philosophers (scala) [default], iteration 8 completed (3865.791 ms) ====== [2026-03-02T15:15:17.858Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-02T15:15:17.858Z] GC before operation: completed in 14.651 ms, heap usage 65.561 MB -> 5.069 MB. [2026-03-02T15:15:23.210Z] Camera thread performed 122 scans. [2026-03-02T15:15:23.211Z] ====== philosophers (scala) [default], iteration 9 completed (4873.045 ms) ====== [2026-03-02T15:15:23.211Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-02T15:15:23.211Z] GC before operation: completed in 16.976 ms, heap usage 11.683 MB -> 5.069 MB. [2026-03-02T15:15:27.346Z] Camera thread performed 122 scans. [2026-03-02T15:15:27.346Z] ====== philosophers (scala) [default], iteration 10 completed (4264.056 ms) ====== [2026-03-02T15:15:27.346Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-02T15:15:27.346Z] GC before operation: completed in 10.648 ms, heap usage 58.040 MB -> 5.069 MB. [2026-03-02T15:15:32.710Z] Camera thread performed 122 scans. [2026-03-02T15:15:32.710Z] ====== philosophers (scala) [default], iteration 11 completed (4556.142 ms) ====== [2026-03-02T15:15:32.710Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-02T15:15:32.710Z] GC before operation: completed in 16.264 ms, heap usage 13.711 MB -> 5.070 MB. [2026-03-02T15:15:36.852Z] Camera thread performed 122 scans. [2026-03-02T15:15:36.852Z] ====== philosophers (scala) [default], iteration 12 completed (4566.963 ms) ====== [2026-03-02T15:15:36.852Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-02T15:15:36.852Z] GC before operation: completed in 10.592 ms, heap usage 52.525 MB -> 5.070 MB. [2026-03-02T15:15:40.994Z] Camera thread performed 122 scans. [2026-03-02T15:15:40.994Z] ====== philosophers (scala) [default], iteration 13 completed (4646.031 ms) ====== [2026-03-02T15:15:40.994Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-02T15:15:40.994Z] GC before operation: completed in 13.673 ms, heap usage 25.262 MB -> 5.070 MB. [2026-03-02T15:15:46.349Z] Camera thread performed 122 scans. [2026-03-02T15:15:46.349Z] ====== philosophers (scala) [default], iteration 14 completed (4673.572 ms) ====== [2026-03-02T15:15:46.349Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-02T15:15:46.349Z] GC before operation: completed in 12.873 ms, heap usage 48.694 MB -> 5.070 MB. [2026-03-02T15:15:49.368Z] Camera thread performed 122 scans. [2026-03-02T15:15:49.368Z] ====== philosophers (scala) [default], iteration 15 completed (3603.669 ms) ====== [2026-03-02T15:15:49.368Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-02T15:15:49.368Z] GC before operation: completed in 8.922 ms, heap usage 14.614 MB -> 5.070 MB. [2026-03-02T15:15:53.511Z] Camera thread performed 122 scans. [2026-03-02T15:15:53.511Z] ====== philosophers (scala) [default], iteration 16 completed (4012.899 ms) ====== [2026-03-02T15:15:53.511Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-02T15:15:53.511Z] GC before operation: completed in 14.398 ms, heap usage 52.082 MB -> 5.071 MB. [2026-03-02T15:15:58.891Z] Camera thread performed 122 scans. [2026-03-02T15:15:58.891Z] ====== philosophers (scala) [default], iteration 17 completed (4771.821 ms) ====== [2026-03-02T15:15:58.891Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-02T15:15:58.891Z] GC before operation: completed in 12.536 ms, heap usage 7.992 MB -> 5.070 MB. [2026-03-02T15:16:03.061Z] Camera thread performed 122 scans. [2026-03-02T15:16:03.061Z] ====== philosophers (scala) [default], iteration 18 completed (4098.777 ms) ====== [2026-03-02T15:16:03.061Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-02T15:16:03.061Z] GC before operation: completed in 10.271 ms, heap usage 19.707 MB -> 5.071 MB. [2026-03-02T15:16:07.199Z] Camera thread performed 122 scans. [2026-03-02T15:16:07.199Z] ====== philosophers (scala) [default], iteration 19 completed (5070.061 ms) ====== [2026-03-02T15:16:07.199Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-02T15:16:07.199Z] GC before operation: completed in 12.734 ms, heap usage 28.105 MB -> 5.070 MB. [2026-03-02T15:16:11.353Z] Camera thread performed 122 scans. [2026-03-02T15:16:11.353Z] ====== philosophers (scala) [default], iteration 20 completed (3369.477 ms) ====== [2026-03-02T15:16:11.353Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-02T15:16:11.353Z] GC before operation: completed in 11.121 ms, heap usage 32.193 MB -> 5.071 MB. [2026-03-02T15:16:14.357Z] Camera thread performed 122 scans. [2026-03-02T15:16:14.357Z] ====== philosophers (scala) [default], iteration 21 completed (3180.134 ms) ====== [2026-03-02T15:16:14.357Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-02T15:16:14.357Z] GC before operation: completed in 12.305 ms, heap usage 16.962 MB -> 5.071 MB. [2026-03-02T15:16:17.362Z] Camera thread performed 122 scans. [2026-03-02T15:16:17.362Z] ====== philosophers (scala) [default], iteration 22 completed (3422.571 ms) ====== [2026-03-02T15:16:17.363Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-02T15:16:17.363Z] GC before operation: completed in 11.698 ms, heap usage 51.738 MB -> 5.071 MB. [2026-03-02T15:16:21.254Z] Camera thread performed 122 scans. [2026-03-02T15:16:21.254Z] ====== philosophers (scala) [default], iteration 23 completed (3493.247 ms) ====== [2026-03-02T15:16:21.254Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-02T15:16:21.254Z] GC before operation: completed in 10.621 ms, heap usage 42.533 MB -> 5.071 MB. [2026-03-02T15:16:24.260Z] Camera thread performed 122 scans. [2026-03-02T15:16:24.260Z] ====== philosophers (scala) [default], iteration 24 completed (3451.078 ms) ====== [2026-03-02T15:16:24.260Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-02T15:16:24.260Z] GC before operation: completed in 8.891 ms, heap usage 22.929 MB -> 5.071 MB. [2026-03-02T15:16:28.392Z] Camera thread performed 122 scans. [2026-03-02T15:16:28.392Z] ====== philosophers (scala) [default], iteration 25 completed (3318.587 ms) ====== [2026-03-02T15:16:28.392Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-02T15:16:28.392Z] GC before operation: completed in 9.248 ms, heap usage 40.074 MB -> 5.071 MB. [2026-03-02T15:16:31.392Z] Camera thread performed 122 scans. [2026-03-02T15:16:31.392Z] ====== philosophers (scala) [default], iteration 26 completed (3430.769 ms) ====== [2026-03-02T15:16:31.392Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-02T15:16:31.392Z] GC before operation: completed in 11.503 ms, heap usage 12.331 MB -> 5.071 MB. [2026-03-02T15:16:34.406Z] Camera thread performed 122 scans. [2026-03-02T15:16:34.406Z] ====== philosophers (scala) [default], iteration 27 completed (3249.088 ms) ====== [2026-03-02T15:16:34.406Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-02T15:16:34.406Z] GC before operation: completed in 11.441 ms, heap usage 27.317 MB -> 5.071 MB. [2026-03-02T15:16:39.766Z] Camera thread performed 122 scans. [2026-03-02T15:16:39.766Z] ====== philosophers (scala) [default], iteration 28 completed (4568.849 ms) ====== [2026-03-02T15:16:39.766Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-02T15:16:39.766Z] GC before operation: completed in 10.647 ms, heap usage 16.107 MB -> 5.071 MB. [2026-03-02T15:16:42.765Z] Camera thread performed 122 scans. [2026-03-02T15:16:42.765Z] ====== philosophers (scala) [default], iteration 29 completed (3516.805 ms) ====== [2026-03-02T15:16:42.765Z] ----------------------------------- [2026-03-02T15:16:42.765Z] renaissance-philosophers_0_PASSED [2026-03-02T15:16:42.765Z] ----------------------------------- [2026-03-02T15:16:42.765Z] [2026-03-02T15:16:42.765Z] TEST TEARDOWN: [2026-03-02T15:16:42.765Z] Nothing to be done for teardown. [2026-03-02T15:16:42.765Z] renaissance-philosophers_0 Finish Time: Mon Mar 2 15:16:42 2026 Epoch Time (ms): 1772464602360