[2024-09-26T21:01:33.279Z] Running test renaissance-scala-kmeans_0 ... [2024-09-26T21:01:33.279Z] =============================================== [2024-09-26T21:01:33.279Z] renaissance-scala-kmeans_0 Start Time: Thu Sep 26 21:01:32 2024 Epoch Time (ms): 1727384492763 [2024-09-26T21:01:33.279Z] variation: NoOptions [2024-09-26T21:01:33.279Z] JVM_OPTIONS: [2024-09-26T21:01:33.279Z] { \ [2024-09-26T21:01:33.279Z] echo ""; echo "TEST SETUP:"; \ [2024-09-26T21:01:33.279Z] echo "Nothing to be done for setup."; \ [2024-09-26T21:01:33.279Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273840375975/renaissance-scala-kmeans_0"; \ [2024-09-26T21:01:33.279Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273840375975/renaissance-scala-kmeans_0"; \ [2024-09-26T21:01:33.279Z] echo ""; echo "TESTING:"; \ [2024-09-26T21:01:33.279Z] /home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273840375975/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/..; \ [2024-09-26T21:01:33.279Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273840375975/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-26T21:01:33.279Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-26T21:01:33.279Z] echo "Nothing to be done for teardown."; \ [2024-09-26T21:01:33.280Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273840375975/TestTargetResult"; [2024-09-26T21:01:33.280Z] [2024-09-26T21:01:33.280Z] TEST SETUP: [2024-09-26T21:01:33.280Z] Nothing to be done for setup. [2024-09-26T21:01:33.280Z] [2024-09-26T21:01:33.280Z] TESTING: [2024-09-26T21:01:34.037Z] Running EXEC_CMD_WITH_AFFINITY=execrset -c 0-15 -e /home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk8_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273840375975/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2024-09-26T21:01:36.460Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2024-09-26T21:01:36.460Z] GC before operation: completed in 203.938 ms, heap usage 28.997 MB -> 24.613 MB. [2024-09-26T21:01:38.023Z] ====== scala-kmeans (scala) [default], iteration 0 completed (1321.190 ms) ====== [2024-09-26T21:01:38.023Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2024-09-26T21:01:38.023Z] GC before operation: completed in 147.753 ms, heap usage 37.941 MB -> 24.667 MB. [2024-09-26T21:01:38.777Z] ====== scala-kmeans (scala) [default], iteration 1 completed (493.109 ms) ====== [2024-09-26T21:01:38.777Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2024-09-26T21:01:38.777Z] GC before operation: completed in 237.007 ms, heap usage 43.535 MB -> 24.660 MB. [2024-09-26T21:01:39.531Z] ====== scala-kmeans (scala) [default], iteration 2 completed (460.492 ms) ====== [2024-09-26T21:01:39.531Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2024-09-26T21:01:39.531Z] GC before operation: completed in 255.645 ms, heap usage 55.193 MB -> 24.660 MB. [2024-09-26T21:01:40.284Z] ====== scala-kmeans (scala) [default], iteration 3 completed (400.394 ms) ====== [2024-09-26T21:01:40.284Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2024-09-26T21:01:40.284Z] GC before operation: completed in 204.208 ms, heap usage 148.377 MB -> 24.660 MB. [2024-09-26T21:01:41.039Z] ====== scala-kmeans (scala) [default], iteration 4 completed (395.767 ms) ====== [2024-09-26T21:01:41.039Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2024-09-26T21:01:41.039Z] GC before operation: completed in 193.584 ms, heap usage 147.426 MB -> 24.660 MB. [2024-09-26T21:01:41.039Z] ====== scala-kmeans (scala) [default], iteration 5 completed (397.465 ms) ====== [2024-09-26T21:01:41.039Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2024-09-26T21:01:41.793Z] GC before operation: completed in 180.714 ms, heap usage 146.808 MB -> 24.660 MB. [2024-09-26T21:01:41.793Z] ====== scala-kmeans (scala) [default], iteration 6 completed (396.936 ms) ====== [2024-09-26T21:01:41.793Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2024-09-26T21:01:42.545Z] GC before operation: completed in 301.304 ms, heap usage 146.406 MB -> 24.660 MB. [2024-09-26T21:01:42.545Z] ====== scala-kmeans (scala) [default], iteration 7 completed (396.467 ms) ====== [2024-09-26T21:01:42.545Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2024-09-26T21:01:42.545Z] GC before operation: completed in 204.969 ms, heap usage 146.145 MB -> 24.662 MB. [2024-09-26T21:01:43.297Z] ====== scala-kmeans (scala) [default], iteration 8 completed (398.528 ms) ====== [2024-09-26T21:01:43.297Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2024-09-26T21:01:43.297Z] GC before operation: completed in 200.531 ms, heap usage 145.977 MB -> 24.662 MB. [2024-09-26T21:01:44.051Z] ====== scala-kmeans (scala) [default], iteration 9 completed (394.336 ms) ====== [2024-09-26T21:01:44.051Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2024-09-26T21:01:44.051Z] GC before operation: completed in 195.908 ms, heap usage 148.560 MB -> 24.662 MB. [2024-09-26T21:01:44.051Z] ====== scala-kmeans (scala) [default], iteration 10 completed (397.712 ms) ====== [2024-09-26T21:01:44.051Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2024-09-26T21:01:44.804Z] GC before operation: completed in 199.984 ms, heap usage 148.508 MB -> 24.662 MB. [2024-09-26T21:01:44.804Z] ====== scala-kmeans (scala) [default], iteration 11 completed (394.737 ms) ====== [2024-09-26T21:01:44.804Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2024-09-26T21:01:45.558Z] GC before operation: completed in 273.605 ms, heap usage 148.475 MB -> 24.663 MB. [2024-09-26T21:01:45.558Z] ====== scala-kmeans (scala) [default], iteration 12 completed (392.988 ms) ====== [2024-09-26T21:01:45.558Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2024-09-26T21:01:45.558Z] GC before operation: completed in 202.838 ms, heap usage 148.453 MB -> 24.663 MB. [2024-09-26T21:01:46.312Z] ====== scala-kmeans (scala) [default], iteration 13 completed (395.486 ms) ====== [2024-09-26T21:01:46.312Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2024-09-26T21:01:46.312Z] GC before operation: completed in 216.605 ms, heap usage 148.439 MB -> 24.663 MB. [2024-09-26T21:01:47.065Z] ====== scala-kmeans (scala) [default], iteration 14 completed (395.743 ms) ====== [2024-09-26T21:01:47.065Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2024-09-26T21:01:47.065Z] GC before operation: completed in 173.757 ms, heap usage 148.430 MB -> 24.663 MB. [2024-09-26T21:01:47.819Z] ====== scala-kmeans (scala) [default], iteration 15 completed (395.993 ms) ====== [2024-09-26T21:01:47.819Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2024-09-26T21:01:47.819Z] GC before operation: completed in 119.853 ms, heap usage 148.424 MB -> 24.663 MB. [2024-09-26T21:01:47.819Z] ====== scala-kmeans (scala) [default], iteration 16 completed (396.202 ms) ====== [2024-09-26T21:01:47.819Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2024-09-26T21:01:48.571Z] GC before operation: completed in 223.384 ms, heap usage 148.420 MB -> 24.716 MB. [2024-09-26T21:01:48.571Z] ====== scala-kmeans (scala) [default], iteration 17 completed (395.420 ms) ====== [2024-09-26T21:01:48.571Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2024-09-26T21:01:48.571Z] GC before operation: completed in 113.802 ms, heap usage 148.470 MB -> 24.665 MB. [2024-09-26T21:01:49.325Z] ====== scala-kmeans (scala) [default], iteration 18 completed (395.672 ms) ====== [2024-09-26T21:01:49.325Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2024-09-26T21:01:49.325Z] GC before operation: completed in 212.789 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:50.078Z] ====== scala-kmeans (scala) [default], iteration 19 completed (395.213 ms) ====== [2024-09-26T21:01:50.078Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2024-09-26T21:01:50.078Z] GC before operation: completed in 174.645 ms, heap usage 148.420 MB -> 24.668 MB. [2024-09-26T21:01:50.078Z] ====== scala-kmeans (scala) [default], iteration 20 completed (394.615 ms) ====== [2024-09-26T21:01:50.078Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2024-09-26T21:01:50.832Z] GC before operation: completed in 197.954 ms, heap usage 148.419 MB -> 24.668 MB. [2024-09-26T21:01:50.832Z] ====== scala-kmeans (scala) [default], iteration 21 completed (395.299 ms) ====== [2024-09-26T21:01:50.832Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2024-09-26T21:01:50.832Z] GC before operation: completed in 277.755 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:51.585Z] ====== scala-kmeans (scala) [default], iteration 22 completed (394.605 ms) ====== [2024-09-26T21:01:51.585Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2024-09-26T21:01:51.585Z] GC before operation: completed in 157.366 ms, heap usage 148.419 MB -> 24.668 MB. [2024-09-26T21:01:52.337Z] ====== scala-kmeans (scala) [default], iteration 23 completed (393.652 ms) ====== [2024-09-26T21:01:52.337Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2024-09-26T21:01:52.337Z] GC before operation: completed in 198.634 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:53.089Z] ====== scala-kmeans (scala) [default], iteration 24 completed (394.636 ms) ====== [2024-09-26T21:01:53.089Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2024-09-26T21:01:53.089Z] GC before operation: completed in 255.048 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:53.089Z] ====== scala-kmeans (scala) [default], iteration 25 completed (392.488 ms) ====== [2024-09-26T21:01:53.089Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2024-09-26T21:01:53.843Z] GC before operation: completed in 189.125 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:53.843Z] ====== scala-kmeans (scala) [default], iteration 26 completed (392.560 ms) ====== [2024-09-26T21:01:53.843Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2024-09-26T21:01:53.843Z] GC before operation: completed in 178.659 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:54.597Z] ====== scala-kmeans (scala) [default], iteration 27 completed (394.470 ms) ====== [2024-09-26T21:01:54.597Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2024-09-26T21:01:54.597Z] GC before operation: completed in 193.053 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:55.352Z] ====== scala-kmeans (scala) [default], iteration 28 completed (395.284 ms) ====== [2024-09-26T21:01:55.352Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2024-09-26T21:01:55.352Z] GC before operation: completed in 233.116 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:56.105Z] ====== scala-kmeans (scala) [default], iteration 29 completed (397.381 ms) ====== [2024-09-26T21:01:56.105Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2024-09-26T21:01:56.105Z] GC before operation: completed in 162.035 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:56.105Z] ====== scala-kmeans (scala) [default], iteration 30 completed (395.984 ms) ====== [2024-09-26T21:01:56.105Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2024-09-26T21:01:56.858Z] GC before operation: completed in 178.893 ms, heap usage 148.418 MB -> 24.668 MB. [2024-09-26T21:01:56.858Z] ====== scala-kmeans (scala) [default], iteration 31 completed (396.779 ms) ====== [2024-09-26T21:01:56.858Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2024-09-26T21:01:56.858Z] GC before operation: completed in 215.511 ms, heap usage 148.419 MB -> 24.668 MB. [2024-09-26T21:01:57.610Z] ====== scala-kmeans (scala) [default], iteration 32 completed (393.647 ms) ====== [2024-09-26T21:01:57.610Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2024-09-26T21:01:57.610Z] GC before operation: completed in 335.202 ms, heap usage 148.418 MB -> 24.669 MB. [2024-09-26T21:01:58.374Z] ====== scala-kmeans (scala) [default], iteration 33 completed (397.000 ms) ====== [2024-09-26T21:01:58.374Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2024-09-26T21:01:58.374Z] GC before operation: completed in 190.629 ms, heap usage 148.419 MB -> 24.669 MB. [2024-09-26T21:01:59.130Z] ====== scala-kmeans (scala) [default], iteration 34 completed (396.956 ms) ====== [2024-09-26T21:01:59.130Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2024-09-26T21:01:59.130Z] GC before operation: completed in 200.749 ms, heap usage 148.418 MB -> 24.669 MB. [2024-09-26T21:01:59.130Z] ====== scala-kmeans (scala) [default], iteration 35 completed (397.206 ms) ====== [2024-09-26T21:01:59.130Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2024-09-26T21:01:59.889Z] GC before operation: completed in 185.817 ms, heap usage 148.419 MB -> 24.669 MB. [2024-09-26T21:01:59.889Z] ====== scala-kmeans (scala) [default], iteration 36 completed (396.220 ms) ====== [2024-09-26T21:01:59.889Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2024-09-26T21:01:59.889Z] GC before operation: completed in 184.918 ms, heap usage 148.419 MB -> 24.669 MB. [2024-09-26T21:02:00.643Z] ====== scala-kmeans (scala) [default], iteration 37 completed (398.058 ms) ====== [2024-09-26T21:02:00.643Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2024-09-26T21:02:00.643Z] GC before operation: completed in 168.108 ms, heap usage 148.419 MB -> 24.669 MB. [2024-09-26T21:02:01.395Z] ====== scala-kmeans (scala) [default], iteration 38 completed (393.483 ms) ====== [2024-09-26T21:02:01.395Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2024-09-26T21:02:01.395Z] GC before operation: completed in 336.537 ms, heap usage 148.419 MB -> 24.669 MB. [2024-09-26T21:02:02.148Z] ====== scala-kmeans (scala) [default], iteration 39 completed (403.084 ms) ====== [2024-09-26T21:02:02.148Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2024-09-26T21:02:02.148Z] GC before operation: completed in 177.698 ms, heap usage 148.419 MB -> 24.669 MB. [2024-09-26T21:02:02.148Z] ====== scala-kmeans (scala) [default], iteration 40 completed (394.670 ms) ====== [2024-09-26T21:02:02.148Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2024-09-26T21:02:02.907Z] GC before operation: completed in 169.808 ms, heap usage 148.419 MB -> 24.669 MB. [2024-09-26T21:02:02.907Z] ====== scala-kmeans (scala) [default], iteration 41 completed (394.651 ms) ====== [2024-09-26T21:02:02.907Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2024-09-26T21:02:02.907Z] GC before operation: completed in 179.860 ms, heap usage 148.419 MB -> 24.670 MB. [2024-09-26T21:02:03.661Z] ====== scala-kmeans (scala) [default], iteration 42 completed (395.476 ms) ====== [2024-09-26T21:02:03.661Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2024-09-26T21:02:03.661Z] GC before operation: completed in 356.335 ms, heap usage 148.420 MB -> 24.670 MB. [2024-09-26T21:02:04.414Z] ====== scala-kmeans (scala) [default], iteration 43 completed (397.074 ms) ====== [2024-09-26T21:02:04.414Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2024-09-26T21:02:04.414Z] GC before operation: completed in 129.365 ms, heap usage 148.420 MB -> 24.670 MB. [2024-09-26T21:02:05.175Z] ====== scala-kmeans (scala) [default], iteration 44 completed (399.317 ms) ====== [2024-09-26T21:02:05.175Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2024-09-26T21:02:05.175Z] GC before operation: completed in 189.660 ms, heap usage 148.420 MB -> 24.670 MB. [2024-09-26T21:02:05.175Z] ====== scala-kmeans (scala) [default], iteration 45 completed (394.197 ms) ====== [2024-09-26T21:02:05.175Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2024-09-26T21:02:05.932Z] GC before operation: completed in 184.408 ms, heap usage 148.420 MB -> 24.670 MB. [2024-09-26T21:02:05.932Z] ====== scala-kmeans (scala) [default], iteration 46 completed (394.146 ms) ====== [2024-09-26T21:02:05.932Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2024-09-26T21:02:05.932Z] GC before operation: completed in 117.364 ms, heap usage 148.420 MB -> 24.670 MB. [2024-09-26T21:02:06.692Z] ====== scala-kmeans (scala) [default], iteration 47 completed (395.074 ms) ====== [2024-09-26T21:02:06.692Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2024-09-26T21:02:06.692Z] GC before operation: completed in 206.368 ms, heap usage 148.420 MB -> 24.670 MB. [2024-09-26T21:02:07.451Z] ====== scala-kmeans (scala) [default], iteration 48 completed (397.340 ms) ====== [2024-09-26T21:02:07.451Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2024-09-26T21:02:07.452Z] GC before operation: completed in 177.700 ms, heap usage 148.420 MB -> 24.670 MB. [2024-09-26T21:02:07.452Z] ====== scala-kmeans (scala) [default], iteration 49 completed (392.962 ms) ====== [2024-09-26T21:02:08.205Z] ----------------------------------- [2024-09-26T21:02:08.205Z] renaissance-scala-kmeans_0_PASSED [2024-09-26T21:02:08.205Z] ----------------------------------- [2024-09-26T21:02:08.205Z] [2024-09-26T21:02:08.205Z] TEST TEARDOWN: [2024-09-26T21:02:08.205Z] Nothing to be done for teardown. [2024-09-26T21:02:08.205Z] renaissance-scala-kmeans_0 Finish Time: Thu Sep 26 21:02:07 2024 Epoch Time (ms): 1727384527534