[2023-04-18T23:46:04.444Z] Running test renaissance-scala-kmeans_0 ... [2023-04-18T23:46:04.444Z] =============================================== [2023-04-18T23:46:04.444Z] renaissance-scala-kmeans_0 Start Time: Tue Apr 18 23:45:48 2023 Epoch Time (ms): 1681861548692 [2023-04-18T23:46:04.444Z] variation: NoOptions [2023-04-18T23:46:04.444Z] JVM_OPTIONS: [2023-04-18T23:46:04.444Z] { \ [2023-04-18T23:46:04.444Z] echo ""; echo "TEST SETUP:"; \ [2023-04-18T23:46:04.444Z] echo "Nothing to be done for setup."; \ [2023-04-18T23:46:04.444Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1681860942701/renaissance-scala-kmeans_0"; \ [2023-04-18T23:46:04.444Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1681860942701/renaissance-scala-kmeans_0"; \ [2023-04-18T23:46:04.444Z] echo ""; echo "TESTING:"; \ [2023-04-18T23:46:04.444Z] /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/openjdkbinary/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_1681860942701/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; \ [2023-04-18T23:46:04.444Z] 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_1681860942701/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-18T23:46:04.444Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-18T23:46:04.444Z] echo "Nothing to be done for teardown."; \ [2023-04-18T23:46:04.444Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1681860942701/TestTargetResult"; [2023-04-18T23:46:04.444Z] [2023-04-18T23:46:04.444Z] TEST SETUP: [2023-04-18T23:46:04.444Z] Nothing to be done for setup. [2023-04-18T23:46:04.444Z] [2023-04-18T23:46:04.444Z] TESTING: [2023-04-18T23:46:04.444Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2023-04-18T23:46:04.444Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_ppc64le_linux/openjdkbinary/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_1681860942701/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2023-04-18T23:46:04.444Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2023-04-18T23:46:04.444Z] GC before operation: completed in 49.124 ms, heap usage 34.754 MB -> 25.804 MB. [2023-04-18T23:46:04.444Z] ====== scala-kmeans (scala) [default], iteration 0 completed (610.285 ms) ====== [2023-04-18T23:46:04.444Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2023-04-18T23:46:04.444Z] GC before operation: completed in 81.145 ms, heap usage 30.189 MB -> 25.857 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 1 completed (447.283 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 43.640 ms, heap usage 54.201 MB -> 25.857 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 2 completed (436.087 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.655 ms, heap usage 48.610 MB -> 25.857 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 3 completed (450.051 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 23.439 ms, heap usage 97.014 MB -> 25.857 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 4 completed (454.112 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 46.312 ms, heap usage 45.619 MB -> 25.857 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 5 completed (450.632 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 48.206 ms, heap usage 48.426 MB -> 25.857 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 6 completed (439.617 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.840 ms, heap usage 49.423 MB -> 25.857 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 7 completed (458.871 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 24.099 ms, heap usage 97.995 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 8 completed (445.129 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.712 ms, heap usage 36.203 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 9 completed (433.469 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.278 ms, heap usage 44.706 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 10 completed (436.543 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.091 ms, heap usage 43.768 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 11 completed (446.144 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 24.779 ms, heap usage 95.198 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 12 completed (431.559 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.114 ms, heap usage 40.008 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 13 completed (435.993 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 43.136 ms, heap usage 43.791 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 14 completed (448.119 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 32.174 ms, heap usage 47.509 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 15 completed (436.084 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 57.718 ms, heap usage 43.748 MB -> 25.858 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 16 completed (454.166 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 86.819 ms, heap usage 44.268 MB -> 25.860 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 17 completed (450.190 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.010 ms, heap usage 43.773 MB -> 25.860 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 18 completed (464.046 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 23.752 ms, heap usage 95.082 MB -> 25.860 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 19 completed (457.496 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 43.958 ms, heap usage 43.799 MB -> 25.860 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 20 completed (445.688 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 44.528 ms, heap usage 43.770 MB -> 25.860 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 21 completed (452.310 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 56.787 ms, heap usage 43.773 MB -> 25.860 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 22 completed (460.477 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 26.335 ms, heap usage 95.202 MB -> 25.860 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 23 completed (447.133 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 58.624 ms, heap usage 40.011 MB -> 25.861 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 24 completed (443.292 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 44.232 ms, heap usage 43.794 MB -> 25.861 MB. [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 25 completed (444.781 ms) ====== [2023-04-18T23:46:04.445Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2023-04-18T23:46:04.445Z] GC before operation: completed in 42.399 ms, heap usage 47.511 MB -> 25.861 MB. [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 26 completed (470.622 ms) ====== [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2023-04-18T23:46:05.932Z] GC before operation: completed in 24.955 ms, heap usage 97.973 MB -> 25.861 MB. [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 27 completed (447.938 ms) ====== [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2023-04-18T23:46:05.932Z] GC before operation: completed in 44.182 ms, heap usage 43.774 MB -> 25.861 MB. [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 28 completed (444.479 ms) ====== [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2023-04-18T23:46:05.932Z] GC before operation: completed in 45.230 ms, heap usage 43.769 MB -> 25.861 MB. [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 29 completed (448.781 ms) ====== [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2023-04-18T23:46:05.932Z] GC before operation: completed in 46.561 ms, heap usage 43.774 MB -> 25.861 MB. [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 30 completed (458.948 ms) ====== [2023-04-18T23:46:05.932Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2023-04-18T23:46:05.932Z] GC before operation: completed in 41.360 ms, heap usage 95.083 MB -> 25.861 MB. [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 31 completed (442.886 ms) ====== [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2023-04-18T23:46:08.005Z] GC before operation: completed in 44.336 ms, heap usage 43.799 MB -> 25.861 MB. [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 32 completed (450.604 ms) ====== [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2023-04-18T23:46:08.005Z] GC before operation: completed in 45.884 ms, heap usage 43.771 MB -> 25.862 MB. [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 33 completed (451.393 ms) ====== [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2023-04-18T23:46:08.005Z] GC before operation: completed in 43.680 ms, heap usage 43.692 MB -> 25.862 MB. [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 34 completed (456.987 ms) ====== [2023-04-18T23:46:08.005Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2023-04-18T23:46:08.005Z] GC before operation: completed in 43.480 ms, heap usage 95.204 MB -> 25.862 MB. [2023-04-18T23:46:11.222Z] ====== scala-kmeans (scala) [default], iteration 35 completed (450.121 ms) ====== [2023-04-18T23:46:11.222Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2023-04-18T23:46:11.222Z] GC before operation: completed in 42.554 ms, heap usage 40.012 MB -> 25.862 MB. [2023-04-18T23:46:11.222Z] ====== scala-kmeans (scala) [default], iteration 36 completed (454.672 ms) ====== [2023-04-18T23:46:11.222Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2023-04-18T23:46:11.222Z] GC before operation: completed in 44.015 ms, heap usage 43.795 MB -> 25.864 MB. [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 37 completed (448.877 ms) ====== [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2023-04-18T23:46:11.223Z] GC before operation: completed in 48.118 ms, heap usage 43.778 MB -> 25.864 MB. [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 38 completed (464.692 ms) ====== [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2023-04-18T23:46:11.223Z] GC before operation: completed in 41.281 ms, heap usage 95.086 MB -> 25.863 MB. [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 39 completed (445.255 ms) ====== [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2023-04-18T23:46:11.223Z] GC before operation: completed in 47.633 ms, heap usage 40.014 MB -> 25.864 MB. [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 40 completed (449.526 ms) ====== [2023-04-18T23:46:11.223Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2023-04-18T23:46:11.223Z] GC before operation: completed in 42.314 ms, heap usage 43.711 MB -> 25.864 MB. [2023-04-18T23:46:12.163Z] ====== scala-kmeans (scala) [default], iteration 41 completed (444.658 ms) ====== [2023-04-18T23:46:12.163Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2023-04-18T23:46:12.163Z] GC before operation: completed in 45.724 ms, heap usage 43.778 MB -> 25.864 MB. [2023-04-18T23:46:12.163Z] ====== scala-kmeans (scala) [default], iteration 42 completed (463.434 ms) ====== [2023-04-18T23:46:12.163Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2023-04-18T23:46:12.163Z] GC before operation: completed in 37.228 ms, heap usage 96.966 MB -> 25.864 MB. [2023-04-18T23:46:12.163Z] ====== scala-kmeans (scala) [default], iteration 43 completed (446.989 ms) ====== [2023-04-18T23:46:12.163Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2023-04-18T23:46:12.163Z] GC before operation: completed in 43.506 ms, heap usage 43.719 MB -> 25.864 MB. [2023-04-18T23:46:13.103Z] ====== scala-kmeans (scala) [default], iteration 44 completed (450.124 ms) ====== [2023-04-18T23:46:13.103Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2023-04-18T23:46:13.103Z] GC before operation: completed in 46.674 ms, heap usage 43.773 MB -> 25.864 MB. [2023-04-18T23:46:13.103Z] ====== scala-kmeans (scala) [default], iteration 45 completed (444.773 ms) ====== [2023-04-18T23:46:13.103Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2023-04-18T23:46:14.043Z] GC before operation: completed in 80.783 ms, heap usage 43.777 MB -> 25.864 MB. [2023-04-18T23:46:14.043Z] ====== scala-kmeans (scala) [default], iteration 46 completed (461.850 ms) ====== [2023-04-18T23:46:14.043Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2023-04-18T23:46:14.043Z] GC before operation: completed in 37.733 ms, heap usage 95.086 MB -> 25.864 MB. [2023-04-18T23:46:15.743Z] ====== scala-kmeans (scala) [default], iteration 47 completed (445.879 ms) ====== [2023-04-18T23:46:15.743Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2023-04-18T23:46:15.743Z] GC before operation: completed in 46.886 ms, heap usage 43.802 MB -> 25.864 MB. [2023-04-18T23:46:15.743Z] ====== scala-kmeans (scala) [default], iteration 48 completed (444.453 ms) ====== [2023-04-18T23:46:15.743Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2023-04-18T23:46:15.743Z] GC before operation: completed in 45.640 ms, heap usage 43.774 MB -> 25.864 MB. [2023-04-18T23:46:15.743Z] ====== scala-kmeans (scala) [default], iteration 49 completed (450.789 ms) ====== [2023-04-18T23:46:15.743Z] ----------------------------------- [2023-04-18T23:46:15.743Z] renaissance-scala-kmeans_0_PASSED [2023-04-18T23:46:15.743Z] ----------------------------------- [2023-04-18T23:46:15.743Z] [2023-04-18T23:46:15.743Z] TEST TEARDOWN: [2023-04-18T23:46:15.743Z] Nothing to be done for teardown. [2023-04-18T23:46:15.743Z] renaissance-scala-kmeans_0 Finish Time: Tue Apr 18 23:46:15 2023 Epoch Time (ms): 1681861575140