[2026-02-05T00:00:39.734Z] Running test renaissance-philosophers_0 ... [2026-02-05T00:00:40.085Z] =============================================== [2026-02-05T00:00:40.085Z] renaissance-philosophers_0 Start Time: Thu Feb 5 00:00:39 2026 Epoch Time (ms): 1770249639857 [2026-02-05T00:00:40.085Z] variation: NoOptions [2026-02-05T00:00:40.085Z] JVM_OPTIONS: [2026-02-05T00:00:40.085Z] { \ [2026-02-05T00:00:40.085Z] echo ""; echo "TEST SETUP:"; \ [2026-02-05T00:00:40.085Z] echo "Nothing to be done for setup."; \ [2026-02-05T00:00:40.085Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-philosophers_0"; \ [2026-02-05T00:00:40.085Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-philosophers_0"; \ [2026-02-05T00:00:40.085Z] echo ""; echo "TESTING:"; \ [2026-02-05T00:00:40.085Z] "c:/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-philosophers_0"\\philosophers.json" philosophers; \ [2026-02-05T00:00:40.085Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-05T00:00:40.085Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-05T00:00:40.085Z] echo "Nothing to be done for teardown."; \ [2026-02-05T00:00:40.085Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\TestTargetResult"; [2026-02-05T00:00:40.440Z] [2026-02-05T00:00:40.440Z] TEST SETUP: [2026-02-05T00:00:40.440Z] Nothing to be done for setup. [2026-02-05T00:00:40.440Z] [2026-02-05T00:00:40.440Z] TESTING: [2026-02-05T00:00:41.207Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-05T00:00:41.207Z] GC before operation: completed in 13.449 ms, heap usage 8.840 MB -> 4.559 MB. [2026-02-05T00:00:43.592Z] Camera thread performed 122 scans. [2026-02-05T00:00:43.592Z] ====== philosophers (scala) [default], iteration 0 completed (1947.263 ms) ====== [2026-02-05T00:00:43.592Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-05T00:00:43.592Z] GC before operation: completed in 16.532 ms, heap usage 42.631 MB -> 4.936 MB. [2026-02-05T00:00:44.338Z] Camera thread performed 122 scans. [2026-02-05T00:00:44.338Z] ====== philosophers (scala) [default], iteration 1 completed (919.171 ms) ====== [2026-02-05T00:00:44.338Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-05T00:00:44.338Z] GC before operation: completed in 10.702 ms, heap usage 48.045 MB -> 4.937 MB. [2026-02-05T00:00:44.698Z] Camera thread performed 122 scans. [2026-02-05T00:00:44.698Z] ====== philosophers (scala) [default], iteration 2 completed (591.514 ms) ====== [2026-02-05T00:00:44.698Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-05T00:00:44.698Z] GC before operation: completed in 10.051 ms, heap usage 16.611 MB -> 4.938 MB. [2026-02-05T00:00:45.453Z] Camera thread performed 122 scans. [2026-02-05T00:00:45.453Z] ====== philosophers (scala) [default], iteration 3 completed (625.947 ms) ====== [2026-02-05T00:00:45.453Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-05T00:00:45.453Z] GC before operation: completed in 9.788 ms, heap usage 36.561 MB -> 4.938 MB. [2026-02-05T00:00:46.235Z] Camera thread performed 122 scans. [2026-02-05T00:00:46.235Z] ====== philosophers (scala) [default], iteration 4 completed (644.994 ms) ====== [2026-02-05T00:00:46.235Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-05T00:00:46.235Z] GC before operation: completed in 10.830 ms, heap usage 36.075 MB -> 4.939 MB. [2026-02-05T00:00:46.587Z] Camera thread performed 122 scans. [2026-02-05T00:00:46.587Z] ====== philosophers (scala) [default], iteration 5 completed (593.371 ms) ====== [2026-02-05T00:00:46.587Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-05T00:00:46.587Z] GC before operation: completed in 10.816 ms, heap usage 23.492 MB -> 4.939 MB. [2026-02-05T00:00:47.794Z] Camera thread performed 122 scans. [2026-02-05T00:00:47.794Z] ====== philosophers (scala) [default], iteration 6 completed (838.643 ms) ====== [2026-02-05T00:00:47.794Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-05T00:00:47.794Z] GC before operation: completed in 9.846 ms, heap usage 26.565 MB -> 4.939 MB. [2026-02-05T00:00:48.146Z] Camera thread performed 122 scans. [2026-02-05T00:00:48.146Z] ====== philosophers (scala) [default], iteration 7 completed (661.223 ms) ====== [2026-02-05T00:00:48.146Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-05T00:00:48.146Z] GC before operation: completed in 10.112 ms, heap usage 56.558 MB -> 4.939 MB. [2026-02-05T00:00:48.887Z] Camera thread performed 122 scans. [2026-02-05T00:00:48.887Z] ====== philosophers (scala) [default], iteration 8 completed (689.686 ms) ====== [2026-02-05T00:00:48.887Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-05T00:00:48.887Z] GC before operation: completed in 9.915 ms, heap usage 22.053 MB -> 4.940 MB. [2026-02-05T00:00:49.644Z] Camera thread performed 122 scans. [2026-02-05T00:00:49.644Z] ====== philosophers (scala) [default], iteration 9 completed (670.867 ms) ====== [2026-02-05T00:00:49.644Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-05T00:00:49.644Z] GC before operation: completed in 9.956 ms, heap usage 43.058 MB -> 4.939 MB. [2026-02-05T00:00:50.391Z] Camera thread performed 122 scans. [2026-02-05T00:00:50.391Z] ====== philosophers (scala) [default], iteration 10 completed (614.758 ms) ====== [2026-02-05T00:00:50.391Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-05T00:00:50.391Z] GC before operation: completed in 10.665 ms, heap usage 11.007 MB -> 4.944 MB. [2026-02-05T00:00:51.137Z] Camera thread performed 122 scans. [2026-02-05T00:00:51.137Z] ====== philosophers (scala) [default], iteration 11 completed (657.414 ms) ====== [2026-02-05T00:00:51.137Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-05T00:00:51.137Z] GC before operation: completed in 10.481 ms, heap usage 55.906 MB -> 4.945 MB. [2026-02-05T00:00:51.491Z] Camera thread performed 122 scans. [2026-02-05T00:00:51.491Z] ====== philosophers (scala) [default], iteration 12 completed (663.697 ms) ====== [2026-02-05T00:00:51.491Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-05T00:00:51.491Z] GC before operation: completed in 10.030 ms, heap usage 37.065 MB -> 4.945 MB. [2026-02-05T00:00:52.263Z] Camera thread performed 122 scans. [2026-02-05T00:00:52.263Z] ====== philosophers (scala) [default], iteration 13 completed (669.192 ms) ====== [2026-02-05T00:00:52.263Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-05T00:00:52.263Z] GC before operation: completed in 10.124 ms, heap usage 39.062 MB -> 4.945 MB. [2026-02-05T00:00:53.008Z] Camera thread performed 122 scans. [2026-02-05T00:00:53.008Z] ====== philosophers (scala) [default], iteration 14 completed (634.273 ms) ====== [2026-02-05T00:00:53.008Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-05T00:00:53.008Z] GC before operation: completed in 10.091 ms, heap usage 35.486 MB -> 4.945 MB. [2026-02-05T00:00:53.750Z] Camera thread performed 122 scans. [2026-02-05T00:00:53.750Z] ====== philosophers (scala) [default], iteration 15 completed (638.219 ms) ====== [2026-02-05T00:00:53.750Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-05T00:00:53.750Z] GC before operation: completed in 10.036 ms, heap usage 54.035 MB -> 4.945 MB. [2026-02-05T00:00:54.104Z] Camera thread performed 122 scans. [2026-02-05T00:00:54.104Z] ====== philosophers (scala) [default], iteration 16 completed (661.807 ms) ====== [2026-02-05T00:00:54.104Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-05T00:00:54.104Z] GC before operation: completed in 9.960 ms, heap usage 28.563 MB -> 4.946 MB. [2026-02-05T00:00:54.848Z] Camera thread performed 122 scans. [2026-02-05T00:00:54.848Z] ====== philosophers (scala) [default], iteration 17 completed (664.015 ms) ====== [2026-02-05T00:00:54.848Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-05T00:00:54.848Z] GC before operation: completed in 9.745 ms, heap usage 10.908 MB -> 4.945 MB. [2026-02-05T00:00:55.588Z] Camera thread performed 122 scans. [2026-02-05T00:00:55.588Z] ====== philosophers (scala) [default], iteration 18 completed (683.790 ms) ====== [2026-02-05T00:00:55.588Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-05T00:00:55.588Z] GC before operation: completed in 11.345 ms, heap usage 38.566 MB -> 4.946 MB. [2026-02-05T00:00:56.515Z] Camera thread performed 122 scans. [2026-02-05T00:00:56.515Z] ====== philosophers (scala) [default], iteration 19 completed (734.083 ms) ====== [2026-02-05T00:00:56.515Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-05T00:00:56.515Z] GC before operation: completed in 9.768 ms, heap usage 14.038 MB -> 4.946 MB. [2026-02-05T00:00:57.055Z] Camera thread performed 122 scans. [2026-02-05T00:00:57.055Z] ====== philosophers (scala) [default], iteration 20 completed (749.820 ms) ====== [2026-02-05T00:00:57.055Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-05T00:00:57.055Z] GC before operation: completed in 9.931 ms, heap usage 46.416 MB -> 4.947 MB. [2026-02-05T00:00:57.870Z] Camera thread performed 122 scans. [2026-02-05T00:00:57.870Z] ====== philosophers (scala) [default], iteration 21 completed (614.633 ms) ====== [2026-02-05T00:00:57.870Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-05T00:00:57.870Z] GC before operation: completed in 9.849 ms, heap usage 18.037 MB -> 4.946 MB. [2026-02-05T00:00:58.604Z] Camera thread performed 122 scans. [2026-02-05T00:00:58.604Z] ====== philosophers (scala) [default], iteration 22 completed (847.277 ms) ====== [2026-02-05T00:00:58.604Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-05T00:00:58.604Z] GC before operation: completed in 10.333 ms, heap usage 38.075 MB -> 4.947 MB. [2026-02-05T00:00:59.344Z] Camera thread performed 122 scans. [2026-02-05T00:00:59.344Z] ====== philosophers (scala) [default], iteration 23 completed (599.476 ms) ====== [2026-02-05T00:00:59.344Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-05T00:00:59.344Z] GC before operation: completed in 10.083 ms, heap usage 8.539 MB -> 4.947 MB. [2026-02-05T00:01:00.083Z] Camera thread performed 122 scans. [2026-02-05T00:01:00.083Z] ====== philosophers (scala) [default], iteration 24 completed (672.468 ms) ====== [2026-02-05T00:01:00.083Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-05T00:01:00.083Z] GC before operation: completed in 10.127 ms, heap usage 54.570 MB -> 4.947 MB. [2026-02-05T00:01:00.435Z] Camera thread performed 122 scans. [2026-02-05T00:01:00.436Z] ====== philosophers (scala) [default], iteration 25 completed (644.136 ms) ====== [2026-02-05T00:01:00.436Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-05T00:01:00.436Z] GC before operation: completed in 9.528 ms, heap usage 38.571 MB -> 4.947 MB. [2026-02-05T00:01:01.177Z] Camera thread performed 122 scans. [2026-02-05T00:01:01.177Z] ====== philosophers (scala) [default], iteration 26 completed (667.405 ms) ====== [2026-02-05T00:01:01.177Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-05T00:01:01.177Z] GC before operation: completed in 9.921 ms, heap usage 29.946 MB -> 4.947 MB. [2026-02-05T00:01:01.919Z] Camera thread performed 122 scans. [2026-02-05T00:01:01.919Z] ====== philosophers (scala) [default], iteration 27 completed (643.910 ms) ====== [2026-02-05T00:01:01.919Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-05T00:01:01.919Z] GC before operation: completed in 10.446 ms, heap usage 47.519 MB -> 4.947 MB. [2026-02-05T00:01:02.659Z] Camera thread performed 122 scans. [2026-02-05T00:01:02.659Z] ====== philosophers (scala) [default], iteration 28 completed (642.228 ms) ====== [2026-02-05T00:01:02.659Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-05T00:01:02.659Z] GC before operation: completed in 10.079 ms, heap usage 6.480 MB -> 4.948 MB. [2026-02-05T00:01:03.398Z] Camera thread performed 122 scans. [2026-02-05T00:01:03.398Z] ====== philosophers (scala) [default], iteration 29 completed (657.228 ms) ====== [2026-02-05T00:01:03.398Z] ----------------------------------- [2026-02-05T00:01:03.398Z] renaissance-philosophers_0_PASSED [2026-02-05T00:01:03.398Z] ----------------------------------- [2026-02-05T00:01:03.398Z] [2026-02-05T00:01:03.398Z] TEST TEARDOWN: [2026-02-05T00:01:03.398Z] Nothing to be done for teardown. [2026-02-05T00:01:03.398Z] renaissance-philosophers_0 Finish Time: Thu Feb 5 00:01:03 2026 Epoch Time (ms): 1770249663337