[2026-02-12T22:28:35.402Z] Running test renaissance-philosophers_0 ... [2026-02-12T22:28:35.402Z] =============================================== [2026-02-12T22:28:35.402Z] renaissance-philosophers_0 Start Time: Thu Feb 12 22:28:35 2026 Epoch Time (ms): 1770935315326 [2026-02-12T22:28:35.760Z] variation: NoOptions [2026-02-12T22:28:35.760Z] JVM_OPTIONS: [2026-02-12T22:28:35.760Z] { \ [2026-02-12T22:28:35.760Z] echo ""; echo "TEST SETUP:"; \ [2026-02-12T22:28:35.760Z] echo "Nothing to be done for setup."; \ [2026-02-12T22:28:35.760Z] mkdir -p "C:/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17709319024677\\renaissance-philosophers_0"; \ [2026-02-12T22:28:35.760Z] cd "C:/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17709319024677\\renaissance-philosophers_0"; \ [2026-02-12T22:28:35.760Z] echo ""; echo "TESTING:"; \ [2026-02-12T22:28:35.760Z] "c:/workspace/workspace/Test_openjdk11_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:/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17709319024677\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-02-12T22:28:35.760Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17709319024677\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-12T22:28:35.760Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-12T22:28:35.760Z] echo "Nothing to be done for teardown."; \ [2026-02-12T22:28:35.760Z] } 2>&1 | tee -a "C:/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17709319024677\\TestTargetResult"; [2026-02-12T22:28:35.760Z] [2026-02-12T22:28:35.760Z] TEST SETUP: [2026-02-12T22:28:35.760Z] Nothing to be done for setup. [2026-02-12T22:28:36.124Z] [2026-02-12T22:28:36.124Z] TESTING: [2026-02-12T22:28:37.821Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-12T22:28:37.821Z] GC before operation: completed in 23.037 ms, heap usage 15.841 MB -> 4.459 MB. [2026-02-12T22:28:40.870Z] Camera thread performed 122 scans. [2026-02-12T22:28:40.870Z] ====== philosophers (scala) [default], iteration 0 completed (2896.747 ms) ====== [2026-02-12T22:28:40.870Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-12T22:28:40.870Z] GC before operation: completed in 40.315 ms, heap usage 98.280 MB -> 4.868 MB. [2026-02-12T22:28:42.530Z] Camera thread performed 122 scans. [2026-02-12T22:28:42.530Z] ====== philosophers (scala) [default], iteration 1 completed (1829.600 ms) ====== [2026-02-12T22:28:42.530Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-12T22:28:42.530Z] GC before operation: completed in 37.147 ms, heap usage 77.069 MB -> 4.871 MB. [2026-02-12T22:28:44.230Z] Camera thread performed 122 scans. [2026-02-12T22:28:44.230Z] ====== philosophers (scala) [default], iteration 2 completed (1719.509 ms) ====== [2026-02-12T22:28:44.230Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-12T22:28:44.230Z] GC before operation: completed in 27.106 ms, heap usage 8.764 MB -> 4.872 MB. [2026-02-12T22:28:45.923Z] Camera thread performed 122 scans. [2026-02-12T22:28:45.923Z] ====== philosophers (scala) [default], iteration 3 completed (1755.523 ms) ====== [2026-02-12T22:28:45.923Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-12T22:28:45.923Z] GC before operation: completed in 41.201 ms, heap usage 126.826 MB -> 4.872 MB. [2026-02-12T22:28:47.617Z] Camera thread performed 122 scans. [2026-02-12T22:28:47.617Z] ====== philosophers (scala) [default], iteration 4 completed (1748.288 ms) ====== [2026-02-12T22:28:47.617Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-12T22:28:47.617Z] GC before operation: completed in 26.638 ms, heap usage 68.974 MB -> 4.874 MB. [2026-02-12T22:28:49.314Z] Camera thread performed 122 scans. [2026-02-12T22:28:49.314Z] ====== philosophers (scala) [default], iteration 5 completed (1698.890 ms) ====== [2026-02-12T22:28:49.314Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-12T22:28:49.314Z] GC before operation: completed in 39.588 ms, heap usage 53.115 MB -> 4.874 MB. [2026-02-12T22:28:51.000Z] Camera thread performed 122 scans. [2026-02-12T22:28:51.000Z] ====== philosophers (scala) [default], iteration 6 completed (1763.468 ms) ====== [2026-02-12T22:28:51.000Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-12T22:28:51.357Z] GC before operation: completed in 32.175 ms, heap usage 22.531 MB -> 4.876 MB. [2026-02-12T22:28:53.069Z] Camera thread performed 122 scans. [2026-02-12T22:28:53.069Z] ====== philosophers (scala) [default], iteration 7 completed (1877.874 ms) ====== [2026-02-12T22:28:53.069Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-12T22:28:53.069Z] GC before operation: completed in 43.732 ms, heap usage 87.104 MB -> 4.876 MB. [2026-02-12T22:28:55.365Z] Camera thread performed 122 scans. [2026-02-12T22:28:55.365Z] ====== philosophers (scala) [default], iteration 8 completed (1827.726 ms) ====== [2026-02-12T22:28:55.365Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-12T22:28:55.365Z] GC before operation: completed in 33.555 ms, heap usage 44.508 MB -> 4.876 MB. [2026-02-12T22:28:57.068Z] Camera thread performed 122 scans. [2026-02-12T22:28:57.068Z] ====== philosophers (scala) [default], iteration 9 completed (1960.703 ms) ====== [2026-02-12T22:28:57.068Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-12T22:28:57.068Z] GC before operation: completed in 45.048 ms, heap usage 55.594 MB -> 4.876 MB. [2026-02-12T22:28:58.763Z] Camera thread performed 122 scans. [2026-02-12T22:28:58.763Z] ====== philosophers (scala) [default], iteration 10 completed (1773.505 ms) ====== [2026-02-12T22:28:58.763Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-12T22:28:58.763Z] GC before operation: completed in 30.958 ms, heap usage 78.899 MB -> 4.876 MB. [2026-02-12T22:29:00.458Z] Camera thread performed 122 scans. [2026-02-12T22:29:00.458Z] ====== philosophers (scala) [default], iteration 11 completed (1739.345 ms) ====== [2026-02-12T22:29:00.458Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-12T22:29:00.458Z] GC before operation: completed in 46.897 ms, heap usage 78.597 MB -> 4.877 MB. [2026-02-12T22:29:02.751Z] Camera thread performed 122 scans. [2026-02-12T22:29:02.751Z] ====== philosophers (scala) [default], iteration 12 completed (1749.062 ms) ====== [2026-02-12T22:29:02.751Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-12T22:29:02.751Z] GC before operation: completed in 31.885 ms, heap usage 71.511 MB -> 4.877 MB. [2026-02-12T22:29:04.445Z] Camera thread performed 122 scans. [2026-02-12T22:29:04.445Z] ====== philosophers (scala) [default], iteration 13 completed (1812.210 ms) ====== [2026-02-12T22:29:04.445Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-12T22:29:04.445Z] GC before operation: completed in 39.338 ms, heap usage 77.095 MB -> 4.877 MB. [2026-02-12T22:29:06.148Z] Camera thread performed 122 scans. [2026-02-12T22:29:06.148Z] ====== philosophers (scala) [default], iteration 14 completed (1736.484 ms) ====== [2026-02-12T22:29:06.148Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-12T22:29:06.148Z] GC before operation: completed in 27.197 ms, heap usage 6.593 MB -> 4.877 MB. [2026-02-12T22:29:07.848Z] Camera thread performed 122 scans. [2026-02-12T22:29:07.848Z] ====== philosophers (scala) [default], iteration 15 completed (1752.090 ms) ====== [2026-02-12T22:29:07.848Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-12T22:29:07.848Z] GC before operation: completed in 37.821 ms, heap usage 82.595 MB -> 4.877 MB. [2026-02-12T22:29:09.546Z] Camera thread performed 122 scans. [2026-02-12T22:29:09.546Z] ====== philosophers (scala) [default], iteration 16 completed (1801.151 ms) ====== [2026-02-12T22:29:09.546Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-12T22:29:09.546Z] GC before operation: completed in 34.246 ms, heap usage 36.079 MB -> 4.877 MB. [2026-02-12T22:29:11.841Z] Camera thread performed 122 scans. [2026-02-12T22:29:11.841Z] ====== philosophers (scala) [default], iteration 17 completed (1890.021 ms) ====== [2026-02-12T22:29:11.841Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-12T22:29:11.841Z] GC before operation: completed in 40.843 ms, heap usage 113.589 MB -> 4.877 MB. [2026-02-12T22:29:13.539Z] Camera thread performed 122 scans. [2026-02-12T22:29:13.539Z] ====== philosophers (scala) [default], iteration 18 completed (1770.157 ms) ====== [2026-02-12T22:29:13.539Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-12T22:29:13.539Z] GC before operation: completed in 37.854 ms, heap usage 68.536 MB -> 4.877 MB. [2026-02-12T22:29:15.269Z] Camera thread performed 122 scans. [2026-02-12T22:29:15.269Z] ====== philosophers (scala) [default], iteration 19 completed (1993.545 ms) ====== [2026-02-12T22:29:15.269Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-12T22:29:15.269Z] GC before operation: completed in 44.266 ms, heap usage 17.095 MB -> 4.877 MB. [2026-02-12T22:29:17.575Z] Camera thread performed 122 scans. [2026-02-12T22:29:17.575Z] ====== philosophers (scala) [default], iteration 20 completed (1799.924 ms) ====== [2026-02-12T22:29:17.575Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-12T22:29:17.575Z] GC before operation: completed in 33.892 ms, heap usage 47.090 MB -> 4.877 MB. [2026-02-12T22:29:19.276Z] Camera thread performed 122 scans. [2026-02-12T22:29:19.276Z] ====== philosophers (scala) [default], iteration 21 completed (1821.433 ms) ====== [2026-02-12T22:29:19.276Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-12T22:29:19.276Z] GC before operation: completed in 33.519 ms, heap usage 80.086 MB -> 4.877 MB. [2026-02-12T22:29:20.981Z] Camera thread performed 122 scans. [2026-02-12T22:29:20.981Z] ====== philosophers (scala) [default], iteration 22 completed (1769.030 ms) ====== [2026-02-12T22:29:20.981Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-12T22:29:20.981Z] GC before operation: completed in 44.804 ms, heap usage 80.597 MB -> 4.878 MB. [2026-02-12T22:29:22.685Z] Camera thread performed 122 scans. [2026-02-12T22:29:22.685Z] ====== philosophers (scala) [default], iteration 23 completed (1768.454 ms) ====== [2026-02-12T22:29:22.685Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-12T22:29:22.685Z] GC before operation: completed in 28.528 ms, heap usage 75.912 MB -> 4.877 MB. [2026-02-12T22:29:24.381Z] Camera thread performed 122 scans. [2026-02-12T22:29:24.381Z] ====== philosophers (scala) [default], iteration 24 completed (1808.284 ms) ====== [2026-02-12T22:29:24.381Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-12T22:29:24.381Z] GC before operation: completed in 39.186 ms, heap usage 24.103 MB -> 4.878 MB. [2026-02-12T22:29:26.673Z] Camera thread performed 122 scans. [2026-02-12T22:29:26.673Z] ====== philosophers (scala) [default], iteration 25 completed (1795.249 ms) ====== [2026-02-12T22:29:26.673Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-12T22:29:26.673Z] GC before operation: completed in 27.414 ms, heap usage 36.095 MB -> 4.878 MB. [2026-02-12T22:29:28.375Z] Camera thread performed 122 scans. [2026-02-12T22:29:28.375Z] ====== philosophers (scala) [default], iteration 26 completed (1886.389 ms) ====== [2026-02-12T22:29:28.375Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-12T22:29:28.375Z] GC before operation: completed in 43.629 ms, heap usage 118.598 MB -> 4.878 MB. [2026-02-12T22:29:30.069Z] Camera thread performed 122 scans. [2026-02-12T22:29:30.069Z] ====== philosophers (scala) [default], iteration 27 completed (1740.309 ms) ====== [2026-02-12T22:29:30.069Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-12T22:29:30.069Z] GC before operation: completed in 28.146 ms, heap usage 10.546 MB -> 4.878 MB. [2026-02-12T22:29:31.760Z] Camera thread performed 122 scans. [2026-02-12T22:29:31.760Z] ====== philosophers (scala) [default], iteration 28 completed (1803.884 ms) ====== [2026-02-12T22:29:31.760Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-12T22:29:31.760Z] GC before operation: completed in 41.174 ms, heap usage 120.594 MB -> 4.878 MB. [2026-02-12T22:29:34.056Z] Camera thread performed 122 scans. [2026-02-12T22:29:34.056Z] ====== philosophers (scala) [default], iteration 29 completed (1769.563 ms) ====== [2026-02-12T22:29:34.056Z] ----------------------------------- [2026-02-12T22:29:34.056Z] renaissance-philosophers_0_PASSED [2026-02-12T22:29:34.056Z] ----------------------------------- [2026-02-12T22:29:34.056Z] [2026-02-12T22:29:34.056Z] TEST TEARDOWN: [2026-02-12T22:29:34.056Z] Nothing to be done for teardown. [2026-02-12T22:29:34.056Z] renaissance-philosophers_0 Finish Time: Thu Feb 12 22:29:33 2026 Epoch Time (ms): 1770935373882