renaissance-philosophers_0
[2025-05-11T08:18:11.108Z] Running test renaissance-philosophers_0 ...
[2025-05-11T08:18:11.108Z] ===============================================
[2025-05-11T08:18:11.499Z] renaissance-philosophers_0 Start Time: Sun May 11 08:18:11 2025 Epoch Time (ms): 1746951491147
[2025-05-11T08:18:11.499Z] variation: NoOptions
[2025-05-11T08:18:11.499Z] JVM_OPTIONS:
[2025-05-11T08:18:11.499Z] { \
[2025-05-11T08:18:11.499Z] echo ""; echo "TEST SETUP:"; \
[2025-05-11T08:18:11.499Z] echo "Nothing to be done for setup."; \
[2025-05-11T08:18:11.499Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17469489429544\\renaissance-philosophers_0"; \
[2025-05-11T08:18:11.499Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17469489429544\\renaissance-philosophers_0"; \
[2025-05-11T08:18:11.499Z] echo ""; echo "TESTING:"; \
[2025-05-11T08:18:11.499Z] "c:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17469489429544\\renaissance-philosophers_0"\\philosophers.json" philosophers; \
[2025-05-11T08:18:11.499Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17469489429544\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \
[2025-05-11T08:18:11.499Z] echo ""; echo "TEST TEARDOWN:"; \
[2025-05-11T08:18:11.499Z] echo "Nothing to be done for teardown."; \
[2025-05-11T08:18:11.499Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17469489429544\\TestTargetResult";
[2025-05-11T08:18:11.499Z]
[2025-05-11T08:18:11.499Z] TEST SETUP:
[2025-05-11T08:18:11.499Z] Nothing to be done for setup.
[2025-05-11T08:18:11.499Z]
[2025-05-11T08:18:11.499Z] TESTING:
[2025-05-11T08:18:12.579Z] ====== philosophers (scala) [default], iteration 0 started ======
[2025-05-11T08:18:12.579Z] GC before operation: completed in 9.537 ms, heap usage 15.579 MB -> 4.473 MB.
[2025-05-11T08:18:15.004Z] Camera thread performed 122 scans.
[2025-05-11T08:18:15.004Z] ====== philosophers (scala) [default], iteration 0 completed (2319.629 ms) ======
[2025-05-11T08:18:15.004Z] ====== philosophers (scala) [default], iteration 1 started ======
[2025-05-11T08:18:15.004Z] GC before operation: completed in 18.620 ms, heap usage 21.655 MB -> 4.870 MB.
[2025-05-11T08:18:16.118Z] Camera thread performed 122 scans.
[2025-05-11T08:18:16.118Z] ====== philosophers (scala) [default], iteration 1 completed (1210.828 ms) ======
[2025-05-11T08:18:16.118Z] ====== philosophers (scala) [default], iteration 2 started ======
[2025-05-11T08:18:16.118Z] GC before operation: completed in 9.520 ms, heap usage 36.041 MB -> 4.872 MB.
[2025-05-11T08:18:17.699Z] Camera thread performed 122 scans.
[2025-05-11T08:18:17.699Z] ====== philosophers (scala) [default], iteration 2 completed (1443.926 ms) ======
[2025-05-11T08:18:17.699Z] ====== philosophers (scala) [default], iteration 3 started ======
[2025-05-11T08:18:17.700Z] GC before operation: completed in 9.573 ms, heap usage 7.914 MB -> 4.876 MB.
[2025-05-11T08:18:19.282Z] Camera thread performed 122 scans.
[2025-05-11T08:18:19.282Z] ====== philosophers (scala) [default], iteration 3 completed (1477.390 ms) ======
[2025-05-11T08:18:19.282Z] ====== philosophers (scala) [default], iteration 4 started ======
[2025-05-11T08:18:19.282Z] GC before operation: completed in 9.305 ms, heap usage 45.848 MB -> 4.877 MB.
[2025-05-11T08:18:20.373Z] Camera thread performed 122 scans.
[2025-05-11T08:18:20.373Z] ====== philosophers (scala) [default], iteration 4 completed (1454.930 ms) ======
[2025-05-11T08:18:20.373Z] ====== philosophers (scala) [default], iteration 5 started ======
[2025-05-11T08:18:20.373Z] GC before operation: completed in 9.866 ms, heap usage 33.744 MB -> 4.878 MB.
[2025-05-11T08:18:21.950Z] Camera thread performed 122 scans.
[2025-05-11T08:18:21.950Z] ====== philosophers (scala) [default], iteration 5 completed (1349.009 ms) ======
[2025-05-11T08:18:21.950Z] ====== philosophers (scala) [default], iteration 6 started ======
[2025-05-11T08:18:21.950Z] GC before operation: completed in 11.794 ms, heap usage 56.782 MB -> 4.879 MB.
[2025-05-11T08:18:23.530Z] Camera thread performed 122 scans.
[2025-05-11T08:18:23.530Z] ====== philosophers (scala) [default], iteration 6 completed (1451.910 ms) ======
[2025-05-11T08:18:23.530Z] ====== philosophers (scala) [default], iteration 7 started ======
[2025-05-11T08:18:23.530Z] GC before operation: completed in 9.590 ms, heap usage 33.122 MB -> 4.879 MB.
[2025-05-11T08:18:24.623Z] Camera thread performed 122 scans.
[2025-05-11T08:18:24.623Z] ====== philosophers (scala) [default], iteration 7 completed (1465.732 ms) ======
[2025-05-11T08:18:24.623Z] ====== philosophers (scala) [default], iteration 8 started ======
[2025-05-11T08:18:24.623Z] GC before operation: completed in 9.703 ms, heap usage 53.090 MB -> 4.880 MB.
[2025-05-11T08:18:26.198Z] Camera thread performed 122 scans.
[2025-05-11T08:18:26.198Z] ====== philosophers (scala) [default], iteration 8 completed (1421.142 ms) ======
[2025-05-11T08:18:26.198Z] ====== philosophers (scala) [default], iteration 9 started ======
[2025-05-11T08:18:26.198Z] GC before operation: completed in 9.468 ms, heap usage 8.944 MB -> 4.881 MB.
[2025-05-11T08:18:27.789Z] Camera thread performed 122 scans.
[2025-05-11T08:18:27.789Z] ====== philosophers (scala) [default], iteration 9 completed (1509.255 ms) ======
[2025-05-11T08:18:27.789Z] ====== philosophers (scala) [default], iteration 10 started ======
[2025-05-11T08:18:27.789Z] GC before operation: completed in 9.728 ms, heap usage 8.427 MB -> 4.880 MB.
[2025-05-11T08:18:29.368Z] Camera thread performed 122 scans.
[2025-05-11T08:18:29.368Z] ====== philosophers (scala) [default], iteration 10 completed (1510.087 ms) ======
[2025-05-11T08:18:29.368Z] ====== philosophers (scala) [default], iteration 11 started ======
[2025-05-11T08:18:29.368Z] GC before operation: completed in 9.834 ms, heap usage 14.425 MB -> 4.882 MB.
[2025-05-11T08:18:30.928Z] Camera thread performed 122 scans.
[2025-05-11T08:18:30.928Z] ====== philosophers (scala) [default], iteration 11 completed (1494.787 ms) ======
[2025-05-11T08:18:30.928Z] ====== philosophers (scala) [default], iteration 12 started ======
[2025-05-11T08:18:30.928Z] GC before operation: completed in 9.682 ms, heap usage 42.426 MB -> 4.881 MB.
[2025-05-11T08:18:32.017Z] Camera thread performed 122 scans.
[2025-05-11T08:18:32.017Z] ====== philosophers (scala) [default], iteration 12 completed (1400.605 ms) ======
[2025-05-11T08:18:32.017Z] ====== philosophers (scala) [default], iteration 13 started ======
[2025-05-11T08:18:32.017Z] GC before operation: completed in 9.956 ms, heap usage 49.104 MB -> 4.881 MB.
[2025-05-11T08:18:33.594Z] Camera thread performed 122 scans.
[2025-05-11T08:18:33.594Z] ====== philosophers (scala) [default], iteration 13 completed (1441.233 ms) ======
[2025-05-11T08:18:33.594Z] ====== philosophers (scala) [default], iteration 14 started ======
[2025-05-11T08:18:33.594Z] GC before operation: completed in 10.227 ms, heap usage 45.094 MB -> 4.883 MB.
[2025-05-11T08:18:35.171Z] Camera thread performed 122 scans.
[2025-05-11T08:18:35.171Z] ====== philosophers (scala) [default], iteration 14 completed (1484.516 ms) ======
[2025-05-11T08:18:35.171Z] ====== philosophers (scala) [default], iteration 15 started ======
[2025-05-11T08:18:35.171Z] GC before operation: completed in 10.283 ms, heap usage 55.099 MB -> 4.883 MB.
[2025-05-11T08:18:36.748Z] Camera thread performed 122 scans.
[2025-05-11T08:18:36.748Z] ====== philosophers (scala) [default], iteration 15 completed (1559.620 ms) ======
[2025-05-11T08:18:36.748Z] ====== philosophers (scala) [default], iteration 16 started ======
[2025-05-11T08:18:36.748Z] GC before operation: completed in 10.139 ms, heap usage 19.418 MB -> 4.883 MB.
[2025-05-11T08:18:38.321Z] Camera thread performed 122 scans.
[2025-05-11T08:18:38.321Z] ====== philosophers (scala) [default], iteration 16 completed (1515.200 ms) ======
[2025-05-11T08:18:38.321Z] ====== philosophers (scala) [default], iteration 17 started ======
[2025-05-11T08:18:38.321Z] GC before operation: completed in 10.506 ms, heap usage 56.127 MB -> 4.884 MB.
[2025-05-11T08:18:39.897Z] Camera thread performed 122 scans.
[2025-05-11T08:18:39.897Z] ====== philosophers (scala) [default], iteration 17 completed (1609.243 ms) ======
[2025-05-11T08:18:39.897Z] ====== philosophers (scala) [default], iteration 18 started ======
[2025-05-11T08:18:39.897Z] GC before operation: completed in 10.025 ms, heap usage 11.116 MB -> 4.884 MB.
[2025-05-11T08:18:41.478Z] Camera thread performed 122 scans.
[2025-05-11T08:18:41.478Z] ====== philosophers (scala) [default], iteration 18 completed (1376.884 ms) ======
[2025-05-11T08:18:41.478Z] ====== philosophers (scala) [default], iteration 19 started ======
[2025-05-11T08:18:41.478Z] GC before operation: completed in 9.629 ms, heap usage 23.900 MB -> 4.884 MB.
[2025-05-11T08:18:43.055Z] Camera thread performed 122 scans.
[2025-05-11T08:18:43.055Z] ====== philosophers (scala) [default], iteration 19 completed (1527.606 ms) ======
[2025-05-11T08:18:43.055Z] ====== philosophers (scala) [default], iteration 20 started ======
[2025-05-11T08:18:43.055Z] GC before operation: completed in 10.013 ms, heap usage 17.406 MB -> 4.884 MB.
[2025-05-11T08:18:44.145Z] Camera thread performed 122 scans.
[2025-05-11T08:18:44.145Z] ====== philosophers (scala) [default], iteration 20 completed (1512.872 ms) ======
[2025-05-11T08:18:44.145Z] ====== philosophers (scala) [default], iteration 21 started ======
[2025-05-11T08:18:44.145Z] GC before operation: completed in 9.362 ms, heap usage 11.510 MB -> 4.884 MB.
[2025-05-11T08:18:45.753Z] Camera thread performed 122 scans.
[2025-05-11T08:18:45.753Z] ====== philosophers (scala) [default], iteration 21 completed (1455.781 ms) ======
[2025-05-11T08:18:45.753Z] ====== philosophers (scala) [default], iteration 22 started ======
[2025-05-11T08:18:45.753Z] GC before operation: completed in 10.064 ms, heap usage 44.672 MB -> 4.884 MB.
[2025-05-11T08:18:47.327Z] Camera thread performed 122 scans.
[2025-05-11T08:18:47.327Z] ====== philosophers (scala) [default], iteration 22 completed (1563.278 ms) ======
[2025-05-11T08:18:47.327Z] ====== philosophers (scala) [default], iteration 23 started ======
[2025-05-11T08:18:47.327Z] GC before operation: completed in 10.624 ms, heap usage 43.398 MB -> 4.885 MB.
[2025-05-11T08:18:48.903Z] Camera thread performed 122 scans.
[2025-05-11T08:18:48.903Z] ====== philosophers (scala) [default], iteration 23 completed (1420.808 ms) ======
[2025-05-11T08:18:48.903Z] ====== philosophers (scala) [default], iteration 24 started ======
[2025-05-11T08:18:48.903Z] GC before operation: completed in 9.692 ms, heap usage 19.577 MB -> 4.885 MB.
[2025-05-11T08:18:50.483Z] Camera thread performed 122 scans.
[2025-05-11T08:18:50.483Z] ====== philosophers (scala) [default], iteration 24 completed (1529.876 ms) ======
[2025-05-11T08:18:50.483Z] ====== philosophers (scala) [default], iteration 25 started ======
[2025-05-11T08:18:50.483Z] GC before operation: completed in 10.924 ms, heap usage 35.418 MB -> 4.885 MB.
[2025-05-11T08:18:51.573Z] Camera thread performed 122 scans.
[2025-05-11T08:18:51.573Z] ====== philosophers (scala) [default], iteration 25 completed (1435.967 ms) ======
[2025-05-11T08:18:51.573Z] ====== philosophers (scala) [default], iteration 26 started ======
[2025-05-11T08:18:51.573Z] GC before operation: completed in 10.254 ms, heap usage 32.814 MB -> 4.885 MB.
[2025-05-11T08:18:53.154Z] Camera thread performed 122 scans.
[2025-05-11T08:18:53.154Z] ====== philosophers (scala) [default], iteration 26 completed (1495.951 ms) ======
[2025-05-11T08:18:53.154Z] ====== philosophers (scala) [default], iteration 27 started ======
[2025-05-11T08:18:53.154Z] GC before operation: completed in 9.859 ms, heap usage 48.665 MB -> 4.885 MB.
[2025-05-11T08:18:54.729Z] Camera thread performed 122 scans.
[2025-05-11T08:18:54.729Z] ====== philosophers (scala) [default], iteration 27 completed (1494.701 ms) ======
[2025-05-11T08:18:54.729Z] ====== philosophers (scala) [default], iteration 28 started ======
[2025-05-11T08:18:54.729Z] GC before operation: completed in 10.423 ms, heap usage 13.432 MB -> 4.885 MB.
[2025-05-11T08:18:56.303Z] Camera thread performed 122 scans.
[2025-05-11T08:18:56.303Z] ====== philosophers (scala) [default], iteration 28 completed (1478.595 ms) ======
[2025-05-11T08:18:56.303Z] ====== philosophers (scala) [default], iteration 29 started ======
[2025-05-11T08:18:56.303Z] GC before operation: completed in 9.860 ms, heap usage 17.052 MB -> 4.885 MB.
[2025-05-11T08:18:57.863Z] Camera thread performed 122 scans.
[2025-05-11T08:18:57.863Z] ====== philosophers (scala) [default], iteration 29 completed (1492.628 ms) ======
[2025-05-11T08:18:57.863Z] -----------------------------------
[2025-05-11T08:18:57.863Z] renaissance-philosophers_0_PASSED
[2025-05-11T08:18:57.863Z] -----------------------------------
[2025-05-11T08:18:57.864Z]
[2025-05-11T08:18:57.864Z] TEST TEARDOWN:
[2025-05-11T08:18:57.864Z] Nothing to be done for teardown.
[2025-05-11T08:18:57.864Z] renaissance-philosophers_0 Finish Time: Sun May 11 08:18:57 2025 Epoch Time (ms): 1746951537808