[2026-03-02T01:04:44.849Z] Running test renaissance-philosophers_0 ... [2026-03-02T01:04:44.849Z] =============================================== [2026-03-02T01:04:45.162Z] renaissance-philosophers_0 Start Time: Mon Mar 2 01:04:44 2026 Epoch Time (ms): 1772413484905 [2026-03-02T01:04:45.162Z] variation: NoOptions [2026-03-02T01:04:45.162Z] JVM_OPTIONS: [2026-03-02T01:04:45.162Z] { \ [2026-03-02T01:04:45.162Z] echo ""; echo "TEST SETUP:"; \ [2026-03-02T01:04:45.162Z] echo "Nothing to be done for setup."; \ [2026-03-02T01:04:45.162Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-philosophers_0"; \ [2026-03-02T01:04:45.162Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-philosophers_0"; \ [2026-03-02T01:04:45.162Z] echo ""; echo "TESTING:"; \ [2026-03-02T01:04:45.162Z] "c:/jenkins/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:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-03-02T01:04:45.162Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-02T01:04:45.162Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-02T01:04:45.162Z] echo "Nothing to be done for teardown."; \ [2026-03-02T01:04:45.162Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\TestTargetResult"; [2026-03-02T01:04:45.522Z] [2026-03-02T01:04:45.522Z] TEST SETUP: [2026-03-02T01:04:45.522Z] Nothing to be done for setup. [2026-03-02T01:04:45.522Z] [2026-03-02T01:04:45.522Z] TESTING: [2026-03-02T01:04:47.227Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-03-02T01:04:47.227Z] GC before operation: completed in 15.594 ms, heap usage 7.245 MB -> 4.444 MB. [2026-03-02T01:04:49.157Z] Camera thread performed 122 scans. [2026-03-02T01:04:49.157Z] ====== philosophers (scala) [default], iteration 0 completed (1864.153 ms) ====== [2026-03-02T01:04:49.157Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-03-02T01:04:49.158Z] GC before operation: completed in 24.680 ms, heap usage 28.689 MB -> 4.864 MB. [2026-03-02T01:04:49.961Z] Camera thread performed 122 scans. [2026-03-02T01:04:49.961Z] ====== philosophers (scala) [default], iteration 1 completed (940.488 ms) ====== [2026-03-02T01:04:49.961Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-03-02T01:04:49.961Z] GC before operation: completed in 27.327 ms, heap usage 19.635 MB -> 4.866 MB. [2026-03-02T01:04:50.768Z] Camera thread performed 122 scans. [2026-03-02T01:04:50.768Z] ====== philosophers (scala) [default], iteration 2 completed (888.654 ms) ====== [2026-03-02T01:04:50.768Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-03-02T01:04:50.768Z] GC before operation: completed in 24.410 ms, heap usage 12.360 MB -> 4.866 MB. [2026-03-02T01:04:51.477Z] Camera thread performed 122 scans. [2026-03-02T01:04:51.477Z] ====== philosophers (scala) [default], iteration 3 completed (834.684 ms) ====== [2026-03-02T01:04:51.477Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-03-02T01:04:51.477Z] GC before operation: completed in 22.533 ms, heap usage 43.140 MB -> 4.871 MB. [2026-03-02T01:04:52.624Z] Camera thread performed 122 scans. [2026-03-02T01:04:52.624Z] ====== philosophers (scala) [default], iteration 4 completed (863.981 ms) ====== [2026-03-02T01:04:52.624Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-03-02T01:04:52.624Z] GC before operation: completed in 21.805 ms, heap usage 31.515 MB -> 4.871 MB. [2026-03-02T01:04:53.388Z] Camera thread performed 122 scans. [2026-03-02T01:04:53.388Z] ====== philosophers (scala) [default], iteration 5 completed (836.462 ms) ====== [2026-03-02T01:04:53.388Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-03-02T01:04:53.388Z] GC before operation: completed in 21.141 ms, heap usage 18.715 MB -> 4.872 MB. [2026-03-02T01:04:54.080Z] Camera thread performed 122 scans. [2026-03-02T01:04:54.080Z] ====== philosophers (scala) [default], iteration 6 completed (810.828 ms) ====== [2026-03-02T01:04:54.080Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-03-02T01:04:54.080Z] GC before operation: completed in 19.819 ms, heap usage 24.913 MB -> 4.872 MB. [2026-03-02T01:04:55.190Z] Camera thread performed 122 scans. [2026-03-02T01:04:55.190Z] ====== philosophers (scala) [default], iteration 7 completed (797.075 ms) ====== [2026-03-02T01:04:55.190Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-03-02T01:04:55.190Z] GC before operation: completed in 19.931 ms, heap usage 47.907 MB -> 4.874 MB. [2026-03-02T01:04:55.948Z] Camera thread performed 122 scans. [2026-03-02T01:04:55.948Z] ====== philosophers (scala) [default], iteration 8 completed (849.867 ms) ====== [2026-03-02T01:04:55.948Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-03-02T01:04:55.948Z] GC before operation: completed in 21.539 ms, heap usage 38.446 MB -> 4.874 MB. [2026-03-02T01:04:56.695Z] Camera thread performed 122 scans. [2026-03-02T01:04:56.695Z] ====== philosophers (scala) [default], iteration 9 completed (820.246 ms) ====== [2026-03-02T01:04:56.695Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-03-02T01:04:56.695Z] GC before operation: completed in 19.428 ms, heap usage 30.467 MB -> 4.874 MB. [2026-03-02T01:04:57.400Z] Camera thread performed 122 scans. [2026-03-02T01:04:57.400Z] ====== philosophers (scala) [default], iteration 10 completed (794.208 ms) ====== [2026-03-02T01:04:57.400Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-03-02T01:04:57.400Z] GC before operation: completed in 19.236 ms, heap usage 11.470 MB -> 4.874 MB. [2026-03-02T01:04:58.516Z] Camera thread performed 122 scans. [2026-03-02T01:04:58.516Z] ====== philosophers (scala) [default], iteration 11 completed (886.051 ms) ====== [2026-03-02T01:04:58.516Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-03-02T01:04:58.516Z] GC before operation: completed in 21.818 ms, heap usage 34.418 MB -> 4.875 MB. [2026-03-02T01:04:59.211Z] Camera thread performed 122 scans. [2026-03-02T01:04:59.211Z] ====== philosophers (scala) [default], iteration 12 completed (882.156 ms) ====== [2026-03-02T01:04:59.211Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-03-02T01:04:59.211Z] GC before operation: completed in 26.676 ms, heap usage 35.421 MB -> 4.875 MB. [2026-03-02T01:05:00.332Z] Camera thread performed 122 scans. [2026-03-02T01:05:00.332Z] ====== philosophers (scala) [default], iteration 13 completed (887.500 ms) ====== [2026-03-02T01:05:00.332Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-03-02T01:05:00.332Z] GC before operation: completed in 21.780 ms, heap usage 26.777 MB -> 4.875 MB. [2026-03-02T01:05:01.021Z] Camera thread performed 122 scans. [2026-03-02T01:05:01.021Z] ====== philosophers (scala) [default], iteration 14 completed (874.753 ms) ====== [2026-03-02T01:05:01.021Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-03-02T01:05:01.021Z] GC before operation: completed in 19.354 ms, heap usage 38.823 MB -> 4.875 MB. [2026-03-02T01:05:02.137Z] Camera thread performed 122 scans. [2026-03-02T01:05:02.137Z] ====== philosophers (scala) [default], iteration 15 completed (945.083 ms) ====== [2026-03-02T01:05:02.137Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-03-02T01:05:02.137Z] GC before operation: completed in 19.233 ms, heap usage 12.393 MB -> 4.875 MB. [2026-03-02T01:05:03.261Z] Camera thread performed 122 scans. [2026-03-02T01:05:03.261Z] ====== philosophers (scala) [default], iteration 16 completed (874.678 ms) ====== [2026-03-02T01:05:03.261Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-03-02T01:05:03.261Z] GC before operation: completed in 21.702 ms, heap usage 25.861 MB -> 4.876 MB. [2026-03-02T01:05:03.954Z] Camera thread performed 122 scans. [2026-03-02T01:05:03.954Z] ====== philosophers (scala) [default], iteration 17 completed (875.385 ms) ====== [2026-03-02T01:05:03.954Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-03-02T01:05:03.954Z] GC before operation: completed in 19.682 ms, heap usage 38.415 MB -> 4.876 MB. [2026-03-02T01:05:04.656Z] Camera thread performed 122 scans. [2026-03-02T01:05:04.656Z] ====== philosophers (scala) [default], iteration 18 completed (885.707 ms) ====== [2026-03-02T01:05:04.656Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-03-02T01:05:04.986Z] GC before operation: completed in 21.985 ms, heap usage 43.855 MB -> 4.876 MB. [2026-03-02T01:05:05.675Z] Camera thread performed 122 scans. [2026-03-02T01:05:05.675Z] ====== philosophers (scala) [default], iteration 19 completed (868.591 ms) ====== [2026-03-02T01:05:05.675Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-03-02T01:05:05.675Z] GC before operation: completed in 22.247 ms, heap usage 17.840 MB -> 4.876 MB. [2026-03-02T01:05:06.788Z] Camera thread performed 122 scans. [2026-03-02T01:05:06.788Z] ====== philosophers (scala) [default], iteration 20 completed (886.306 ms) ====== [2026-03-02T01:05:06.788Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-03-02T01:05:06.788Z] GC before operation: completed in 21.985 ms, heap usage 45.852 MB -> 4.876 MB. [2026-03-02T01:05:07.505Z] Camera thread performed 122 scans. [2026-03-02T01:05:07.505Z] ====== philosophers (scala) [default], iteration 21 completed (856.107 ms) ====== [2026-03-02T01:05:07.505Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-03-02T01:05:07.505Z] GC before operation: completed in 22.130 ms, heap usage 23.801 MB -> 4.877 MB. [2026-03-02T01:05:08.283Z] Camera thread performed 122 scans. [2026-03-02T01:05:08.283Z] ====== philosophers (scala) [default], iteration 22 completed (843.656 ms) ====== [2026-03-02T01:05:08.283Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-03-02T01:05:08.283Z] GC before operation: completed in 20.075 ms, heap usage 21.774 MB -> 4.878 MB. [2026-03-02T01:05:09.403Z] Camera thread performed 122 scans. [2026-03-02T01:05:09.403Z] ====== philosophers (scala) [default], iteration 23 completed (858.359 ms) ====== [2026-03-02T01:05:09.403Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-03-02T01:05:09.403Z] GC before operation: completed in 19.752 ms, heap usage 26.407 MB -> 4.877 MB. [2026-03-02T01:05:10.092Z] Camera thread performed 122 scans. [2026-03-02T01:05:10.092Z] ====== philosophers (scala) [default], iteration 24 completed (848.587 ms) ====== [2026-03-02T01:05:10.092Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-03-02T01:05:10.092Z] GC before operation: completed in 19.438 ms, heap usage 8.974 MB -> 4.878 MB. [2026-03-02T01:05:11.209Z] Camera thread performed 122 scans. [2026-03-02T01:05:11.209Z] ====== philosophers (scala) [default], iteration 25 completed (889.564 ms) ====== [2026-03-02T01:05:11.209Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-03-02T01:05:11.209Z] GC before operation: completed in 21.657 ms, heap usage 5.975 MB -> 4.878 MB. [2026-03-02T01:05:11.909Z] Camera thread performed 122 scans. [2026-03-02T01:05:11.909Z] ====== philosophers (scala) [default], iteration 26 completed (888.492 ms) ====== [2026-03-02T01:05:11.909Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-03-02T01:05:11.909Z] GC before operation: completed in 21.218 ms, heap usage 31.505 MB -> 4.878 MB. [2026-03-02T01:05:13.023Z] Camera thread performed 122 scans. [2026-03-02T01:05:13.023Z] ====== philosophers (scala) [default], iteration 27 completed (876.752 ms) ====== [2026-03-02T01:05:13.023Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-03-02T01:05:13.023Z] GC before operation: completed in 20.486 ms, heap usage 29.004 MB -> 4.878 MB. [2026-03-02T01:05:13.725Z] Camera thread performed 122 scans. [2026-03-02T01:05:13.725Z] ====== philosophers (scala) [default], iteration 28 completed (886.420 ms) ====== [2026-03-02T01:05:13.725Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-03-02T01:05:13.725Z] GC before operation: completed in 24.322 ms, heap usage 47.003 MB -> 4.878 MB. [2026-03-02T01:05:14.821Z] Camera thread performed 122 scans. [2026-03-02T01:05:14.821Z] ====== philosophers (scala) [default], iteration 29 completed (873.649 ms) ====== [2026-03-02T01:05:14.821Z] ----------------------------------- [2026-03-02T01:05:14.821Z] renaissance-philosophers_0_PASSED [2026-03-02T01:05:14.821Z] ----------------------------------- [2026-03-02T01:05:14.821Z] [2026-03-02T01:05:14.821Z] TEST TEARDOWN: [2026-03-02T01:05:14.821Z] Nothing to be done for teardown. [2026-03-02T01:05:15.136Z] renaissance-philosophers_0 Finish Time: Mon Mar 2 01:05:14 2026 Epoch Time (ms): 1772413514861