[2025-06-11T21:02:44.435Z] Running test renaissance-scala-kmeans_0 ... [2025-06-11T21:02:44.435Z] =============================================== [2025-06-11T21:02:44.435Z] renaissance-scala-kmeans_0 Start Time: Wed Jun 11 21:02:44 2025 Epoch Time (ms): 1749675764312 [2025-06-11T21:02:44.435Z] variation: NoOptions [2025-06-11T21:02:44.435Z] JVM_OPTIONS: [2025-06-11T21:02:44.435Z] { \ [2025-06-11T21:02:44.435Z] echo ""; echo "TEST SETUP:"; \ [2025-06-11T21:02:44.435Z] echo "Nothing to be done for setup."; \ [2025-06-11T21:02:44.435Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1749675196178/renaissance-scala-kmeans_0"; \ [2025-06-11T21:02:44.435Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1749675196178/renaissance-scala-kmeans_0"; \ [2025-06-11T21:02:44.435Z] echo ""; echo "TESTING:"; \ [2025-06-11T21:02:44.435Z] /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_1749675196178/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-06-11T21:02:44.435Z] 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_1749675196178/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-11T21:02:44.435Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-11T21:02:44.435Z] echo "Nothing to be done for teardown."; \ [2025-06-11T21:02:44.435Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1749675196178/TestTargetResult"; [2025-06-11T21:02:44.435Z] [2025-06-11T21:02:44.435Z] TEST SETUP: [2025-06-11T21:02:44.435Z] Nothing to be done for setup. [2025-06-11T21:02:44.435Z] [2025-06-11T21:02:44.435Z] TESTING: [2025-06-11T21:02:45.388Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-06-11T21:02:45.388Z] 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_1749675196178/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-06-11T21:02:46.338Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-06-11T21:02:46.338Z] GC before operation: completed in 45.320 ms, heap usage 32.853 MB -> 26.078 MB. [2025-06-11T21:02:47.290Z] ====== scala-kmeans (scala) [default], iteration 0 completed (560.814 ms) ====== [2025-06-11T21:02:47.291Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-06-11T21:02:47.291Z] GC before operation: completed in 83.823 ms, heap usage 67.151 MB -> 26.172 MB. [2025-06-11T21:02:47.291Z] ====== scala-kmeans (scala) [default], iteration 1 completed (431.561 ms) ====== [2025-06-11T21:02:47.291Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-06-11T21:02:47.291Z] GC before operation: completed in 54.612 ms, heap usage 48.393 MB -> 26.172 MB. [2025-06-11T21:02:48.241Z] ====== scala-kmeans (scala) [default], iteration 2 completed (424.054 ms) ====== [2025-06-11T21:02:48.241Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-06-11T21:02:48.241Z] GC before operation: completed in 46.266 ms, heap usage 42.234 MB -> 26.172 MB. [2025-06-11T21:02:48.241Z] ====== scala-kmeans (scala) [default], iteration 3 completed (438.760 ms) ====== [2025-06-11T21:02:48.241Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-06-11T21:02:48.241Z] GC before operation: completed in 29.894 ms, heap usage 94.837 MB -> 26.172 MB. [2025-06-11T21:02:49.194Z] ====== scala-kmeans (scala) [default], iteration 4 completed (423.807 ms) ====== [2025-06-11T21:02:49.194Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-06-11T21:02:49.194Z] GC before operation: completed in 46.556 ms, heap usage 42.380 MB -> 26.172 MB. [2025-06-11T21:02:49.194Z] ====== scala-kmeans (scala) [default], iteration 5 completed (422.435 ms) ====== [2025-06-11T21:02:49.194Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-06-11T21:02:49.194Z] GC before operation: completed in 46.661 ms, heap usage 42.380 MB -> 26.172 MB. [2025-06-11T21:02:50.144Z] ====== scala-kmeans (scala) [default], iteration 6 completed (424.683 ms) ====== [2025-06-11T21:02:50.144Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-06-11T21:02:50.144Z] GC before operation: completed in 46.235 ms, heap usage 42.701 MB -> 26.172 MB. [2025-06-11T21:02:50.144Z] ====== scala-kmeans (scala) [default], iteration 7 completed (435.235 ms) ====== [2025-06-11T21:02:50.144Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-06-11T21:02:50.144Z] GC before operation: completed in 26.907 ms, heap usage 94.576 MB -> 26.172 MB. [2025-06-11T21:02:51.153Z] ====== scala-kmeans (scala) [default], iteration 8 completed (436.050 ms) ====== [2025-06-11T21:02:51.153Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-06-11T21:02:51.153Z] GC before operation: completed in 46.497 ms, heap usage 42.381 MB -> 26.172 MB. [2025-06-11T21:02:51.153Z] ====== scala-kmeans (scala) [default], iteration 9 completed (429.147 ms) ====== [2025-06-11T21:02:51.153Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-06-11T21:02:51.153Z] GC before operation: completed in 46.066 ms, heap usage 42.203 MB -> 26.173 MB. [2025-06-11T21:02:52.106Z] ====== scala-kmeans (scala) [default], iteration 10 completed (425.027 ms) ====== [2025-06-11T21:02:52.106Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-06-11T21:02:52.106Z] GC before operation: completed in 49.347 ms, heap usage 42.385 MB -> 26.172 MB. [2025-06-11T21:02:52.106Z] ====== scala-kmeans (scala) [default], iteration 11 completed (437.345 ms) ====== [2025-06-11T21:02:52.106Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-06-11T21:02:52.106Z] GC before operation: completed in 30.871 ms, heap usage 94.730 MB -> 26.173 MB. [2025-06-11T21:02:53.055Z] ====== scala-kmeans (scala) [default], iteration 12 completed (426.159 ms) ====== [2025-06-11T21:02:53.055Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-06-11T21:02:53.055Z] GC before operation: completed in 47.153 ms, heap usage 42.224 MB -> 26.173 MB. [2025-06-11T21:02:53.055Z] ====== scala-kmeans (scala) [default], iteration 13 completed (423.568 ms) ====== [2025-06-11T21:02:53.055Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-06-11T21:02:53.055Z] GC before operation: completed in 47.077 ms, heap usage 42.204 MB -> 26.173 MB. [2025-06-11T21:02:54.005Z] ====== scala-kmeans (scala) [default], iteration 14 completed (428.218 ms) ====== [2025-06-11T21:02:54.005Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-06-11T21:02:54.005Z] GC before operation: completed in 46.335 ms, heap usage 42.385 MB -> 26.173 MB. [2025-06-11T21:02:54.005Z] ====== scala-kmeans (scala) [default], iteration 15 completed (435.062 ms) ====== [2025-06-11T21:02:54.005Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-06-11T21:02:54.005Z] GC before operation: completed in 29.519 ms, heap usage 94.455 MB -> 26.173 MB. [2025-06-11T21:02:54.962Z] ====== scala-kmeans (scala) [default], iteration 16 completed (429.176 ms) ====== [2025-06-11T21:02:54.962Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-06-11T21:02:54.962Z] GC before operation: completed in 45.647 ms, heap usage 42.224 MB -> 26.173 MB. [2025-06-11T21:02:54.962Z] ====== scala-kmeans (scala) [default], iteration 17 completed (429.251 ms) ====== [2025-06-11T21:02:54.962Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-06-11T21:02:54.962Z] GC before operation: completed in 46.501 ms, heap usage 42.204 MB -> 26.173 MB. [2025-06-11T21:02:55.914Z] ====== scala-kmeans (scala) [default], iteration 18 completed (434.387 ms) ====== [2025-06-11T21:02:55.914Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-06-11T21:02:55.914Z] GC before operation: completed in 25.967 ms, heap usage 94.584 MB -> 26.174 MB. [2025-06-11T21:02:55.914Z] ====== scala-kmeans (scala) [default], iteration 19 completed (425.955 ms) ====== [2025-06-11T21:02:55.914Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-06-11T21:02:55.914Z] GC before operation: completed in 47.113 ms, heap usage 42.225 MB -> 26.173 MB. [2025-06-11T21:02:56.863Z] ====== scala-kmeans (scala) [default], iteration 20 completed (424.852 ms) ====== [2025-06-11T21:02:56.863Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-06-11T21:02:56.863Z] GC before operation: completed in 48.104 ms, heap usage 42.204 MB -> 26.173 MB. [2025-06-11T21:02:56.863Z] ====== scala-kmeans (scala) [default], iteration 21 completed (428.212 ms) ====== [2025-06-11T21:02:56.863Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-06-11T21:02:56.863Z] GC before operation: completed in 26.933 ms, heap usage 42.386 MB -> 26.174 MB. [2025-06-11T21:02:57.825Z] ====== scala-kmeans (scala) [default], iteration 22 completed (426.301 ms) ====== [2025-06-11T21:02:57.825Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-06-11T21:02:57.825Z] GC before operation: completed in 52.109 ms, heap usage 38.549 MB -> 26.174 MB. [2025-06-11T21:02:57.825Z] ====== scala-kmeans (scala) [default], iteration 23 completed (423.794 ms) ====== [2025-06-11T21:02:57.825Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-06-11T21:02:57.825Z] GC before operation: completed in 81.293 ms, heap usage 42.329 MB -> 26.174 MB. [2025-06-11T21:02:58.948Z] ====== scala-kmeans (scala) [default], iteration 24 completed (433.293 ms) ====== [2025-06-11T21:02:58.948Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-06-11T21:02:58.948Z] GC before operation: completed in 29.723 ms, heap usage 94.462 MB -> 26.174 MB. [2025-06-11T21:02:58.948Z] ====== scala-kmeans (scala) [default], iteration 25 completed (437.663 ms) ====== [2025-06-11T21:02:58.948Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-06-11T21:02:58.948Z] GC before operation: completed in 46.301 ms, heap usage 42.226 MB -> 26.174 MB. [2025-06-11T21:02:58.948Z] ====== scala-kmeans (scala) [default], iteration 26 completed (439.178 ms) ====== [2025-06-11T21:02:58.948Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-06-11T21:02:59.904Z] GC before operation: completed in 48.589 ms, heap usage 42.204 MB -> 26.174 MB. [2025-06-11T21:02:59.904Z] ====== scala-kmeans (scala) [default], iteration 27 completed (444.235 ms) ====== [2025-06-11T21:02:59.904Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-06-11T21:02:59.904Z] GC before operation: completed in 53.043 ms, heap usage 42.386 MB -> 26.174 MB. [2025-06-11T21:02:59.904Z] ====== scala-kmeans (scala) [default], iteration 28 completed (438.198 ms) ====== [2025-06-11T21:02:59.904Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-06-11T21:03:00.858Z] GC before operation: completed in 47.054 ms, heap usage 38.549 MB -> 26.174 MB. [2025-06-11T21:03:00.858Z] ====== scala-kmeans (scala) [default], iteration 29 completed (450.472 ms) ====== [2025-06-11T21:03:00.858Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-06-11T21:03:00.858Z] GC before operation: completed in 46.497 ms, heap usage 42.330 MB -> 26.174 MB. [2025-06-11T21:03:00.858Z] ====== scala-kmeans (scala) [default], iteration 30 completed (449.048 ms) ====== [2025-06-11T21:03:00.858Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-06-11T21:03:01.814Z] GC before operation: completed in 33.812 ms, heap usage 94.594 MB -> 26.174 MB. [2025-06-11T21:03:01.814Z] ====== scala-kmeans (scala) [default], iteration 31 completed (437.868 ms) ====== [2025-06-11T21:03:01.814Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-06-11T21:03:01.814Z] GC before operation: completed in 48.087 ms, heap usage 42.226 MB -> 26.174 MB. [2025-06-11T21:03:02.766Z] ====== scala-kmeans (scala) [default], iteration 32 completed (443.466 ms) ====== [2025-06-11T21:03:02.766Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-06-11T21:03:02.766Z] GC before operation: completed in 47.553 ms, heap usage 42.382 MB -> 26.175 MB. [2025-06-11T21:03:02.766Z] ====== scala-kmeans (scala) [default], iteration 33 completed (442.192 ms) ====== [2025-06-11T21:03:02.766Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-06-11T21:03:02.766Z] GC before operation: completed in 32.034 ms, heap usage 42.387 MB -> 26.175 MB. [2025-06-11T21:03:03.715Z] ====== scala-kmeans (scala) [default], iteration 34 completed (443.302 ms) ====== [2025-06-11T21:03:03.716Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-06-11T21:03:03.716Z] GC before operation: completed in 47.248 ms, heap usage 38.453 MB -> 26.175 MB. [2025-06-11T21:03:03.716Z] ====== scala-kmeans (scala) [default], iteration 35 completed (437.618 ms) ====== [2025-06-11T21:03:03.716Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-06-11T21:03:03.716Z] GC before operation: completed in 50.042 ms, heap usage 42.331 MB -> 26.175 MB. [2025-06-11T21:03:04.665Z] ====== scala-kmeans (scala) [default], iteration 36 completed (451.131 ms) ====== [2025-06-11T21:03:04.665Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-06-11T21:03:04.665Z] GC before operation: completed in 34.082 ms, heap usage 94.464 MB -> 26.177 MB. [2025-06-11T21:03:04.665Z] ====== scala-kmeans (scala) [default], iteration 37 completed (438.114 ms) ====== [2025-06-11T21:03:04.665Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-06-11T21:03:04.665Z] GC before operation: completed in 48.390 ms, heap usage 42.229 MB -> 26.177 MB. [2025-06-11T21:03:05.615Z] ====== scala-kmeans (scala) [default], iteration 38 completed (441.602 ms) ====== [2025-06-11T21:03:05.615Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-06-11T21:03:05.615Z] GC before operation: completed in 28.147 ms, heap usage 42.384 MB -> 26.177 MB. [2025-06-11T21:03:05.615Z] ====== scala-kmeans (scala) [default], iteration 39 completed (437.321 ms) ====== [2025-06-11T21:03:05.615Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-06-11T21:03:05.615Z] GC before operation: completed in 46.635 ms, heap usage 42.389 MB -> 26.177 MB. [2025-06-11T21:03:06.564Z] ====== scala-kmeans (scala) [default], iteration 40 completed (437.295 ms) ====== [2025-06-11T21:03:06.564Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-06-11T21:03:06.564Z] GC before operation: completed in 45.504 ms, heap usage 42.389 MB -> 26.177 MB. [2025-06-11T21:03:06.564Z] ====== scala-kmeans (scala) [default], iteration 41 completed (441.771 ms) ====== [2025-06-11T21:03:06.564Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-06-11T21:03:06.564Z] GC before operation: completed in 32.598 ms, heap usage 42.300 MB -> 26.177 MB. [2025-06-11T21:03:07.513Z] ====== scala-kmeans (scala) [default], iteration 42 completed (438.081 ms) ====== [2025-06-11T21:03:07.513Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-06-11T21:03:07.513Z] GC before operation: completed in 85.287 ms, heap usage 38.552 MB -> 26.177 MB. [2025-06-11T21:03:07.513Z] ====== scala-kmeans (scala) [default], iteration 43 completed (442.804 ms) ====== [2025-06-11T21:03:07.513Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-06-11T21:03:07.513Z] GC before operation: completed in 31.365 ms, heap usage 42.333 MB -> 26.177 MB. [2025-06-11T21:03:08.464Z] ====== scala-kmeans (scala) [default], iteration 44 completed (437.050 ms) ====== [2025-06-11T21:03:08.464Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-06-11T21:03:08.464Z] GC before operation: completed in 46.495 ms, heap usage 38.555 MB -> 26.177 MB. [2025-06-11T21:03:08.464Z] ====== scala-kmeans (scala) [default], iteration 45 completed (431.450 ms) ====== [2025-06-11T21:03:08.464Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-06-11T21:03:08.464Z] GC before operation: completed in 48.149 ms, heap usage 42.333 MB -> 26.177 MB. [2025-06-11T21:03:09.416Z] ====== scala-kmeans (scala) [default], iteration 46 completed (428.964 ms) ====== [2025-06-11T21:03:09.416Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-06-11T21:03:09.416Z] GC before operation: completed in 45.879 ms, heap usage 42.392 MB -> 26.177 MB. [2025-06-11T21:03:09.416Z] ====== scala-kmeans (scala) [default], iteration 47 completed (437.680 ms) ====== [2025-06-11T21:03:09.416Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-06-11T21:03:09.416Z] GC before operation: completed in 28.513 ms, heap usage 94.459 MB -> 26.177 MB. [2025-06-11T21:03:10.367Z] ====== scala-kmeans (scala) [default], iteration 48 completed (427.432 ms) ====== [2025-06-11T21:03:10.367Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-06-11T21:03:10.367Z] GC before operation: completed in 46.077 ms, heap usage 42.386 MB -> 26.177 MB. [2025-06-11T21:03:10.367Z] ====== scala-kmeans (scala) [default], iteration 49 completed (426.622 ms) ====== [2025-06-11T21:03:10.367Z] ----------------------------------- [2025-06-11T21:03:10.367Z] renaissance-scala-kmeans_0_PASSED [2025-06-11T21:03:10.367Z] ----------------------------------- [2025-06-11T21:03:10.367Z] [2025-06-11T21:03:10.367Z] TEST TEARDOWN: [2025-06-11T21:03:10.367Z] Nothing to be done for teardown. [2025-06-11T21:03:10.367Z] renaissance-scala-kmeans_0 Finish Time: Wed Jun 11 21:03:10 2025 Epoch Time (ms): 1749675790155