[2025-06-28T15:33:48.182Z] Running test renaissance-philosophers_0 ... [2025-06-28T15:33:48.182Z] =============================================== [2025-06-28T15:33:48.478Z] renaissance-philosophers_0 Start Time: Sat Jun 28 15:33:48 2025 Epoch Time (ms): 1751124828302 [2025-06-28T15:33:48.775Z] variation: NoOptions [2025-06-28T15:33:48.775Z] JVM_OPTIONS: [2025-06-28T15:33:48.775Z] { \ [2025-06-28T15:33:48.775Z] echo ""; echo "TEST SETUP:"; \ [2025-06-28T15:33:48.775Z] echo "Nothing to be done for setup."; \ [2025-06-28T15:33:48.775Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17511242487431\\renaissance-philosophers_0"; \ [2025-06-28T15:33:48.775Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17511242487431\\renaissance-philosophers_0"; \ [2025-06-28T15:33:48.775Z] echo ""; echo "TESTING:"; \ [2025-06-28T15:33:48.775Z] "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_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:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17511242487431\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2025-06-28T15:33:48.775Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/; rm -f -r "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17511242487431\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-28T15:33:48.775Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-28T15:33:48.775Z] echo "Nothing to be done for teardown."; \ [2025-06-28T15:33:48.775Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_windows/aqa-tests/\\TKG\\output_17511242487431\\TestTargetResult"; [2025-06-28T15:33:49.071Z] [2025-06-28T15:33:49.071Z] TEST SETUP: [2025-06-28T15:33:49.071Z] Nothing to be done for setup. [2025-06-28T15:33:49.071Z] [2025-06-28T15:33:49.071Z] TESTING: [2025-06-28T15:33:50.599Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-06-28T15:33:50.599Z] GC before operation: completed in 14.534 ms, heap usage 16.042 MB -> 4.563 MB. [2025-06-28T15:33:52.125Z] Camera thread performed 122 scans. [2025-06-28T15:33:52.125Z] ====== philosophers (scala) [default], iteration 0 completed (1953.924 ms) ====== [2025-06-28T15:33:52.125Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-06-28T15:33:52.422Z] GC before operation: completed in 14.369 ms, heap usage 29.735 MB -> 4.928 MB. [2025-06-28T15:33:53.518Z] Camera thread performed 122 scans. [2025-06-28T15:33:53.518Z] ====== philosophers (scala) [default], iteration 1 completed (1340.192 ms) ====== [2025-06-28T15:33:53.518Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-06-28T15:33:53.518Z] GC before operation: completed in 13.017 ms, heap usage 26.120 MB -> 4.927 MB. [2025-06-28T15:33:55.046Z] Camera thread performed 122 scans. [2025-06-28T15:33:55.046Z] ====== philosophers (scala) [default], iteration 2 completed (1165.166 ms) ====== [2025-06-28T15:33:55.046Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-06-28T15:33:55.046Z] GC before operation: completed in 11.086 ms, heap usage 58.108 MB -> 4.928 MB. [2025-06-28T15:33:56.092Z] Camera thread performed 122 scans. [2025-06-28T15:33:56.092Z] ====== philosophers (scala) [default], iteration 3 completed (1125.623 ms) ====== [2025-06-28T15:33:56.092Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-06-28T15:33:56.092Z] GC before operation: completed in 14.360 ms, heap usage 16.114 MB -> 4.929 MB. [2025-06-28T15:33:57.619Z] Camera thread performed 122 scans. [2025-06-28T15:33:57.619Z] ====== philosophers (scala) [default], iteration 4 completed (1412.284 ms) ====== [2025-06-28T15:33:57.619Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-06-28T15:33:57.619Z] GC before operation: completed in 12.714 ms, heap usage 52.114 MB -> 4.929 MB. [2025-06-28T15:33:58.673Z] Camera thread performed 122 scans. [2025-06-28T15:33:58.673Z] ====== philosophers (scala) [default], iteration 5 completed (1309.600 ms) ====== [2025-06-28T15:33:58.673Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-06-28T15:33:58.673Z] GC before operation: completed in 14.756 ms, heap usage 63.741 MB -> 4.932 MB. [2025-06-28T15:34:00.203Z] Camera thread performed 122 scans. [2025-06-28T15:34:00.203Z] ====== philosophers (scala) [default], iteration 6 completed (1317.912 ms) ====== [2025-06-28T15:34:00.203Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-06-28T15:34:00.203Z] GC before operation: completed in 14.750 ms, heap usage 31.764 MB -> 4.933 MB. [2025-06-28T15:34:01.732Z] Camera thread performed 122 scans. [2025-06-28T15:34:01.732Z] ====== philosophers (scala) [default], iteration 7 completed (1552.538 ms) ====== [2025-06-28T15:34:01.732Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-06-28T15:34:01.732Z] GC before operation: completed in 11.144 ms, heap usage 40.429 MB -> 4.934 MB. [2025-06-28T15:34:02.781Z] Camera thread performed 122 scans. [2025-06-28T15:34:02.781Z] ====== philosophers (scala) [default], iteration 8 completed (1303.507 ms) ====== [2025-06-28T15:34:02.781Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-06-28T15:34:02.781Z] GC before operation: completed in 10.812 ms, heap usage 50.735 MB -> 4.935 MB. [2025-06-28T15:34:04.307Z] Camera thread performed 122 scans. [2025-06-28T15:34:04.307Z] ====== philosophers (scala) [default], iteration 9 completed (1174.350 ms) ====== [2025-06-28T15:34:04.307Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-06-28T15:34:04.307Z] GC before operation: completed in 10.852 ms, heap usage 37.685 MB -> 4.935 MB. [2025-06-28T15:34:05.354Z] Camera thread performed 122 scans. [2025-06-28T15:34:05.354Z] ====== philosophers (scala) [default], iteration 10 completed (1251.403 ms) ====== [2025-06-28T15:34:05.354Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-06-28T15:34:05.354Z] GC before operation: completed in 11.017 ms, heap usage 31.481 MB -> 4.935 MB. [2025-06-28T15:34:06.879Z] Camera thread performed 122 scans. [2025-06-28T15:34:06.879Z] ====== philosophers (scala) [default], iteration 11 completed (1197.605 ms) ====== [2025-06-28T15:34:06.879Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-06-28T15:34:06.879Z] GC before operation: completed in 11.402 ms, heap usage 63.730 MB -> 4.935 MB. [2025-06-28T15:34:07.945Z] Camera thread performed 122 scans. [2025-06-28T15:34:07.945Z] ====== philosophers (scala) [default], iteration 12 completed (1386.131 ms) ====== [2025-06-28T15:34:07.945Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-06-28T15:34:07.945Z] GC before operation: completed in 11.132 ms, heap usage 61.045 MB -> 4.935 MB. [2025-06-28T15:34:08.992Z] Camera thread performed 122 scans. [2025-06-28T15:34:08.992Z] ====== philosophers (scala) [default], iteration 13 completed (1066.994 ms) ====== [2025-06-28T15:34:08.992Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-06-28T15:34:08.992Z] GC before operation: completed in 10.867 ms, heap usage 66.099 MB -> 4.935 MB. [2025-06-28T15:34:10.041Z] Camera thread performed 122 scans. [2025-06-28T15:34:10.041Z] ====== philosophers (scala) [default], iteration 14 completed (972.056 ms) ====== [2025-06-28T15:34:10.041Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-06-28T15:34:10.041Z] GC before operation: completed in 11.490 ms, heap usage 73.133 MB -> 4.935 MB. [2025-06-28T15:34:11.564Z] Camera thread performed 122 scans. [2025-06-28T15:34:11.564Z] ====== philosophers (scala) [default], iteration 15 completed (1354.228 ms) ====== [2025-06-28T15:34:11.564Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-06-28T15:34:11.564Z] GC before operation: completed in 11.076 ms, heap usage 38.537 MB -> 4.935 MB. [2025-06-28T15:34:12.610Z] Camera thread performed 122 scans. [2025-06-28T15:34:12.610Z] ====== philosophers (scala) [default], iteration 16 completed (1273.495 ms) ====== [2025-06-28T15:34:12.610Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-06-28T15:34:12.610Z] GC before operation: completed in 11.592 ms, heap usage 55.503 MB -> 4.936 MB. [2025-06-28T15:34:14.137Z] Camera thread performed 122 scans. [2025-06-28T15:34:14.137Z] ====== philosophers (scala) [default], iteration 17 completed (1314.159 ms) ====== [2025-06-28T15:34:14.137Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-06-28T15:34:14.137Z] GC before operation: completed in 11.562 ms, heap usage 78.993 MB -> 4.936 MB. [2025-06-28T15:34:15.318Z] Camera thread performed 122 scans. [2025-06-28T15:34:15.318Z] ====== philosophers (scala) [default], iteration 18 completed (1285.870 ms) ====== [2025-06-28T15:34:15.318Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-06-28T15:34:15.318Z] GC before operation: completed in 10.798 ms, heap usage 62.076 MB -> 4.936 MB. [2025-06-28T15:34:16.365Z] Camera thread performed 122 scans. [2025-06-28T15:34:16.365Z] ====== philosophers (scala) [default], iteration 19 completed (1174.409 ms) ====== [2025-06-28T15:34:16.365Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-06-28T15:34:16.365Z] GC before operation: completed in 11.257 ms, heap usage 12.082 MB -> 4.936 MB. [2025-06-28T15:34:17.891Z] Camera thread performed 122 scans. [2025-06-28T15:34:17.891Z] ====== philosophers (scala) [default], iteration 20 completed (1320.938 ms) ====== [2025-06-28T15:34:17.891Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-06-28T15:34:17.891Z] GC before operation: completed in 10.919 ms, heap usage 43.944 MB -> 4.936 MB. [2025-06-28T15:34:19.415Z] Camera thread performed 122 scans. [2025-06-28T15:34:19.415Z] ====== philosophers (scala) [default], iteration 21 completed (1291.392 ms) ====== [2025-06-28T15:34:19.415Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-06-28T15:34:19.415Z] GC before operation: completed in 15.412 ms, heap usage 59.522 MB -> 4.936 MB. [2025-06-28T15:34:20.460Z] Camera thread performed 122 scans. [2025-06-28T15:34:20.460Z] ====== philosophers (scala) [default], iteration 22 completed (1100.617 ms) ====== [2025-06-28T15:34:20.460Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-06-28T15:34:20.460Z] GC before operation: completed in 11.961 ms, heap usage 29.052 MB -> 4.936 MB. [2025-06-28T15:34:21.507Z] Camera thread performed 122 scans. [2025-06-28T15:34:21.507Z] ====== philosophers (scala) [default], iteration 23 completed (1329.720 ms) ====== [2025-06-28T15:34:21.507Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-06-28T15:34:21.507Z] GC before operation: completed in 11.708 ms, heap usage 19.866 MB -> 4.936 MB. [2025-06-28T15:34:23.034Z] Camera thread performed 122 scans. [2025-06-28T15:34:23.034Z] ====== philosophers (scala) [default], iteration 24 completed (1437.465 ms) ====== [2025-06-28T15:34:23.034Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-06-28T15:34:23.034Z] GC before operation: completed in 11.267 ms, heap usage 58.677 MB -> 4.937 MB. [2025-06-28T15:34:24.561Z] Camera thread performed 122 scans. [2025-06-28T15:34:24.561Z] ====== philosophers (scala) [default], iteration 25 completed (1290.209 ms) ====== [2025-06-28T15:34:24.561Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-06-28T15:34:24.561Z] GC before operation: completed in 11.127 ms, heap usage 38.492 MB -> 4.936 MB. [2025-06-28T15:34:25.651Z] Camera thread performed 122 scans. [2025-06-28T15:34:25.651Z] ====== philosophers (scala) [default], iteration 26 completed (1263.075 ms) ====== [2025-06-28T15:34:25.651Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-06-28T15:34:25.651Z] GC before operation: completed in 14.319 ms, heap usage 18.139 MB -> 4.937 MB. [2025-06-28T15:34:26.697Z] Camera thread performed 122 scans. [2025-06-28T15:34:26.697Z] ====== philosophers (scala) [default], iteration 27 completed (1160.656 ms) ====== [2025-06-28T15:34:26.697Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-06-28T15:34:26.697Z] GC before operation: completed in 11.170 ms, heap usage 10.140 MB -> 4.937 MB. [2025-06-28T15:34:28.224Z] Camera thread performed 122 scans. [2025-06-28T15:34:28.224Z] ====== philosophers (scala) [default], iteration 28 completed (1306.305 ms) ====== [2025-06-28T15:34:28.224Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-06-28T15:34:28.224Z] GC before operation: completed in 11.977 ms, heap usage 12.526 MB -> 4.937 MB. [2025-06-28T15:34:29.749Z] Camera thread performed 122 scans. [2025-06-28T15:34:29.749Z] ====== philosophers (scala) [default], iteration 29 completed (1527.124 ms) ====== [2025-06-28T15:34:29.749Z] ----------------------------------- [2025-06-28T15:34:29.749Z] renaissance-philosophers_0_PASSED [2025-06-28T15:34:29.749Z] ----------------------------------- [2025-06-28T15:34:30.044Z] [2025-06-28T15:34:30.044Z] TEST TEARDOWN: [2025-06-28T15:34:30.044Z] Nothing to be done for teardown. [2025-06-28T15:34:30.044Z] renaissance-philosophers_0 Finish Time: Sat Jun 28 15:34:29 2025 Epoch Time (ms): 1751124869891