[2026-02-12T01:33:28.808Z] Running test renaissance-philosophers_0 ... [2026-02-12T01:33:28.808Z] =============================================== [2026-02-12T01:33:28.808Z] renaissance-philosophers_0 Start Time: Thu Feb 12 01:33:28 2026 Epoch Time (ms): 1770860008652 [2026-02-12T01:33:28.808Z] variation: NoOptions [2026-02-12T01:33:28.808Z] JVM_OPTIONS: [2026-02-12T01:33:28.808Z] { \ [2026-02-12T01:33:28.808Z] echo ""; echo "TEST SETUP:"; \ [2026-02-12T01:33:28.808Z] echo "Nothing to be done for setup."; \ [2026-02-12T01:33:28.808Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17708584592104/renaissance-philosophers_0"; \ [2026-02-12T01:33:28.808Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17708584592104/renaissance-philosophers_0"; \ [2026-02-12T01:33:28.808Z] echo ""; echo "TESTING:"; \ [2026-02-12T01:33:28.808Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17708584592104/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-12T01:33:28.808Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17708584592104/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-12T01:33:28.808Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-12T01:33:28.808Z] echo "Nothing to be done for teardown."; \ [2026-02-12T01:33:28.808Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17708584592104/TestTargetResult"; [2026-02-12T01:33:28.808Z] [2026-02-12T01:33:28.808Z] TEST SETUP: [2026-02-12T01:33:28.808Z] Nothing to be done for setup. [2026-02-12T01:33:28.808Z] [2026-02-12T01:33:28.808Z] TESTING: [2026-02-12T01:33:29.773Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-12T01:33:29.773Z] GC before operation: completed in 17.947 ms, heap usage 15.070 MB -> 4.203 MB. [2026-02-12T01:33:35.186Z] Camera thread performed 122 scans. [2026-02-12T01:33:35.186Z] ====== philosophers (scala) [default], iteration 0 completed (4874.692 ms) ====== [2026-02-12T01:33:35.186Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-12T01:33:35.186Z] GC before operation: completed in 17.788 ms, heap usage 10.957 MB -> 4.614 MB. [2026-02-12T01:33:42.010Z] Camera thread performed 122 scans. [2026-02-12T01:33:42.010Z] ====== philosophers (scala) [default], iteration 1 completed (5132.294 ms) ====== [2026-02-12T01:33:42.010Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-12T01:33:42.010Z] GC before operation: completed in 13.570 ms, heap usage 18.310 MB -> 4.618 MB. [2026-02-12T01:33:45.073Z] Camera thread performed 122 scans. [2026-02-12T01:33:45.073Z] ====== philosophers (scala) [default], iteration 2 completed (5151.062 ms) ====== [2026-02-12T01:33:45.073Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-12T01:33:45.073Z] GC before operation: completed in 14.558 ms, heap usage 14.972 MB -> 4.619 MB. [2026-02-12T01:33:50.483Z] Camera thread performed 122 scans. [2026-02-12T01:33:50.483Z] ====== philosophers (scala) [default], iteration 3 completed (4965.739 ms) ====== [2026-02-12T01:33:50.483Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-12T01:33:50.483Z] GC before operation: completed in 16.548 ms, heap usage 13.096 MB -> 4.619 MB. [2026-02-12T01:33:55.923Z] Camera thread performed 122 scans. [2026-02-12T01:33:55.923Z] ====== philosophers (scala) [default], iteration 4 completed (5137.363 ms) ====== [2026-02-12T01:33:55.923Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-12T01:33:55.923Z] GC before operation: completed in 13.905 ms, heap usage 10.949 MB -> 4.620 MB. [2026-02-12T01:33:58.974Z] Camera thread performed 122 scans. [2026-02-12T01:33:58.974Z] ====== philosophers (scala) [default], iteration 5 completed (3506.631 ms) ====== [2026-02-12T01:33:58.974Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-12T01:33:58.974Z] GC before operation: completed in 11.444 ms, heap usage 17.763 MB -> 4.621 MB. [2026-02-12T01:34:03.164Z] Camera thread performed 122 scans. [2026-02-12T01:34:03.164Z] ====== philosophers (scala) [default], iteration 6 completed (4100.649 ms) ====== [2026-02-12T01:34:03.164Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-12T01:34:03.164Z] GC before operation: completed in 11.101 ms, heap usage 13.638 MB -> 4.622 MB. [2026-02-12T01:34:07.406Z] Camera thread performed 122 scans. [2026-02-12T01:34:07.406Z] ====== philosophers (scala) [default], iteration 7 completed (3601.097 ms) ====== [2026-02-12T01:34:07.406Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-12T01:34:07.406Z] GC before operation: completed in 11.934 ms, heap usage 8.626 MB -> 4.622 MB. [2026-02-12T01:34:10.447Z] Camera thread performed 122 scans. [2026-02-12T01:34:10.447Z] ====== philosophers (scala) [default], iteration 8 completed (3525.037 ms) ====== [2026-02-12T01:34:10.447Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-12T01:34:10.447Z] GC before operation: completed in 11.577 ms, heap usage 38.340 MB -> 4.622 MB. [2026-02-12T01:34:14.629Z] Camera thread performed 122 scans. [2026-02-12T01:34:14.629Z] ====== philosophers (scala) [default], iteration 9 completed (4232.125 ms) ====== [2026-02-12T01:34:14.629Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-12T01:34:14.629Z] GC before operation: completed in 11.829 ms, heap usage 23.959 MB -> 4.622 MB. [2026-02-12T01:34:20.055Z] Camera thread performed 122 scans. [2026-02-12T01:34:20.055Z] ====== philosophers (scala) [default], iteration 10 completed (5252.369 ms) ====== [2026-02-12T01:34:20.055Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-12T01:34:20.055Z] GC before operation: completed in 15.881 ms, heap usage 31.309 MB -> 4.622 MB. [2026-02-12T01:34:25.472Z] Camera thread performed 122 scans. [2026-02-12T01:34:25.472Z] ====== philosophers (scala) [default], iteration 11 completed (5081.160 ms) ====== [2026-02-12T01:34:25.472Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-12T01:34:25.472Z] GC before operation: completed in 13.751 ms, heap usage 29.928 MB -> 4.623 MB. [2026-02-12T01:34:29.659Z] Camera thread performed 122 scans. [2026-02-12T01:34:29.659Z] ====== philosophers (scala) [default], iteration 12 completed (4792.156 ms) ====== [2026-02-12T01:34:29.659Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-12T01:34:29.659Z] GC before operation: completed in 14.668 ms, heap usage 17.955 MB -> 4.623 MB. [2026-02-12T01:34:35.075Z] Camera thread performed 122 scans. [2026-02-12T01:34:35.075Z] ====== philosophers (scala) [default], iteration 13 completed (4576.278 ms) ====== [2026-02-12T01:34:35.075Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-12T01:34:35.075Z] GC before operation: completed in 13.925 ms, heap usage 13.830 MB -> 4.623 MB. [2026-02-12T01:34:40.492Z] Camera thread performed 122 scans. [2026-02-12T01:34:40.492Z] ====== philosophers (scala) [default], iteration 14 completed (5388.489 ms) ====== [2026-02-12T01:34:40.492Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-12T01:34:40.492Z] GC before operation: completed in 14.641 ms, heap usage 10.813 MB -> 4.623 MB. [2026-02-12T01:34:44.676Z] Camera thread performed 122 scans. [2026-02-12T01:34:44.676Z] ====== philosophers (scala) [default], iteration 15 completed (5317.476 ms) ====== [2026-02-12T01:34:44.676Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-12T01:34:44.676Z] GC before operation: completed in 14.382 ms, heap usage 13.219 MB -> 4.623 MB. [2026-02-12T01:34:50.088Z] Camera thread performed 122 scans. [2026-02-12T01:34:50.088Z] ====== philosophers (scala) [default], iteration 16 completed (4809.954 ms) ====== [2026-02-12T01:34:50.088Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-12T01:34:50.088Z] GC before operation: completed in 13.556 ms, heap usage 28.641 MB -> 4.624 MB. [2026-02-12T01:34:55.502Z] Camera thread performed 122 scans. [2026-02-12T01:34:55.502Z] ====== philosophers (scala) [default], iteration 17 completed (5042.887 ms) ====== [2026-02-12T01:34:55.502Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-12T01:34:55.502Z] GC before operation: completed in 13.041 ms, heap usage 13.856 MB -> 4.623 MB. [2026-02-12T01:34:59.695Z] Camera thread performed 122 scans. [2026-02-12T01:34:59.695Z] ====== philosophers (scala) [default], iteration 18 completed (4109.781 ms) ====== [2026-02-12T01:34:59.695Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-12T01:34:59.695Z] GC before operation: completed in 11.422 ms, heap usage 28.579 MB -> 4.624 MB. [2026-02-12T01:35:02.732Z] Camera thread performed 122 scans. [2026-02-12T01:35:02.732Z] ====== philosophers (scala) [default], iteration 19 completed (3445.336 ms) ====== [2026-02-12T01:35:02.732Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-12T01:35:02.732Z] GC before operation: completed in 13.249 ms, heap usage 33.625 MB -> 4.624 MB. [2026-02-12T01:35:05.733Z] Camera thread performed 122 scans. [2026-02-12T01:35:05.733Z] ====== philosophers (scala) [default], iteration 20 completed (3535.143 ms) ====== [2026-02-12T01:35:05.733Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-12T01:35:05.733Z] GC before operation: completed in 11.058 ms, heap usage 26.677 MB -> 4.624 MB. [2026-02-12T01:35:11.157Z] Camera thread performed 122 scans. [2026-02-12T01:35:11.157Z] ====== philosophers (scala) [default], iteration 21 completed (4422.945 ms) ====== [2026-02-12T01:35:11.157Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-12T01:35:11.157Z] GC before operation: completed in 13.928 ms, heap usage 33.321 MB -> 4.625 MB. [2026-02-12T01:35:16.569Z] Camera thread performed 122 scans. [2026-02-12T01:35:16.569Z] ====== philosophers (scala) [default], iteration 22 completed (5395.928 ms) ====== [2026-02-12T01:35:16.569Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-12T01:35:16.569Z] GC before operation: completed in 15.570 ms, heap usage 13.526 MB -> 4.624 MB. [2026-02-12T01:35:21.984Z] Camera thread performed 122 scans. [2026-02-12T01:35:21.984Z] ====== philosophers (scala) [default], iteration 23 completed (5511.698 ms) ====== [2026-02-12T01:35:21.984Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-12T01:35:21.984Z] GC before operation: completed in 14.862 ms, heap usage 18.629 MB -> 4.624 MB. [2026-02-12T01:35:27.390Z] Camera thread performed 122 scans. [2026-02-12T01:35:27.390Z] ====== philosophers (scala) [default], iteration 24 completed (5186.274 ms) ====== [2026-02-12T01:35:27.390Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-12T01:35:27.390Z] GC before operation: completed in 16.615 ms, heap usage 17.828 MB -> 4.624 MB. [2026-02-12T01:35:31.577Z] Camera thread performed 122 scans. [2026-02-12T01:35:31.577Z] ====== philosophers (scala) [default], iteration 25 completed (4926.256 ms) ====== [2026-02-12T01:35:31.577Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-12T01:35:31.577Z] GC before operation: completed in 14.785 ms, heap usage 17.586 MB -> 4.625 MB. [2026-02-12T01:35:36.988Z] Camera thread performed 122 scans. [2026-02-12T01:35:36.988Z] ====== philosophers (scala) [default], iteration 26 completed (5157.759 ms) ====== [2026-02-12T01:35:36.988Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-12T01:35:36.988Z] GC before operation: completed in 20.795 ms, heap usage 23.215 MB -> 4.624 MB. [2026-02-12T01:35:42.396Z] Camera thread performed 122 scans. [2026-02-12T01:35:42.396Z] ====== philosophers (scala) [default], iteration 27 completed (5257.065 ms) ====== [2026-02-12T01:35:42.396Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-12T01:35:42.396Z] GC before operation: completed in 16.235 ms, heap usage 16.815 MB -> 4.624 MB. [2026-02-12T01:35:47.801Z] Camera thread performed 122 scans. [2026-02-12T01:35:47.801Z] ====== philosophers (scala) [default], iteration 28 completed (5123.482 ms) ====== [2026-02-12T01:35:47.801Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-12T01:35:47.801Z] GC before operation: completed in 16.525 ms, heap usage 23.618 MB -> 4.625 MB. [2026-02-12T01:35:53.206Z] Camera thread performed 122 scans. [2026-02-12T01:35:53.206Z] ====== philosophers (scala) [default], iteration 29 completed (5880.381 ms) ====== [2026-02-12T01:35:53.206Z] ----------------------------------- [2026-02-12T01:35:53.206Z] renaissance-philosophers_0_PASSED [2026-02-12T01:35:53.206Z] ----------------------------------- [2026-02-12T01:35:53.206Z] [2026-02-12T01:35:53.206Z] TEST TEARDOWN: [2026-02-12T01:35:53.206Z] Nothing to be done for teardown. [2026-02-12T01:35:53.206Z] renaissance-philosophers_0 Finish Time: Thu Feb 12 01:35:52 2026 Epoch Time (ms): 1770860152780