[2024-08-30T21:00:31.760Z] Running test renaissance-scala-kmeans_0 ... [2024-08-30T21:00:31.760Z] =============================================== [2024-08-30T21:00:31.760Z] renaissance-scala-kmeans_0 Start Time: Fri Aug 30 21:00:31 2024 Epoch Time (ms): 1725051631101 [2024-08-30T21:00:31.760Z] variation: NoOptions [2024-08-30T21:00:31.760Z] JVM_OPTIONS: [2024-08-30T21:00:31.760Z] { \ [2024-08-30T21:00:31.760Z] echo ""; echo "TEST SETUP:"; \ [2024-08-30T21:00:31.760Z] echo "Nothing to be done for setup."; \ [2024-08-30T21:00:31.760Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17250500343114/renaissance-scala-kmeans_0"; \ [2024-08-30T21:00:31.760Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17250500343114/renaissance-scala-kmeans_0"; \ [2024-08-30T21:00:31.760Z] echo ""; echo "TESTING:"; \ [2024-08-30T21:00:31.760Z] /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17250500343114/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/..; \ [2024-08-30T21:00:31.760Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17250500343114/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-30T21:00:31.760Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-30T21:00:31.760Z] echo "Nothing to be done for teardown."; \ [2024-08-30T21:00:31.760Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17250500343114/TestTargetResult"; [2024-08-30T21:00:31.760Z] [2024-08-30T21:00:31.760Z] TEST SETUP: [2024-08-30T21:00:31.760Z] Nothing to be done for setup. [2024-08-30T21:00:31.760Z] [2024-08-30T21:00:31.760Z] TESTING: [2024-08-30T21:00:31.760Z] Warning!!! Affinity is NOT set. Affinity tool may NOT be installed/supported. [2024-08-30T21:00:31.760Z] Running EXEC_CMD_WITH_AFFINITY= /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk21_hs_sanity.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17250500343114/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2024-08-30T21:00:33.879Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2024-08-30T21:00:33.879Z] GC before operation: completed in 129.079 ms, heap usage 40.499 MB -> 25.996 MB. [2024-08-30T21:00:34.569Z] ====== scala-kmeans (scala) [default], iteration 0 completed (873.247 ms) ====== [2024-08-30T21:00:34.569Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2024-08-30T21:00:35.239Z] GC before operation: completed in 77.929 ms, heap usage 49.156 MB -> 26.057 MB. [2024-08-30T21:00:35.933Z] ====== scala-kmeans (scala) [default], iteration 1 completed (713.759 ms) ====== [2024-08-30T21:00:35.933Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2024-08-30T21:00:35.933Z] GC before operation: completed in 184.114 ms, heap usage 30.382 MB -> 26.057 MB. [2024-08-30T21:00:36.537Z] ====== scala-kmeans (scala) [default], iteration 2 completed (570.019 ms) ====== [2024-08-30T21:00:36.537Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2024-08-30T21:00:36.537Z] GC before operation: completed in 52.980 ms, heap usage 42.696 MB -> 26.057 MB. [2024-08-30T21:00:37.151Z] ====== scala-kmeans (scala) [default], iteration 3 completed (549.601 ms) ====== [2024-08-30T21:00:37.151Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2024-08-30T21:00:37.151Z] GC before operation: completed in 47.405 ms, heap usage 94.862 MB -> 26.057 MB. [2024-08-30T21:00:37.779Z] ====== scala-kmeans (scala) [default], iteration 4 completed (457.606 ms) ====== [2024-08-30T21:00:37.779Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2024-08-30T21:00:37.779Z] GC before operation: completed in 69.212 ms, heap usage 42.608 MB -> 26.057 MB. [2024-08-30T21:00:38.387Z] ====== scala-kmeans (scala) [default], iteration 5 completed (558.610 ms) ====== [2024-08-30T21:00:38.387Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2024-08-30T21:00:38.387Z] GC before operation: completed in 76.586 ms, heap usage 42.586 MB -> 26.057 MB. [2024-08-30T21:00:38.993Z] ====== scala-kmeans (scala) [default], iteration 6 completed (564.636 ms) ====== [2024-08-30T21:00:38.993Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2024-08-30T21:00:38.993Z] GC before operation: completed in 84.912 ms, heap usage 94.835 MB -> 26.057 MB. [2024-08-30T21:00:39.608Z] ====== scala-kmeans (scala) [default], iteration 7 completed (575.594 ms) ====== [2024-08-30T21:00:39.608Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2024-08-30T21:00:39.608Z] GC before operation: completed in 151.295 ms, heap usage 42.528 MB -> 26.057 MB. [2024-08-30T21:00:40.226Z] ====== scala-kmeans (scala) [default], iteration 8 completed (724.297 ms) ====== [2024-08-30T21:00:40.226Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2024-08-30T21:00:40.226Z] GC before operation: completed in 63.328 ms, heap usage 42.674 MB -> 26.057 MB. [2024-08-30T21:00:40.854Z] ====== scala-kmeans (scala) [default], iteration 9 completed (601.330 ms) ====== [2024-08-30T21:00:40.854Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2024-08-30T21:00:40.854Z] GC before operation: completed in 115.283 ms, heap usage 94.835 MB -> 26.058 MB. [2024-08-30T21:00:41.549Z] ====== scala-kmeans (scala) [default], iteration 10 completed (595.425 ms) ====== [2024-08-30T21:00:41.549Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2024-08-30T21:00:41.549Z] GC before operation: completed in 69.072 ms, heap usage 42.529 MB -> 26.058 MB. [2024-08-30T21:00:42.195Z] ====== scala-kmeans (scala) [default], iteration 11 completed (528.043 ms) ====== [2024-08-30T21:00:42.195Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2024-08-30T21:00:42.196Z] GC before operation: completed in 46.611 ms, heap usage 42.586 MB -> 26.058 MB. [2024-08-30T21:00:42.831Z] ====== scala-kmeans (scala) [default], iteration 12 completed (493.624 ms) ====== [2024-08-30T21:00:42.831Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2024-08-30T21:00:42.831Z] GC before operation: completed in 124.526 ms, heap usage 94.835 MB -> 26.058 MB. [2024-08-30T21:00:43.437Z] ====== scala-kmeans (scala) [default], iteration 13 completed (498.311 ms) ====== [2024-08-30T21:00:43.437Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2024-08-30T21:00:43.437Z] GC before operation: completed in 69.189 ms, heap usage 42.529 MB -> 26.058 MB. [2024-08-30T21:00:44.043Z] ====== scala-kmeans (scala) [default], iteration 14 completed (500.182 ms) ====== [2024-08-30T21:00:44.043Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2024-08-30T21:00:44.043Z] GC before operation: completed in 36.772 ms, heap usage 42.586 MB -> 26.058 MB. [2024-08-30T21:00:44.640Z] ====== scala-kmeans (scala) [default], iteration 15 completed (520.096 ms) ====== [2024-08-30T21:00:44.640Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2024-08-30T21:00:44.640Z] GC before operation: completed in 84.818 ms, heap usage 42.590 MB -> 26.058 MB. [2024-08-30T21:00:45.238Z] ====== scala-kmeans (scala) [default], iteration 16 completed (567.811 ms) ====== [2024-08-30T21:00:45.238Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2024-08-30T21:00:45.238Z] GC before operation: completed in 80.273 ms, heap usage 42.591 MB -> 26.060 MB. [2024-08-30T21:00:45.848Z] ====== scala-kmeans (scala) [default], iteration 17 completed (447.619 ms) ====== [2024-08-30T21:00:45.849Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2024-08-30T21:00:45.849Z] GC before operation: completed in 94.372 ms, heap usage 42.681 MB -> 26.060 MB. [2024-08-30T21:00:46.457Z] ====== scala-kmeans (scala) [default], iteration 18 completed (483.324 ms) ====== [2024-08-30T21:00:46.457Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2024-08-30T21:00:46.457Z] GC before operation: completed in 72.705 ms, heap usage 42.592 MB -> 26.060 MB. [2024-08-30T21:00:47.081Z] ====== scala-kmeans (scala) [default], iteration 19 completed (610.560 ms) ====== [2024-08-30T21:00:47.081Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2024-08-30T21:00:47.081Z] GC before operation: completed in 96.538 ms, heap usage 42.592 MB -> 26.060 MB. [2024-08-30T21:00:47.695Z] ====== scala-kmeans (scala) [default], iteration 20 completed (561.580 ms) ====== [2024-08-30T21:00:47.695Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2024-08-30T21:00:47.695Z] GC before operation: completed in 48.649 ms, heap usage 42.592 MB -> 26.060 MB. [2024-08-30T21:00:48.306Z] ====== scala-kmeans (scala) [default], iteration 21 completed (505.683 ms) ====== [2024-08-30T21:00:48.306Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2024-08-30T21:00:48.306Z] GC before operation: completed in 77.463 ms, heap usage 42.681 MB -> 26.060 MB. [2024-08-30T21:00:48.935Z] ====== scala-kmeans (scala) [default], iteration 22 completed (505.078 ms) ====== [2024-08-30T21:00:48.935Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2024-08-30T21:00:48.935Z] GC before operation: completed in 35.369 ms, heap usage 42.593 MB -> 26.060 MB. [2024-08-30T21:00:49.554Z] ====== scala-kmeans (scala) [default], iteration 23 completed (516.252 ms) ====== [2024-08-30T21:00:49.554Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2024-08-30T21:00:49.554Z] GC before operation: completed in 52.873 ms, heap usage 94.839 MB -> 26.060 MB. [2024-08-30T21:00:50.152Z] ====== scala-kmeans (scala) [default], iteration 24 completed (496.153 ms) ====== [2024-08-30T21:00:50.152Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2024-08-30T21:00:50.152Z] GC before operation: completed in 63.393 ms, heap usage 42.610 MB -> 26.060 MB. [2024-08-30T21:00:50.780Z] ====== scala-kmeans (scala) [default], iteration 25 completed (630.524 ms) ====== [2024-08-30T21:00:50.780Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2024-08-30T21:00:50.780Z] GC before operation: completed in 50.186 ms, heap usage 42.589 MB -> 26.060 MB. [2024-08-30T21:00:51.404Z] ====== scala-kmeans (scala) [default], iteration 26 completed (502.233 ms) ====== [2024-08-30T21:00:51.404Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2024-08-30T21:00:51.404Z] GC before operation: completed in 73.401 ms, heap usage 42.681 MB -> 26.060 MB. [2024-08-30T21:00:52.000Z] ====== scala-kmeans (scala) [default], iteration 27 completed (464.220 ms) ====== [2024-08-30T21:00:52.000Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2024-08-30T21:00:52.000Z] GC before operation: completed in 46.414 ms, heap usage 42.682 MB -> 26.060 MB. [2024-08-30T21:00:52.610Z] ====== scala-kmeans (scala) [default], iteration 28 completed (618.629 ms) ====== [2024-08-30T21:00:52.610Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2024-08-30T21:00:52.610Z] GC before operation: completed in 81.790 ms, heap usage 94.839 MB -> 26.060 MB. [2024-08-30T21:00:53.209Z] ====== scala-kmeans (scala) [default], iteration 29 completed (616.833 ms) ====== [2024-08-30T21:00:53.209Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2024-08-30T21:00:53.209Z] GC before operation: completed in 61.733 ms, heap usage 42.610 MB -> 26.061 MB. [2024-08-30T21:00:53.813Z] ====== scala-kmeans (scala) [default], iteration 30 completed (522.538 ms) ====== [2024-08-30T21:00:53.814Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2024-08-30T21:00:53.814Z] GC before operation: completed in 38.035 ms, heap usage 42.589 MB -> 26.061 MB. [2024-08-30T21:00:54.445Z] ====== scala-kmeans (scala) [default], iteration 31 completed (454.016 ms) ====== [2024-08-30T21:00:54.445Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2024-08-30T21:00:54.445Z] GC before operation: completed in 62.524 ms, heap usage 94.968 MB -> 26.061 MB. [2024-08-30T21:00:55.065Z] ====== scala-kmeans (scala) [default], iteration 32 completed (542.442 ms) ====== [2024-08-30T21:00:55.065Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2024-08-30T21:00:55.065Z] GC before operation: completed in 43.613 ms, heap usage 42.610 MB -> 26.061 MB. [2024-08-30T21:00:55.065Z] ====== scala-kmeans (scala) [default], iteration 33 completed (520.244 ms) ====== [2024-08-30T21:00:55.065Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2024-08-30T21:00:55.692Z] GC before operation: completed in 73.361 ms, heap usage 42.590 MB -> 26.061 MB. [2024-08-30T21:00:55.692Z] ====== scala-kmeans (scala) [default], iteration 34 completed (528.718 ms) ====== [2024-08-30T21:00:55.692Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2024-08-30T21:00:56.332Z] GC before operation: completed in 76.741 ms, heap usage 42.593 MB -> 26.061 MB. [2024-08-30T21:00:56.332Z] ====== scala-kmeans (scala) [default], iteration 35 completed (535.557 ms) ====== [2024-08-30T21:00:56.332Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2024-08-30T21:00:57.452Z] GC before operation: completed in 62.757 ms, heap usage 42.594 MB -> 26.061 MB. [2024-08-30T21:00:57.452Z] ====== scala-kmeans (scala) [default], iteration 36 completed (574.070 ms) ====== [2024-08-30T21:00:57.452Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2024-08-30T21:00:57.452Z] GC before operation: completed in 96.271 ms, heap usage 94.970 MB -> 26.063 MB. [2024-08-30T21:00:58.170Z] ====== scala-kmeans (scala) [default], iteration 37 completed (515.514 ms) ====== [2024-08-30T21:00:58.170Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2024-08-30T21:00:58.170Z] GC before operation: completed in 51.337 ms, heap usage 42.534 MB -> 26.063 MB. [2024-08-30T21:00:58.170Z] ====== scala-kmeans (scala) [default], iteration 38 completed (491.690 ms) ====== [2024-08-30T21:00:58.170Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2024-08-30T21:00:58.170Z] GC before operation: completed in 72.681 ms, heap usage 42.592 MB -> 26.063 MB. [2024-08-30T21:00:58.812Z] ====== scala-kmeans (scala) [default], iteration 39 completed (509.629 ms) ====== [2024-08-30T21:00:58.812Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2024-08-30T21:00:58.812Z] GC before operation: completed in 58.006 ms, heap usage 42.596 MB -> 26.063 MB. [2024-08-30T21:00:59.471Z] ====== scala-kmeans (scala) [default], iteration 40 completed (445.778 ms) ====== [2024-08-30T21:00:59.471Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2024-08-30T21:00:59.471Z] GC before operation: completed in 258.527 ms, heap usage 42.596 MB -> 26.063 MB. [2024-08-30T21:01:00.129Z] ====== scala-kmeans (scala) [default], iteration 41 completed (476.797 ms) ====== [2024-08-30T21:01:00.129Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2024-08-30T21:01:00.129Z] GC before operation: completed in 67.632 ms, heap usage 42.685 MB -> 26.063 MB. [2024-08-30T21:01:00.790Z] ====== scala-kmeans (scala) [default], iteration 42 completed (457.923 ms) ====== [2024-08-30T21:01:00.790Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2024-08-30T21:01:00.790Z] GC before operation: completed in 212.093 ms, heap usage 42.596 MB -> 26.063 MB. [2024-08-30T21:01:01.463Z] ====== scala-kmeans (scala) [default], iteration 43 completed (569.493 ms) ====== [2024-08-30T21:01:01.463Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2024-08-30T21:01:01.463Z] GC before operation: completed in 82.709 ms, heap usage 42.596 MB -> 26.063 MB. [2024-08-30T21:01:02.073Z] ====== scala-kmeans (scala) [default], iteration 44 completed (633.234 ms) ====== [2024-08-30T21:01:02.073Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2024-08-30T21:01:02.073Z] GC before operation: completed in 72.776 ms, heap usage 94.842 MB -> 26.063 MB. [2024-08-30T21:01:02.670Z] ====== scala-kmeans (scala) [default], iteration 45 completed (502.613 ms) ====== [2024-08-30T21:01:02.670Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2024-08-30T21:01:02.670Z] GC before operation: completed in 51.155 ms, heap usage 42.534 MB -> 26.064 MB. [2024-08-30T21:01:03.326Z] ====== scala-kmeans (scala) [default], iteration 46 completed (484.443 ms) ====== [2024-08-30T21:01:03.326Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2024-08-30T21:01:03.326Z] GC before operation: completed in 78.076 ms, heap usage 42.768 MB -> 26.064 MB. [2024-08-30T21:01:03.951Z] ====== scala-kmeans (scala) [default], iteration 47 completed (508.393 ms) ====== [2024-08-30T21:01:03.951Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2024-08-30T21:01:03.951Z] GC before operation: completed in 100.507 ms, heap usage 42.596 MB -> 26.064 MB. [2024-08-30T21:01:04.564Z] ====== scala-kmeans (scala) [default], iteration 48 completed (543.666 ms) ====== [2024-08-30T21:01:04.564Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2024-08-30T21:01:04.564Z] GC before operation: completed in 148.094 ms, heap usage 42.596 MB -> 26.064 MB. [2024-08-30T21:01:05.209Z] ====== scala-kmeans (scala) [default], iteration 49 completed (610.343 ms) ====== [2024-08-30T21:01:05.897Z] ----------------------------------- [2024-08-30T21:01:05.897Z] renaissance-scala-kmeans_0_PASSED [2024-08-30T21:01:05.897Z] ----------------------------------- [2024-08-30T21:01:05.897Z] [2024-08-30T21:01:05.897Z] TEST TEARDOWN: [2024-08-30T21:01:05.897Z] Nothing to be done for teardown. [2024-08-30T21:01:05.897Z] renaissance-scala-kmeans_0 Finish Time: Fri Aug 30 21:01:05 2024 Epoch Time (ms): 1725051665448