[2025-01-30T23:17:42.027Z] Running test renaissance-scala-kmeans_0 ... [2025-01-30T23:17:42.027Z] =============================================== [2025-01-30T23:17:42.027Z] renaissance-scala-kmeans_0 Start Time: Thu Jan 30 23:17:41 2025 Epoch Time (ms): 1738279061115 [2025-01-30T23:17:42.027Z] variation: NoOptions [2025-01-30T23:17:42.027Z] JVM_OPTIONS: [2025-01-30T23:17:42.027Z] { \ [2025-01-30T23:17:42.027Z] echo ""; echo "TEST SETUP:"; \ [2025-01-30T23:17:42.027Z] echo "Nothing to be done for setup."; \ [2025-01-30T23:17:42.027Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17382784364302/renaissance-scala-kmeans_0"; \ [2025-01-30T23:17:42.027Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17382784364302/renaissance-scala-kmeans_0"; \ [2025-01-30T23:17:42.027Z] echo ""; echo "TESTING:"; \ [2025-01-30T23:17:42.027Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17382784364302/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; \ [2025-01-30T23:17:42.027Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17382784364302/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-30T23:17:42.027Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-30T23:17:42.027Z] echo "Nothing to be done for teardown."; \ [2025-01-30T23:17:42.027Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17382784364302/TestTargetResult"; [2025-01-30T23:17:42.027Z] [2025-01-30T23:17:42.027Z] TEST SETUP: [2025-01-30T23:17:42.027Z] Nothing to be done for setup. [2025-01-30T23:17:42.027Z] [2025-01-30T23:17:42.027Z] TESTING: [2025-01-30T23:17:42.027Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-01-30T23:17:42.027Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17382784364302/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-01-30T23:17:42.978Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-01-30T23:17:42.978Z] GC before operation: completed in 52.565 ms, heap usage 36.662 MB -> 25.916 MB. [2025-01-30T23:17:43.928Z] ====== scala-kmeans (scala) [default], iteration 0 completed (512.512 ms) ====== [2025-01-30T23:17:43.928Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-01-30T23:17:43.928Z] GC before operation: completed in 42.810 ms, heap usage 50.270 MB -> 25.974 MB. [2025-01-30T23:17:43.928Z] ====== scala-kmeans (scala) [default], iteration 1 completed (375.669 ms) ====== [2025-01-30T23:17:43.928Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-01-30T23:17:43.928Z] GC before operation: completed in 24.404 ms, heap usage 34.974 MB -> 25.974 MB. [2025-01-30T23:17:43.928Z] ====== scala-kmeans (scala) [default], iteration 2 completed (368.819 ms) ====== [2025-01-30T23:17:43.928Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-01-30T23:17:43.928Z] GC before operation: completed in 42.011 ms, heap usage 61.961 MB -> 25.974 MB. [2025-01-30T23:17:44.879Z] ====== scala-kmeans (scala) [default], iteration 3 completed (371.102 ms) ====== [2025-01-30T23:17:44.879Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-01-30T23:17:44.879Z] GC before operation: completed in 42.048 ms, heap usage 55.188 MB -> 25.974 MB. [2025-01-30T23:17:44.879Z] ====== scala-kmeans (scala) [default], iteration 4 completed (373.080 ms) ====== [2025-01-30T23:17:44.879Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-01-30T23:17:44.879Z] GC before operation: completed in 42.506 ms, heap usage 49.576 MB -> 25.974 MB. [2025-01-30T23:17:45.831Z] ====== scala-kmeans (scala) [default], iteration 5 completed (380.108 ms) ====== [2025-01-30T23:17:45.831Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-01-30T23:17:45.831Z] GC before operation: completed in 23.674 ms, heap usage 97.177 MB -> 25.974 MB. [2025-01-30T23:17:45.831Z] ====== scala-kmeans (scala) [default], iteration 6 completed (375.469 ms) ====== [2025-01-30T23:17:45.831Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-01-30T23:17:45.831Z] GC before operation: completed in 41.631 ms, heap usage 41.957 MB -> 25.974 MB. [2025-01-30T23:17:46.781Z] ====== scala-kmeans (scala) [default], iteration 7 completed (372.843 ms) ====== [2025-01-30T23:17:46.781Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-01-30T23:17:46.781Z] GC before operation: completed in 45.608 ms, heap usage 43.105 MB -> 25.975 MB. [2025-01-30T23:17:46.781Z] ====== scala-kmeans (scala) [default], iteration 8 completed (379.205 ms) ====== [2025-01-30T23:17:46.781Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-01-30T23:17:46.781Z] GC before operation: completed in 44.494 ms, heap usage 42.001 MB -> 25.975 MB. [2025-01-30T23:17:47.872Z] ====== scala-kmeans (scala) [default], iteration 9 completed (386.143 ms) ====== [2025-01-30T23:17:47.872Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-01-30T23:17:47.872Z] GC before operation: completed in 27.323 ms, heap usage 94.255 MB -> 25.975 MB. [2025-01-30T23:17:47.872Z] ====== scala-kmeans (scala) [default], iteration 10 completed (378.828 ms) ====== [2025-01-30T23:17:47.872Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-01-30T23:17:47.872Z] GC before operation: completed in 44.500 ms, heap usage 42.026 MB -> 25.975 MB. [2025-01-30T23:17:47.872Z] ====== scala-kmeans (scala) [default], iteration 11 completed (372.302 ms) ====== [2025-01-30T23:17:47.872Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-01-30T23:17:47.872Z] GC before operation: completed in 42.750 ms, heap usage 42.183 MB -> 25.975 MB. [2025-01-30T23:17:48.827Z] ====== scala-kmeans (scala) [default], iteration 12 completed (371.766 ms) ====== [2025-01-30T23:17:48.827Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-01-30T23:17:48.827Z] GC before operation: completed in 42.558 ms, heap usage 42.188 MB -> 25.975 MB. [2025-01-30T23:17:48.827Z] ====== scala-kmeans (scala) [default], iteration 13 completed (380.337 ms) ====== [2025-01-30T23:17:48.827Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-01-30T23:17:48.827Z] GC before operation: completed in 36.761 ms, heap usage 94.387 MB -> 25.975 MB. [2025-01-30T23:17:49.781Z] ====== scala-kmeans (scala) [default], iteration 14 completed (374.185 ms) ====== [2025-01-30T23:17:49.781Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-01-30T23:17:49.781Z] GC before operation: completed in 42.366 ms, heap usage 42.027 MB -> 25.975 MB. [2025-01-30T23:17:49.781Z] ====== scala-kmeans (scala) [default], iteration 15 completed (375.778 ms) ====== [2025-01-30T23:17:49.781Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-01-30T23:17:49.781Z] GC before operation: completed in 43.280 ms, heap usage 42.183 MB -> 25.975 MB. [2025-01-30T23:17:49.781Z] ====== scala-kmeans (scala) [default], iteration 16 completed (373.212 ms) ====== [2025-01-30T23:17:49.781Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-01-30T23:17:49.781Z] GC before operation: completed in 44.281 ms, heap usage 42.688 MB -> 25.977 MB. [2025-01-30T23:17:50.730Z] ====== scala-kmeans (scala) [default], iteration 17 completed (397.504 ms) ====== [2025-01-30T23:17:50.730Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-01-30T23:17:50.730Z] GC before operation: completed in 31.101 ms, heap usage 94.389 MB -> 25.977 MB. [2025-01-30T23:17:50.730Z] ====== scala-kmeans (scala) [default], iteration 18 completed (384.127 ms) ====== [2025-01-30T23:17:50.730Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-01-30T23:17:50.730Z] GC before operation: completed in 44.443 ms, heap usage 42.186 MB -> 25.977 MB. [2025-01-30T23:17:51.680Z] ====== scala-kmeans (scala) [default], iteration 19 completed (369.014 ms) ====== [2025-01-30T23:17:51.680Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-01-30T23:17:51.680Z] GC before operation: completed in 42.890 ms, heap usage 42.185 MB -> 25.977 MB. [2025-01-30T23:17:51.680Z] ====== scala-kmeans (scala) [default], iteration 20 completed (371.067 ms) ====== [2025-01-30T23:17:51.680Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-01-30T23:17:51.680Z] GC before operation: completed in 42.813 ms, heap usage 42.190 MB -> 25.977 MB. [2025-01-30T23:17:52.635Z] ====== scala-kmeans (scala) [default], iteration 21 completed (385.712 ms) ====== [2025-01-30T23:17:52.635Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-01-30T23:17:52.635Z] GC before operation: completed in 28.984 ms, heap usage 94.389 MB -> 25.978 MB. [2025-01-30T23:17:52.635Z] ====== scala-kmeans (scala) [default], iteration 22 completed (369.450 ms) ====== [2025-01-30T23:17:52.635Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-01-30T23:17:52.635Z] GC before operation: completed in 80.261 ms, heap usage 42.029 MB -> 25.977 MB. [2025-01-30T23:17:53.585Z] ====== scala-kmeans (scala) [default], iteration 23 completed (370.425 ms) ====== [2025-01-30T23:17:53.585Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-01-30T23:17:53.585Z] GC before operation: completed in 42.780 ms, heap usage 42.185 MB -> 25.978 MB. [2025-01-30T23:17:53.585Z] ====== scala-kmeans (scala) [default], iteration 24 completed (373.310 ms) ====== [2025-01-30T23:17:53.585Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-01-30T23:17:53.585Z] GC before operation: completed in 43.607 ms, heap usage 42.190 MB -> 25.978 MB. [2025-01-30T23:17:53.585Z] ====== scala-kmeans (scala) [default], iteration 25 completed (375.571 ms) ====== [2025-01-30T23:17:53.585Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-01-30T23:17:53.585Z] GC before operation: completed in 28.889 ms, heap usage 94.390 MB -> 25.978 MB. [2025-01-30T23:17:54.534Z] ====== scala-kmeans (scala) [default], iteration 26 completed (371.383 ms) ====== [2025-01-30T23:17:54.534Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-01-30T23:17:54.534Z] GC before operation: completed in 42.569 ms, heap usage 42.029 MB -> 25.978 MB. [2025-01-30T23:17:54.534Z] ====== scala-kmeans (scala) [default], iteration 27 completed (373.100 ms) ====== [2025-01-30T23:17:54.534Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-01-30T23:17:54.534Z] GC before operation: completed in 44.738 ms, heap usage 42.097 MB -> 25.978 MB. [2025-01-30T23:17:55.484Z] ====== scala-kmeans (scala) [default], iteration 28 completed (375.590 ms) ====== [2025-01-30T23:17:55.484Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-01-30T23:17:55.484Z] GC before operation: completed in 23.608 ms, heap usage 94.389 MB -> 25.978 MB. [2025-01-30T23:17:55.484Z] ====== scala-kmeans (scala) [default], iteration 29 completed (370.599 ms) ====== [2025-01-30T23:17:55.484Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-01-30T23:17:55.484Z] GC before operation: completed in 42.387 ms, heap usage 42.029 MB -> 25.978 MB. [2025-01-30T23:17:56.439Z] ====== scala-kmeans (scala) [default], iteration 30 completed (368.195 ms) ====== [2025-01-30T23:17:56.439Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-01-30T23:17:56.439Z] GC before operation: completed in 42.594 ms, heap usage 42.185 MB -> 25.978 MB. [2025-01-30T23:17:56.439Z] ====== scala-kmeans (scala) [default], iteration 31 completed (367.733 ms) ====== [2025-01-30T23:17:56.439Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-01-30T23:17:56.439Z] GC before operation: completed in 41.961 ms, heap usage 42.190 MB -> 25.978 MB. [2025-01-30T23:17:56.439Z] ====== scala-kmeans (scala) [default], iteration 32 completed (375.123 ms) ====== [2025-01-30T23:17:56.439Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-01-30T23:17:57.392Z] GC before operation: completed in 42.602 ms, heap usage 94.260 MB -> 25.978 MB. [2025-01-30T23:17:57.392Z] ====== scala-kmeans (scala) [default], iteration 33 completed (368.323 ms) ====== [2025-01-30T23:17:57.392Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-01-30T23:17:57.392Z] GC before operation: completed in 45.077 ms, heap usage 42.187 MB -> 25.979 MB. [2025-01-30T23:17:57.392Z] ====== scala-kmeans (scala) [default], iteration 34 completed (369.391 ms) ====== [2025-01-30T23:17:57.392Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-01-30T23:17:57.392Z] GC before operation: completed in 43.557 ms, heap usage 42.186 MB -> 25.979 MB. [2025-01-30T23:17:58.342Z] ====== scala-kmeans (scala) [default], iteration 35 completed (376.226 ms) ====== [2025-01-30T23:17:58.343Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-01-30T23:17:58.343Z] GC before operation: completed in 43.519 ms, heap usage 42.013 MB -> 25.979 MB. [2025-01-30T23:17:58.343Z] ====== scala-kmeans (scala) [default], iteration 36 completed (378.104 ms) ====== [2025-01-30T23:17:58.343Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-01-30T23:17:58.343Z] GC before operation: completed in 30.344 ms, heap usage 94.391 MB -> 25.980 MB. [2025-01-30T23:17:59.307Z] ====== scala-kmeans (scala) [default], iteration 37 completed (371.661 ms) ====== [2025-01-30T23:17:59.307Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-01-30T23:17:59.307Z] GC before operation: completed in 48.252 ms, heap usage 42.032 MB -> 25.981 MB. [2025-01-30T23:17:59.307Z] ====== scala-kmeans (scala) [default], iteration 38 completed (368.126 ms) ====== [2025-01-30T23:17:59.307Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-01-30T23:17:59.307Z] GC before operation: completed in 43.283 ms, heap usage 42.188 MB -> 25.981 MB. [2025-01-30T23:18:00.259Z] ====== scala-kmeans (scala) [default], iteration 39 completed (372.056 ms) ====== [2025-01-30T23:18:00.259Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-01-30T23:18:00.259Z] GC before operation: completed in 79.889 ms, heap usage 42.015 MB -> 25.981 MB. [2025-01-30T23:18:00.259Z] ====== scala-kmeans (scala) [default], iteration 40 completed (382.299 ms) ====== [2025-01-30T23:18:00.259Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-01-30T23:18:00.259Z] GC before operation: completed in 37.432 ms, heap usage 94.393 MB -> 25.981 MB. [2025-01-30T23:18:00.259Z] ====== scala-kmeans (scala) [default], iteration 41 completed (374.728 ms) ====== [2025-01-30T23:18:00.259Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-01-30T23:18:00.259Z] GC before operation: completed in 58.384 ms, heap usage 42.032 MB -> 25.981 MB. [2025-01-30T23:18:01.209Z] ====== scala-kmeans (scala) [default], iteration 42 completed (372.816 ms) ====== [2025-01-30T23:18:01.209Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-01-30T23:18:01.209Z] GC before operation: completed in 46.620 ms, heap usage 42.188 MB -> 25.981 MB. [2025-01-30T23:18:01.209Z] ====== scala-kmeans (scala) [default], iteration 43 completed (379.920 ms) ====== [2025-01-30T23:18:01.209Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-01-30T23:18:01.209Z] GC before operation: completed in 27.305 ms, heap usage 94.392 MB -> 25.981 MB. [2025-01-30T23:18:02.162Z] ====== scala-kmeans (scala) [default], iteration 44 completed (375.456 ms) ====== [2025-01-30T23:18:02.162Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-01-30T23:18:02.162Z] GC before operation: completed in 43.514 ms, heap usage 42.190 MB -> 25.981 MB. [2025-01-30T23:18:02.162Z] ====== scala-kmeans (scala) [default], iteration 45 completed (369.220 ms) ====== [2025-01-30T23:18:02.162Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-01-30T23:18:02.162Z] GC before operation: completed in 42.442 ms, heap usage 42.188 MB -> 25.981 MB. [2025-01-30T23:18:03.146Z] ====== scala-kmeans (scala) [default], iteration 46 completed (374.630 ms) ====== [2025-01-30T23:18:03.146Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-01-30T23:18:03.146Z] GC before operation: completed in 42.726 ms, heap usage 42.193 MB -> 25.981 MB. [2025-01-30T23:18:03.146Z] ====== scala-kmeans (scala) [default], iteration 47 completed (375.611 ms) ====== [2025-01-30T23:18:03.146Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-01-30T23:18:03.146Z] GC before operation: completed in 29.190 ms, heap usage 94.393 MB -> 25.981 MB. [2025-01-30T23:18:03.146Z] ====== scala-kmeans (scala) [default], iteration 48 completed (369.055 ms) ====== [2025-01-30T23:18:03.146Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-01-30T23:18:04.096Z] GC before operation: completed in 43.151 ms, heap usage 42.032 MB -> 25.981 MB. [2025-01-30T23:18:04.096Z] ====== scala-kmeans (scala) [default], iteration 49 completed (380.541 ms) ====== [2025-01-30T23:18:04.096Z] ----------------------------------- [2025-01-30T23:18:04.096Z] renaissance-scala-kmeans_0_PASSED [2025-01-30T23:18:04.096Z] ----------------------------------- [2025-01-30T23:18:04.096Z] [2025-01-30T23:18:04.096Z] TEST TEARDOWN: [2025-01-30T23:18:04.096Z] Nothing to be done for teardown. [2025-01-30T23:18:04.096Z] renaissance-scala-kmeans_0 Finish Time: Thu Jan 30 23:18:03 2025 Epoch Time (ms): 1738279083681