[2025-01-22T11:22:30.296Z] Running test renaissance-scala-kmeans_0 ... [2025-01-22T11:22:30.296Z] =============================================== [2025-01-22T11:22:30.296Z] renaissance-scala-kmeans_0 Start Time: Wed Jan 22 11:22:29 2025 Epoch Time (ms): 1737544949595 [2025-01-22T11:22:30.296Z] variation: NoOptions [2025-01-22T11:22:30.296Z] JVM_OPTIONS: [2025-01-22T11:22:30.296Z] { \ [2025-01-22T11:22:30.296Z] echo ""; echo "TEST SETUP:"; \ [2025-01-22T11:22:30.296Z] echo "Nothing to be done for setup."; \ [2025-01-22T11:22:30.296Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17375428699448/renaissance-scala-kmeans_0"; \ [2025-01-22T11:22:30.296Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17375428699448/renaissance-scala-kmeans_0"; \ [2025-01-22T11:22:30.296Z] echo ""; echo "TESTING:"; \ [2025-01-22T11:22:30.296Z] /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17375428699448/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/..; \ [2025-01-22T11:22:30.296Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17375428699448/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-22T11:22:30.296Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-22T11:22:30.296Z] echo "Nothing to be done for teardown."; \ [2025-01-22T11:22:30.296Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17375428699448/TestTargetResult"; [2025-01-22T11:22:30.296Z] [2025-01-22T11:22:30.296Z] TEST SETUP: [2025-01-22T11:22:30.296Z] Nothing to be done for setup. [2025-01-22T11:22:30.296Z] [2025-01-22T11:22:30.296Z] TESTING: [2025-01-22T11:22:31.943Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-01-22T11:22:31.943Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17375428699448/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-01-22T11:22:36.568Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-01-22T11:22:36.568Z] GC before operation: completed in 286.318 ms, heap usage 33.900 MB -> 25.661 MB. [2025-01-22T11:22:39.101Z] ====== scala-kmeans (scala) [default], iteration 0 completed (2497.746 ms) ====== [2025-01-22T11:22:39.101Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-01-22T11:22:39.101Z] GC before operation: completed in 164.452 ms, heap usage 59.209 MB -> 25.718 MB. [2025-01-22T11:22:39.906Z] ====== scala-kmeans (scala) [default], iteration 1 completed (1045.207 ms) ====== [2025-01-22T11:22:39.906Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-01-22T11:22:39.906Z] GC before operation: completed in 138.435 ms, heap usage 52.613 MB -> 25.717 MB. [2025-01-22T11:22:41.536Z] ====== scala-kmeans (scala) [default], iteration 2 completed (905.261 ms) ====== [2025-01-22T11:22:41.536Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-01-22T11:22:41.536Z] GC before operation: completed in 105.706 ms, heap usage 49.707 MB -> 25.718 MB. [2025-01-22T11:22:42.331Z] ====== scala-kmeans (scala) [default], iteration 3 completed (867.832 ms) ====== [2025-01-22T11:22:42.331Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-01-22T11:22:42.331Z] GC before operation: completed in 124.872 ms, heap usage 48.343 MB -> 25.717 MB. [2025-01-22T11:22:43.129Z] ====== scala-kmeans (scala) [default], iteration 4 completed (950.118 ms) ====== [2025-01-22T11:22:43.129Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-01-22T11:22:43.129Z] GC before operation: completed in 117.115 ms, heap usage 47.422 MB -> 25.717 MB. [2025-01-22T11:22:43.931Z] ====== scala-kmeans (scala) [default], iteration 5 completed (900.516 ms) ====== [2025-01-22T11:22:43.931Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-01-22T11:22:44.714Z] GC before operation: completed in 132.986 ms, heap usage 47.426 MB -> 25.718 MB. [2025-01-22T11:22:45.515Z] ====== scala-kmeans (scala) [default], iteration 6 completed (1071.373 ms) ====== [2025-01-22T11:22:45.515Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-01-22T11:22:45.515Z] GC before operation: completed in 144.398 ms, heap usage 47.357 MB -> 25.718 MB. [2025-01-22T11:22:47.169Z] ====== scala-kmeans (scala) [default], iteration 7 completed (1358.671 ms) ====== [2025-01-22T11:22:47.169Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-01-22T11:22:47.169Z] GC before operation: completed in 173.320 ms, heap usage 47.856 MB -> 25.718 MB. [2025-01-22T11:22:48.834Z] ====== scala-kmeans (scala) [default], iteration 8 completed (1416.909 ms) ====== [2025-01-22T11:22:48.834Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-01-22T11:22:48.834Z] GC before operation: completed in 186.171 ms, heap usage 47.357 MB -> 25.718 MB. [2025-01-22T11:22:50.486Z] ====== scala-kmeans (scala) [default], iteration 9 completed (1572.267 ms) ====== [2025-01-22T11:22:50.486Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-01-22T11:22:50.486Z] GC before operation: completed in 187.660 ms, heap usage 47.357 MB -> 25.718 MB. [2025-01-22T11:22:52.159Z] ====== scala-kmeans (scala) [default], iteration 10 completed (1620.624 ms) ====== [2025-01-22T11:22:52.159Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-01-22T11:22:52.159Z] GC before operation: completed in 188.672 ms, heap usage 47.427 MB -> 25.718 MB. [2025-01-22T11:22:53.811Z] ====== scala-kmeans (scala) [default], iteration 11 completed (1375.310 ms) ====== [2025-01-22T11:22:53.811Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-01-22T11:22:53.811Z] GC before operation: completed in 154.898 ms, heap usage 47.357 MB -> 25.718 MB. [2025-01-22T11:22:55.463Z] ====== scala-kmeans (scala) [default], iteration 12 completed (1379.183 ms) ====== [2025-01-22T11:22:55.463Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-01-22T11:22:55.463Z] GC before operation: completed in 146.359 ms, heap usage 47.427 MB -> 25.718 MB. [2025-01-22T11:22:57.249Z] ====== scala-kmeans (scala) [default], iteration 13 completed (1456.178 ms) ====== [2025-01-22T11:22:57.249Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-01-22T11:22:57.249Z] GC before operation: completed in 132.580 ms, heap usage 47.427 MB -> 25.719 MB. [2025-01-22T11:22:58.062Z] ====== scala-kmeans (scala) [default], iteration 14 completed (1355.653 ms) ====== [2025-01-22T11:22:58.062Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-01-22T11:22:58.870Z] GC before operation: completed in 151.884 ms, heap usage 47.358 MB -> 25.718 MB. [2025-01-22T11:23:00.500Z] ====== scala-kmeans (scala) [default], iteration 15 completed (1803.867 ms) ====== [2025-01-22T11:23:00.500Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-01-22T11:23:00.500Z] GC before operation: completed in 177.979 ms, heap usage 96.824 MB -> 25.719 MB. [2025-01-22T11:23:02.147Z] ====== scala-kmeans (scala) [default], iteration 16 completed (1656.000 ms) ====== [2025-01-22T11:23:02.147Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-01-22T11:23:02.147Z] GC before operation: completed in 236.827 ms, heap usage 46.449 MB -> 25.720 MB. [2025-01-22T11:23:03.777Z] ====== scala-kmeans (scala) [default], iteration 17 completed (1631.427 ms) ====== [2025-01-22T11:23:03.777Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-01-22T11:23:04.568Z] GC before operation: completed in 198.212 ms, heap usage 47.431 MB -> 25.720 MB. [2025-01-22T11:23:06.183Z] ====== scala-kmeans (scala) [default], iteration 18 completed (1560.363 ms) ====== [2025-01-22T11:23:06.183Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-01-22T11:23:06.183Z] GC before operation: completed in 173.562 ms, heap usage 47.429 MB -> 25.720 MB. [2025-01-22T11:23:07.822Z] ====== scala-kmeans (scala) [default], iteration 19 completed (1483.381 ms) ====== [2025-01-22T11:23:07.822Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-01-22T11:23:07.822Z] GC before operation: completed in 155.679 ms, heap usage 47.359 MB -> 25.721 MB. [2025-01-22T11:23:08.620Z] ====== scala-kmeans (scala) [default], iteration 20 completed (1102.807 ms) ====== [2025-01-22T11:23:08.621Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-01-22T11:23:08.621Z] GC before operation: completed in 114.558 ms, heap usage 47.429 MB -> 25.721 MB. [2025-01-22T11:23:10.319Z] ====== scala-kmeans (scala) [default], iteration 21 completed (1077.777 ms) ====== [2025-01-22T11:23:10.319Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-01-22T11:23:10.319Z] GC before operation: completed in 115.842 ms, heap usage 47.429 MB -> 25.721 MB. [2025-01-22T11:23:11.965Z] ====== scala-kmeans (scala) [default], iteration 22 completed (1386.958 ms) ====== [2025-01-22T11:23:11.965Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-01-22T11:23:11.965Z] GC before operation: completed in 166.876 ms, heap usage 43.610 MB -> 25.721 MB. [2025-01-22T11:23:12.786Z] ====== scala-kmeans (scala) [default], iteration 23 completed (1260.141 ms) ====== [2025-01-22T11:23:12.786Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-01-22T11:23:12.786Z] GC before operation: completed in 136.860 ms, heap usage 47.369 MB -> 25.721 MB. [2025-01-22T11:23:14.444Z] ====== scala-kmeans (scala) [default], iteration 24 completed (1274.581 ms) ====== [2025-01-22T11:23:14.444Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-01-22T11:23:14.444Z] GC before operation: completed in 115.666 ms, heap usage 47.360 MB -> 25.721 MB. [2025-01-22T11:23:16.078Z] ====== scala-kmeans (scala) [default], iteration 25 completed (1328.713 ms) ====== [2025-01-22T11:23:16.078Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-01-22T11:23:16.078Z] GC before operation: completed in 163.544 ms, heap usage 47.430 MB -> 25.721 MB. [2025-01-22T11:23:16.869Z] ====== scala-kmeans (scala) [default], iteration 26 completed (1233.630 ms) ====== [2025-01-22T11:23:16.869Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-01-22T11:23:17.663Z] GC before operation: completed in 160.570 ms, heap usage 47.360 MB -> 25.721 MB. [2025-01-22T11:23:18.500Z] ====== scala-kmeans (scala) [default], iteration 27 completed (1234.452 ms) ====== [2025-01-22T11:23:18.501Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-01-22T11:23:18.501Z] GC before operation: completed in 139.505 ms, heap usage 47.429 MB -> 25.721 MB. [2025-01-22T11:23:20.134Z] ====== scala-kmeans (scala) [default], iteration 28 completed (1257.051 ms) ====== [2025-01-22T11:23:20.134Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-01-22T11:23:20.134Z] GC before operation: completed in 177.922 ms, heap usage 47.430 MB -> 25.721 MB. [2025-01-22T11:23:21.774Z] ====== scala-kmeans (scala) [default], iteration 29 completed (1387.616 ms) ====== [2025-01-22T11:23:21.774Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-01-22T11:23:21.774Z] GC before operation: completed in 169.090 ms, heap usage 47.430 MB -> 25.721 MB. [2025-01-22T11:23:23.421Z] ====== scala-kmeans (scala) [default], iteration 30 completed (1344.838 ms) ====== [2025-01-22T11:23:23.421Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-01-22T11:23:23.421Z] GC before operation: completed in 166.089 ms, heap usage 96.826 MB -> 25.721 MB. [2025-01-22T11:23:25.075Z] ====== scala-kmeans (scala) [default], iteration 31 completed (1335.606 ms) ====== [2025-01-22T11:23:25.075Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-01-22T11:23:25.075Z] GC before operation: completed in 135.598 ms, heap usage 46.468 MB -> 25.721 MB. [2025-01-22T11:23:25.870Z] ====== scala-kmeans (scala) [default], iteration 32 completed (1386.585 ms) ====== [2025-01-22T11:23:25.870Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-01-22T11:23:26.651Z] GC before operation: completed in 139.623 ms, heap usage 47.361 MB -> 25.722 MB. [2025-01-22T11:23:27.441Z] ====== scala-kmeans (scala) [default], iteration 33 completed (1168.153 ms) ====== [2025-01-22T11:23:27.441Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-01-22T11:23:27.441Z] GC before operation: completed in 145.275 ms, heap usage 47.361 MB -> 25.722 MB. [2025-01-22T11:23:29.092Z] ====== scala-kmeans (scala) [default], iteration 34 completed (1303.786 ms) ====== [2025-01-22T11:23:29.092Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-01-22T11:23:29.092Z] GC before operation: completed in 155.627 ms, heap usage 47.361 MB -> 25.722 MB. [2025-01-22T11:23:30.729Z] ====== scala-kmeans (scala) [default], iteration 35 completed (1375.218 ms) ====== [2025-01-22T11:23:30.729Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-01-22T11:23:30.729Z] GC before operation: completed in 157.888 ms, heap usage 47.361 MB -> 25.722 MB. [2025-01-22T11:23:32.353Z] ====== scala-kmeans (scala) [default], iteration 36 completed (1347.234 ms) ====== [2025-01-22T11:23:32.353Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-01-22T11:23:32.353Z] GC before operation: completed in 171.841 ms, heap usage 47.361 MB -> 25.724 MB. [2025-01-22T11:23:33.965Z] ====== scala-kmeans (scala) [default], iteration 37 completed (1333.034 ms) ====== [2025-01-22T11:23:33.965Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-01-22T11:23:33.965Z] GC before operation: completed in 171.685 ms, heap usage 47.363 MB -> 25.724 MB. [2025-01-22T11:23:35.586Z] ====== scala-kmeans (scala) [default], iteration 38 completed (1463.428 ms) ====== [2025-01-22T11:23:35.586Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-01-22T11:23:35.586Z] GC before operation: completed in 166.295 ms, heap usage 47.363 MB -> 25.724 MB. [2025-01-22T11:23:37.204Z] ====== scala-kmeans (scala) [default], iteration 39 completed (1421.088 ms) ====== [2025-01-22T11:23:37.204Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-01-22T11:23:37.204Z] GC before operation: completed in 161.837 ms, heap usage 96.829 MB -> 25.724 MB. [2025-01-22T11:23:37.983Z] ====== scala-kmeans (scala) [default], iteration 40 completed (1349.976 ms) ====== [2025-01-22T11:23:37.983Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-01-22T11:23:38.774Z] GC before operation: completed in 146.039 ms, heap usage 46.471 MB -> 25.724 MB. [2025-01-22T11:23:39.569Z] ====== scala-kmeans (scala) [default], iteration 41 completed (1271.099 ms) ====== [2025-01-22T11:23:39.569Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-01-22T11:23:39.569Z] GC before operation: completed in 172.799 ms, heap usage 47.434 MB -> 25.724 MB. [2025-01-22T11:23:41.206Z] ====== scala-kmeans (scala) [default], iteration 42 completed (1379.054 ms) ====== [2025-01-22T11:23:41.206Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-01-22T11:23:41.206Z] GC before operation: completed in 175.584 ms, heap usage 47.363 MB -> 25.724 MB. [2025-01-22T11:23:42.817Z] ====== scala-kmeans (scala) [default], iteration 43 completed (1424.991 ms) ====== [2025-01-22T11:23:42.817Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-01-22T11:23:42.817Z] GC before operation: completed in 153.772 ms, heap usage 47.363 MB -> 25.724 MB. [2025-01-22T11:23:44.451Z] ====== scala-kmeans (scala) [default], iteration 44 completed (1365.302 ms) ====== [2025-01-22T11:23:44.452Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-01-22T11:23:44.452Z] GC before operation: completed in 168.345 ms, heap usage 43.613 MB -> 25.724 MB. [2025-01-22T11:23:46.110Z] ====== scala-kmeans (scala) [default], iteration 45 completed (1490.521 ms) ====== [2025-01-22T11:23:46.110Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-01-22T11:23:46.110Z] GC before operation: completed in 158.748 ms, heap usage 47.372 MB -> 25.724 MB. [2025-01-22T11:23:47.756Z] ====== scala-kmeans (scala) [default], iteration 46 completed (1511.307 ms) ====== [2025-01-22T11:23:47.756Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-01-22T11:23:47.756Z] GC before operation: completed in 154.175 ms, heap usage 43.614 MB -> 25.725 MB. [2025-01-22T11:23:49.400Z] ====== scala-kmeans (scala) [default], iteration 47 completed (1346.133 ms) ====== [2025-01-22T11:23:49.400Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-01-22T11:23:49.400Z] GC before operation: completed in 166.093 ms, heap usage 47.447 MB -> 25.724 MB. [2025-01-22T11:23:51.014Z] ====== scala-kmeans (scala) [default], iteration 48 completed (1407.711 ms) ====== [2025-01-22T11:23:51.014Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-01-22T11:23:51.014Z] GC before operation: completed in 155.300 ms, heap usage 47.434 MB -> 25.724 MB. [2025-01-22T11:23:52.644Z] ====== scala-kmeans (scala) [default], iteration 49 completed (1585.661 ms) ====== [2025-01-22T11:23:53.453Z] ----------------------------------- [2025-01-22T11:23:53.453Z] renaissance-scala-kmeans_0_PASSED [2025-01-22T11:23:53.453Z] ----------------------------------- [2025-01-22T11:23:53.453Z] [2025-01-22T11:23:53.453Z] TEST TEARDOWN: [2025-01-22T11:23:53.453Z] Nothing to be done for teardown. [2025-01-22T11:23:54.245Z] renaissance-scala-kmeans_0 Finish Time: Wed Jan 22 11:23:53 2025 Epoch Time (ms): 1737545033433