[2025-01-31T00:16:24.280Z] Running test renaissance-scala-kmeans_0 ... [2025-01-31T00:16:24.280Z] =============================================== [2025-01-31T00:16:24.280Z] renaissance-scala-kmeans_0 Start Time: Thu Jan 30 18:16:23 2025 Epoch Time (ms): 1738282583990 [2025-01-31T00:16:24.280Z] variation: NoOptions [2025-01-31T00:16:24.280Z] JVM_OPTIONS: [2025-01-31T00:16:24.280Z] { \ [2025-01-31T00:16:24.280Z] echo ""; echo "TEST SETUP:"; \ [2025-01-31T00:16:24.280Z] echo "Nothing to be done for setup."; \ [2025-01-31T00:16:24.280Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17382822528701/renaissance-scala-kmeans_0"; \ [2025-01-31T00:16:24.280Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17382822528701/renaissance-scala-kmeans_0"; \ [2025-01-31T00:16:24.280Z] echo ""; echo "TESTING:"; \ [2025-01-31T00:16:24.280Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17382822528701/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/..; \ [2025-01-31T00:16:24.280Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17382822528701/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-31T00:16:24.280Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-31T00:16:24.280Z] echo "Nothing to be done for teardown."; \ [2025-01-31T00:16:24.280Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17382822528701/TestTargetResult"; [2025-01-31T00:16:24.280Z] [2025-01-31T00:16:24.280Z] TEST SETUP: [2025-01-31T00:16:24.280Z] Nothing to be done for setup. [2025-01-31T00:16:24.280Z] [2025-01-31T00:16:24.280Z] TESTING: [2025-01-31T00:16:24.957Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-01-31T00:16:24.957Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17382822528701/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-01-31T00:16:25.632Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-01-31T00:16:25.632Z] GC before operation: completed in 39.488 ms, heap usage 27.117 MB -> 26.165 MB. [2025-01-31T00:16:26.308Z] ====== scala-kmeans (scala) [default], iteration 0 completed (474.018 ms) ====== [2025-01-31T00:16:26.308Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-01-31T00:16:26.308Z] GC before operation: completed in 47.615 ms, heap usage 51.424 MB -> 26.225 MB. [2025-01-31T00:16:26.986Z] ====== scala-kmeans (scala) [default], iteration 1 completed (350.113 ms) ====== [2025-01-31T00:16:26.986Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-01-31T00:16:26.986Z] GC before operation: completed in 33.331 ms, heap usage 75.725 MB -> 26.224 MB. [2025-01-31T00:16:26.986Z] ====== scala-kmeans (scala) [default], iteration 2 completed (279.281 ms) ====== [2025-01-31T00:16:26.986Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-01-31T00:16:26.986Z] GC before operation: completed in 46.890 ms, heap usage 53.732 MB -> 26.224 MB. [2025-01-31T00:16:27.664Z] ====== scala-kmeans (scala) [default], iteration 3 completed (307.504 ms) ====== [2025-01-31T00:16:27.664Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-01-31T00:16:27.664Z] GC before operation: completed in 32.070 ms, heap usage 51.724 MB -> 26.224 MB. [2025-01-31T00:16:27.664Z] ====== scala-kmeans (scala) [default], iteration 4 completed (275.727 ms) ====== [2025-01-31T00:16:27.664Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-01-31T00:16:27.664Z] GC before operation: completed in 41.268 ms, heap usage 44.159 MB -> 26.224 MB. [2025-01-31T00:16:28.407Z] ====== scala-kmeans (scala) [default], iteration 5 completed (293.739 ms) ====== [2025-01-31T00:16:28.407Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-01-31T00:16:28.407Z] GC before operation: completed in 27.047 ms, heap usage 41.413 MB -> 26.224 MB. [2025-01-31T00:16:28.407Z] ====== scala-kmeans (scala) [default], iteration 6 completed (270.774 ms) ====== [2025-01-31T00:16:28.407Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-01-31T00:16:28.407Z] GC before operation: completed in 40.394 ms, heap usage 39.412 MB -> 26.224 MB. [2025-01-31T00:16:28.407Z] ====== scala-kmeans (scala) [default], iteration 7 completed (298.126 ms) ====== [2025-01-31T00:16:28.407Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-01-31T00:16:28.407Z] GC before operation: completed in 25.632 ms, heap usage 38.724 MB -> 26.225 MB. [2025-01-31T00:16:29.086Z] ====== scala-kmeans (scala) [default], iteration 8 completed (272.021 ms) ====== [2025-01-31T00:16:29.086Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-01-31T00:16:29.086Z] GC before operation: completed in 40.536 ms, heap usage 35.609 MB -> 26.225 MB. [2025-01-31T00:16:29.086Z] ====== scala-kmeans (scala) [default], iteration 9 completed (287.521 ms) ====== [2025-01-31T00:16:29.086Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-01-31T00:16:29.086Z] GC before operation: completed in 25.590 ms, heap usage 38.571 MB -> 26.225 MB. [2025-01-31T00:16:29.762Z] ====== scala-kmeans (scala) [default], iteration 10 completed (271.301 ms) ====== [2025-01-31T00:16:29.762Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-01-31T00:16:29.762Z] GC before operation: completed in 49.675 ms, heap usage 35.725 MB -> 26.225 MB. [2025-01-31T00:16:29.762Z] ====== scala-kmeans (scala) [default], iteration 11 completed (304.675 ms) ====== [2025-01-31T00:16:29.762Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-01-31T00:16:29.762Z] GC before operation: completed in 24.539 ms, heap usage 38.467 MB -> 26.225 MB. [2025-01-31T00:16:30.441Z] ====== scala-kmeans (scala) [default], iteration 12 completed (270.817 ms) ====== [2025-01-31T00:16:30.441Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-01-31T00:16:30.441Z] GC before operation: completed in 39.748 ms, heap usage 35.612 MB -> 26.225 MB. [2025-01-31T00:16:30.441Z] ====== scala-kmeans (scala) [default], iteration 13 completed (298.334 ms) ====== [2025-01-31T00:16:30.441Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-01-31T00:16:30.441Z] GC before operation: completed in 25.338 ms, heap usage 38.573 MB -> 26.225 MB. [2025-01-31T00:16:31.118Z] ====== scala-kmeans (scala) [default], iteration 14 completed (278.719 ms) ====== [2025-01-31T00:16:31.118Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-01-31T00:16:31.118Z] GC before operation: completed in 45.766 ms, heap usage 35.725 MB -> 26.225 MB. [2025-01-31T00:16:31.118Z] ====== scala-kmeans (scala) [default], iteration 15 completed (292.553 ms) ====== [2025-01-31T00:16:31.118Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-01-31T00:16:31.118Z] GC before operation: completed in 27.748 ms, heap usage 38.467 MB -> 26.225 MB. [2025-01-31T00:16:31.796Z] ====== scala-kmeans (scala) [default], iteration 16 completed (278.656 ms) ====== [2025-01-31T00:16:31.796Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-01-31T00:16:31.796Z] GC before operation: completed in 47.710 ms, heap usage 36.112 MB -> 26.227 MB. [2025-01-31T00:16:31.796Z] ====== scala-kmeans (scala) [default], iteration 17 completed (293.748 ms) ====== [2025-01-31T00:16:31.796Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-01-31T00:16:31.796Z] GC before operation: completed in 27.365 ms, heap usage 38.469 MB -> 26.227 MB. [2025-01-31T00:16:32.475Z] ====== scala-kmeans (scala) [default], iteration 18 completed (275.513 ms) ====== [2025-01-31T00:16:32.475Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-01-31T00:16:32.475Z] GC before operation: completed in 44.971 ms, heap usage 35.688 MB -> 26.227 MB. [2025-01-31T00:16:32.475Z] ====== scala-kmeans (scala) [default], iteration 19 completed (297.234 ms) ====== [2025-01-31T00:16:32.475Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-01-31T00:16:32.475Z] GC before operation: completed in 27.777 ms, heap usage 38.469 MB -> 26.227 MB. [2025-01-31T00:16:33.152Z] ====== scala-kmeans (scala) [default], iteration 20 completed (279.584 ms) ====== [2025-01-31T00:16:33.152Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-01-31T00:16:33.152Z] GC before operation: completed in 52.987 ms, heap usage 35.727 MB -> 26.227 MB. [2025-01-31T00:16:33.152Z] ====== scala-kmeans (scala) [default], iteration 21 completed (292.684 ms) ====== [2025-01-31T00:16:33.153Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-01-31T00:16:33.153Z] GC before operation: completed in 27.384 ms, heap usage 38.469 MB -> 26.228 MB. [2025-01-31T00:16:33.830Z] ====== scala-kmeans (scala) [default], iteration 22 completed (276.426 ms) ====== [2025-01-31T00:16:33.830Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-01-31T00:16:33.830Z] GC before operation: completed in 48.086 ms, heap usage 35.728 MB -> 26.228 MB. [2025-01-31T00:16:33.830Z] ====== scala-kmeans (scala) [default], iteration 23 completed (295.299 ms) ====== [2025-01-31T00:16:33.830Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-01-31T00:16:33.830Z] GC before operation: completed in 27.471 ms, heap usage 38.469 MB -> 26.228 MB. [2025-01-31T00:16:34.510Z] ====== scala-kmeans (scala) [default], iteration 24 completed (274.884 ms) ====== [2025-01-31T00:16:34.510Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-01-31T00:16:34.510Z] GC before operation: completed in 47.197 ms, heap usage 35.728 MB -> 26.228 MB. [2025-01-31T00:16:34.510Z] ====== scala-kmeans (scala) [default], iteration 25 completed (290.530 ms) ====== [2025-01-31T00:16:34.510Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-01-31T00:16:34.510Z] GC before operation: completed in 27.875 ms, heap usage 38.469 MB -> 26.228 MB. [2025-01-31T00:16:34.510Z] ====== scala-kmeans (scala) [default], iteration 26 completed (282.758 ms) ====== [2025-01-31T00:16:34.510Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-01-31T00:16:35.189Z] GC before operation: completed in 51.257 ms, heap usage 35.689 MB -> 26.228 MB. [2025-01-31T00:16:35.189Z] ====== scala-kmeans (scala) [default], iteration 27 completed (288.572 ms) ====== [2025-01-31T00:16:35.189Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-01-31T00:16:35.189Z] GC before operation: completed in 24.303 ms, heap usage 38.469 MB -> 26.228 MB. [2025-01-31T00:16:35.189Z] ====== scala-kmeans (scala) [default], iteration 28 completed (277.770 ms) ====== [2025-01-31T00:16:35.189Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-01-31T00:16:35.866Z] GC before operation: completed in 60.592 ms, heap usage 35.728 MB -> 26.228 MB. [2025-01-31T00:16:35.866Z] ====== scala-kmeans (scala) [default], iteration 29 completed (303.233 ms) ====== [2025-01-31T00:16:35.866Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-01-31T00:16:35.866Z] GC before operation: completed in 28.188 ms, heap usage 38.469 MB -> 26.228 MB. [2025-01-31T00:16:35.866Z] ====== scala-kmeans (scala) [default], iteration 30 completed (280.835 ms) ====== [2025-01-31T00:16:35.866Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-01-31T00:16:36.543Z] GC before operation: completed in 47.991 ms, heap usage 35.615 MB -> 26.228 MB. [2025-01-31T00:16:36.543Z] ====== scala-kmeans (scala) [default], iteration 31 completed (295.759 ms) ====== [2025-01-31T00:16:36.543Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-01-31T00:16:36.543Z] GC before operation: completed in 26.233 ms, heap usage 38.576 MB -> 26.228 MB. [2025-01-31T00:16:36.543Z] ====== scala-kmeans (scala) [default], iteration 32 completed (274.085 ms) ====== [2025-01-31T00:16:36.543Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-01-31T00:16:36.543Z] GC before operation: completed in 56.343 ms, heap usage 38.480 MB -> 26.228 MB. [2025-01-31T00:16:37.222Z] ====== scala-kmeans (scala) [default], iteration 33 completed (295.814 ms) ====== [2025-01-31T00:16:37.222Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-01-31T00:16:37.222Z] GC before operation: completed in 26.007 ms, heap usage 38.445 MB -> 26.229 MB. [2025-01-31T00:16:37.222Z] ====== scala-kmeans (scala) [default], iteration 34 completed (279.248 ms) ====== [2025-01-31T00:16:37.222Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-01-31T00:16:37.222Z] GC before operation: completed in 47.507 ms, heap usage 35.729 MB -> 26.229 MB. [2025-01-31T00:16:37.902Z] ====== scala-kmeans (scala) [default], iteration 35 completed (298.509 ms) ====== [2025-01-31T00:16:37.902Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-01-31T00:16:37.902Z] GC before operation: completed in 25.745 ms, heap usage 38.470 MB -> 26.229 MB. [2025-01-31T00:16:37.902Z] ====== scala-kmeans (scala) [default], iteration 36 completed (271.864 ms) ====== [2025-01-31T00:16:37.902Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-01-31T00:16:37.902Z] GC before operation: completed in 48.833 ms, heap usage 39.481 MB -> 26.231 MB. [2025-01-31T00:16:38.579Z] ====== scala-kmeans (scala) [default], iteration 37 completed (285.345 ms) ====== [2025-01-31T00:16:38.579Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-01-31T00:16:38.579Z] GC before operation: completed in 24.961 ms, heap usage 38.440 MB -> 26.231 MB. [2025-01-31T00:16:38.579Z] ====== scala-kmeans (scala) [default], iteration 38 completed (269.903 ms) ====== [2025-01-31T00:16:38.579Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-01-31T00:16:38.579Z] GC before operation: completed in 41.456 ms, heap usage 35.878 MB -> 26.231 MB. [2025-01-31T00:16:39.258Z] ====== scala-kmeans (scala) [default], iteration 39 completed (281.911 ms) ====== [2025-01-31T00:16:39.258Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-01-31T00:16:39.258Z] GC before operation: completed in 24.440 ms, heap usage 38.578 MB -> 26.231 MB. [2025-01-31T00:16:39.258Z] ====== scala-kmeans (scala) [default], iteration 40 completed (269.661 ms) ====== [2025-01-31T00:16:39.258Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-01-31T00:16:39.258Z] GC before operation: completed in 50.263 ms, heap usage 35.691 MB -> 26.231 MB. [2025-01-31T00:16:39.935Z] ====== scala-kmeans (scala) [default], iteration 41 completed (284.474 ms) ====== [2025-01-31T00:16:39.935Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-01-31T00:16:39.935Z] GC before operation: completed in 24.960 ms, heap usage 38.472 MB -> 26.231 MB. [2025-01-31T00:16:39.935Z] ====== scala-kmeans (scala) [default], iteration 42 completed (269.105 ms) ====== [2025-01-31T00:16:39.935Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-01-31T00:16:39.935Z] GC before operation: completed in 47.196 ms, heap usage 35.692 MB -> 26.231 MB. [2025-01-31T00:16:40.613Z] ====== scala-kmeans (scala) [default], iteration 43 completed (285.973 ms) ====== [2025-01-31T00:16:40.613Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-01-31T00:16:40.613Z] GC before operation: completed in 24.463 ms, heap usage 38.578 MB -> 26.231 MB. [2025-01-31T00:16:40.613Z] ====== scala-kmeans (scala) [default], iteration 44 completed (272.878 ms) ====== [2025-01-31T00:16:40.613Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-01-31T00:16:40.613Z] GC before operation: completed in 48.565 ms, heap usage 35.731 MB -> 26.231 MB. [2025-01-31T00:16:41.290Z] ====== scala-kmeans (scala) [default], iteration 45 completed (285.848 ms) ====== [2025-01-31T00:16:41.290Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-01-31T00:16:41.290Z] GC before operation: completed in 25.219 ms, heap usage 38.473 MB -> 26.231 MB. [2025-01-31T00:16:41.290Z] ====== scala-kmeans (scala) [default], iteration 46 completed (268.302 ms) ====== [2025-01-31T00:16:41.290Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-01-31T00:16:41.290Z] GC before operation: completed in 45.576 ms, heap usage 38.551 MB -> 26.231 MB. [2025-01-31T00:16:41.290Z] ====== scala-kmeans (scala) [default], iteration 47 completed (282.690 ms) ====== [2025-01-31T00:16:41.290Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-01-31T00:16:41.290Z] GC before operation: completed in 25.502 ms, heap usage 38.550 MB -> 26.231 MB. [2025-01-31T00:16:42.437Z] ====== scala-kmeans (scala) [default], iteration 48 completed (280.011 ms) ====== [2025-01-31T00:16:42.437Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-01-31T00:16:42.437Z] GC before operation: completed in 60.785 ms, heap usage 38.481 MB -> 26.231 MB. [2025-01-31T00:16:42.437Z] ====== scala-kmeans (scala) [default], iteration 49 completed (286.591 ms) ====== [2025-01-31T00:16:43.172Z] ----------------------------------- [2025-01-31T00:16:43.172Z] renaissance-scala-kmeans_0_PASSED [2025-01-31T00:16:43.172Z] ----------------------------------- [2025-01-31T00:16:43.172Z] [2025-01-31T00:16:43.172Z] TEST TEARDOWN: [2025-01-31T00:16:43.172Z] Nothing to be done for teardown. [2025-01-31T00:16:43.172Z] renaissance-scala-kmeans_0 Finish Time: Thu Jan 30 18:16:42 2025 Epoch Time (ms): 1738282602280