[2025-08-25T22:18:40.899Z] Running test renaissance-scala-kmeans_0 ... [2025-08-25T22:18:40.899Z] =============================================== [2025-08-25T22:18:40.899Z] renaissance-scala-kmeans_0 Start Time: Mon Aug 25 22:18:40 2025 Epoch Time (ms): 1756160320229 [2025-08-25T22:18:40.899Z] variation: NoOptions [2025-08-25T22:18:40.899Z] JVM_OPTIONS: [2025-08-25T22:18:40.899Z] { \ [2025-08-25T22:18:40.899Z] echo ""; echo "TEST SETUP:"; \ [2025-08-25T22:18:40.899Z] echo "Nothing to be done for setup."; \ [2025-08-25T22:18:40.899Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17561583406012/renaissance-scala-kmeans_0"; \ [2025-08-25T22:18:40.899Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17561583406012/renaissance-scala-kmeans_0"; \ [2025-08-25T22:18:40.899Z] echo ""; echo "TESTING:"; \ [2025-08-25T22:18:40.899Z] /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17561583406012/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; \ [2025-08-25T22:18:40.899Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17561583406012/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-25T22:18:40.899Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-25T22:18:40.899Z] echo "Nothing to be done for teardown."; \ [2025-08-25T22:18:40.899Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17561583406012/TestTargetResult"; [2025-08-25T22:18:40.899Z] [2025-08-25T22:18:40.899Z] TEST SETUP: [2025-08-25T22:18:40.899Z] Nothing to be done for setup. [2025-08-25T22:18:40.899Z] [2025-08-25T22:18:40.899Z] TESTING: [2025-08-25T22:18:40.899Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-08-25T22:18:40.899Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17561583406012/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-08-25T22:18:42.842Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-08-25T22:18:42.842Z] GC before operation: completed in 50.871 ms, heap usage 52.540 MB -> 25.514 MB. [2025-08-25T22:18:42.842Z] ====== scala-kmeans (scala) [default], iteration 0 completed (507.248 ms) ====== [2025-08-25T22:18:42.842Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-08-25T22:18:42.842Z] GC before operation: completed in 63.720 ms, heap usage 32.514 MB -> 25.619 MB. [2025-08-25T22:18:43.813Z] ====== scala-kmeans (scala) [default], iteration 1 completed (369.535 ms) ====== [2025-08-25T22:18:43.813Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-08-25T22:18:43.813Z] GC before operation: completed in 55.792 ms, heap usage 68.646 MB -> 25.619 MB. [2025-08-25T22:18:43.813Z] ====== scala-kmeans (scala) [default], iteration 2 completed (372.225 ms) ====== [2025-08-25T22:18:43.813Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-08-25T22:18:43.813Z] GC before operation: completed in 55.137 ms, heap usage 66.882 MB -> 25.619 MB. [2025-08-25T22:18:44.759Z] ====== scala-kmeans (scala) [default], iteration 3 completed (373.498 ms) ====== [2025-08-25T22:18:44.759Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-08-25T22:18:44.759Z] GC before operation: completed in 55.430 ms, heap usage 66.700 MB -> 25.619 MB. [2025-08-25T22:18:44.759Z] ====== scala-kmeans (scala) [default], iteration 4 completed (361.967 ms) ====== [2025-08-25T22:18:44.759Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-08-25T22:18:44.759Z] GC before operation: completed in 53.296 ms, heap usage 67.827 MB -> 25.619 MB. [2025-08-25T22:18:45.704Z] ====== scala-kmeans (scala) [default], iteration 5 completed (368.647 ms) ====== [2025-08-25T22:18:45.704Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-08-25T22:18:45.704Z] GC before operation: completed in 58.723 ms, heap usage 68.592 MB -> 25.619 MB. [2025-08-25T22:18:45.704Z] ====== scala-kmeans (scala) [default], iteration 6 completed (374.211 ms) ====== [2025-08-25T22:18:45.704Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-08-25T22:18:45.704Z] GC before operation: completed in 53.381 ms, heap usage 68.651 MB -> 25.619 MB. [2025-08-25T22:18:46.658Z] ====== scala-kmeans (scala) [default], iteration 7 completed (383.991 ms) ====== [2025-08-25T22:18:46.658Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-08-25T22:18:46.658Z] GC before operation: completed in 54.450 ms, heap usage 67.645 MB -> 25.619 MB. [2025-08-25T22:18:46.658Z] ====== scala-kmeans (scala) [default], iteration 8 completed (375.968 ms) ====== [2025-08-25T22:18:46.658Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-08-25T22:18:46.658Z] GC before operation: completed in 53.807 ms, heap usage 64.963 MB -> 25.620 MB. [2025-08-25T22:18:46.658Z] ====== scala-kmeans (scala) [default], iteration 9 completed (370.943 ms) ====== [2025-08-25T22:18:46.658Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-08-25T22:18:47.603Z] GC before operation: completed in 54.082 ms, heap usage 64.897 MB -> 25.620 MB. [2025-08-25T22:18:47.603Z] ====== scala-kmeans (scala) [default], iteration 10 completed (373.517 ms) ====== [2025-08-25T22:18:47.603Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-08-25T22:18:47.603Z] GC before operation: completed in 53.819 ms, heap usage 64.920 MB -> 25.620 MB. [2025-08-25T22:18:47.603Z] ====== scala-kmeans (scala) [default], iteration 11 completed (375.475 ms) ====== [2025-08-25T22:18:47.603Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-08-25T22:18:47.603Z] GC before operation: completed in 54.116 ms, heap usage 64.765 MB -> 25.620 MB. [2025-08-25T22:18:48.551Z] ====== scala-kmeans (scala) [default], iteration 12 completed (367.258 ms) ====== [2025-08-25T22:18:48.551Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-08-25T22:18:48.551Z] GC before operation: completed in 54.016 ms, heap usage 64.927 MB -> 25.620 MB. [2025-08-25T22:18:48.551Z] ====== scala-kmeans (scala) [default], iteration 13 completed (365.741 ms) ====== [2025-08-25T22:18:48.551Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-08-25T22:18:48.551Z] GC before operation: completed in 56.230 ms, heap usage 64.928 MB -> 25.620 MB. [2025-08-25T22:18:49.497Z] ====== scala-kmeans (scala) [default], iteration 14 completed (366.985 ms) ====== [2025-08-25T22:18:49.497Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-08-25T22:18:49.497Z] GC before operation: completed in 53.882 ms, heap usage 64.767 MB -> 25.620 MB. [2025-08-25T22:18:49.497Z] ====== scala-kmeans (scala) [default], iteration 15 completed (373.734 ms) ====== [2025-08-25T22:18:49.497Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-08-25T22:18:49.497Z] GC before operation: completed in 54.399 ms, heap usage 64.767 MB -> 25.621 MB. [2025-08-25T22:18:50.444Z] ====== scala-kmeans (scala) [default], iteration 16 completed (372.628 ms) ====== [2025-08-25T22:18:50.444Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-08-25T22:18:50.444Z] GC before operation: completed in 56.433 ms, heap usage 64.928 MB -> 25.621 MB. [2025-08-25T22:18:50.444Z] ====== scala-kmeans (scala) [default], iteration 17 completed (370.137 ms) ====== [2025-08-25T22:18:50.444Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-08-25T22:18:50.444Z] GC before operation: completed in 53.554 ms, heap usage 64.767 MB -> 25.621 MB. [2025-08-25T22:18:51.400Z] ====== scala-kmeans (scala) [default], iteration 18 completed (375.567 ms) ====== [2025-08-25T22:18:51.400Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-08-25T22:18:51.400Z] GC before operation: completed in 53.908 ms, heap usage 64.928 MB -> 25.621 MB. [2025-08-25T22:18:51.400Z] ====== scala-kmeans (scala) [default], iteration 19 completed (376.833 ms) ====== [2025-08-25T22:18:51.400Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-08-25T22:18:51.400Z] GC before operation: completed in 55.815 ms, heap usage 64.928 MB -> 25.621 MB. [2025-08-25T22:18:51.400Z] ====== scala-kmeans (scala) [default], iteration 20 completed (372.079 ms) ====== [2025-08-25T22:18:51.400Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-08-25T22:18:52.346Z] GC before operation: completed in 55.578 ms, heap usage 64.767 MB -> 25.621 MB. [2025-08-25T22:18:52.346Z] ====== scala-kmeans (scala) [default], iteration 21 completed (376.458 ms) ====== [2025-08-25T22:18:52.347Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-08-25T22:18:52.347Z] GC before operation: completed in 53.080 ms, heap usage 64.928 MB -> 25.621 MB. [2025-08-25T22:18:52.347Z] ====== scala-kmeans (scala) [default], iteration 22 completed (373.851 ms) ====== [2025-08-25T22:18:52.347Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-08-25T22:18:52.347Z] GC before operation: completed in 52.940 ms, heap usage 64.767 MB -> 25.622 MB. [2025-08-25T22:18:53.296Z] ====== scala-kmeans (scala) [default], iteration 23 completed (377.916 ms) ====== [2025-08-25T22:18:53.296Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-08-25T22:18:53.296Z] GC before operation: completed in 61.058 ms, heap usage 64.929 MB -> 25.622 MB. [2025-08-25T22:18:53.296Z] ====== scala-kmeans (scala) [default], iteration 24 completed (371.257 ms) ====== [2025-08-25T22:18:53.296Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-08-25T22:18:53.296Z] GC before operation: completed in 53.559 ms, heap usage 64.929 MB -> 25.622 MB. [2025-08-25T22:18:54.245Z] ====== scala-kmeans (scala) [default], iteration 25 completed (372.643 ms) ====== [2025-08-25T22:18:54.245Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-08-25T22:18:54.245Z] GC before operation: completed in 51.356 ms, heap usage 64.768 MB -> 25.623 MB. [2025-08-25T22:18:54.245Z] ====== scala-kmeans (scala) [default], iteration 26 completed (371.220 ms) ====== [2025-08-25T22:18:54.245Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-08-25T22:18:54.245Z] GC before operation: completed in 56.520 ms, heap usage 64.931 MB -> 25.623 MB. [2025-08-25T22:18:55.193Z] ====== scala-kmeans (scala) [default], iteration 27 completed (377.423 ms) ====== [2025-08-25T22:18:55.193Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-08-25T22:18:55.193Z] GC before operation: completed in 54.659 ms, heap usage 64.931 MB -> 25.623 MB. [2025-08-25T22:18:55.193Z] ====== scala-kmeans (scala) [default], iteration 28 completed (368.996 ms) ====== [2025-08-25T22:18:55.193Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-08-25T22:18:55.193Z] GC before operation: completed in 52.959 ms, heap usage 64.931 MB -> 25.623 MB. [2025-08-25T22:18:56.139Z] ====== scala-kmeans (scala) [default], iteration 29 completed (369.451 ms) ====== [2025-08-25T22:18:56.139Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-08-25T22:18:56.139Z] GC before operation: completed in 52.228 ms, heap usage 64.931 MB -> 25.623 MB. [2025-08-25T22:18:56.139Z] ====== scala-kmeans (scala) [default], iteration 30 completed (373.917 ms) ====== [2025-08-25T22:18:56.139Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-08-25T22:18:56.139Z] GC before operation: completed in 52.152 ms, heap usage 64.931 MB -> 25.624 MB. [2025-08-25T22:18:56.139Z] ====== scala-kmeans (scala) [default], iteration 31 completed (374.658 ms) ====== [2025-08-25T22:18:56.139Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-08-25T22:18:56.139Z] GC before operation: completed in 52.693 ms, heap usage 64.931 MB -> 25.624 MB. [2025-08-25T22:18:57.089Z] ====== scala-kmeans (scala) [default], iteration 32 completed (370.584 ms) ====== [2025-08-25T22:18:57.089Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-08-25T22:18:57.089Z] GC before operation: completed in 53.357 ms, heap usage 64.931 MB -> 25.624 MB. [2025-08-25T22:18:57.089Z] ====== scala-kmeans (scala) [default], iteration 33 completed (371.198 ms) ====== [2025-08-25T22:18:57.089Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-08-25T22:18:57.089Z] GC before operation: completed in 53.254 ms, heap usage 64.931 MB -> 25.624 MB. [2025-08-25T22:18:58.036Z] ====== scala-kmeans (scala) [default], iteration 34 completed (372.749 ms) ====== [2025-08-25T22:18:58.036Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-08-25T22:18:58.036Z] GC before operation: completed in 54.090 ms, heap usage 64.931 MB -> 25.624 MB. [2025-08-25T22:18:58.036Z] ====== scala-kmeans (scala) [default], iteration 35 completed (377.492 ms) ====== [2025-08-25T22:18:58.036Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-08-25T22:18:58.036Z] GC before operation: completed in 54.488 ms, heap usage 64.771 MB -> 25.624 MB. [2025-08-25T22:18:58.983Z] ====== scala-kmeans (scala) [default], iteration 36 completed (371.864 ms) ====== [2025-08-25T22:18:58.983Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-08-25T22:18:58.983Z] GC before operation: completed in 53.341 ms, heap usage 64.932 MB -> 25.624 MB. [2025-08-25T22:18:58.983Z] ====== scala-kmeans (scala) [default], iteration 37 completed (372.024 ms) ====== [2025-08-25T22:18:58.983Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-08-25T22:18:58.983Z] GC before operation: completed in 52.777 ms, heap usage 64.932 MB -> 25.624 MB. [2025-08-25T22:18:59.929Z] ====== scala-kmeans (scala) [default], iteration 38 completed (372.410 ms) ====== [2025-08-25T22:18:59.929Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-08-25T22:18:59.929Z] GC before operation: completed in 53.532 ms, heap usage 64.771 MB -> 25.626 MB. [2025-08-25T22:18:59.929Z] ====== scala-kmeans (scala) [default], iteration 39 completed (372.323 ms) ====== [2025-08-25T22:18:59.929Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-08-25T22:18:59.929Z] GC before operation: completed in 53.530 ms, heap usage 64.773 MB -> 25.626 MB. [2025-08-25T22:18:59.929Z] ====== scala-kmeans (scala) [default], iteration 40 completed (376.490 ms) ====== [2025-08-25T22:18:59.929Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-08-25T22:19:00.876Z] GC before operation: completed in 53.786 ms, heap usage 64.773 MB -> 25.626 MB. [2025-08-25T22:19:00.876Z] ====== scala-kmeans (scala) [default], iteration 41 completed (371.184 ms) ====== [2025-08-25T22:19:00.876Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-08-25T22:19:00.876Z] GC before operation: completed in 52.198 ms, heap usage 64.934 MB -> 25.626 MB. [2025-08-25T22:19:00.876Z] ====== scala-kmeans (scala) [default], iteration 42 completed (372.077 ms) ====== [2025-08-25T22:19:00.876Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-08-25T22:19:00.876Z] GC before operation: completed in 52.926 ms, heap usage 64.934 MB -> 25.626 MB. [2025-08-25T22:19:01.823Z] ====== scala-kmeans (scala) [default], iteration 43 completed (370.294 ms) ====== [2025-08-25T22:19:01.823Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-08-25T22:19:01.823Z] GC before operation: completed in 57.702 ms, heap usage 64.773 MB -> 25.626 MB. [2025-08-25T22:19:01.823Z] ====== scala-kmeans (scala) [default], iteration 44 completed (374.624 ms) ====== [2025-08-25T22:19:01.823Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-08-25T22:19:01.823Z] GC before operation: completed in 54.143 ms, heap usage 66.773 MB -> 25.626 MB. [2025-08-25T22:19:02.769Z] ====== scala-kmeans (scala) [default], iteration 45 completed (370.036 ms) ====== [2025-08-25T22:19:02.769Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-08-25T22:19:02.769Z] GC before operation: completed in 52.526 ms, heap usage 66.727 MB -> 25.627 MB. [2025-08-25T22:19:02.769Z] ====== scala-kmeans (scala) [default], iteration 46 completed (370.343 ms) ====== [2025-08-25T22:19:02.769Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-08-25T22:19:02.769Z] GC before operation: completed in 53.412 ms, heap usage 67.716 MB -> 25.627 MB. [2025-08-25T22:19:03.717Z] ====== scala-kmeans (scala) [default], iteration 47 completed (374.291 ms) ====== [2025-08-25T22:19:03.717Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-08-25T22:19:03.717Z] GC before operation: completed in 52.697 ms, heap usage 67.550 MB -> 25.627 MB. [2025-08-25T22:19:03.717Z] ====== scala-kmeans (scala) [default], iteration 48 completed (372.160 ms) ====== [2025-08-25T22:19:03.717Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-08-25T22:19:03.717Z] GC before operation: completed in 58.196 ms, heap usage 67.684 MB -> 25.627 MB. [2025-08-25T22:19:04.665Z] ====== scala-kmeans (scala) [default], iteration 49 completed (372.974 ms) ====== [2025-08-25T22:19:04.665Z] ----------------------------------- [2025-08-25T22:19:04.665Z] renaissance-scala-kmeans_0_PASSED [2025-08-25T22:19:04.665Z] ----------------------------------- [2025-08-25T22:19:04.665Z] [2025-08-25T22:19:04.665Z] TEST TEARDOWN: [2025-08-25T22:19:04.665Z] Nothing to be done for teardown. [2025-08-25T22:19:04.665Z] renaissance-scala-kmeans_0 Finish Time: Mon Aug 25 22:19:03 2025 Epoch Time (ms): 1756160343912