renaissance-philosophers_0
[2025-05-21T21:26:08.750Z] Running test renaissance-philosophers_0 ...
[2025-05-21T21:26:08.750Z] ===============================================
[2025-05-21T21:26:08.750Z] renaissance-philosophers_0 Start Time: Wed May 21 21:26:07 2025 Epoch Time (ms): 1747862767812
[2025-05-21T21:26:08.750Z] variation: NoOptions
[2025-05-21T21:26:08.750Z] JVM_OPTIONS:
[2025-05-21T21:26:08.750Z] { \
[2025-05-21T21:26:08.750Z] echo ""; echo "TEST SETUP:"; \
[2025-05-21T21:26:08.750Z] echo "Nothing to be done for setup."; \
[2025-05-21T21:26:08.750Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17478610187960/renaissance-philosophers_0"; \
[2025-05-21T21:26:08.750Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17478610187960/renaissance-philosophers_0"; \
[2025-05-21T21:26:08.750Z] echo ""; echo "TESTING:"; \
[2025-05-21T21:26:08.750Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/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_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17478610187960/renaissance-philosophers_0"/philosophers.json" philosophers; \
[2025-05-21T21:26:08.750Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17478610187960/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \
[2025-05-21T21:26:08.750Z] echo ""; echo "TEST TEARDOWN:"; \
[2025-05-21T21:26:08.750Z] echo "Nothing to be done for teardown."; \
[2025-05-21T21:26:08.750Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17478610187960/TestTargetResult";
[2025-05-21T21:26:08.750Z]
[2025-05-21T21:26:08.750Z] TEST SETUP:
[2025-05-21T21:26:08.750Z] Nothing to be done for setup.
[2025-05-21T21:26:08.750Z]
[2025-05-21T21:26:08.750Z] TESTING:
[2025-05-21T21:26:09.551Z] ====== philosophers (scala) [default], iteration 0 started ======
[2025-05-21T21:26:09.551Z] GC before operation: completed in 21.012 ms, heap usage 7.224 MB -> 4.329 MB.
[2025-05-21T21:26:20.007Z] Camera thread performed 122 scans.
[2025-05-21T21:26:20.007Z] ====== philosophers (scala) [default], iteration 0 completed (9445.248 ms) ======
[2025-05-21T21:26:20.007Z] ====== philosophers (scala) [default], iteration 1 started ======
[2025-05-21T21:26:20.007Z] GC before operation: completed in 16.444 ms, heap usage 181.009 MB -> 4.768 MB.
[2025-05-21T21:26:26.976Z] Camera thread performed 122 scans.
[2025-05-21T21:26:26.976Z] ====== philosophers (scala) [default], iteration 1 completed (7967.982 ms) ======
[2025-05-21T21:26:26.976Z] ====== philosophers (scala) [default], iteration 2 started ======
[2025-05-21T21:26:26.976Z] GC before operation: completed in 13.891 ms, heap usage 169.796 MB -> 4.771 MB.
[2025-05-21T21:26:35.328Z] Camera thread performed 122 scans.
[2025-05-21T21:26:35.328Z] ====== philosophers (scala) [default], iteration 2 completed (7590.820 ms) ======
[2025-05-21T21:26:35.328Z] ====== philosophers (scala) [default], iteration 3 started ======
[2025-05-21T21:26:35.328Z] GC before operation: completed in 15.692 ms, heap usage 138.688 MB -> 4.773 MB.
[2025-05-21T21:26:42.252Z] Camera thread performed 122 scans.
[2025-05-21T21:26:42.252Z] ====== philosophers (scala) [default], iteration 3 completed (7643.028 ms) ======
[2025-05-21T21:26:42.252Z] ====== philosophers (scala) [default], iteration 4 started ======
[2025-05-21T21:26:42.252Z] GC before operation: completed in 14.233 ms, heap usage 173.761 MB -> 4.773 MB.
[2025-05-21T21:26:50.597Z] Camera thread performed 122 scans.
[2025-05-21T21:26:50.597Z] ====== philosophers (scala) [default], iteration 4 completed (7772.229 ms) ======
[2025-05-21T21:26:50.597Z] ====== philosophers (scala) [default], iteration 5 started ======
[2025-05-21T21:26:50.597Z] GC before operation: completed in 13.748 ms, heap usage 160.601 MB -> 4.773 MB.
[2025-05-21T21:26:57.518Z] Camera thread performed 122 scans.
[2025-05-21T21:26:57.518Z] ====== philosophers (scala) [default], iteration 5 completed (7736.526 ms) ======
[2025-05-21T21:26:57.518Z] ====== philosophers (scala) [default], iteration 6 started ======
[2025-05-21T21:26:57.518Z] GC before operation: completed in 13.180 ms, heap usage 149.156 MB -> 4.773 MB.
[2025-05-21T21:27:06.039Z] Camera thread performed 122 scans.
[2025-05-21T21:27:06.039Z] ====== philosophers (scala) [default], iteration 6 completed (7815.424 ms) ======
[2025-05-21T21:27:06.039Z] ====== philosophers (scala) [default], iteration 7 started ======
[2025-05-21T21:27:06.039Z] GC before operation: completed in 13.994 ms, heap usage 35.652 MB -> 4.773 MB.
[2025-05-21T21:27:14.381Z] Camera thread performed 122 scans.
[2025-05-21T21:27:14.381Z] ====== philosophers (scala) [default], iteration 7 completed (7783.676 ms) ======
[2025-05-21T21:27:14.381Z] ====== philosophers (scala) [default], iteration 8 started ======
[2025-05-21T21:27:14.381Z] GC before operation: completed in 14.907 ms, heap usage 123.754 MB -> 4.773 MB.
[2025-05-21T21:27:21.301Z] Camera thread performed 122 scans.
[2025-05-21T21:27:21.301Z] ====== philosophers (scala) [default], iteration 8 completed (7791.692 ms) ======
[2025-05-21T21:27:21.301Z] ====== philosophers (scala) [default], iteration 9 started ======
[2025-05-21T21:27:21.301Z] GC before operation: completed in 14.447 ms, heap usage 8.639 MB -> 4.773 MB.
[2025-05-21T21:27:29.648Z] Camera thread performed 122 scans.
[2025-05-21T21:27:29.648Z] ====== philosophers (scala) [default], iteration 9 completed (7722.165 ms) ======
[2025-05-21T21:27:29.648Z] ====== philosophers (scala) [default], iteration 10 started ======
[2025-05-21T21:27:29.648Z] GC before operation: completed in 14.925 ms, heap usage 33.767 MB -> 4.773 MB.
[2025-05-21T21:27:36.632Z] Camera thread performed 122 scans.
[2025-05-21T21:27:36.632Z] ====== philosophers (scala) [default], iteration 10 completed (7818.072 ms) ======
[2025-05-21T21:27:36.632Z] ====== philosophers (scala) [default], iteration 11 started ======
[2025-05-21T21:27:36.632Z] GC before operation: completed in 14.542 ms, heap usage 130.873 MB -> 4.773 MB.
[2025-05-21T21:27:44.972Z] Camera thread performed 122 scans.
[2025-05-21T21:27:44.972Z] ====== philosophers (scala) [default], iteration 11 completed (7736.330 ms) ======
[2025-05-21T21:27:44.972Z] ====== philosophers (scala) [default], iteration 12 started ======
[2025-05-21T21:27:44.972Z] GC before operation: completed in 14.401 ms, heap usage 153.388 MB -> 4.773 MB.
[2025-05-21T21:27:53.321Z] Camera thread performed 122 scans.
[2025-05-21T21:27:53.321Z] ====== philosophers (scala) [default], iteration 12 completed (7769.757 ms) ======
[2025-05-21T21:27:53.321Z] ====== philosophers (scala) [default], iteration 13 started ======
[2025-05-21T21:27:53.321Z] GC before operation: completed in 14.866 ms, heap usage 140.387 MB -> 4.773 MB.
[2025-05-21T21:28:00.245Z] Camera thread performed 122 scans.
[2025-05-21T21:28:00.245Z] ====== philosophers (scala) [default], iteration 13 completed (7563.860 ms) ======
[2025-05-21T21:28:00.245Z] ====== philosophers (scala) [default], iteration 14 started ======
[2025-05-21T21:28:00.245Z] GC before operation: completed in 14.497 ms, heap usage 166.009 MB -> 4.773 MB.
[2025-05-21T21:28:08.593Z] Camera thread performed 122 scans.
[2025-05-21T21:28:08.593Z] ====== philosophers (scala) [default], iteration 14 completed (7662.608 ms) ======
[2025-05-21T21:28:08.593Z] ====== philosophers (scala) [default], iteration 15 started ======
[2025-05-21T21:28:08.593Z] GC before operation: completed in 14.271 ms, heap usage 173.085 MB -> 4.774 MB.
[2025-05-21T21:28:15.514Z] Camera thread performed 122 scans.
[2025-05-21T21:28:15.514Z] ====== philosophers (scala) [default], iteration 15 completed (7713.988 ms) ======
[2025-05-21T21:28:15.514Z] ====== philosophers (scala) [default], iteration 16 started ======
[2025-05-21T21:28:15.514Z] GC before operation: completed in 13.645 ms, heap usage 143.439 MB -> 4.773 MB.
[2025-05-21T21:28:24.210Z] Camera thread performed 122 scans.
[2025-05-21T21:28:24.210Z] ====== philosophers (scala) [default], iteration 16 completed (7923.922 ms) ======
[2025-05-21T21:28:24.210Z] ====== philosophers (scala) [default], iteration 17 started ======
[2025-05-21T21:28:24.210Z] GC before operation: completed in 14.556 ms, heap usage 78.154 MB -> 4.774 MB.
[2025-05-21T21:28:31.229Z] Camera thread performed 122 scans.
[2025-05-21T21:28:31.229Z] ====== philosophers (scala) [default], iteration 17 completed (7508.137 ms) ======
[2025-05-21T21:28:31.229Z] ====== philosophers (scala) [default], iteration 18 started ======
[2025-05-21T21:28:31.229Z] GC before operation: completed in 13.796 ms, heap usage 124.258 MB -> 4.774 MB.
[2025-05-21T21:28:38.148Z] Camera thread performed 122 scans.
[2025-05-21T21:28:38.148Z] ====== philosophers (scala) [default], iteration 18 completed (7574.612 ms) ======
[2025-05-21T21:28:38.148Z] ====== philosophers (scala) [default], iteration 19 started ======
[2025-05-21T21:28:38.148Z] GC before operation: completed in 15.387 ms, heap usage 19.541 MB -> 4.774 MB.
[2025-05-21T21:28:46.492Z] Camera thread performed 122 scans.
[2025-05-21T21:28:46.492Z] ====== philosophers (scala) [default], iteration 19 completed (7575.934 ms) ======
[2025-05-21T21:28:46.492Z] ====== philosophers (scala) [default], iteration 20 started ======
[2025-05-21T21:28:46.492Z] GC before operation: completed in 15.798 ms, heap usage 161.196 MB -> 4.774 MB.
[2025-05-21T21:28:53.759Z] Camera thread performed 122 scans.
[2025-05-21T21:28:53.759Z] ====== philosophers (scala) [default], iteration 20 completed (7797.021 ms) ======
[2025-05-21T21:28:53.759Z] ====== philosophers (scala) [default], iteration 21 started ======
[2025-05-21T21:28:53.759Z] GC before operation: completed in 13.099 ms, heap usage 51.838 MB -> 4.774 MB.
[2025-05-21T21:29:02.104Z] Camera thread performed 122 scans.
[2025-05-21T21:29:02.104Z] ====== philosophers (scala) [default], iteration 21 completed (7776.896 ms) ======
[2025-05-21T21:29:02.104Z] ====== philosophers (scala) [default], iteration 22 started ======
[2025-05-21T21:29:02.104Z] GC before operation: completed in 13.957 ms, heap usage 172.911 MB -> 4.774 MB.
[2025-05-21T21:29:09.026Z] Camera thread performed 122 scans.
[2025-05-21T21:29:09.026Z] ====== philosophers (scala) [default], iteration 22 completed (7606.056 ms) ======
[2025-05-21T21:29:09.026Z] ====== philosophers (scala) [default], iteration 23 started ======
[2025-05-21T21:29:09.026Z] GC before operation: completed in 14.736 ms, heap usage 138.021 MB -> 4.774 MB.
[2025-05-21T21:29:17.420Z] Camera thread performed 122 scans.
[2025-05-21T21:29:17.420Z] ====== philosophers (scala) [default], iteration 23 completed (7716.677 ms) ======
[2025-05-21T21:29:17.420Z] ====== philosophers (scala) [default], iteration 24 started ======
[2025-05-21T21:29:17.420Z] GC before operation: completed in 13.514 ms, heap usage 43.191 MB -> 4.774 MB.
[2025-05-21T21:29:25.779Z] Camera thread performed 122 scans.
[2025-05-21T21:29:25.779Z] ====== philosophers (scala) [default], iteration 24 completed (7820.962 ms) ======
[2025-05-21T21:29:25.779Z] ====== philosophers (scala) [default], iteration 25 started ======
[2025-05-21T21:29:25.779Z] GC before operation: completed in 14.325 ms, heap usage 82.002 MB -> 4.774 MB.
[2025-05-21T21:29:32.772Z] Camera thread performed 122 scans.
[2025-05-21T21:29:32.772Z] ====== philosophers (scala) [default], iteration 25 completed (7741.674 ms) ======
[2025-05-21T21:29:32.773Z] ====== philosophers (scala) [default], iteration 26 started ======
[2025-05-21T21:29:32.773Z] GC before operation: completed in 12.840 ms, heap usage 9.035 MB -> 4.775 MB.
[2025-05-21T21:29:41.108Z] Camera thread performed 122 scans.
[2025-05-21T21:29:41.108Z] ====== philosophers (scala) [default], iteration 26 completed (7817.258 ms) ======
[2025-05-21T21:29:41.108Z] ====== philosophers (scala) [default], iteration 27 started ======
[2025-05-21T21:29:41.108Z] GC before operation: completed in 13.867 ms, heap usage 12.023 MB -> 4.774 MB.
[2025-05-21T21:29:48.024Z] Camera thread performed 122 scans.
[2025-05-21T21:29:48.024Z] ====== philosophers (scala) [default], iteration 27 completed (7923.986 ms) ======
[2025-05-21T21:29:48.024Z] ====== philosophers (scala) [default], iteration 28 started ======
[2025-05-21T21:29:48.024Z] GC before operation: completed in 13.197 ms, heap usage 56.419 MB -> 4.775 MB.
[2025-05-21T21:29:56.575Z] Camera thread performed 122 scans.
[2025-05-21T21:29:56.575Z] ====== philosophers (scala) [default], iteration 28 completed (7756.861 ms) ======
[2025-05-21T21:29:56.575Z] ====== philosophers (scala) [default], iteration 29 started ======
[2025-05-21T21:29:56.575Z] GC before operation: completed in 14.223 ms, heap usage 22.027 MB -> 4.774 MB.
[2025-05-21T21:30:04.958Z] Camera thread performed 122 scans.
[2025-05-21T21:30:04.958Z] ====== philosophers (scala) [default], iteration 29 completed (7849.260 ms) ======
[2025-05-21T21:30:04.958Z] -----------------------------------
[2025-05-21T21:30:04.958Z] renaissance-philosophers_0_PASSED
[2025-05-21T21:30:04.958Z] -----------------------------------
[2025-05-21T21:30:04.958Z]
[2025-05-21T21:30:04.958Z] TEST TEARDOWN:
[2025-05-21T21:30:04.958Z] Nothing to be done for teardown.
[2025-05-21T21:30:04.958Z] renaissance-philosophers_0 Finish Time: Wed May 21 21:30:03 2025 Epoch Time (ms): 1747863003661