[2026-02-20T23:30:48.969Z] Running test renaissance-philosophers_0 ... [2026-02-20T23:30:48.969Z] =============================================== [2026-02-20T23:30:48.969Z] renaissance-philosophers_0 Start Time: Fri Feb 20 23:30:47 2026 Epoch Time (ms): 1771630247966 [2026-02-20T23:30:48.969Z] variation: NoOptions [2026-02-20T23:30:48.969Z] JVM_OPTIONS: [2026-02-20T23:30:48.969Z] { \ [2026-02-20T23:30:48.969Z] echo ""; echo "TEST SETUP:"; \ [2026-02-20T23:30:48.969Z] echo "Nothing to be done for setup."; \ [2026-02-20T23:30:48.969Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17716295784861/renaissance-philosophers_0"; \ [2026-02-20T23:30:48.969Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17716295784861/renaissance-philosophers_0"; \ [2026-02-20T23:30:48.969Z] echo ""; echo "TESTING:"; \ [2026-02-20T23:30:48.969Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_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_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17716295784861/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-20T23:30:48.969Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17716295784861/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-20T23:30:48.969Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-20T23:30:48.969Z] echo "Nothing to be done for teardown."; \ [2026-02-20T23:30:48.969Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17716295784861/TestTargetResult"; [2026-02-20T23:30:48.969Z] [2026-02-20T23:30:48.969Z] TEST SETUP: [2026-02-20T23:30:48.969Z] Nothing to be done for setup. [2026-02-20T23:30:48.969Z] [2026-02-20T23:30:48.969Z] TESTING: [2026-02-20T23:30:49.946Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-20T23:30:49.946Z] GC before operation: completed in 29.103 ms, heap usage 17.452 MB -> 4.607 MB. [2026-02-20T23:30:59.881Z] Camera thread performed 122 scans. [2026-02-20T23:30:59.882Z] ====== philosophers (scala) [default], iteration 0 completed (8671.403 ms) ====== [2026-02-20T23:30:59.882Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-20T23:30:59.882Z] GC before operation: completed in 39.408 ms, heap usage 34.034 MB -> 5.019 MB. [2026-02-20T23:31:05.389Z] Camera thread performed 122 scans. [2026-02-20T23:31:05.389Z] ====== philosophers (scala) [default], iteration 1 completed (5726.697 ms) ====== [2026-02-20T23:31:05.389Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-20T23:31:05.389Z] GC before operation: completed in 30.424 ms, heap usage 14.288 MB -> 5.024 MB. [2026-02-20T23:31:12.982Z] Camera thread performed 122 scans. [2026-02-20T23:31:12.982Z] ====== philosophers (scala) [default], iteration 2 completed (7942.816 ms) ====== [2026-02-20T23:31:12.982Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-20T23:31:12.982Z] GC before operation: completed in 34.810 ms, heap usage 20.435 MB -> 5.024 MB. [2026-02-20T23:31:19.800Z] Camera thread performed 122 scans. [2026-02-20T23:31:19.800Z] ====== philosophers (scala) [default], iteration 3 completed (6936.715 ms) ====== [2026-02-20T23:31:19.800Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-20T23:31:19.800Z] GC before operation: completed in 27.984 ms, heap usage 26.122 MB -> 5.032 MB. [2026-02-20T23:31:25.273Z] Camera thread performed 122 scans. [2026-02-20T23:31:25.273Z] ====== philosophers (scala) [default], iteration 4 completed (5944.738 ms) ====== [2026-02-20T23:31:25.273Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-20T23:31:25.273Z] GC before operation: completed in 26.783 ms, heap usage 16.746 MB -> 5.032 MB. [2026-02-20T23:31:32.140Z] Camera thread performed 122 scans. [2026-02-20T23:31:32.140Z] ====== philosophers (scala) [default], iteration 5 completed (6882.059 ms) ====== [2026-02-20T23:31:32.140Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-20T23:31:32.140Z] GC before operation: completed in 29.300 ms, heap usage 7.347 MB -> 5.032 MB. [2026-02-20T23:31:38.948Z] Camera thread performed 122 scans. [2026-02-20T23:31:38.948Z] ====== philosophers (scala) [default], iteration 6 completed (6410.491 ms) ====== [2026-02-20T23:31:38.948Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-20T23:31:38.948Z] GC before operation: completed in 26.300 ms, heap usage 21.097 MB -> 5.034 MB. [2026-02-20T23:31:45.751Z] Camera thread performed 122 scans. [2026-02-20T23:31:45.751Z] ====== philosophers (scala) [default], iteration 7 completed (6632.838 ms) ====== [2026-02-20T23:31:45.751Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-20T23:31:45.751Z] GC before operation: completed in 37.478 ms, heap usage 10.198 MB -> 5.033 MB. [2026-02-20T23:31:49.985Z] Camera thread performed 122 scans. [2026-02-20T23:31:49.985Z] ====== philosophers (scala) [default], iteration 8 completed (4570.016 ms) ====== [2026-02-20T23:31:49.985Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-20T23:31:49.985Z] GC before operation: completed in 39.284 ms, heap usage 18.170 MB -> 5.034 MB. [2026-02-20T23:31:56.803Z] Camera thread performed 122 scans. [2026-02-20T23:31:56.803Z] ====== philosophers (scala) [default], iteration 9 completed (5786.162 ms) ====== [2026-02-20T23:31:56.803Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-20T23:31:56.803Z] GC before operation: completed in 30.702 ms, heap usage 5.729 MB -> 5.033 MB. [2026-02-20T23:32:02.269Z] Camera thread performed 122 scans. [2026-02-20T23:32:02.269Z] ====== philosophers (scala) [default], iteration 10 completed (6604.560 ms) ====== [2026-02-20T23:32:02.269Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-20T23:32:03.240Z] GC before operation: completed in 32.003 ms, heap usage 19.893 MB -> 5.036 MB. [2026-02-20T23:32:08.735Z] Camera thread performed 122 scans. [2026-02-20T23:32:08.735Z] ====== philosophers (scala) [default], iteration 11 completed (6082.008 ms) ====== [2026-02-20T23:32:08.735Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-20T23:32:08.735Z] GC before operation: completed in 29.555 ms, heap usage 27.677 MB -> 5.036 MB. [2026-02-20T23:32:15.551Z] Camera thread performed 122 scans. [2026-02-20T23:32:15.551Z] ====== philosophers (scala) [default], iteration 12 completed (7052.974 ms) ====== [2026-02-20T23:32:15.551Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-20T23:32:15.551Z] GC before operation: completed in 27.399 ms, heap usage 7.322 MB -> 5.037 MB. [2026-02-20T23:32:22.359Z] Camera thread performed 122 scans. [2026-02-20T23:32:22.359Z] ====== philosophers (scala) [default], iteration 13 completed (6258.777 ms) ====== [2026-02-20T23:32:22.359Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-20T23:32:22.359Z] GC before operation: completed in 33.201 ms, heap usage 36.592 MB -> 5.037 MB. [2026-02-20T23:32:28.566Z] Camera thread performed 122 scans. [2026-02-20T23:32:28.566Z] ====== philosophers (scala) [default], iteration 14 completed (5657.641 ms) ====== [2026-02-20T23:32:28.566Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-20T23:32:28.566Z] GC before operation: completed in 29.543 ms, heap usage 9.223 MB -> 5.037 MB. [2026-02-20T23:32:35.672Z] Camera thread performed 122 scans. [2026-02-20T23:32:35.672Z] ====== philosophers (scala) [default], iteration 15 completed (7081.022 ms) ====== [2026-02-20T23:32:35.672Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-20T23:32:35.672Z] GC before operation: completed in 27.072 ms, heap usage 28.264 MB -> 5.037 MB. [2026-02-20T23:32:42.494Z] Camera thread performed 122 scans. [2026-02-20T23:32:42.494Z] ====== philosophers (scala) [default], iteration 16 completed (7081.503 ms) ====== [2026-02-20T23:32:42.494Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-20T23:32:42.494Z] GC before operation: completed in 30.799 ms, heap usage 21.214 MB -> 5.037 MB. [2026-02-20T23:32:49.309Z] Camera thread performed 122 scans. [2026-02-20T23:32:49.309Z] ====== philosophers (scala) [default], iteration 17 completed (6756.434 ms) ====== [2026-02-20T23:32:49.309Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-20T23:32:49.309Z] GC before operation: completed in 27.295 ms, heap usage 25.067 MB -> 5.037 MB. [2026-02-20T23:32:56.142Z] Camera thread performed 122 scans. [2026-02-20T23:32:56.142Z] ====== philosophers (scala) [default], iteration 18 completed (7319.384 ms) ====== [2026-02-20T23:32:56.142Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-20T23:32:56.142Z] GC before operation: completed in 27.032 ms, heap usage 11.824 MB -> 5.037 MB. [2026-02-20T23:33:02.952Z] Camera thread performed 122 scans. [2026-02-20T23:33:02.952Z] ====== philosophers (scala) [default], iteration 19 completed (6969.758 ms) ====== [2026-02-20T23:33:02.952Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-20T23:33:02.952Z] GC before operation: completed in 27.524 ms, heap usage 7.203 MB -> 5.037 MB. [2026-02-20T23:33:09.882Z] Camera thread performed 122 scans. [2026-02-20T23:33:09.882Z] ====== philosophers (scala) [default], iteration 20 completed (6043.890 ms) ====== [2026-02-20T23:33:09.882Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-20T23:33:09.882Z] GC before operation: completed in 25.674 ms, heap usage 25.318 MB -> 5.037 MB. [2026-02-20T23:33:15.349Z] Camera thread performed 122 scans. [2026-02-20T23:33:15.349Z] ====== philosophers (scala) [default], iteration 21 completed (5970.352 ms) ====== [2026-02-20T23:33:15.349Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-20T23:33:15.349Z] GC before operation: completed in 24.323 ms, heap usage 16.306 MB -> 5.037 MB. [2026-02-20T23:33:19.587Z] Camera thread performed 122 scans. [2026-02-20T23:33:19.587Z] ====== philosophers (scala) [default], iteration 22 completed (4178.483 ms) ====== [2026-02-20T23:33:19.587Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-20T23:33:19.587Z] GC before operation: completed in 25.298 ms, heap usage 14.752 MB -> 5.037 MB. [2026-02-20T23:33:27.872Z] Camera thread performed 122 scans. [2026-02-20T23:33:27.872Z] ====== philosophers (scala) [default], iteration 23 completed (7362.654 ms) ====== [2026-02-20T23:33:27.872Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-20T23:33:27.872Z] GC before operation: completed in 29.605 ms, heap usage 6.564 MB -> 5.037 MB. [2026-02-20T23:33:34.141Z] Camera thread performed 122 scans. [2026-02-20T23:33:34.141Z] ====== philosophers (scala) [default], iteration 24 completed (6118.094 ms) ====== [2026-02-20T23:33:34.141Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-20T23:33:34.141Z] GC before operation: completed in 25.662 ms, heap usage 13.323 MB -> 5.038 MB. [2026-02-20T23:33:38.368Z] Camera thread performed 122 scans. [2026-02-20T23:33:38.368Z] ====== philosophers (scala) [default], iteration 25 completed (4622.189 ms) ====== [2026-02-20T23:33:38.368Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-20T23:33:38.368Z] GC before operation: completed in 26.705 ms, heap usage 17.291 MB -> 5.039 MB. [2026-02-20T23:33:43.833Z] Camera thread performed 122 scans. [2026-02-20T23:33:43.833Z] ====== philosophers (scala) [default], iteration 26 completed (5683.108 ms) ====== [2026-02-20T23:33:43.833Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-20T23:33:43.833Z] GC before operation: completed in 27.365 ms, heap usage 22.135 MB -> 5.039 MB. [2026-02-20T23:33:49.306Z] Camera thread performed 122 scans. [2026-02-20T23:33:49.306Z] ====== philosophers (scala) [default], iteration 27 completed (6225.792 ms) ====== [2026-02-20T23:33:49.306Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-20T23:33:49.306Z] GC before operation: completed in 26.074 ms, heap usage 9.659 MB -> 5.039 MB. [2026-02-20T23:33:56.122Z] Camera thread performed 122 scans. [2026-02-20T23:33:56.122Z] ====== philosophers (scala) [default], iteration 28 completed (6262.524 ms) ====== [2026-02-20T23:33:56.122Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-20T23:33:56.122Z] GC before operation: completed in 29.705 ms, heap usage 28.482 MB -> 5.039 MB. [2026-02-20T23:34:00.357Z] Camera thread performed 122 scans. [2026-02-20T23:34:00.357Z] ====== philosophers (scala) [default], iteration 29 completed (4303.802 ms) ====== [2026-02-20T23:34:00.357Z] ----------------------------------- [2026-02-20T23:34:00.357Z] renaissance-philosophers_0_PASSED [2026-02-20T23:34:00.357Z] ----------------------------------- [2026-02-20T23:34:00.357Z] [2026-02-20T23:34:00.357Z] TEST TEARDOWN: [2026-02-20T23:34:00.357Z] Nothing to be done for teardown. [2026-02-20T23:34:00.357Z] renaissance-philosophers_0 Finish Time: Fri Feb 20 23:34:00 2026 Epoch Time (ms): 1771630440168