[2024-09-25T20:59:59.337Z] Running test renaissance-scala-kmeans_0 ... [2024-09-25T20:59:59.337Z] =============================================== [2024-09-25T20:59:59.337Z] renaissance-scala-kmeans_0 Start Time: Wed Sep 25 20:59:58 2024 Epoch Time (ms): 1727297998792 [2024-09-25T20:59:59.337Z] variation: NoOptions [2024-09-25T20:59:59.337Z] JVM_OPTIONS: [2024-09-25T20:59:59.337Z] { \ [2024-09-25T20:59:59.337Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T20:59:59.337Z] echo "Nothing to be done for setup."; \ [2024-09-25T20:59:59.337Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1727297387919/renaissance-scala-kmeans_0"; \ [2024-09-25T20:59:59.337Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1727297387919/renaissance-scala-kmeans_0"; \ [2024-09-25T20:59:59.337Z] echo ""; echo "TESTING:"; \ [2024-09-25T20:59:59.337Z] /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1727297387919/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; \ [2024-09-25T20:59:59.337Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1727297387919/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T20:59:59.337Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T20:59:59.337Z] echo "Nothing to be done for teardown."; \ [2024-09-25T20:59:59.337Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1727297387919/TestTargetResult"; [2024-09-25T20:59:59.337Z] [2024-09-25T20:59:59.337Z] TEST SETUP: [2024-09-25T20:59:59.337Z] Nothing to be done for setup. [2024-09-25T20:59:59.337Z] [2024-09-25T20:59:59.337Z] TESTING: [2024-09-25T20:59:59.337Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2024-09-25T20:59:59.337Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk11_hs_sanity.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1727297387919/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2024-09-25T21:00:01.246Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2024-09-25T21:00:01.246Z] GC before operation: completed in 48.390 ms, heap usage 50.980 MB -> 25.313 MB. [2024-09-25T21:00:01.246Z] ====== scala-kmeans (scala) [default], iteration 0 completed (494.681 ms) ====== [2024-09-25T21:00:01.246Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2024-09-25T21:00:01.246Z] GC before operation: completed in 60.451 ms, heap usage 29.173 MB -> 25.379 MB. [2024-09-25T21:00:02.174Z] ====== scala-kmeans (scala) [default], iteration 1 completed (339.846 ms) ====== [2024-09-25T21:00:02.174Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2024-09-25T21:00:02.174Z] GC before operation: completed in 53.859 ms, heap usage 69.271 MB -> 25.379 MB. [2024-09-25T21:00:02.174Z] ====== scala-kmeans (scala) [default], iteration 2 completed (353.572 ms) ====== [2024-09-25T21:00:02.174Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2024-09-25T21:00:02.174Z] GC before operation: completed in 55.393 ms, heap usage 68.428 MB -> 25.379 MB. [2024-09-25T21:00:03.105Z] ====== scala-kmeans (scala) [default], iteration 3 completed (351.745 ms) ====== [2024-09-25T21:00:03.105Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2024-09-25T21:00:03.105Z] GC before operation: completed in 50.868 ms, heap usage 68.281 MB -> 25.379 MB. [2024-09-25T21:00:03.105Z] ====== scala-kmeans (scala) [default], iteration 4 completed (358.797 ms) ====== [2024-09-25T21:00:03.105Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2024-09-25T21:00:03.105Z] GC before operation: completed in 52.739 ms, heap usage 68.275 MB -> 25.379 MB. [2024-09-25T21:00:03.105Z] ====== scala-kmeans (scala) [default], iteration 5 completed (360.858 ms) ====== [2024-09-25T21:00:03.105Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2024-09-25T21:00:03.105Z] GC before operation: completed in 50.455 ms, heap usage 68.273 MB -> 25.379 MB. [2024-09-25T21:00:04.033Z] ====== scala-kmeans (scala) [default], iteration 6 completed (358.501 ms) ====== [2024-09-25T21:00:04.033Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2024-09-25T21:00:04.033Z] GC before operation: completed in 60.774 ms, heap usage 67.404 MB -> 25.379 MB. [2024-09-25T21:00:04.033Z] ====== scala-kmeans (scala) [default], iteration 7 completed (358.753 ms) ====== [2024-09-25T21:00:04.033Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2024-09-25T21:00:04.033Z] GC before operation: completed in 52.140 ms, heap usage 67.427 MB -> 25.380 MB. [2024-09-25T21:00:04.966Z] ====== scala-kmeans (scala) [default], iteration 8 completed (360.224 ms) ====== [2024-09-25T21:00:04.966Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2024-09-25T21:00:04.966Z] GC before operation: completed in 50.253 ms, heap usage 67.431 MB -> 25.380 MB. [2024-09-25T21:00:04.966Z] ====== scala-kmeans (scala) [default], iteration 9 completed (367.829 ms) ====== [2024-09-25T21:00:04.966Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2024-09-25T21:00:04.966Z] GC before operation: completed in 39.558 ms, heap usage 67.434 MB -> 25.380 MB. [2024-09-25T21:00:05.893Z] ====== scala-kmeans (scala) [default], iteration 10 completed (359.920 ms) ====== [2024-09-25T21:00:05.893Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2024-09-25T21:00:05.893Z] GC before operation: completed in 50.851 ms, heap usage 64.617 MB -> 25.380 MB. [2024-09-25T21:00:05.893Z] ====== scala-kmeans (scala) [default], iteration 11 completed (358.836 ms) ====== [2024-09-25T21:00:05.893Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2024-09-25T21:00:05.893Z] GC before operation: completed in 59.437 ms, heap usage 64.659 MB -> 25.380 MB. [2024-09-25T21:00:06.820Z] ====== scala-kmeans (scala) [default], iteration 12 completed (360.667 ms) ====== [2024-09-25T21:00:06.820Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2024-09-25T21:00:06.820Z] GC before operation: completed in 50.471 ms, heap usage 66.521 MB -> 25.380 MB. [2024-09-25T21:00:06.820Z] ====== scala-kmeans (scala) [default], iteration 13 completed (362.578 ms) ====== [2024-09-25T21:00:06.820Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2024-09-25T21:00:06.820Z] GC before operation: completed in 50.531 ms, heap usage 67.330 MB -> 25.380 MB. [2024-09-25T21:00:06.820Z] ====== scala-kmeans (scala) [default], iteration 14 completed (368.072 ms) ====== [2024-09-25T21:00:06.820Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2024-09-25T21:00:06.820Z] GC before operation: completed in 50.648 ms, heap usage 67.446 MB -> 25.380 MB. [2024-09-25T21:00:07.747Z] ====== scala-kmeans (scala) [default], iteration 15 completed (350.689 ms) ====== [2024-09-25T21:00:07.747Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2024-09-25T21:00:07.747Z] GC before operation: completed in 50.203 ms, heap usage 67.299 MB -> 25.380 MB. [2024-09-25T21:00:07.747Z] ====== scala-kmeans (scala) [default], iteration 16 completed (351.214 ms) ====== [2024-09-25T21:00:07.747Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2024-09-25T21:00:07.747Z] GC before operation: completed in 51.811 ms, heap usage 67.436 MB -> 25.382 MB. [2024-09-25T21:00:08.674Z] ====== scala-kmeans (scala) [default], iteration 17 completed (352.173 ms) ====== [2024-09-25T21:00:08.674Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2024-09-25T21:00:08.674Z] GC before operation: completed in 60.560 ms, heap usage 67.299 MB -> 25.382 MB. [2024-09-25T21:00:08.674Z] ====== scala-kmeans (scala) [default], iteration 18 completed (371.347 ms) ====== [2024-09-25T21:00:08.674Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2024-09-25T21:00:08.674Z] GC before operation: completed in 53.346 ms, heap usage 67.299 MB -> 25.382 MB. [2024-09-25T21:00:09.603Z] ====== scala-kmeans (scala) [default], iteration 19 completed (359.296 ms) ====== [2024-09-25T21:00:09.603Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2024-09-25T21:00:09.603Z] GC before operation: completed in 51.859 ms, heap usage 64.714 MB -> 25.382 MB. [2024-09-25T21:00:09.603Z] ====== scala-kmeans (scala) [default], iteration 20 completed (357.351 ms) ====== [2024-09-25T21:00:09.603Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2024-09-25T21:00:09.603Z] GC before operation: completed in 50.288 ms, heap usage 64.661 MB -> 25.382 MB. [2024-09-25T21:00:10.531Z] ====== scala-kmeans (scala) [default], iteration 21 completed (366.134 ms) ====== [2024-09-25T21:00:10.531Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2024-09-25T21:00:10.531Z] GC before operation: completed in 53.191 ms, heap usage 64.683 MB -> 25.383 MB. [2024-09-25T21:00:10.531Z] ====== scala-kmeans (scala) [default], iteration 22 completed (361.894 ms) ====== [2024-09-25T21:00:10.531Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2024-09-25T21:00:10.531Z] GC before operation: completed in 51.867 ms, heap usage 64.688 MB -> 25.383 MB. [2024-09-25T21:00:10.531Z] ====== scala-kmeans (scala) [default], iteration 23 completed (355.771 ms) ====== [2024-09-25T21:00:10.531Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2024-09-25T21:00:10.531Z] GC before operation: completed in 49.840 ms, heap usage 64.690 MB -> 25.383 MB. [2024-09-25T21:00:11.458Z] ====== scala-kmeans (scala) [default], iteration 24 completed (359.725 ms) ====== [2024-09-25T21:00:11.458Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2024-09-25T21:00:11.458Z] GC before operation: completed in 50.060 ms, heap usage 64.530 MB -> 25.383 MB. [2024-09-25T21:00:11.458Z] ====== scala-kmeans (scala) [default], iteration 25 completed (358.021 ms) ====== [2024-09-25T21:00:11.458Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2024-09-25T21:00:11.458Z] GC before operation: completed in 50.485 ms, heap usage 64.691 MB -> 25.385 MB. [2024-09-25T21:00:12.384Z] ====== scala-kmeans (scala) [default], iteration 26 completed (361.646 ms) ====== [2024-09-25T21:00:12.384Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2024-09-25T21:00:12.384Z] GC before operation: completed in 50.532 ms, heap usage 64.693 MB -> 25.385 MB. [2024-09-25T21:00:12.384Z] ====== scala-kmeans (scala) [default], iteration 27 completed (359.220 ms) ====== [2024-09-25T21:00:12.384Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2024-09-25T21:00:12.384Z] GC before operation: completed in 55.516 ms, heap usage 64.693 MB -> 25.385 MB. [2024-09-25T21:00:13.311Z] ====== scala-kmeans (scala) [default], iteration 28 completed (357.774 ms) ====== [2024-09-25T21:00:13.311Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2024-09-25T21:00:13.311Z] GC before operation: completed in 49.647 ms, heap usage 64.531 MB -> 25.385 MB. [2024-09-25T21:00:13.311Z] ====== scala-kmeans (scala) [default], iteration 29 completed (357.986 ms) ====== [2024-09-25T21:00:13.311Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2024-09-25T21:00:13.311Z] GC before operation: completed in 55.382 ms, heap usage 64.693 MB -> 25.385 MB. [2024-09-25T21:00:14.328Z] ====== scala-kmeans (scala) [default], iteration 30 completed (361.799 ms) ====== [2024-09-25T21:00:14.328Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2024-09-25T21:00:14.328Z] GC before operation: completed in 51.592 ms, heap usage 64.693 MB -> 25.385 MB. [2024-09-25T21:00:14.328Z] ====== scala-kmeans (scala) [default], iteration 31 completed (357.705 ms) ====== [2024-09-25T21:00:14.328Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2024-09-25T21:00:14.328Z] GC before operation: completed in 51.446 ms, heap usage 64.693 MB -> 25.385 MB. [2024-09-25T21:00:14.328Z] ====== scala-kmeans (scala) [default], iteration 32 completed (359.157 ms) ====== [2024-09-25T21:00:14.328Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2024-09-25T21:00:14.328Z] GC before operation: completed in 53.838 ms, heap usage 64.693 MB -> 25.385 MB. [2024-09-25T21:00:15.255Z] ====== scala-kmeans (scala) [default], iteration 33 completed (358.756 ms) ====== [2024-09-25T21:00:15.255Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2024-09-25T21:00:15.255Z] GC before operation: completed in 55.621 ms, heap usage 64.532 MB -> 25.386 MB. [2024-09-25T21:00:15.255Z] ====== scala-kmeans (scala) [default], iteration 34 completed (356.014 ms) ====== [2024-09-25T21:00:15.255Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2024-09-25T21:00:15.255Z] GC before operation: completed in 51.533 ms, heap usage 64.532 MB -> 25.386 MB. [2024-09-25T21:00:16.183Z] ====== scala-kmeans (scala) [default], iteration 35 completed (361.019 ms) ====== [2024-09-25T21:00:16.183Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2024-09-25T21:00:16.183Z] GC before operation: completed in 50.476 ms, heap usage 64.693 MB -> 25.386 MB. [2024-09-25T21:00:16.183Z] ====== scala-kmeans (scala) [default], iteration 36 completed (359.090 ms) ====== [2024-09-25T21:00:16.183Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2024-09-25T21:00:16.183Z] GC before operation: completed in 53.831 ms, heap usage 64.532 MB -> 25.388 MB. [2024-09-25T21:00:17.111Z] ====== scala-kmeans (scala) [default], iteration 37 completed (366.769 ms) ====== [2024-09-25T21:00:17.111Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2024-09-25T21:00:17.111Z] GC before operation: completed in 52.883 ms, heap usage 64.695 MB -> 25.388 MB. [2024-09-25T21:00:17.111Z] ====== scala-kmeans (scala) [default], iteration 38 completed (361.866 ms) ====== [2024-09-25T21:00:17.111Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2024-09-25T21:00:17.112Z] GC before operation: completed in 54.450 ms, heap usage 66.534 MB -> 25.388 MB. [2024-09-25T21:00:17.112Z] ====== scala-kmeans (scala) [default], iteration 39 completed (360.430 ms) ====== [2024-09-25T21:00:17.112Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2024-09-25T21:00:17.112Z] GC before operation: completed in 51.303 ms, heap usage 67.488 MB -> 25.388 MB. [2024-09-25T21:00:18.039Z] ====== scala-kmeans (scala) [default], iteration 40 completed (352.637 ms) ====== [2024-09-25T21:00:18.039Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2024-09-25T21:00:18.039Z] GC before operation: completed in 57.531 ms, heap usage 67.454 MB -> 25.388 MB. [2024-09-25T21:00:18.039Z] ====== scala-kmeans (scala) [default], iteration 41 completed (362.858 ms) ====== [2024-09-25T21:00:18.039Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2024-09-25T21:00:18.039Z] GC before operation: completed in 50.317 ms, heap usage 67.446 MB -> 25.388 MB. [2024-09-25T21:00:18.970Z] ====== scala-kmeans (scala) [default], iteration 42 completed (358.453 ms) ====== [2024-09-25T21:00:18.970Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2024-09-25T21:00:18.970Z] GC before operation: completed in 50.288 ms, heap usage 67.443 MB -> 25.388 MB. [2024-09-25T21:00:18.970Z] ====== scala-kmeans (scala) [default], iteration 43 completed (359.760 ms) ====== [2024-09-25T21:00:18.970Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2024-09-25T21:00:18.970Z] GC before operation: completed in 50.097 ms, heap usage 67.443 MB -> 25.388 MB. [2024-09-25T21:00:19.898Z] ====== scala-kmeans (scala) [default], iteration 44 completed (359.720 ms) ====== [2024-09-25T21:00:19.898Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2024-09-25T21:00:19.898Z] GC before operation: completed in 50.318 ms, heap usage 66.443 MB -> 25.388 MB. [2024-09-25T21:00:19.898Z] ====== scala-kmeans (scala) [default], iteration 45 completed (360.199 ms) ====== [2024-09-25T21:00:19.898Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2024-09-25T21:00:19.898Z] GC before operation: completed in 50.721 ms, heap usage 67.466 MB -> 25.388 MB. [2024-09-25T21:00:20.827Z] ====== scala-kmeans (scala) [default], iteration 46 completed (363.385 ms) ====== [2024-09-25T21:00:20.827Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2024-09-25T21:00:20.827Z] GC before operation: completed in 28.198 ms, heap usage 67.449 MB -> 25.388 MB. [2024-09-25T21:00:20.827Z] ====== scala-kmeans (scala) [default], iteration 47 completed (363.970 ms) ====== [2024-09-25T21:00:20.827Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2024-09-25T21:00:20.827Z] GC before operation: completed in 50.971 ms, heap usage 63.721 MB -> 25.388 MB. [2024-09-25T21:00:20.827Z] ====== scala-kmeans (scala) [default], iteration 48 completed (355.839 ms) ====== [2024-09-25T21:00:20.827Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2024-09-25T21:00:20.827Z] GC before operation: completed in 51.383 ms, heap usage 64.696 MB -> 25.388 MB. [2024-09-25T21:00:21.753Z] ====== scala-kmeans (scala) [default], iteration 49 completed (367.306 ms) ====== [2024-09-25T21:00:21.753Z] ----------------------------------- [2024-09-25T21:00:21.753Z] renaissance-scala-kmeans_0_PASSED [2024-09-25T21:00:21.753Z] ----------------------------------- [2024-09-25T21:00:21.753Z] [2024-09-25T21:00:21.753Z] TEST TEARDOWN: [2024-09-25T21:00:21.753Z] Nothing to be done for teardown. [2024-09-25T21:00:21.753Z] renaissance-scala-kmeans_0 Finish Time: Wed Sep 25 21:00:21 2024 Epoch Time (ms): 1727298021281