[2025-05-16T11:09:54.325Z] Running test renaissance-scala-kmeans_0 ... [2025-05-16T11:09:54.325Z] =============================================== [2025-05-16T11:09:54.325Z] renaissance-scala-kmeans_0 Start Time: Fri May 16 11:09:53 2025 Epoch Time (ms): 1747393793093 [2025-05-16T11:09:54.325Z] variation: NoOptions [2025-05-16T11:09:54.325Z] JVM_OPTIONS: [2025-05-16T11:09:54.325Z] { \ [2025-05-16T11:09:54.325Z] echo ""; echo "TEST SETUP:"; \ [2025-05-16T11:09:54.325Z] echo "Nothing to be done for setup."; \ [2025-05-16T11:09:54.325Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17473925652952/renaissance-scala-kmeans_0"; \ [2025-05-16T11:09:54.325Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17473925652952/renaissance-scala-kmeans_0"; \ [2025-05-16T11:09:54.325Z] echo ""; echo "TESTING:"; \ [2025-05-16T11:09:54.325Z] /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17473925652952/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/..; \ [2025-05-16T11:09:54.325Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17473925652952/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-16T11:09:54.325Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-16T11:09:54.325Z] echo "Nothing to be done for teardown."; \ [2025-05-16T11:09:54.325Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17473925652952/TestTargetResult"; [2025-05-16T11:09:54.325Z] [2025-05-16T11:09:54.325Z] TEST SETUP: [2025-05-16T11:09:54.325Z] Nothing to be done for setup. [2025-05-16T11:09:54.325Z] [2025-05-16T11:09:54.325Z] TESTING: [2025-05-16T11:09:54.325Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-05-16T11:09:54.325Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17473925652952/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-05-16T11:09:56.406Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-05-16T11:09:56.406Z] GC before operation: completed in 58.401 ms, heap usage 27.452 MB -> 26.201 MB. [2025-05-16T11:09:56.406Z] ====== scala-kmeans (scala) [default], iteration 0 completed (563.461 ms) ====== [2025-05-16T11:09:56.406Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-05-16T11:09:56.406Z] GC before operation: completed in 88.491 ms, heap usage 29.266 MB -> 26.294 MB. [2025-05-16T11:09:56.406Z] ====== scala-kmeans (scala) [default], iteration 1 completed (368.784 ms) ====== [2025-05-16T11:09:56.406Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-05-16T11:09:56.406Z] GC before operation: completed in 78.974 ms, heap usage 39.011 MB -> 26.294 MB. [2025-05-16T11:09:57.193Z] ====== scala-kmeans (scala) [default], iteration 2 completed (328.597 ms) ====== [2025-05-16T11:09:57.193Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-05-16T11:09:57.193Z] GC before operation: completed in 47.141 ms, heap usage 56.294 MB -> 26.294 MB. [2025-05-16T11:09:58.043Z] ====== scala-kmeans (scala) [default], iteration 3 completed (544.230 ms) ====== [2025-05-16T11:09:58.043Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-05-16T11:09:58.043Z] GC before operation: completed in 102.101 ms, heap usage 56.294 MB -> 26.294 MB. [2025-05-16T11:09:58.043Z] ====== scala-kmeans (scala) [default], iteration 4 completed (365.433 ms) ====== [2025-05-16T11:09:58.043Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-05-16T11:09:58.043Z] GC before operation: completed in 62.663 ms, heap usage 56.294 MB -> 26.294 MB. [2025-05-16T11:09:58.715Z] ====== scala-kmeans (scala) [default], iteration 5 completed (325.284 ms) ====== [2025-05-16T11:09:58.715Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-05-16T11:09:58.715Z] GC before operation: completed in 47.128 ms, heap usage 56.794 MB -> 26.294 MB. [2025-05-16T11:09:58.715Z] ====== scala-kmeans (scala) [default], iteration 6 completed (335.623 ms) ====== [2025-05-16T11:09:58.715Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-05-16T11:09:58.715Z] GC before operation: completed in 62.065 ms, heap usage 56.294 MB -> 26.294 MB. [2025-05-16T11:09:59.363Z] ====== scala-kmeans (scala) [default], iteration 7 completed (355.164 ms) ====== [2025-05-16T11:09:59.363Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-05-16T11:09:59.363Z] GC before operation: completed in 53.270 ms, heap usage 56.294 MB -> 26.295 MB. [2025-05-16T11:10:00.038Z] ====== scala-kmeans (scala) [default], iteration 8 completed (384.745 ms) ====== [2025-05-16T11:10:00.038Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-05-16T11:10:00.038Z] GC before operation: completed in 111.697 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:00.038Z] ====== scala-kmeans (scala) [default], iteration 9 completed (357.140 ms) ====== [2025-05-16T11:10:00.039Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-05-16T11:10:00.039Z] GC before operation: completed in 60.425 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:00.728Z] ====== scala-kmeans (scala) [default], iteration 10 completed (309.178 ms) ====== [2025-05-16T11:10:00.728Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-05-16T11:10:00.728Z] GC before operation: completed in 63.638 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:00.728Z] ====== scala-kmeans (scala) [default], iteration 11 completed (334.978 ms) ====== [2025-05-16T11:10:00.728Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-05-16T11:10:00.728Z] GC before operation: completed in 62.016 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:01.389Z] ====== scala-kmeans (scala) [default], iteration 12 completed (421.703 ms) ====== [2025-05-16T11:10:01.389Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-05-16T11:10:01.389Z] GC before operation: completed in 55.442 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:02.056Z] ====== scala-kmeans (scala) [default], iteration 13 completed (352.031 ms) ====== [2025-05-16T11:10:02.056Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-05-16T11:10:02.056Z] GC before operation: completed in 45.212 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:02.056Z] ====== scala-kmeans (scala) [default], iteration 14 completed (395.303 ms) ====== [2025-05-16T11:10:02.056Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-05-16T11:10:02.701Z] GC before operation: completed in 113.365 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:02.701Z] ====== scala-kmeans (scala) [default], iteration 15 completed (329.180 ms) ====== [2025-05-16T11:10:02.701Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-05-16T11:10:02.701Z] GC before operation: completed in 60.459 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:03.346Z] ====== scala-kmeans (scala) [default], iteration 16 completed (335.665 ms) ====== [2025-05-16T11:10:03.346Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-05-16T11:10:03.346Z] GC before operation: completed in 52.451 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:03.346Z] ====== scala-kmeans (scala) [default], iteration 17 completed (317.165 ms) ====== [2025-05-16T11:10:03.346Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-05-16T11:10:03.346Z] GC before operation: completed in 49.944 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:04.006Z] ====== scala-kmeans (scala) [default], iteration 18 completed (351.808 ms) ====== [2025-05-16T11:10:04.006Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-05-16T11:10:04.006Z] GC before operation: completed in 84.437 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:04.645Z] ====== scala-kmeans (scala) [default], iteration 19 completed (339.931 ms) ====== [2025-05-16T11:10:04.645Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-05-16T11:10:04.645Z] GC before operation: completed in 114.138 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:04.645Z] ====== scala-kmeans (scala) [default], iteration 20 completed (352.795 ms) ====== [2025-05-16T11:10:04.645Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-05-16T11:10:04.645Z] GC before operation: completed in 50.845 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:05.333Z] ====== scala-kmeans (scala) [default], iteration 21 completed (346.628 ms) ====== [2025-05-16T11:10:05.333Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-05-16T11:10:05.333Z] GC before operation: completed in 96.166 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:05.333Z] ====== scala-kmeans (scala) [default], iteration 22 completed (319.288 ms) ====== [2025-05-16T11:10:05.333Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-05-16T11:10:06.036Z] GC before operation: completed in 77.869 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:06.036Z] ====== scala-kmeans (scala) [default], iteration 23 completed (322.428 ms) ====== [2025-05-16T11:10:06.036Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-05-16T11:10:06.036Z] GC before operation: completed in 42.730 ms, heap usage 56.295 MB -> 26.295 MB. [2025-05-16T11:10:06.725Z] ====== scala-kmeans (scala) [default], iteration 24 completed (301.697 ms) ====== [2025-05-16T11:10:06.725Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-05-16T11:10:06.725Z] GC before operation: completed in 58.670 ms, heap usage 56.295 MB -> 26.296 MB. [2025-05-16T11:10:06.725Z] ====== scala-kmeans (scala) [default], iteration 25 completed (330.774 ms) ====== [2025-05-16T11:10:06.725Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-05-16T11:10:06.725Z] GC before operation: completed in 53.479 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:07.392Z] ====== scala-kmeans (scala) [default], iteration 26 completed (380.180 ms) ====== [2025-05-16T11:10:07.392Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-05-16T11:10:07.392Z] GC before operation: completed in 88.342 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:07.392Z] ====== scala-kmeans (scala) [default], iteration 27 completed (377.229 ms) ====== [2025-05-16T11:10:07.392Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-05-16T11:10:08.065Z] GC before operation: completed in 80.751 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:08.065Z] ====== scala-kmeans (scala) [default], iteration 28 completed (392.378 ms) ====== [2025-05-16T11:10:08.065Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-05-16T11:10:08.065Z] GC before operation: completed in 84.089 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:08.725Z] ====== scala-kmeans (scala) [default], iteration 29 completed (306.668 ms) ====== [2025-05-16T11:10:08.725Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-05-16T11:10:08.725Z] GC before operation: completed in 43.747 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:08.725Z] ====== scala-kmeans (scala) [default], iteration 30 completed (320.775 ms) ====== [2025-05-16T11:10:08.725Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-05-16T11:10:08.725Z] GC before operation: completed in 128.399 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:09.389Z] ====== scala-kmeans (scala) [default], iteration 31 completed (387.685 ms) ====== [2025-05-16T11:10:09.389Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-05-16T11:10:09.389Z] GC before operation: completed in 93.114 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:10.053Z] ====== scala-kmeans (scala) [default], iteration 32 completed (353.992 ms) ====== [2025-05-16T11:10:10.053Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-05-16T11:10:10.053Z] GC before operation: completed in 49.439 ms, heap usage 56.296 MB -> 26.296 MB. [2025-05-16T11:10:10.053Z] ====== scala-kmeans (scala) [default], iteration 33 completed (355.784 ms) ====== [2025-05-16T11:10:10.053Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-05-16T11:10:10.711Z] GC before operation: completed in 102.491 ms, heap usage 56.296 MB -> 26.297 MB. [2025-05-16T11:10:10.711Z] ====== scala-kmeans (scala) [default], iteration 34 completed (321.049 ms) ====== [2025-05-16T11:10:10.711Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-05-16T11:10:10.711Z] GC before operation: completed in 89.021 ms, heap usage 56.297 MB -> 26.297 MB. [2025-05-16T11:10:11.397Z] ====== scala-kmeans (scala) [default], iteration 35 completed (350.016 ms) ====== [2025-05-16T11:10:11.397Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-05-16T11:10:11.397Z] GC before operation: completed in 56.125 ms, heap usage 56.297 MB -> 26.297 MB. [2025-05-16T11:10:11.397Z] ====== scala-kmeans (scala) [default], iteration 36 completed (348.600 ms) ====== [2025-05-16T11:10:11.397Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-05-16T11:10:11.397Z] GC before operation: completed in 79.421 ms, heap usage 56.297 MB -> 26.299 MB. [2025-05-16T11:10:12.114Z] ====== scala-kmeans (scala) [default], iteration 37 completed (341.979 ms) ====== [2025-05-16T11:10:12.114Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-05-16T11:10:12.114Z] GC before operation: completed in 47.405 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:12.114Z] ====== scala-kmeans (scala) [default], iteration 38 completed (339.353 ms) ====== [2025-05-16T11:10:12.114Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-05-16T11:10:12.114Z] GC before operation: completed in 52.411 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:12.799Z] ====== scala-kmeans (scala) [default], iteration 39 completed (329.719 ms) ====== [2025-05-16T11:10:12.799Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-05-16T11:10:12.799Z] GC before operation: completed in 97.935 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:13.450Z] ====== scala-kmeans (scala) [default], iteration 40 completed (328.257 ms) ====== [2025-05-16T11:10:13.450Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-05-16T11:10:13.450Z] GC before operation: completed in 58.334 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:13.450Z] ====== scala-kmeans (scala) [default], iteration 41 completed (314.282 ms) ====== [2025-05-16T11:10:13.450Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-05-16T11:10:13.450Z] GC before operation: completed in 91.120 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:14.105Z] ====== scala-kmeans (scala) [default], iteration 42 completed (316.661 ms) ====== [2025-05-16T11:10:14.105Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-05-16T11:10:14.105Z] GC before operation: completed in 77.506 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:14.105Z] ====== scala-kmeans (scala) [default], iteration 43 completed (313.245 ms) ====== [2025-05-16T11:10:14.105Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-05-16T11:10:14.105Z] GC before operation: completed in 54.607 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:14.778Z] ====== scala-kmeans (scala) [default], iteration 44 completed (316.947 ms) ====== [2025-05-16T11:10:14.778Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-05-16T11:10:14.778Z] GC before operation: completed in 85.575 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:15.449Z] ====== scala-kmeans (scala) [default], iteration 45 completed (318.674 ms) ====== [2025-05-16T11:10:15.449Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-05-16T11:10:15.449Z] GC before operation: completed in 96.010 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:15.449Z] ====== scala-kmeans (scala) [default], iteration 46 completed (286.033 ms) ====== [2025-05-16T11:10:15.449Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-05-16T11:10:15.449Z] GC before operation: completed in 31.463 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:16.140Z] ====== scala-kmeans (scala) [default], iteration 47 completed (280.898 ms) ====== [2025-05-16T11:10:16.140Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-05-16T11:10:16.140Z] GC before operation: completed in 60.790 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:16.140Z] ====== scala-kmeans (scala) [default], iteration 48 completed (313.036 ms) ====== [2025-05-16T11:10:16.140Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-05-16T11:10:16.140Z] GC before operation: completed in 71.670 ms, heap usage 56.299 MB -> 26.299 MB. [2025-05-16T11:10:16.785Z] ====== scala-kmeans (scala) [default], iteration 49 completed (334.784 ms) ====== [2025-05-16T11:10:16.785Z] ----------------------------------- [2025-05-16T11:10:16.785Z] renaissance-scala-kmeans_0_PASSED [2025-05-16T11:10:16.785Z] ----------------------------------- [2025-05-16T11:10:16.785Z] [2025-05-16T11:10:16.785Z] TEST TEARDOWN: [2025-05-16T11:10:16.785Z] Nothing to be done for teardown. [2025-05-16T11:10:16.785Z] renaissance-scala-kmeans_0 Finish Time: Fri May 16 11:10:16 2025 Epoch Time (ms): 1747393816476