[2026-01-21T01:43:24.321Z] Running test renaissance-philosophers_0 ... [2026-01-21T01:43:24.321Z] =============================================== [2026-01-21T01:43:24.321Z] renaissance-philosophers_0 Start Time: Wed Jan 21 01:43:24 2026 Epoch Time (ms): 1768959804227 [2026-01-21T01:43:24.321Z] variation: NoOptions [2026-01-21T01:43:24.321Z] JVM_OPTIONS: [2026-01-21T01:43:24.321Z] { \ [2026-01-21T01:43:24.321Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T01:43:24.321Z] echo "Nothing to be done for setup."; \ [2026-01-21T01:43:24.321Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-philosophers_0"; \ [2026-01-21T01:43:24.321Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-philosophers_0"; \ [2026-01-21T01:43:24.321Z] echo ""; echo "TESTING:"; \ [2026-01-21T01:43:24.321Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/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 "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-01-21T01:43:24.321Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T01:43:24.321Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T01:43:24.321Z] echo "Nothing to be done for teardown."; \ [2026-01-21T01:43:24.321Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/TestTargetResult"; [2026-01-21T01:43:24.321Z] [2026-01-21T01:43:24.321Z] TEST SETUP: [2026-01-21T01:43:24.321Z] Nothing to be done for setup. [2026-01-21T01:43:24.321Z] [2026-01-21T01:43:24.321Z] TESTING: [2026-01-21T01:43:25.600Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-01-21T01:43:25.600Z] GC before operation: completed in 15.316 ms, heap usage 14.298 MB -> 4.675 MB. [2026-01-21T01:43:30.821Z] Camera thread performed 122 scans. [2026-01-21T01:43:30.821Z] ====== philosophers (scala) [default], iteration 0 completed (5250.998 ms) ====== [2026-01-21T01:43:30.821Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-01-21T01:43:30.821Z] GC before operation: completed in 16.256 ms, heap usage 47.837 MB -> 5.042 MB. [2026-01-21T01:43:33.297Z] Camera thread performed 122 scans. [2026-01-21T01:43:33.297Z] ====== philosophers (scala) [default], iteration 1 completed (2544.362 ms) ====== [2026-01-21T01:43:33.297Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-01-21T01:43:33.297Z] GC before operation: completed in 12.347 ms, heap usage 32.006 MB -> 5.042 MB. [2026-01-21T01:43:35.769Z] Camera thread performed 122 scans. [2026-01-21T01:43:35.769Z] ====== philosophers (scala) [default], iteration 2 completed (2102.152 ms) ====== [2026-01-21T01:43:35.769Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-01-21T01:43:35.769Z] GC before operation: completed in 11.492 ms, heap usage 36.950 MB -> 5.042 MB. [2026-01-21T01:43:37.596Z] Camera thread performed 122 scans. [2026-01-21T01:43:37.596Z] ====== philosophers (scala) [default], iteration 3 completed (2127.427 ms) ====== [2026-01-21T01:43:37.596Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-01-21T01:43:37.596Z] GC before operation: completed in 11.546 ms, heap usage 31.399 MB -> 5.044 MB. [2026-01-21T01:43:40.067Z] Camera thread performed 122 scans. [2026-01-21T01:43:40.067Z] ====== philosophers (scala) [default], iteration 4 completed (2207.952 ms) ====== [2026-01-21T01:43:40.067Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-01-21T01:43:40.067Z] GC before operation: completed in 11.404 ms, heap usage 34.635 MB -> 5.044 MB. [2026-01-21T01:43:41.899Z] Camera thread performed 122 scans. [2026-01-21T01:43:41.899Z] ====== philosophers (scala) [default], iteration 5 completed (2193.653 ms) ====== [2026-01-21T01:43:41.899Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-01-21T01:43:41.899Z] GC before operation: completed in 11.535 ms, heap usage 20.301 MB -> 5.044 MB. [2026-01-21T01:43:44.496Z] Camera thread performed 122 scans. [2026-01-21T01:43:44.496Z] ====== philosophers (scala) [default], iteration 6 completed (2179.849 ms) ====== [2026-01-21T01:43:44.496Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-01-21T01:43:44.496Z] GC before operation: completed in 11.221 ms, heap usage 11.657 MB -> 5.045 MB. [2026-01-21T01:43:46.322Z] Camera thread performed 122 scans. [2026-01-21T01:43:46.322Z] ====== philosophers (scala) [default], iteration 7 completed (2211.230 ms) ====== [2026-01-21T01:43:46.322Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-01-21T01:43:46.323Z] GC before operation: completed in 13.215 ms, heap usage 34.623 MB -> 5.045 MB. [2026-01-21T01:43:48.809Z] Camera thread performed 122 scans. [2026-01-21T01:43:48.809Z] ====== philosophers (scala) [default], iteration 8 completed (2154.936 ms) ====== [2026-01-21T01:43:48.809Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-01-21T01:43:48.809Z] GC before operation: completed in 11.299 ms, heap usage 34.921 MB -> 5.045 MB. [2026-01-21T01:43:50.655Z] Camera thread performed 122 scans. [2026-01-21T01:43:50.655Z] ====== philosophers (scala) [default], iteration 9 completed (2099.665 ms) ====== [2026-01-21T01:43:50.655Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-01-21T01:43:50.655Z] GC before operation: completed in 11.173 ms, heap usage 7.730 MB -> 5.045 MB. [2026-01-21T01:43:53.125Z] Camera thread performed 122 scans. [2026-01-21T01:43:53.125Z] ====== philosophers (scala) [default], iteration 10 completed (2220.723 ms) ====== [2026-01-21T01:43:53.125Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-01-21T01:43:53.126Z] GC before operation: completed in 11.251 ms, heap usage 43.268 MB -> 5.046 MB. [2026-01-21T01:43:55.594Z] Camera thread performed 122 scans. [2026-01-21T01:43:55.594Z] ====== philosophers (scala) [default], iteration 11 completed (2187.034 ms) ====== [2026-01-21T01:43:55.594Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-01-21T01:43:55.594Z] GC before operation: completed in 11.496 ms, heap usage 70.972 MB -> 5.046 MB. [2026-01-21T01:43:57.426Z] Camera thread performed 122 scans. [2026-01-21T01:43:57.426Z] ====== philosophers (scala) [default], iteration 12 completed (2127.745 ms) ====== [2026-01-21T01:43:57.426Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-01-21T01:43:57.426Z] GC before operation: completed in 12.807 ms, heap usage 70.925 MB -> 5.047 MB. [2026-01-21T01:43:59.256Z] Camera thread performed 122 scans. [2026-01-21T01:43:59.256Z] ====== philosophers (scala) [default], iteration 13 completed (2028.087 ms) ====== [2026-01-21T01:43:59.256Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-01-21T01:43:59.256Z] GC before operation: completed in 11.523 ms, heap usage 24.588 MB -> 5.046 MB. [2026-01-21T01:44:01.731Z] Camera thread performed 122 scans. [2026-01-21T01:44:01.731Z] ====== philosophers (scala) [default], iteration 14 completed (2142.676 ms) ====== [2026-01-21T01:44:01.731Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-01-21T01:44:01.731Z] GC before operation: completed in 11.344 ms, heap usage 64.888 MB -> 5.047 MB. [2026-01-21T01:44:04.206Z] Camera thread performed 122 scans. [2026-01-21T01:44:04.206Z] ====== philosophers (scala) [default], iteration 15 completed (2235.396 ms) ====== [2026-01-21T01:44:04.206Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-01-21T01:44:04.206Z] GC before operation: completed in 11.314 ms, heap usage 69.933 MB -> 5.047 MB. [2026-01-21T01:44:06.082Z] Camera thread performed 122 scans. [2026-01-21T01:44:06.082Z] ====== philosophers (scala) [default], iteration 16 completed (2012.374 ms) ====== [2026-01-21T01:44:06.082Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-01-21T01:44:06.082Z] GC before operation: completed in 11.201 ms, heap usage 22.633 MB -> 5.047 MB. [2026-01-21T01:44:08.005Z] Camera thread performed 122 scans. [2026-01-21T01:44:08.005Z] ====== philosophers (scala) [default], iteration 17 completed (2095.562 ms) ====== [2026-01-21T01:44:08.005Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-01-21T01:44:08.005Z] GC before operation: completed in 11.577 ms, heap usage 49.804 MB -> 5.047 MB. [2026-01-21T01:44:10.477Z] Camera thread performed 122 scans. [2026-01-21T01:44:10.477Z] ====== philosophers (scala) [default], iteration 18 completed (2194.408 ms) ====== [2026-01-21T01:44:10.477Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-01-21T01:44:10.477Z] GC before operation: completed in 11.358 ms, heap usage 39.587 MB -> 5.047 MB. [2026-01-21T01:44:12.307Z] Camera thread performed 122 scans. [2026-01-21T01:44:12.307Z] ====== philosophers (scala) [default], iteration 19 completed (2164.900 ms) ====== [2026-01-21T01:44:12.307Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-01-21T01:44:12.307Z] GC before operation: completed in 11.415 ms, heap usage 64.573 MB -> 5.047 MB. [2026-01-21T01:44:14.790Z] Camera thread performed 122 scans. [2026-01-21T01:44:14.790Z] ====== philosophers (scala) [default], iteration 20 completed (2120.471 ms) ====== [2026-01-21T01:44:14.790Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-01-21T01:44:14.790Z] GC before operation: completed in 11.341 ms, heap usage 53.604 MB -> 5.047 MB. [2026-01-21T01:44:16.617Z] Camera thread performed 122 scans. [2026-01-21T01:44:16.618Z] ====== philosophers (scala) [default], iteration 21 completed (2169.634 ms) ====== [2026-01-21T01:44:16.618Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-01-21T01:44:16.618Z] GC before operation: completed in 11.397 ms, heap usage 28.270 MB -> 5.047 MB. [2026-01-21T01:44:19.105Z] Camera thread performed 122 scans. [2026-01-21T01:44:19.105Z] ====== philosophers (scala) [default], iteration 22 completed (2135.118 ms) ====== [2026-01-21T01:44:19.105Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-01-21T01:44:19.105Z] GC before operation: completed in 11.468 ms, heap usage 54.275 MB -> 5.047 MB. [2026-01-21T01:44:20.996Z] Camera thread performed 122 scans. [2026-01-21T01:44:20.996Z] ====== philosophers (scala) [default], iteration 23 completed (2171.293 ms) ====== [2026-01-21T01:44:20.996Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-01-21T01:44:20.996Z] GC before operation: completed in 11.546 ms, heap usage 65.647 MB -> 5.047 MB. [2026-01-21T01:44:25.723Z] Camera thread performed 122 scans. [2026-01-21T01:44:25.723Z] ====== philosophers (scala) [default], iteration 24 completed (2108.680 ms) ====== [2026-01-21T01:44:25.723Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-01-21T01:44:25.723Z] GC before operation: completed in 11.281 ms, heap usage 42.042 MB -> 5.047 MB. [2026-01-21T01:44:25.723Z] Camera thread performed 122 scans. [2026-01-21T01:44:25.723Z] ====== philosophers (scala) [default], iteration 25 completed (2283.378 ms) ====== [2026-01-21T01:44:25.723Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-01-21T01:44:25.723Z] GC before operation: completed in 11.331 ms, heap usage 17.269 MB -> 5.047 MB. [2026-01-21T01:44:27.546Z] Camera thread performed 122 scans. [2026-01-21T01:44:27.546Z] ====== philosophers (scala) [default], iteration 26 completed (2243.159 ms) ====== [2026-01-21T01:44:27.546Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-01-21T01:44:27.546Z] GC before operation: completed in 11.185 ms, heap usage 5.627 MB -> 5.048 MB. [2026-01-21T01:44:30.010Z] Camera thread performed 122 scans. [2026-01-21T01:44:30.010Z] ====== philosophers (scala) [default], iteration 27 completed (2138.539 ms) ====== [2026-01-21T01:44:30.010Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-01-21T01:44:30.010Z] GC before operation: completed in 11.451 ms, heap usage 67.011 MB -> 5.048 MB. [2026-01-21T01:44:32.479Z] Camera thread performed 122 scans. [2026-01-21T01:44:32.480Z] ====== philosophers (scala) [default], iteration 28 completed (2251.326 ms) ====== [2026-01-21T01:44:32.480Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-01-21T01:44:32.480Z] GC before operation: completed in 11.520 ms, heap usage 44.189 MB -> 5.048 MB. [2026-01-21T01:44:34.435Z] Camera thread performed 122 scans. [2026-01-21T01:44:34.435Z] ====== philosophers (scala) [default], iteration 29 completed (2099.938 ms) ====== [2026-01-21T01:44:34.435Z] ----------------------------------- [2026-01-21T01:44:34.435Z] renaissance-philosophers_0_PASSED [2026-01-21T01:44:34.435Z] ----------------------------------- [2026-01-21T01:44:34.435Z] [2026-01-21T01:44:34.435Z] TEST TEARDOWN: [2026-01-21T01:44:34.435Z] Nothing to be done for teardown. [2026-01-21T01:44:34.435Z] renaissance-philosophers_0 Finish Time: Wed Jan 21 01:44:34 2026 Epoch Time (ms): 1768959874219