[2025-08-29T09:28:48.387Z] Running test renaissance-scala-kmeans_0 ... [2025-08-29T09:28:48.387Z] =============================================== [2025-08-29T09:28:48.387Z] renaissance-scala-kmeans_0 Start Time: Fri Aug 29 09:28:48 2025 Epoch Time (ms): 1756459728119 [2025-08-29T09:28:48.387Z] variation: NoOptions [2025-08-29T09:28:48.387Z] JVM_OPTIONS: [2025-08-29T09:28:48.387Z] { \ [2025-08-29T09:28:48.387Z] echo ""; echo "TEST SETUP:"; \ [2025-08-29T09:28:48.387Z] echo "Nothing to be done for setup."; \ [2025-08-29T09:28:48.387Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17564581072868/renaissance-scala-kmeans_0"; \ [2025-08-29T09:28:48.387Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17564581072868/renaissance-scala-kmeans_0"; \ [2025-08-29T09:28:48.387Z] echo ""; echo "TESTING:"; \ [2025-08-29T09:28:48.387Z] /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17564581072868/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; \ [2025-08-29T09:28:48.387Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17564581072868/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-29T09:28:48.387Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-29T09:28:48.387Z] echo "Nothing to be done for teardown."; \ [2025-08-29T09:28:48.387Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17564581072868/TestTargetResult"; [2025-08-29T09:28:48.387Z] [2025-08-29T09:28:48.387Z] TEST SETUP: [2025-08-29T09:28:48.387Z] Nothing to be done for setup. [2025-08-29T09:28:48.387Z] [2025-08-29T09:28:48.387Z] TESTING: [2025-08-29T09:28:49.336Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-08-29T09:28:49.336Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17564581072868/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-08-29T09:28:50.286Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-08-29T09:28:50.286Z] GC before operation: completed in 49.926 ms, heap usage 31.545 MB -> 26.038 MB. [2025-08-29T09:28:51.235Z] ====== scala-kmeans (scala) [default], iteration 0 completed (576.162 ms) ====== [2025-08-29T09:28:51.235Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-08-29T09:28:51.235Z] GC before operation: completed in 74.059 ms, heap usage 30.001 MB -> 26.131 MB. [2025-08-29T09:28:51.235Z] ====== scala-kmeans (scala) [default], iteration 1 completed (442.312 ms) ====== [2025-08-29T09:28:51.235Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-08-29T09:28:51.235Z] GC before operation: completed in 43.801 ms, heap usage 49.315 MB -> 26.131 MB. [2025-08-29T09:28:52.183Z] ====== scala-kmeans (scala) [default], iteration 2 completed (433.345 ms) ====== [2025-08-29T09:28:52.183Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-08-29T09:28:52.183Z] GC before operation: completed in 44.599 ms, heap usage 42.204 MB -> 26.132 MB. [2025-08-29T09:28:52.183Z] ====== scala-kmeans (scala) [default], iteration 3 completed (450.088 ms) ====== [2025-08-29T09:28:52.183Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-08-29T09:28:52.183Z] GC before operation: completed in 25.878 ms, heap usage 94.671 MB -> 26.132 MB. [2025-08-29T09:28:53.132Z] ====== scala-kmeans (scala) [default], iteration 4 completed (431.145 ms) ====== [2025-08-29T09:28:53.132Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-08-29T09:28:53.132Z] GC before operation: completed in 44.829 ms, heap usage 42.183 MB -> 26.132 MB. [2025-08-29T09:28:53.132Z] ====== scala-kmeans (scala) [default], iteration 5 completed (428.463 ms) ====== [2025-08-29T09:28:53.132Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-08-29T09:28:53.132Z] GC before operation: completed in 45.195 ms, heap usage 42.339 MB -> 26.132 MB. [2025-08-29T09:28:54.078Z] ====== scala-kmeans (scala) [default], iteration 6 completed (428.064 ms) ====== [2025-08-29T09:28:54.078Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-08-29T09:28:54.079Z] GC before operation: completed in 73.619 ms, heap usage 42.661 MB -> 26.132 MB. [2025-08-29T09:28:54.079Z] ====== scala-kmeans (scala) [default], iteration 7 completed (440.631 ms) ====== [2025-08-29T09:28:54.079Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-08-29T09:28:54.079Z] GC before operation: completed in 33.332 ms, heap usage 94.536 MB -> 26.132 MB. [2025-08-29T09:28:55.028Z] ====== scala-kmeans (scala) [default], iteration 8 completed (425.661 ms) ====== [2025-08-29T09:28:55.028Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-08-29T09:28:55.028Z] GC before operation: completed in 43.706 ms, heap usage 42.183 MB -> 26.132 MB. [2025-08-29T09:28:55.028Z] ====== scala-kmeans (scala) [default], iteration 9 completed (425.201 ms) ====== [2025-08-29T09:28:55.028Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-08-29T09:28:55.028Z] GC before operation: completed in 44.210 ms, heap usage 42.340 MB -> 26.132 MB. [2025-08-29T09:28:55.976Z] ====== scala-kmeans (scala) [default], iteration 10 completed (426.782 ms) ====== [2025-08-29T09:28:55.976Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-08-29T09:28:55.976Z] GC before operation: completed in 44.662 ms, heap usage 42.167 MB -> 26.132 MB. [2025-08-29T09:28:55.976Z] ====== scala-kmeans (scala) [default], iteration 11 completed (434.127 ms) ====== [2025-08-29T09:28:55.976Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-08-29T09:28:55.976Z] GC before operation: completed in 27.699 ms, heap usage 94.560 MB -> 26.133 MB. [2025-08-29T09:28:56.924Z] ====== scala-kmeans (scala) [default], iteration 12 completed (424.906 ms) ====== [2025-08-29T09:28:56.924Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-08-29T09:28:56.924Z] GC before operation: completed in 59.336 ms, heap usage 42.342 MB -> 26.133 MB. [2025-08-29T09:28:56.924Z] ====== scala-kmeans (scala) [default], iteration 13 completed (423.575 ms) ====== [2025-08-29T09:28:56.924Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-08-29T09:28:56.924Z] GC before operation: completed in 43.574 ms, heap usage 42.341 MB -> 26.133 MB. [2025-08-29T09:28:57.873Z] ====== scala-kmeans (scala) [default], iteration 14 completed (425.104 ms) ====== [2025-08-29T09:28:57.873Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-08-29T09:28:57.873Z] GC before operation: completed in 43.655 ms, heap usage 42.345 MB -> 26.133 MB. [2025-08-29T09:28:57.873Z] ====== scala-kmeans (scala) [default], iteration 15 completed (434.485 ms) ====== [2025-08-29T09:28:57.873Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-08-29T09:28:57.873Z] GC before operation: completed in 24.194 ms, heap usage 94.545 MB -> 26.133 MB. [2025-08-29T09:28:58.823Z] ====== scala-kmeans (scala) [default], iteration 16 completed (425.341 ms) ====== [2025-08-29T09:28:58.823Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-08-29T09:28:58.823Z] GC before operation: completed in 44.344 ms, heap usage 42.185 MB -> 26.133 MB. [2025-08-29T09:28:58.823Z] ====== scala-kmeans (scala) [default], iteration 17 completed (434.240 ms) ====== [2025-08-29T09:28:58.823Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-08-29T09:28:58.823Z] GC before operation: completed in 43.811 ms, heap usage 42.341 MB -> 26.133 MB. [2025-08-29T09:28:59.771Z] ====== scala-kmeans (scala) [default], iteration 18 completed (430.573 ms) ====== [2025-08-29T09:28:59.771Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-08-29T09:28:59.771Z] GC before operation: completed in 46.258 ms, heap usage 42.346 MB -> 26.133 MB. [2025-08-29T09:28:59.771Z] ====== scala-kmeans (scala) [default], iteration 19 completed (433.164 ms) ====== [2025-08-29T09:28:59.771Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-08-29T09:28:59.771Z] GC before operation: completed in 30.724 ms, heap usage 94.545 MB -> 26.133 MB. [2025-08-29T09:29:00.720Z] ====== scala-kmeans (scala) [default], iteration 20 completed (424.965 ms) ====== [2025-08-29T09:29:00.720Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-08-29T09:29:00.720Z] GC before operation: completed in 44.114 ms, heap usage 42.342 MB -> 26.133 MB. [2025-08-29T09:29:00.720Z] ====== scala-kmeans (scala) [default], iteration 21 completed (423.160 ms) ====== [2025-08-29T09:29:00.720Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-08-29T09:29:00.720Z] GC before operation: completed in 44.431 ms, heap usage 42.341 MB -> 26.134 MB. [2025-08-29T09:29:01.668Z] ====== scala-kmeans (scala) [default], iteration 22 completed (427.514 ms) ====== [2025-08-29T09:29:01.668Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-08-29T09:29:01.668Z] GC before operation: completed in 47.256 ms, heap usage 42.168 MB -> 26.134 MB. [2025-08-29T09:29:01.668Z] ====== scala-kmeans (scala) [default], iteration 23 completed (431.559 ms) ====== [2025-08-29T09:29:01.668Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-08-29T09:29:01.668Z] GC before operation: completed in 29.331 ms, heap usage 94.415 MB -> 26.134 MB. [2025-08-29T09:29:02.618Z] ====== scala-kmeans (scala) [default], iteration 24 completed (421.962 ms) ====== [2025-08-29T09:29:02.618Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-08-29T09:29:02.618Z] GC before operation: completed in 48.381 ms, heap usage 42.185 MB -> 26.134 MB. [2025-08-29T09:29:02.618Z] ====== scala-kmeans (scala) [default], iteration 25 completed (423.965 ms) ====== [2025-08-29T09:29:02.618Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-08-29T09:29:02.618Z] GC before operation: completed in 58.105 ms, heap usage 42.341 MB -> 26.134 MB. [2025-08-29T09:29:03.567Z] ====== scala-kmeans (scala) [default], iteration 26 completed (432.178 ms) ====== [2025-08-29T09:29:03.567Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-08-29T09:29:03.567Z] GC before operation: completed in 29.838 ms, heap usage 94.545 MB -> 26.134 MB. [2025-08-29T09:29:03.567Z] ====== scala-kmeans (scala) [default], iteration 27 completed (427.008 ms) ====== [2025-08-29T09:29:03.567Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-08-29T09:29:03.567Z] GC before operation: completed in 43.924 ms, heap usage 38.329 MB -> 26.134 MB. [2025-08-29T09:29:04.520Z] ====== scala-kmeans (scala) [default], iteration 28 completed (423.353 ms) ====== [2025-08-29T09:29:04.520Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-08-29T09:29:04.520Z] GC before operation: completed in 48.090 ms, heap usage 42.285 MB -> 26.134 MB. [2025-08-29T09:29:04.520Z] ====== scala-kmeans (scala) [default], iteration 29 completed (421.142 ms) ====== [2025-08-29T09:29:04.520Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-08-29T09:29:04.520Z] GC before operation: completed in 46.773 ms, heap usage 42.349 MB -> 26.134 MB. [2025-08-29T09:29:05.468Z] ====== scala-kmeans (scala) [default], iteration 30 completed (431.820 ms) ====== [2025-08-29T09:29:05.468Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-08-29T09:29:05.468Z] GC before operation: completed in 39.656 ms, heap usage 94.547 MB -> 26.134 MB. [2025-08-29T09:29:05.468Z] ====== scala-kmeans (scala) [default], iteration 31 completed (432.650 ms) ====== [2025-08-29T09:29:05.468Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-08-29T09:29:05.468Z] GC before operation: completed in 46.866 ms, heap usage 42.343 MB -> 26.134 MB. [2025-08-29T09:29:06.418Z] ====== scala-kmeans (scala) [default], iteration 32 completed (428.354 ms) ====== [2025-08-29T09:29:06.419Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-08-29T09:29:06.419Z] GC before operation: completed in 44.265 ms, heap usage 42.342 MB -> 26.135 MB. [2025-08-29T09:29:06.419Z] ====== scala-kmeans (scala) [default], iteration 33 completed (439.094 ms) ====== [2025-08-29T09:29:06.419Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-08-29T09:29:06.419Z] GC before operation: completed in 37.436 ms, heap usage 94.415 MB -> 26.135 MB. [2025-08-29T09:29:07.367Z] ====== scala-kmeans (scala) [default], iteration 34 completed (429.278 ms) ====== [2025-08-29T09:29:07.367Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-08-29T09:29:07.367Z] GC before operation: completed in 43.784 ms, heap usage 35.635 MB -> 26.135 MB. [2025-08-29T09:29:07.367Z] ====== scala-kmeans (scala) [default], iteration 35 completed (426.056 ms) ====== [2025-08-29T09:29:07.367Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-08-29T09:29:07.367Z] GC before operation: completed in 43.919 ms, heap usage 42.311 MB -> 26.135 MB. [2025-08-29T09:29:08.315Z] ====== scala-kmeans (scala) [default], iteration 36 completed (433.755 ms) ====== [2025-08-29T09:29:08.315Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-08-29T09:29:08.315Z] GC before operation: completed in 28.368 ms, heap usage 94.428 MB -> 26.137 MB. [2025-08-29T09:29:08.315Z] ====== scala-kmeans (scala) [default], iteration 37 completed (420.184 ms) ====== [2025-08-29T09:29:08.315Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-08-29T09:29:08.315Z] GC before operation: completed in 45.986 ms, heap usage 38.333 MB -> 26.137 MB. [2025-08-29T09:29:09.263Z] ====== scala-kmeans (scala) [default], iteration 38 completed (421.223 ms) ====== [2025-08-29T09:29:09.263Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-08-29T09:29:09.263Z] GC before operation: completed in 70.809 ms, heap usage 42.288 MB -> 26.137 MB. [2025-08-29T09:29:09.263Z] ====== scala-kmeans (scala) [default], iteration 39 completed (426.414 ms) ====== [2025-08-29T09:29:09.263Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-08-29T09:29:09.263Z] GC before operation: completed in 30.529 ms, heap usage 94.556 MB -> 26.137 MB. [2025-08-29T09:29:10.210Z] ====== scala-kmeans (scala) [default], iteration 40 completed (417.530 ms) ====== [2025-08-29T09:29:10.211Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-08-29T09:29:10.211Z] GC before operation: completed in 45.034 ms, heap usage 42.346 MB -> 26.137 MB. [2025-08-29T09:29:10.211Z] ====== scala-kmeans (scala) [default], iteration 41 completed (419.020 ms) ====== [2025-08-29T09:29:10.211Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-08-29T09:29:10.211Z] GC before operation: completed in 45.002 ms, heap usage 42.344 MB -> 26.137 MB. [2025-08-29T09:29:11.159Z] ====== scala-kmeans (scala) [default], iteration 42 completed (425.711 ms) ====== [2025-08-29T09:29:11.159Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-08-29T09:29:11.159Z] GC before operation: completed in 31.421 ms, heap usage 94.548 MB -> 26.137 MB. [2025-08-29T09:29:11.159Z] ====== scala-kmeans (scala) [default], iteration 43 completed (427.404 ms) ====== [2025-08-29T09:29:11.159Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-08-29T09:29:11.159Z] GC before operation: completed in 43.777 ms, heap usage 42.109 MB -> 26.137 MB. [2025-08-29T09:29:12.107Z] ====== scala-kmeans (scala) [default], iteration 44 completed (419.961 ms) ====== [2025-08-29T09:29:12.107Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-08-29T09:29:12.107Z] GC before operation: completed in 44.333 ms, heap usage 42.344 MB -> 26.137 MB. [2025-08-29T09:29:12.107Z] ====== scala-kmeans (scala) [default], iteration 45 completed (424.595 ms) ====== [2025-08-29T09:29:12.107Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-08-29T09:29:12.107Z] GC before operation: completed in 44.876 ms, heap usage 42.171 MB -> 26.137 MB. [2025-08-29T09:29:13.055Z] ====== scala-kmeans (scala) [default], iteration 46 completed (430.022 ms) ====== [2025-08-29T09:29:13.055Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-08-29T09:29:13.055Z] GC before operation: completed in 31.533 ms, heap usage 94.419 MB -> 26.137 MB. [2025-08-29T09:29:13.055Z] ====== scala-kmeans (scala) [default], iteration 47 completed (424.365 ms) ====== [2025-08-29T09:29:13.055Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-08-29T09:29:13.055Z] GC before operation: completed in 45.089 ms, heap usage 42.188 MB -> 26.137 MB. [2025-08-29T09:29:14.005Z] ====== scala-kmeans (scala) [default], iteration 48 completed (427.007 ms) ====== [2025-08-29T09:29:14.005Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-08-29T09:29:14.005Z] GC before operation: completed in 43.614 ms, heap usage 42.345 MB -> 26.137 MB. [2025-08-29T09:29:14.005Z] ====== scala-kmeans (scala) [default], iteration 49 completed (419.759 ms) ====== [2025-08-29T09:29:14.005Z] ----------------------------------- [2025-08-29T09:29:14.005Z] renaissance-scala-kmeans_0_PASSED [2025-08-29T09:29:14.005Z] ----------------------------------- [2025-08-29T09:29:14.005Z] [2025-08-29T09:29:14.005Z] TEST TEARDOWN: [2025-08-29T09:29:14.005Z] Nothing to be done for teardown. [2025-08-29T09:29:14.005Z] renaissance-scala-kmeans_0 Finish Time: Fri Aug 29 09:29:13 2025 Epoch Time (ms): 1756459753747