[2026-01-14T23:05:08.421Z] Running test renaissance-philosophers_0 ... [2026-01-14T23:05:08.421Z] =============================================== [2026-01-14T23:05:08.421Z] renaissance-philosophers_0 Start Time: Wed Jan 14 23:05:07 2026 Epoch Time (ms): 1768431907722 [2026-01-14T23:05:08.421Z] variation: NoOptions [2026-01-14T23:05:08.421Z] JVM_OPTIONS: [2026-01-14T23:05:08.421Z] { \ [2026-01-14T23:05:08.421Z] echo ""; echo "TEST SETUP:"; \ [2026-01-14T23:05:08.421Z] echo "Nothing to be done for setup."; \ [2026-01-14T23:05:08.421Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17684297398571/renaissance-philosophers_0"; \ [2026-01-14T23:05:08.421Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17684297398571/renaissance-philosophers_0"; \ [2026-01-14T23:05:08.421Z] echo ""; echo "TESTING:"; \ [2026-01-14T23:05:08.421Z] "/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_17684297398571/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-14T23:05:08.421Z] 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_17684297398571/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-14T23:05:08.421Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-14T23:05:08.421Z] echo "Nothing to be done for teardown."; \ [2026-01-14T23:05:08.421Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17684297398571/TestTargetResult"; [2026-01-14T23:05:08.421Z] [2026-01-14T23:05:08.421Z] TEST SETUP: [2026-01-14T23:05:08.421Z] Nothing to be done for setup. [2026-01-14T23:05:08.421Z] [2026-01-14T23:05:08.421Z] TESTING: [2026-01-14T23:05:09.378Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-14T23:05:09.378Z] GC before operation: completed in 11.277 ms, heap usage 15.071 MB -> 4.204 MB. [2026-01-14T23:05:14.772Z] Camera thread performed 122 scans. [2026-01-14T23:05:14.772Z] ====== philosophers (scala) [default], iteration 0 completed (4726.461 ms) ====== [2026-01-14T23:05:14.772Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-14T23:05:14.772Z] GC before operation: completed in 17.755 ms, heap usage 35.733 MB -> 4.615 MB. [2026-01-14T23:05:17.795Z] Camera thread performed 122 scans. [2026-01-14T23:05:17.795Z] ====== philosophers (scala) [default], iteration 1 completed (4011.570 ms) ====== [2026-01-14T23:05:17.795Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-14T23:05:17.795Z] GC before operation: completed in 11.011 ms, heap usage 20.887 MB -> 4.618 MB. [2026-01-14T23:05:23.159Z] Camera thread performed 122 scans. [2026-01-14T23:05:23.159Z] ====== philosophers (scala) [default], iteration 2 completed (4819.422 ms) ====== [2026-01-14T23:05:23.159Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-14T23:05:23.159Z] GC before operation: completed in 14.141 ms, heap usage 5.045 MB -> 4.619 MB. [2026-01-14T23:05:27.381Z] Camera thread performed 122 scans. [2026-01-14T23:05:27.381Z] ====== philosophers (scala) [default], iteration 3 completed (4543.804 ms) ====== [2026-01-14T23:05:27.381Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-14T23:05:27.381Z] GC before operation: completed in 13.077 ms, heap usage 23.460 MB -> 4.620 MB. [2026-01-14T23:05:31.526Z] Camera thread performed 122 scans. [2026-01-14T23:05:31.526Z] ====== philosophers (scala) [default], iteration 4 completed (3991.751 ms) ====== [2026-01-14T23:05:31.526Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-14T23:05:31.526Z] GC before operation: completed in 12.140 ms, heap usage 5.576 MB -> 4.621 MB. [2026-01-14T23:05:36.923Z] Camera thread performed 122 scans. [2026-01-14T23:05:36.923Z] ====== philosophers (scala) [default], iteration 5 completed (4915.518 ms) ====== [2026-01-14T23:05:36.923Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-14T23:05:36.923Z] GC before operation: completed in 12.050 ms, heap usage 12.314 MB -> 4.621 MB. [2026-01-14T23:05:42.301Z] Camera thread performed 122 scans. [2026-01-14T23:05:42.301Z] ====== philosophers (scala) [default], iteration 6 completed (5337.383 ms) ====== [2026-01-14T23:05:42.301Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-14T23:05:42.301Z] GC before operation: completed in 15.706 ms, heap usage 25.206 MB -> 4.622 MB. [2026-01-14T23:05:47.685Z] Camera thread performed 122 scans. [2026-01-14T23:05:47.685Z] ====== philosophers (scala) [default], iteration 7 completed (5373.777 ms) ====== [2026-01-14T23:05:47.685Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-14T23:05:47.685Z] GC before operation: completed in 16.518 ms, heap usage 38.820 MB -> 4.623 MB. [2026-01-14T23:05:51.828Z] Camera thread performed 122 scans. [2026-01-14T23:05:51.828Z] ====== philosophers (scala) [default], iteration 8 completed (4639.878 ms) ====== [2026-01-14T23:05:51.828Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-14T23:05:51.828Z] GC before operation: completed in 15.284 ms, heap usage 23.117 MB -> 4.623 MB. [2026-01-14T23:05:57.192Z] Camera thread performed 122 scans. [2026-01-14T23:05:57.192Z] ====== philosophers (scala) [default], iteration 9 completed (4999.325 ms) ====== [2026-01-14T23:05:57.192Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-14T23:05:57.192Z] GC before operation: completed in 17.325 ms, heap usage 24.312 MB -> 4.622 MB. [2026-01-14T23:06:02.051Z] Camera thread performed 122 scans. [2026-01-14T23:06:02.051Z] ====== philosophers (scala) [default], iteration 10 completed (4715.253 ms) ====== [2026-01-14T23:06:02.051Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-14T23:06:02.051Z] GC before operation: completed in 15.235 ms, heap usage 57.237 MB -> 4.622 MB. [2026-01-14T23:06:06.224Z] Camera thread performed 122 scans. [2026-01-14T23:06:06.224Z] ====== philosophers (scala) [default], iteration 11 completed (4140.714 ms) ====== [2026-01-14T23:06:06.224Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-14T23:06:06.224Z] GC before operation: completed in 13.895 ms, heap usage 15.886 MB -> 4.624 MB. [2026-01-14T23:06:10.385Z] Camera thread performed 122 scans. [2026-01-14T23:06:10.385Z] ====== philosophers (scala) [default], iteration 12 completed (4713.214 ms) ====== [2026-01-14T23:06:10.385Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-14T23:06:10.385Z] GC before operation: completed in 14.575 ms, heap usage 8.257 MB -> 4.624 MB. [2026-01-14T23:06:15.762Z] Camera thread performed 122 scans. [2026-01-14T23:06:15.762Z] ====== philosophers (scala) [default], iteration 13 completed (4902.304 ms) ====== [2026-01-14T23:06:15.762Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-14T23:06:15.762Z] GC before operation: completed in 14.805 ms, heap usage 13.723 MB -> 4.624 MB. [2026-01-14T23:06:19.924Z] Camera thread performed 122 scans. [2026-01-14T23:06:19.924Z] ====== philosophers (scala) [default], iteration 14 completed (4779.075 ms) ====== [2026-01-14T23:06:19.924Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-14T23:06:19.924Z] GC before operation: completed in 16.351 ms, heap usage 31.851 MB -> 4.625 MB. [2026-01-14T23:06:24.069Z] Camera thread performed 122 scans. [2026-01-14T23:06:24.069Z] ====== philosophers (scala) [default], iteration 15 completed (3379.824 ms) ====== [2026-01-14T23:06:24.069Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-14T23:06:24.069Z] GC before operation: completed in 14.135 ms, heap usage 20.758 MB -> 4.624 MB. [2026-01-14T23:06:28.217Z] Camera thread performed 122 scans. [2026-01-14T23:06:28.217Z] ====== philosophers (scala) [default], iteration 16 completed (4916.746 ms) ====== [2026-01-14T23:06:28.217Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-14T23:06:28.217Z] GC before operation: completed in 15.328 ms, heap usage 11.324 MB -> 4.624 MB. [2026-01-14T23:06:33.672Z] Camera thread performed 122 scans. [2026-01-14T23:06:33.672Z] ====== philosophers (scala) [default], iteration 17 completed (5228.178 ms) ====== [2026-01-14T23:06:33.672Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-14T23:06:33.672Z] GC before operation: completed in 13.501 ms, heap usage 10.928 MB -> 4.624 MB. [2026-01-14T23:06:39.048Z] Camera thread performed 122 scans. [2026-01-14T23:06:39.048Z] ====== philosophers (scala) [default], iteration 18 completed (4754.429 ms) ====== [2026-01-14T23:06:39.048Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-14T23:06:39.048Z] GC before operation: completed in 14.671 ms, heap usage 5.518 MB -> 4.625 MB. [2026-01-14T23:06:44.425Z] Camera thread performed 122 scans. [2026-01-14T23:06:44.425Z] ====== philosophers (scala) [default], iteration 19 completed (5339.807 ms) ====== [2026-01-14T23:06:44.425Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-14T23:06:44.425Z] GC before operation: completed in 12.900 ms, heap usage 20.133 MB -> 4.624 MB. [2026-01-14T23:06:49.799Z] Camera thread performed 122 scans. [2026-01-14T23:06:49.799Z] ====== philosophers (scala) [default], iteration 20 completed (5311.731 ms) ====== [2026-01-14T23:06:49.799Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-14T23:06:49.799Z] GC before operation: completed in 14.453 ms, heap usage 32.497 MB -> 4.625 MB. [2026-01-14T23:06:55.177Z] Camera thread performed 122 scans. [2026-01-14T23:06:55.178Z] ====== philosophers (scala) [default], iteration 21 completed (5408.506 ms) ====== [2026-01-14T23:06:55.178Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-14T23:06:55.178Z] GC before operation: completed in 14.824 ms, heap usage 24.414 MB -> 4.625 MB. [2026-01-14T23:07:00.253Z] Camera thread performed 122 scans. [2026-01-14T23:07:00.253Z] ====== philosophers (scala) [default], iteration 22 completed (5177.062 ms) ====== [2026-01-14T23:07:00.253Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-14T23:07:00.253Z] GC before operation: completed in 14.290 ms, heap usage 27.897 MB -> 4.625 MB. [2026-01-14T23:07:05.630Z] Camera thread performed 122 scans. [2026-01-14T23:07:05.630Z] ====== philosophers (scala) [default], iteration 23 completed (5366.971 ms) ====== [2026-01-14T23:07:05.630Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-14T23:07:05.630Z] GC before operation: completed in 13.877 ms, heap usage 9.721 MB -> 4.625 MB. [2026-01-14T23:07:11.009Z] Camera thread performed 122 scans. [2026-01-14T23:07:11.009Z] ====== philosophers (scala) [default], iteration 24 completed (5780.166 ms) ====== [2026-01-14T23:07:11.009Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-14T23:07:11.009Z] GC before operation: completed in 15.789 ms, heap usage 12.488 MB -> 4.625 MB. [2026-01-14T23:07:17.711Z] Camera thread performed 122 scans. [2026-01-14T23:07:17.711Z] ====== philosophers (scala) [default], iteration 25 completed (5882.601 ms) ====== [2026-01-14T23:07:17.711Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-14T23:07:17.711Z] GC before operation: completed in 16.115 ms, heap usage 15.093 MB -> 4.625 MB. [2026-01-14T23:07:23.079Z] Camera thread performed 122 scans. [2026-01-14T23:07:23.079Z] ====== philosophers (scala) [default], iteration 26 completed (5645.560 ms) ====== [2026-01-14T23:07:23.079Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-14T23:07:23.079Z] GC before operation: completed in 14.068 ms, heap usage 27.755 MB -> 4.625 MB. [2026-01-14T23:07:29.774Z] Camera thread performed 122 scans. [2026-01-14T23:07:29.774Z] ====== philosophers (scala) [default], iteration 27 completed (6823.765 ms) ====== [2026-01-14T23:07:29.774Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-14T23:07:29.774Z] GC before operation: completed in 16.644 ms, heap usage 13.838 MB -> 4.625 MB. [2026-01-14T23:07:33.935Z] Camera thread performed 122 scans. [2026-01-14T23:07:33.935Z] ====== philosophers (scala) [default], iteration 28 completed (4375.390 ms) ====== [2026-01-14T23:07:33.935Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-14T23:07:33.935Z] GC before operation: completed in 16.092 ms, heap usage 6.856 MB -> 4.625 MB. [2026-01-14T23:07:40.635Z] Camera thread performed 122 scans. [2026-01-14T23:07:40.636Z] ====== philosophers (scala) [default], iteration 29 completed (6216.304 ms) ====== [2026-01-14T23:07:40.636Z] ----------------------------------- [2026-01-14T23:07:40.636Z] renaissance-philosophers_0_PASSED [2026-01-14T23:07:40.636Z] ----------------------------------- [2026-01-14T23:07:40.636Z] [2026-01-14T23:07:40.636Z] TEST TEARDOWN: [2026-01-14T23:07:40.636Z] Nothing to be done for teardown. [2026-01-14T23:07:40.636Z] renaissance-philosophers_0 Finish Time: Wed Jan 14 23:07:39 2026 Epoch Time (ms): 1768432059666