[2025-12-17T22:30:56.168Z] Running test renaissance-philosophers_0 ... [2025-12-17T22:30:56.168Z] =============================================== [2025-12-17T22:30:56.168Z] renaissance-philosophers_0 Start Time: Wed Dec 17 22:30:37 2025 Epoch Time (ms): 1766010637853 [2025-12-17T22:30:56.168Z] variation: NoOptions [2025-12-17T22:30:56.168Z] JVM_OPTIONS: [2025-12-17T22:30:56.168Z] { \ [2025-12-17T22:30:56.168Z] echo ""; echo "TEST SETUP:"; \ [2025-12-17T22:30:56.168Z] echo "Nothing to be done for setup."; \ [2025-12-17T22:30:56.168Z] mkdir -p "/ssd/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17660082904139/renaissance-philosophers_0"; \ [2025-12-17T22:30:56.168Z] cd "/ssd/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17660082904139/renaissance-philosophers_0"; \ [2025-12-17T22:30:56.168Z] echo ""; echo "TESTING:"; \ [2025-12-17T22:30:56.168Z] "/ssd/jenkins/workspace/Test_openjdk17_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 "/ssd/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/ssd/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17660082904139/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-12-17T22:30:56.169Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /ssd/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/..; rm -f -r "/ssd/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17660082904139/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-17T22:30:56.169Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-17T22:30:56.169Z] echo "Nothing to be done for teardown."; \ [2025-12-17T22:30:56.169Z] } 2>&1 | tee -a "/ssd/jenkins/workspace/Test_openjdk17_hs_extended.perf_arm_linux/aqa-tests/TKG/../TKG/output_17660082904139/TestTargetResult"; [2025-12-17T22:30:56.169Z] [2025-12-17T22:30:56.169Z] TEST SETUP: [2025-12-17T22:30:56.169Z] Nothing to be done for setup. [2025-12-17T22:30:56.169Z] [2025-12-17T22:30:56.169Z] TESTING: [2025-12-17T22:30:56.169Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-12-17T22:30:56.169Z] GC before operation: completed in 63.130 ms, heap usage 15.068 MB -> 4.667 MB. [2025-12-17T22:31:20.775Z] Camera thread performed 122 scans. [2025-12-17T22:31:20.775Z] ====== philosophers (scala) [default], iteration 0 completed (37589.647 ms) ====== [2025-12-17T22:31:20.775Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-12-17T22:31:20.775Z] GC before operation: completed in 57.339 ms, heap usage 11.082 MB -> 5.072 MB. [2025-12-17T22:31:55.772Z] Camera thread performed 122 scans. [2025-12-17T22:31:55.772Z] ====== philosophers (scala) [default], iteration 1 completed (32010.530 ms) ====== [2025-12-17T22:31:55.772Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-12-17T22:31:55.772Z] GC before operation: completed in 51.763 ms, heap usage 25.284 MB -> 5.075 MB. [2025-12-17T22:32:25.130Z] Camera thread performed 122 scans. [2025-12-17T22:32:25.130Z] ====== philosophers (scala) [default], iteration 2 completed (32105.989 ms) ====== [2025-12-17T22:32:25.130Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-12-17T22:32:25.130Z] GC before operation: completed in 61.443 ms, heap usage 23.280 MB -> 5.075 MB. [2025-12-17T22:33:00.034Z] Camera thread performed 122 scans. [2025-12-17T22:33:00.034Z] ====== philosophers (scala) [default], iteration 3 completed (32462.994 ms) ====== [2025-12-17T22:33:00.034Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-12-17T22:33:00.034Z] GC before operation: completed in 65.712 ms, heap usage 5.875 MB -> 5.076 MB. [2025-12-17T22:33:29.221Z] Camera thread performed 122 scans. [2025-12-17T22:33:29.221Z] ====== philosophers (scala) [default], iteration 4 completed (32238.996 ms) ====== [2025-12-17T22:33:29.221Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-12-17T22:33:29.221Z] GC before operation: completed in 44.697 ms, heap usage 7.013 MB -> 5.077 MB. [2025-12-17T22:34:04.202Z] Camera thread performed 122 scans. [2025-12-17T22:34:04.202Z] ====== philosophers (scala) [default], iteration 5 completed (32680.083 ms) ====== [2025-12-17T22:34:04.202Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-12-17T22:34:04.202Z] GC before operation: completed in 44.230 ms, heap usage 21.544 MB -> 5.079 MB. [2025-12-17T22:34:39.323Z] Camera thread performed 122 scans. [2025-12-17T22:34:39.323Z] ====== philosophers (scala) [default], iteration 6 completed (32918.059 ms) ====== [2025-12-17T22:34:39.323Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-12-17T22:34:39.323Z] GC before operation: completed in 44.326 ms, heap usage 25.985 MB -> 5.079 MB. [2025-12-17T22:35:08.654Z] Camera thread performed 122 scans. [2025-12-17T22:35:08.654Z] ====== philosophers (scala) [default], iteration 7 completed (32754.853 ms) ====== [2025-12-17T22:35:08.654Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-12-17T22:35:08.654Z] GC before operation: completed in 44.476 ms, heap usage 19.188 MB -> 5.079 MB. [2025-12-17T22:35:43.634Z] Camera thread performed 122 scans. [2025-12-17T22:35:43.634Z] ====== philosophers (scala) [default], iteration 8 completed (32360.031 ms) ====== [2025-12-17T22:35:43.634Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-12-17T22:35:43.634Z] GC before operation: completed in 32.929 ms, heap usage 34.024 MB -> 5.079 MB. [2025-12-17T22:36:12.805Z] Camera thread performed 122 scans. [2025-12-17T22:36:12.805Z] ====== philosophers (scala) [default], iteration 9 completed (33161.350 ms) ====== [2025-12-17T22:36:12.805Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-12-17T22:36:12.805Z] GC before operation: completed in 49.163 ms, heap usage 22.444 MB -> 5.080 MB. [2025-12-17T22:36:47.809Z] Camera thread performed 122 scans. [2025-12-17T22:36:47.809Z] ====== philosophers (scala) [default], iteration 10 completed (33258.678 ms) ====== [2025-12-17T22:36:47.809Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-12-17T22:36:47.809Z] GC before operation: completed in 56.205 ms, heap usage 21.564 MB -> 5.081 MB. [2025-12-17T22:37:22.745Z] Camera thread performed 122 scans. [2025-12-17T22:37:22.745Z] ====== philosophers (scala) [default], iteration 11 completed (32853.759 ms) ====== [2025-12-17T22:37:22.745Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-12-17T22:37:22.745Z] GC before operation: completed in 43.650 ms, heap usage 6.576 MB -> 5.081 MB. [2025-12-17T22:37:52.017Z] Camera thread performed 122 scans. [2025-12-17T22:37:52.017Z] ====== philosophers (scala) [default], iteration 12 completed (32902.841 ms) ====== [2025-12-17T22:37:52.017Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-12-17T22:37:52.017Z] GC before operation: completed in 51.819 ms, heap usage 29.405 MB -> 5.081 MB. [2025-12-17T22:38:27.015Z] Camera thread performed 122 scans. [2025-12-17T22:38:27.015Z] ====== philosophers (scala) [default], iteration 13 completed (32994.508 ms) ====== [2025-12-17T22:38:27.015Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-12-17T22:38:27.015Z] GC before operation: completed in 44.584 ms, heap usage 16.765 MB -> 5.081 MB. [2025-12-17T22:39:01.905Z] Camera thread performed 122 scans. [2025-12-17T22:39:01.905Z] ====== philosophers (scala) [default], iteration 14 completed (32638.800 ms) ====== [2025-12-17T22:39:01.905Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-12-17T22:39:01.905Z] GC before operation: completed in 50.110 ms, heap usage 26.019 MB -> 4.386 MB. [2025-12-17T22:39:31.123Z] Camera thread performed 122 scans. [2025-12-17T22:39:31.123Z] ====== philosophers (scala) [default], iteration 15 completed (33072.579 ms) ====== [2025-12-17T22:39:31.123Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-12-17T22:39:31.123Z] GC before operation: completed in 40.615 ms, heap usage 11.072 MB -> 4.386 MB. [2025-12-17T22:40:06.037Z] Camera thread performed 122 scans. [2025-12-17T22:40:06.037Z] ====== philosophers (scala) [default], iteration 16 completed (32653.888 ms) ====== [2025-12-17T22:40:06.037Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-12-17T22:40:06.037Z] GC before operation: completed in 39.551 ms, heap usage 29.700 MB -> 3.746 MB. [2025-12-17T22:40:41.006Z] Camera thread performed 122 scans. [2025-12-17T22:40:41.006Z] ====== philosophers (scala) [default], iteration 17 completed (32537.361 ms) ====== [2025-12-17T22:40:41.006Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-12-17T22:40:41.006Z] GC before operation: completed in 41.675 ms, heap usage 8.908 MB -> 3.746 MB. [2025-12-17T22:41:10.199Z] Camera thread performed 122 scans. [2025-12-17T22:41:10.199Z] ====== philosophers (scala) [default], iteration 18 completed (33377.418 ms) ====== [2025-12-17T22:41:10.199Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-12-17T22:41:10.199Z] GC before operation: completed in 31.093 ms, heap usage 28.653 MB -> 3.746 MB. [2025-12-17T22:41:45.041Z] Camera thread performed 122 scans. [2025-12-17T22:41:45.041Z] ====== philosophers (scala) [default], iteration 19 completed (32628.516 ms) ====== [2025-12-17T22:41:45.041Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-12-17T22:41:45.041Z] GC before operation: completed in 57.866 ms, heap usage 10.986 MB -> 3.746 MB. [2025-12-17T22:42:34.195Z] test-sxa-armv7l-ubuntu2004-odroid-2 seems to be removed or offline (java.lang.InterruptedException); will wait for 5 min 0 sec for it to come back online [2025-12-17T22:42:34.495Z] test-sxa-armv7l-ubuntu2004-odroid-2 is back online [2025-12-17T22:42:45.053Z] Camera thread performed 122 scans. [2025-12-17T22:42:45.053Z] ====== philosophers (scala) [default], iteration 20 completed (32360.122 ms) ====== [2025-12-17T22:42:45.053Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-12-17T22:42:45.053Z] GC before operation: completed in 38.915 ms, heap usage 8.656 MB -> 3.746 MB. [2025-12-17T22:42:46.459Z] Camera thread performed 122 scans. [2025-12-17T22:42:46.459Z] ====== philosophers (scala) [default], iteration 21 completed (32217.782 ms) ====== [2025-12-17T22:42:46.459Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-12-17T22:42:46.459Z] GC before operation: completed in 40.560 ms, heap usage 27.391 MB -> 3.746 MB. [2025-12-17T22:43:21.361Z] Camera thread performed 122 scans. [2025-12-17T22:43:21.361Z] ====== philosophers (scala) [default], iteration 22 completed (32913.980 ms) ====== [2025-12-17T22:43:21.361Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-12-17T22:43:21.361Z] GC before operation: completed in 48.169 ms, heap usage 27.372 MB -> 3.747 MB. [2025-12-17T22:43:56.304Z] Camera thread performed 122 scans. [2025-12-17T22:43:56.305Z] ====== philosophers (scala) [default], iteration 23 completed (31675.336 ms) ====== [2025-12-17T22:43:56.305Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-12-17T22:43:56.305Z] GC before operation: completed in 37.350 ms, heap usage 6.713 MB -> 3.746 MB. [2025-12-17T22:44:25.512Z] Camera thread performed 122 scans. [2025-12-17T22:44:25.512Z] ====== philosophers (scala) [default], iteration 24 completed (32580.793 ms) ====== [2025-12-17T22:44:25.512Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-12-17T22:44:25.512Z] GC before operation: completed in 49.001 ms, heap usage 16.413 MB -> 3.747 MB. [2025-12-17T22:45:00.373Z] Camera thread performed 122 scans. [2025-12-17T22:45:00.373Z] ====== philosophers (scala) [default], iteration 25 completed (33778.101 ms) ====== [2025-12-17T22:45:00.373Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-12-17T22:45:00.373Z] GC before operation: completed in 39.024 ms, heap usage 29.507 MB -> 3.747 MB. [2025-12-17T22:45:35.350Z] Camera thread performed 122 scans. [2025-12-17T22:45:35.350Z] ====== philosophers (scala) [default], iteration 26 completed (32955.252 ms) ====== [2025-12-17T22:45:35.350Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-12-17T22:45:35.350Z] GC before operation: completed in 26.337 ms, heap usage 6.235 MB -> 3.747 MB. [2025-12-17T22:46:04.568Z] Camera thread performed 122 scans. [2025-12-17T22:46:04.568Z] ====== philosophers (scala) [default], iteration 27 completed (32541.302 ms) ====== [2025-12-17T22:46:04.568Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-12-17T22:46:04.568Z] GC before operation: completed in 50.171 ms, heap usage 14.384 MB -> 3.747 MB. [2025-12-17T22:46:39.495Z] Camera thread performed 122 scans. [2025-12-17T22:46:39.495Z] ====== philosophers (scala) [default], iteration 28 completed (32806.905 ms) ====== [2025-12-17T22:46:39.495Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-12-17T22:46:39.495Z] GC before operation: completed in 48.467 ms, heap usage 30.494 MB -> 3.747 MB. [2025-12-17T22:47:14.409Z] Camera thread performed 122 scans. [2025-12-17T22:47:14.409Z] ====== philosophers (scala) [default], iteration 29 completed (33321.476 ms) ====== [2025-12-17T22:47:14.409Z] ----------------------------------- [2025-12-17T22:47:14.409Z] renaissance-philosophers_0_PASSED [2025-12-17T22:47:14.409Z] ----------------------------------- [2025-12-17T22:47:14.409Z] [2025-12-17T22:47:14.409Z] TEST TEARDOWN: [2025-12-17T22:47:14.409Z] Nothing to be done for teardown. [2025-12-17T22:47:14.409Z] renaissance-philosophers_0 Finish Time: Wed Dec 17 22:47:09 2025 Epoch Time (ms): 1766011629754