[2025-09-25T00:05:04.445Z] Running test renaissance-scala-kmeans_0 ... [2025-09-25T00:05:04.445Z] =============================================== [2025-09-25T00:05:04.445Z] renaissance-scala-kmeans_0 Start Time: Thu Sep 25 00:05:04 2025 Epoch Time (ms): 1758758704081 [2025-09-25T00:05:04.445Z] variation: NoOptions [2025-09-25T00:05:04.445Z] JVM_OPTIONS: [2025-09-25T00:05:04.445Z] { \ [2025-09-25T00:05:04.445Z] echo ""; echo "TEST SETUP:"; \ [2025-09-25T00:05:04.445Z] echo "Nothing to be done for setup."; \ [2025-09-25T00:05:04.445Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17587570417247/renaissance-scala-kmeans_0"; \ [2025-09-25T00:05:04.445Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17587570417247/renaissance-scala-kmeans_0"; \ [2025-09-25T00:05:04.445Z] echo ""; echo "TESTING:"; \ [2025-09-25T00:05:04.445Z] /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17587570417247/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; \ [2025-09-25T00:05:04.445Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17587570417247/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-09-25T00:05:04.445Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-09-25T00:05:04.445Z] echo "Nothing to be done for teardown."; \ [2025-09-25T00:05:04.445Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17587570417247/TestTargetResult"; [2025-09-25T00:05:04.445Z] [2025-09-25T00:05:04.445Z] TEST SETUP: [2025-09-25T00:05:04.445Z] Nothing to be done for setup. [2025-09-25T00:05:04.445Z] [2025-09-25T00:05:04.445Z] TESTING: [2025-09-25T00:05:05.389Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-09-25T00:05:05.389Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17587570417247/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-09-25T00:05:06.339Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-09-25T00:05:06.339Z] GC before operation: completed in 48.857 ms, heap usage 36.075 MB -> 25.942 MB. [2025-09-25T00:05:06.339Z] ====== scala-kmeans (scala) [default], iteration 0 completed (618.918 ms) ====== [2025-09-25T00:05:06.340Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-09-25T00:05:07.443Z] GC before operation: completed in 81.005 ms, heap usage 30.828 MB -> 26.027 MB. [2025-09-25T00:05:07.443Z] ====== scala-kmeans (scala) [default], iteration 1 completed (476.309 ms) ====== [2025-09-25T00:05:07.443Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-09-25T00:05:07.443Z] GC before operation: completed in 47.443 ms, heap usage 54.787 MB -> 26.027 MB. [2025-09-25T00:05:07.443Z] ====== scala-kmeans (scala) [default], iteration 2 completed (498.105 ms) ====== [2025-09-25T00:05:07.443Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-09-25T00:05:08.385Z] GC before operation: completed in 29.465 ms, heap usage 98.101 MB -> 26.028 MB. [2025-09-25T00:05:08.385Z] ====== scala-kmeans (scala) [default], iteration 3 completed (474.514 ms) ====== [2025-09-25T00:05:08.385Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-09-25T00:05:08.385Z] GC before operation: completed in 42.363 ms, heap usage 42.996 MB -> 26.027 MB. [2025-09-25T00:05:09.331Z] ====== scala-kmeans (scala) [default], iteration 4 completed (472.551 ms) ====== [2025-09-25T00:05:09.331Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-09-25T00:05:09.331Z] GC before operation: completed in 42.351 ms, heap usage 46.825 MB -> 26.027 MB. [2025-09-25T00:05:09.331Z] ====== scala-kmeans (scala) [default], iteration 5 completed (471.694 ms) ====== [2025-09-25T00:05:09.331Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-09-25T00:05:09.331Z] GC before operation: completed in 44.438 ms, heap usage 46.323 MB -> 26.028 MB. [2025-09-25T00:05:11.046Z] ====== scala-kmeans (scala) [default], iteration 6 completed (486.440 ms) ====== [2025-09-25T00:05:11.046Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-09-25T00:05:11.046Z] GC before operation: completed in 25.789 ms, heap usage 96.292 MB -> 26.028 MB. [2025-09-25T00:05:11.046Z] ====== scala-kmeans (scala) [default], iteration 7 completed (472.658 ms) ====== [2025-09-25T00:05:11.046Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-09-25T00:05:11.046Z] GC before operation: completed in 42.793 ms, heap usage 40.664 MB -> 26.028 MB. [2025-09-25T00:05:11.046Z] ====== scala-kmeans (scala) [default], iteration 8 completed (471.649 ms) ====== [2025-09-25T00:05:11.046Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-09-25T00:05:11.046Z] GC before operation: completed in 42.245 ms, heap usage 41.070 MB -> 26.028 MB. [2025-09-25T00:05:11.987Z] ====== scala-kmeans (scala) [default], iteration 9 completed (473.727 ms) ====== [2025-09-25T00:05:11.987Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-09-25T00:05:11.987Z] GC before operation: completed in 42.399 ms, heap usage 41.069 MB -> 26.028 MB. [2025-09-25T00:05:11.987Z] ====== scala-kmeans (scala) [default], iteration 10 completed (486.074 ms) ====== [2025-09-25T00:05:11.987Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-09-25T00:05:11.987Z] GC before operation: completed in 23.736 ms, heap usage 94.336 MB -> 26.028 MB. [2025-09-25T00:05:12.929Z] ====== scala-kmeans (scala) [default], iteration 11 completed (475.810 ms) ====== [2025-09-25T00:05:12.929Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-09-25T00:05:12.929Z] GC before operation: completed in 42.958 ms, heap usage 40.110 MB -> 26.028 MB. [2025-09-25T00:05:12.929Z] ====== scala-kmeans (scala) [default], iteration 12 completed (468.296 ms) ====== [2025-09-25T00:05:12.929Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-09-25T00:05:12.929Z] GC before operation: completed in 42.935 ms, heap usage 41.164 MB -> 26.028 MB. [2025-09-25T00:05:13.871Z] ====== scala-kmeans (scala) [default], iteration 13 completed (472.494 ms) ====== [2025-09-25T00:05:13.871Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-09-25T00:05:13.871Z] GC before operation: completed in 42.184 ms, heap usage 41.160 MB -> 26.028 MB. [2025-09-25T00:05:13.871Z] ====== scala-kmeans (scala) [default], iteration 14 completed (474.806 ms) ====== [2025-09-25T00:05:13.871Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-09-25T00:05:13.871Z] GC before operation: completed in 23.675 ms, heap usage 94.337 MB -> 26.029 MB. [2025-09-25T00:05:14.816Z] ====== scala-kmeans (scala) [default], iteration 15 completed (459.840 ms) ====== [2025-09-25T00:05:14.817Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-09-25T00:05:14.817Z] GC before operation: completed in 41.828 ms, heap usage 36.351 MB -> 26.029 MB. [2025-09-25T00:05:14.817Z] ====== scala-kmeans (scala) [default], iteration 16 completed (457.678 ms) ====== [2025-09-25T00:05:14.817Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-09-25T00:05:14.817Z] GC before operation: completed in 42.491 ms, heap usage 41.101 MB -> 26.029 MB. [2025-09-25T00:05:15.766Z] ====== scala-kmeans (scala) [default], iteration 17 completed (458.623 ms) ====== [2025-09-25T00:05:15.766Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-09-25T00:05:15.766Z] GC before operation: completed in 41.750 ms, heap usage 41.162 MB -> 26.029 MB. [2025-09-25T00:05:15.766Z] ====== scala-kmeans (scala) [default], iteration 18 completed (469.391 ms) ====== [2025-09-25T00:05:15.766Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-09-25T00:05:15.766Z] GC before operation: completed in 30.562 ms, heap usage 94.472 MB -> 26.029 MB. [2025-09-25T00:05:16.707Z] ====== scala-kmeans (scala) [default], iteration 19 completed (459.469 ms) ====== [2025-09-25T00:05:16.707Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-09-25T00:05:16.707Z] GC before operation: completed in 42.916 ms, heap usage 36.352 MB -> 26.029 MB. [2025-09-25T00:05:16.707Z] ====== scala-kmeans (scala) [default], iteration 20 completed (458.008 ms) ====== [2025-09-25T00:05:16.707Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-09-25T00:05:16.707Z] GC before operation: completed in 42.790 ms, heap usage 41.102 MB -> 26.029 MB. [2025-09-25T00:05:17.654Z] ====== scala-kmeans (scala) [default], iteration 21 completed (461.836 ms) ====== [2025-09-25T00:05:17.654Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-09-25T00:05:17.654Z] GC before operation: completed in 42.160 ms, heap usage 41.162 MB -> 26.029 MB. [2025-09-25T00:05:17.654Z] ====== scala-kmeans (scala) [default], iteration 22 completed (470.558 ms) ====== [2025-09-25T00:05:17.654Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-09-25T00:05:18.596Z] GC before operation: completed in 24.267 ms, heap usage 94.338 MB -> 26.029 MB. [2025-09-25T00:05:18.596Z] ====== scala-kmeans (scala) [default], iteration 23 completed (461.889 ms) ====== [2025-09-25T00:05:18.596Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-09-25T00:05:18.596Z] GC before operation: completed in 42.462 ms, heap usage 36.351 MB -> 26.029 MB. [2025-09-25T00:05:19.538Z] ====== scala-kmeans (scala) [default], iteration 24 completed (459.615 ms) ====== [2025-09-25T00:05:19.538Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-09-25T00:05:19.538Z] GC before operation: completed in 42.903 ms, heap usage 41.101 MB -> 26.029 MB. [2025-09-25T00:05:19.538Z] ====== scala-kmeans (scala) [default], iteration 25 completed (454.645 ms) ====== [2025-09-25T00:05:19.538Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-09-25T00:05:19.538Z] GC before operation: completed in 42.287 ms, heap usage 41.163 MB -> 26.029 MB. [2025-09-25T00:05:20.482Z] ====== scala-kmeans (scala) [default], iteration 26 completed (468.056 ms) ====== [2025-09-25T00:05:20.482Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-09-25T00:05:20.482Z] GC before operation: completed in 23.190 ms, heap usage 94.338 MB -> 26.029 MB. [2025-09-25T00:05:20.482Z] ====== scala-kmeans (scala) [default], iteration 27 completed (458.766 ms) ====== [2025-09-25T00:05:20.482Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-09-25T00:05:20.482Z] GC before operation: completed in 42.441 ms, heap usage 40.195 MB -> 26.029 MB. [2025-09-25T00:05:21.425Z] ====== scala-kmeans (scala) [default], iteration 28 completed (459.898 ms) ====== [2025-09-25T00:05:21.425Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-09-25T00:05:21.425Z] GC before operation: completed in 43.721 ms, heap usage 41.074 MB -> 26.030 MB. [2025-09-25T00:05:21.425Z] ====== scala-kmeans (scala) [default], iteration 29 completed (457.457 ms) ====== [2025-09-25T00:05:21.425Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-09-25T00:05:21.425Z] GC before operation: completed in 43.184 ms, heap usage 41.071 MB -> 26.030 MB. [2025-09-25T00:05:22.369Z] ====== scala-kmeans (scala) [default], iteration 30 completed (468.908 ms) ====== [2025-09-25T00:05:22.369Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-09-25T00:05:22.369Z] GC before operation: completed in 26.836 ms, heap usage 94.473 MB -> 26.030 MB. [2025-09-25T00:05:22.369Z] ====== scala-kmeans (scala) [default], iteration 31 completed (455.844 ms) ====== [2025-09-25T00:05:22.369Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-09-25T00:05:22.369Z] GC before operation: completed in 42.572 ms, heap usage 40.195 MB -> 26.030 MB. [2025-09-25T00:05:23.312Z] ====== scala-kmeans (scala) [default], iteration 32 completed (457.337 ms) ====== [2025-09-25T00:05:23.312Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-09-25T00:05:23.312Z] GC before operation: completed in 42.821 ms, heap usage 40.194 MB -> 26.030 MB. [2025-09-25T00:05:23.312Z] ====== scala-kmeans (scala) [default], iteration 33 completed (458.140 ms) ====== [2025-09-25T00:05:23.312Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-09-25T00:05:23.312Z] GC before operation: completed in 42.647 ms, heap usage 41.079 MB -> 26.030 MB. [2025-09-25T00:05:24.255Z] ====== scala-kmeans (scala) [default], iteration 34 completed (470.188 ms) ====== [2025-09-25T00:05:24.255Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-09-25T00:05:24.255Z] GC before operation: completed in 23.517 ms, heap usage 94.475 MB -> 26.030 MB. [2025-09-25T00:05:24.255Z] ====== scala-kmeans (scala) [default], iteration 35 completed (457.131 ms) ====== [2025-09-25T00:05:24.255Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-09-25T00:05:24.255Z] GC before operation: completed in 42.452 ms, heap usage 40.196 MB -> 26.032 MB. [2025-09-25T00:05:25.196Z] ====== scala-kmeans (scala) [default], iteration 36 completed (456.583 ms) ====== [2025-09-25T00:05:25.196Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-09-25T00:05:25.196Z] GC before operation: completed in 42.682 ms, heap usage 43.879 MB -> 26.032 MB. [2025-09-25T00:05:25.196Z] ====== scala-kmeans (scala) [default], iteration 37 completed (455.455 ms) ====== [2025-09-25T00:05:25.196Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-09-25T00:05:25.196Z] GC before operation: completed in 42.319 ms, heap usage 45.847 MB -> 26.032 MB. [2025-09-25T00:05:26.139Z] ====== scala-kmeans (scala) [default], iteration 38 completed (469.724 ms) ====== [2025-09-25T00:05:26.139Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-09-25T00:05:26.139Z] GC before operation: completed in 30.372 ms, heap usage 96.311 MB -> 26.033 MB. [2025-09-25T00:05:27.082Z] ====== scala-kmeans (scala) [default], iteration 39 completed (457.155 ms) ====== [2025-09-25T00:05:27.082Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-09-25T00:05:27.082Z] GC before operation: completed in 42.421 ms, heap usage 40.170 MB -> 26.032 MB. [2025-09-25T00:05:27.082Z] ====== scala-kmeans (scala) [default], iteration 40 completed (458.720 ms) ====== [2025-09-25T00:05:27.082Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-09-25T00:05:27.082Z] GC before operation: completed in 43.465 ms, heap usage 40.195 MB -> 26.032 MB. [2025-09-25T00:05:28.024Z] ====== scala-kmeans (scala) [default], iteration 41 completed (456.499 ms) ====== [2025-09-25T00:05:28.024Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-09-25T00:05:28.025Z] GC before operation: completed in 43.246 ms, heap usage 41.173 MB -> 26.032 MB. [2025-09-25T00:05:28.025Z] ====== scala-kmeans (scala) [default], iteration 42 completed (468.955 ms) ====== [2025-09-25T00:05:28.025Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-09-25T00:05:28.025Z] GC before operation: completed in 24.318 ms, heap usage 96.343 MB -> 26.033 MB. [2025-09-25T00:05:28.966Z] ====== scala-kmeans (scala) [default], iteration 43 completed (457.534 ms) ====== [2025-09-25T00:05:28.966Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-09-25T00:05:28.966Z] GC before operation: completed in 42.812 ms, heap usage 40.182 MB -> 26.033 MB. [2025-09-25T00:05:28.966Z] ====== scala-kmeans (scala) [default], iteration 44 completed (460.475 ms) ====== [2025-09-25T00:05:28.966Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-09-25T00:05:28.966Z] GC before operation: completed in 42.867 ms, heap usage 40.196 MB -> 26.033 MB. [2025-09-25T00:05:29.908Z] ====== scala-kmeans (scala) [default], iteration 45 completed (456.203 ms) ====== [2025-09-25T00:05:29.908Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-09-25T00:05:29.908Z] GC before operation: completed in 43.883 ms, heap usage 41.173 MB -> 26.033 MB. [2025-09-25T00:05:29.908Z] ====== scala-kmeans (scala) [default], iteration 46 completed (469.995 ms) ====== [2025-09-25T00:05:29.908Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-09-25T00:05:29.908Z] GC before operation: completed in 23.723 ms, heap usage 94.478 MB -> 26.033 MB. [2025-09-25T00:05:30.853Z] ====== scala-kmeans (scala) [default], iteration 47 completed (457.979 ms) ====== [2025-09-25T00:05:30.853Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-09-25T00:05:30.853Z] GC before operation: completed in 43.310 ms, heap usage 40.198 MB -> 26.033 MB. [2025-09-25T00:05:30.853Z] ====== scala-kmeans (scala) [default], iteration 48 completed (458.225 ms) ====== [2025-09-25T00:05:30.853Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-09-25T00:05:30.853Z] GC before operation: completed in 43.763 ms, heap usage 40.197 MB -> 26.033 MB. [2025-09-25T00:05:31.796Z] ====== scala-kmeans (scala) [default], iteration 49 completed (457.072 ms) ====== [2025-09-25T00:05:31.796Z] ----------------------------------- [2025-09-25T00:05:31.796Z] renaissance-scala-kmeans_0_PASSED [2025-09-25T00:05:31.796Z] ----------------------------------- [2025-09-25T00:05:31.796Z] [2025-09-25T00:05:31.796Z] TEST TEARDOWN: [2025-09-25T00:05:31.796Z] Nothing to be done for teardown. [2025-09-25T00:05:31.796Z] renaissance-scala-kmeans_0 Finish Time: Thu Sep 25 00:05:31 2025 Epoch Time (ms): 1758758731255