[2025-09-25T02:54:10.630Z] Running test renaissance-scala-kmeans_0 ... [2025-09-25T02:54:10.630Z] =============================================== [2025-09-25T02:54:10.630Z] renaissance-scala-kmeans_0 Start Time: Thu Sep 25 02:54:10 2025 Epoch Time (ms): 1758768850504 [2025-09-25T02:54:10.630Z] variation: NoOptions [2025-09-25T02:54:10.630Z] JVM_OPTIONS: [2025-09-25T02:54:10.630Z] { \ [2025-09-25T02:54:10.630Z] echo ""; echo "TEST SETUP:"; \ [2025-09-25T02:54:10.630Z] echo "Nothing to be done for setup."; \ [2025-09-25T02:54:10.631Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1758766172450/renaissance-scala-kmeans_0"; \ [2025-09-25T02:54:10.631Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1758766172450/renaissance-scala-kmeans_0"; \ [2025-09-25T02:54:10.631Z] echo ""; echo "TESTING:"; \ [2025-09-25T02:54:10.631Z] /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1758766172450/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/..; \ [2025-09-25T02:54:10.631Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1758766172450/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-09-25T02:54:10.631Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-09-25T02:54:10.631Z] echo "Nothing to be done for teardown."; \ [2025-09-25T02:54:10.631Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1758766172450/TestTargetResult"; [2025-09-25T02:54:10.631Z] [2025-09-25T02:54:10.631Z] TEST SETUP: [2025-09-25T02:54:10.631Z] Nothing to be done for setup. [2025-09-25T02:54:10.631Z] [2025-09-25T02:54:10.631Z] TESTING: [2025-09-25T02:54:11.294Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2025-09-25T02:54:11.294Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk17_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1758766172450/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-09-25T02:54:12.592Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-09-25T02:54:12.592Z] GC before operation: completed in 40.362 ms, heap usage 27.187 MB -> 26.125 MB. [2025-09-25T02:54:13.237Z] ====== scala-kmeans (scala) [default], iteration 0 completed (743.588 ms) ====== [2025-09-25T02:54:13.237Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-09-25T02:54:13.858Z] GC before operation: completed in 66.228 ms, heap usage 78.706 MB -> 26.212 MB. [2025-09-25T02:54:13.858Z] ====== scala-kmeans (scala) [default], iteration 1 completed (516.400 ms) ====== [2025-09-25T02:54:13.858Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-09-25T02:54:13.858Z] GC before operation: completed in 40.934 ms, heap usage 49.471 MB -> 26.212 MB. [2025-09-25T02:54:14.482Z] ====== scala-kmeans (scala) [default], iteration 2 completed (554.653 ms) ====== [2025-09-25T02:54:14.483Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-09-25T02:54:14.483Z] GC before operation: completed in 38.500 ms, heap usage 110.543 MB -> 26.212 MB. [2025-09-25T02:54:15.113Z] ====== scala-kmeans (scala) [default], iteration 3 completed (469.478 ms) ====== [2025-09-25T02:54:15.113Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-09-25T02:54:15.113Z] GC before operation: completed in 45.663 ms, heap usage 63.466 MB -> 26.212 MB. [2025-09-25T02:54:15.738Z] ====== scala-kmeans (scala) [default], iteration 4 completed (470.510 ms) ====== [2025-09-25T02:54:15.738Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-09-25T02:54:15.738Z] GC before operation: completed in 39.975 ms, heap usage 54.018 MB -> 26.212 MB. [2025-09-25T02:54:16.371Z] ====== scala-kmeans (scala) [default], iteration 5 completed (488.488 ms) ====== [2025-09-25T02:54:16.371Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-09-25T02:54:16.371Z] GC before operation: completed in 68.195 ms, heap usage 99.749 MB -> 26.212 MB. [2025-09-25T02:54:16.997Z] ====== scala-kmeans (scala) [default], iteration 6 completed (425.437 ms) ====== [2025-09-25T02:54:16.997Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-09-25T02:54:16.997Z] GC before operation: completed in 40.549 ms, heap usage 48.326 MB -> 26.212 MB. [2025-09-25T02:54:16.997Z] ====== scala-kmeans (scala) [default], iteration 7 completed (481.771 ms) ====== [2025-09-25T02:54:16.998Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-09-25T02:54:16.998Z] GC before operation: completed in 41.723 ms, heap usage 47.417 MB -> 26.212 MB. [2025-09-25T02:54:17.605Z] ====== scala-kmeans (scala) [default], iteration 8 completed (460.581 ms) ====== [2025-09-25T02:54:17.605Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-09-25T02:54:17.605Z] GC before operation: completed in 63.154 ms, heap usage 97.837 MB -> 26.213 MB. [2025-09-25T02:54:18.254Z] ====== scala-kmeans (scala) [default], iteration 9 completed (523.083 ms) ====== [2025-09-25T02:54:18.254Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-09-25T02:54:18.254Z] GC before operation: completed in 55.477 ms, heap usage 45.541 MB -> 26.213 MB. [2025-09-25T02:54:18.871Z] ====== scala-kmeans (scala) [default], iteration 10 completed (442.891 ms) ====== [2025-09-25T02:54:18.871Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-09-25T02:54:18.871Z] GC before operation: completed in 47.369 ms, heap usage 46.441 MB -> 26.213 MB. [2025-09-25T02:54:19.476Z] ====== scala-kmeans (scala) [default], iteration 11 completed (450.846 ms) ====== [2025-09-25T02:54:19.476Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-09-25T02:54:19.476Z] GC before operation: completed in 74.046 ms, heap usage 44.611 MB -> 26.213 MB. [2025-09-25T02:54:20.120Z] ====== scala-kmeans (scala) [default], iteration 12 completed (462.127 ms) ====== [2025-09-25T02:54:20.120Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-09-25T02:54:20.120Z] GC before operation: completed in 43.123 ms, heap usage 44.540 MB -> 26.213 MB. [2025-09-25T02:54:20.120Z] ====== scala-kmeans (scala) [default], iteration 13 completed (430.875 ms) ====== [2025-09-25T02:54:20.120Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-09-25T02:54:20.791Z] GC before operation: completed in 53.871 ms, heap usage 46.447 MB -> 26.213 MB. [2025-09-25T02:54:20.791Z] ====== scala-kmeans (scala) [default], iteration 14 completed (500.786 ms) ====== [2025-09-25T02:54:20.791Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-09-25T02:54:20.791Z] GC before operation: completed in 55.715 ms, heap usage 44.613 MB -> 26.213 MB. [2025-09-25T02:54:21.432Z] ====== scala-kmeans (scala) [default], iteration 15 completed (471.694 ms) ====== [2025-09-25T02:54:21.432Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-09-25T02:54:21.432Z] GC before operation: completed in 64.841 ms, heap usage 44.623 MB -> 26.213 MB. [2025-09-25T02:54:22.062Z] ====== scala-kmeans (scala) [default], iteration 16 completed (442.455 ms) ====== [2025-09-25T02:54:22.062Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-09-25T02:54:22.062Z] GC before operation: completed in 46.074 ms, heap usage 95.933 MB -> 26.214 MB. [2025-09-25T02:54:22.701Z] ====== scala-kmeans (scala) [default], iteration 17 completed (492.013 ms) ====== [2025-09-25T02:54:22.701Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-09-25T02:54:22.701Z] GC before operation: completed in 41.531 ms, heap usage 44.577 MB -> 26.214 MB. [2025-09-25T02:54:23.333Z] ====== scala-kmeans (scala) [default], iteration 18 completed (509.238 ms) ====== [2025-09-25T02:54:23.333Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-09-25T02:54:23.333Z] GC before operation: completed in 46.002 ms, heap usage 44.621 MB -> 26.214 MB. [2025-09-25T02:54:23.333Z] ====== scala-kmeans (scala) [default], iteration 19 completed (410.064 ms) ====== [2025-09-25T02:54:23.333Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-09-25T02:54:23.333Z] GC before operation: completed in 34.742 ms, heap usage 44.542 MB -> 26.214 MB. [2025-09-25T02:54:23.982Z] ====== scala-kmeans (scala) [default], iteration 20 completed (407.664 ms) ====== [2025-09-25T02:54:23.983Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-09-25T02:54:23.983Z] GC before operation: completed in 28.655 ms, heap usage 44.624 MB -> 26.214 MB. [2025-09-25T02:54:24.604Z] ====== scala-kmeans (scala) [default], iteration 21 completed (470.391 ms) ====== [2025-09-25T02:54:24.604Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-09-25T02:54:24.604Z] GC before operation: completed in 38.333 ms, heap usage 97.053 MB -> 26.214 MB. [2025-09-25T02:54:25.228Z] ====== scala-kmeans (scala) [default], iteration 22 completed (491.093 ms) ====== [2025-09-25T02:54:25.228Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-09-25T02:54:25.228Z] GC before operation: completed in 38.824 ms, heap usage 44.644 MB -> 26.214 MB. [2025-09-25T02:54:25.228Z] ====== scala-kmeans (scala) [default], iteration 23 completed (454.413 ms) ====== [2025-09-25T02:54:25.228Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-09-25T02:54:25.842Z] GC before operation: completed in 71.836 ms, heap usage 44.621 MB -> 26.214 MB. [2025-09-25T02:54:25.842Z] ====== scala-kmeans (scala) [default], iteration 24 completed (411.027 ms) ====== [2025-09-25T02:54:25.842Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-09-25T02:54:25.842Z] GC before operation: completed in 38.750 ms, heap usage 44.624 MB -> 26.214 MB. [2025-09-25T02:54:26.500Z] ====== scala-kmeans (scala) [default], iteration 25 completed (442.296 ms) ====== [2025-09-25T02:54:26.500Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-09-25T02:54:26.500Z] GC before operation: completed in 103.641 ms, heap usage 46.526 MB -> 26.214 MB. [2025-09-25T02:54:27.121Z] ====== scala-kmeans (scala) [default], iteration 26 completed (423.630 ms) ====== [2025-09-25T02:54:27.121Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-09-25T02:54:27.121Z] GC before operation: completed in 26.769 ms, heap usage 44.613 MB -> 26.214 MB. [2025-09-25T02:54:27.121Z] ====== scala-kmeans (scala) [default], iteration 27 completed (395.137 ms) ====== [2025-09-25T02:54:27.121Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-09-25T02:54:27.736Z] GC before operation: completed in 50.073 ms, heap usage 46.448 MB -> 26.214 MB. [2025-09-25T02:54:27.736Z] ====== scala-kmeans (scala) [default], iteration 28 completed (426.653 ms) ====== [2025-09-25T02:54:27.736Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-09-25T02:54:27.736Z] GC before operation: completed in 57.311 ms, heap usage 40.830 MB -> 26.214 MB. [2025-09-25T02:54:28.360Z] ====== scala-kmeans (scala) [default], iteration 29 completed (466.783 ms) ====== [2025-09-25T02:54:28.360Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-09-25T02:54:28.360Z] GC before operation: completed in 45.226 ms, heap usage 44.561 MB -> 26.214 MB. [2025-09-25T02:54:29.010Z] ====== scala-kmeans (scala) [default], iteration 30 completed (428.946 ms) ====== [2025-09-25T02:54:29.010Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-09-25T02:54:29.010Z] GC before operation: completed in 52.386 ms, heap usage 40.849 MB -> 26.214 MB. [2025-09-25T02:54:29.658Z] ====== scala-kmeans (scala) [default], iteration 31 completed (500.245 ms) ====== [2025-09-25T02:54:29.658Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-09-25T02:54:29.658Z] GC before operation: completed in 32.741 ms, heap usage 41.760 MB -> 26.214 MB. [2025-09-25T02:54:29.658Z] ====== scala-kmeans (scala) [default], iteration 32 completed (454.393 ms) ====== [2025-09-25T02:54:29.658Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-09-25T02:54:30.284Z] GC before operation: completed in 35.493 ms, heap usage 95.021 MB -> 26.215 MB. [2025-09-25T02:54:30.284Z] ====== scala-kmeans (scala) [default], iteration 33 completed (458.286 ms) ====== [2025-09-25T02:54:30.284Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-09-25T02:54:30.284Z] GC before operation: completed in 40.088 ms, heap usage 40.878 MB -> 26.215 MB. [2025-09-25T02:54:30.918Z] ====== scala-kmeans (scala) [default], iteration 34 completed (499.179 ms) ====== [2025-09-25T02:54:30.918Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-09-25T02:54:30.918Z] GC before operation: completed in 67.015 ms, heap usage 40.877 MB -> 26.215 MB. [2025-09-25T02:54:31.539Z] ====== scala-kmeans (scala) [default], iteration 35 completed (563.733 ms) ====== [2025-09-25T02:54:31.539Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-09-25T02:54:31.539Z] GC before operation: completed in 44.316 ms, heap usage 45.547 MB -> 26.215 MB. [2025-09-25T02:54:32.164Z] ====== scala-kmeans (scala) [default], iteration 36 completed (438.169 ms) ====== [2025-09-25T02:54:32.164Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-09-25T02:54:32.164Z] GC before operation: completed in 47.488 ms, heap usage 44.621 MB -> 26.217 MB. [2025-09-25T02:54:32.774Z] ====== scala-kmeans (scala) [default], iteration 37 completed (636.353 ms) ====== [2025-09-25T02:54:32.774Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-09-25T02:54:32.774Z] GC before operation: completed in 39.552 ms, heap usage 96.935 MB -> 26.217 MB. [2025-09-25T02:54:33.408Z] ====== scala-kmeans (scala) [default], iteration 38 completed (522.332 ms) ====== [2025-09-25T02:54:33.408Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-09-25T02:54:33.408Z] GC before operation: completed in 81.771 ms, heap usage 40.856 MB -> 26.218 MB. [2025-09-25T02:54:34.027Z] ====== scala-kmeans (scala) [default], iteration 39 completed (508.992 ms) ====== [2025-09-25T02:54:34.027Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-09-25T02:54:34.027Z] GC before operation: completed in 59.667 ms, heap usage 44.648 MB -> 26.217 MB. [2025-09-25T02:54:34.646Z] ====== scala-kmeans (scala) [default], iteration 40 completed (589.734 ms) ====== [2025-09-25T02:54:34.646Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-09-25T02:54:34.646Z] GC before operation: completed in 62.224 ms, heap usage 95.942 MB -> 26.217 MB. [2025-09-25T02:54:35.305Z] ====== scala-kmeans (scala) [default], iteration 41 completed (477.052 ms) ====== [2025-09-25T02:54:35.305Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-09-25T02:54:35.305Z] GC before operation: completed in 78.745 ms, heap usage 44.581 MB -> 26.217 MB. [2025-09-25T02:54:35.935Z] ====== scala-kmeans (scala) [default], iteration 42 completed (476.521 ms) ====== [2025-09-25T02:54:35.935Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-09-25T02:54:35.935Z] GC before operation: completed in 53.935 ms, heap usage 44.543 MB -> 26.218 MB. [2025-09-25T02:54:35.935Z] ====== scala-kmeans (scala) [default], iteration 43 completed (444.714 ms) ====== [2025-09-25T02:54:35.935Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-09-25T02:54:36.586Z] GC before operation: completed in 46.454 ms, heap usage 44.546 MB -> 26.217 MB. [2025-09-25T02:54:36.586Z] ====== scala-kmeans (scala) [default], iteration 44 completed (505.973 ms) ====== [2025-09-25T02:54:36.586Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-09-25T02:54:36.586Z] GC before operation: completed in 79.652 ms, heap usage 44.628 MB -> 26.217 MB. [2025-09-25T02:54:37.218Z] ====== scala-kmeans (scala) [default], iteration 45 completed (418.704 ms) ====== [2025-09-25T02:54:37.218Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-09-25T02:54:37.218Z] GC before operation: completed in 45.284 ms, heap usage 44.546 MB -> 26.217 MB. [2025-09-25T02:54:37.860Z] ====== scala-kmeans (scala) [default], iteration 46 completed (425.372 ms) ====== [2025-09-25T02:54:37.860Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-09-25T02:54:37.860Z] GC before operation: completed in 62.024 ms, heap usage 44.628 MB -> 26.217 MB. [2025-09-25T02:54:38.484Z] ====== scala-kmeans (scala) [default], iteration 47 completed (492.451 ms) ====== [2025-09-25T02:54:38.484Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-09-25T02:54:38.484Z] GC before operation: completed in 46.389 ms, heap usage 95.937 MB -> 26.217 MB. [2025-09-25T02:54:39.120Z] ====== scala-kmeans (scala) [default], iteration 48 completed (518.356 ms) ====== [2025-09-25T02:54:39.120Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-09-25T02:54:39.120Z] GC before operation: completed in 89.609 ms, heap usage 44.654 MB -> 26.217 MB. [2025-09-25T02:54:39.740Z] ====== scala-kmeans (scala) [default], iteration 49 completed (538.960 ms) ====== [2025-09-25T02:54:39.740Z] ----------------------------------- [2025-09-25T02:54:39.740Z] renaissance-scala-kmeans_0_PASSED [2025-09-25T02:54:39.740Z] ----------------------------------- [2025-09-25T02:54:39.740Z] [2025-09-25T02:54:39.740Z] TEST TEARDOWN: [2025-09-25T02:54:39.740Z] Nothing to be done for teardown. [2025-09-25T02:54:39.740Z] renaissance-scala-kmeans_0 Finish Time: Thu Sep 25 02:54:39 2025 Epoch Time (ms): 1758768879524