[2025-04-05T11:16:30.597Z] Running test renaissance-scala-kmeans_0 ... [2025-04-05T11:16:30.597Z] =============================================== [2025-04-05T11:16:30.597Z] renaissance-scala-kmeans_0 Start Time: Sat Apr 5 11:16:30 2025 Epoch Time (ms): 1743851790289 [2025-04-05T11:16:30.597Z] variation: NoOptions [2025-04-05T11:16:30.597Z] JVM_OPTIONS: [2025-04-05T11:16:30.597Z] { \ [2025-04-05T11:16:30.597Z] echo ""; echo "TEST SETUP:"; \ [2025-04-05T11:16:30.597Z] echo "Nothing to be done for setup."; \ [2025-04-05T11:16:30.597Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17438514615073/renaissance-scala-kmeans_0"; \ [2025-04-05T11:16:30.597Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17438514615073/renaissance-scala-kmeans_0"; \ [2025-04-05T11:16:30.597Z] echo ""; echo "TESTING:"; \ [2025-04-05T11:16:30.597Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../perf/run_with_affinity.sh --exec_cmd ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17438514615073/renaissance-scala-kmeans_0"/scala-kmeans.json" scala-kmeans" --test_root /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/..; \ [2025-04-05T11:16:30.597Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17438514615073/renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-04-05T11:16:30.597Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-04-05T11:16:30.597Z] echo "Nothing to be done for teardown."; \ [2025-04-05T11:16:30.597Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17438514615073/TestTargetResult"; [2025-04-05T11:16:30.597Z] [2025-04-05T11:16:30.597Z] TEST SETUP: [2025-04-05T11:16:30.597Z] Nothing to be done for setup. [2025-04-05T11:16:30.597Z] [2025-04-05T11:16:30.597Z] TESTING: [2025-04-05T11:16:32.193Z] Running EXEC_CMD_WITH_AFFINITY=execrset -c 0-7 -e /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/jdkbinary/j2sdk-image/bin/java -jar /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar --json /home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17438514615073/renaissance-scala-kmeans_0/scala-kmeans.json scala-kmeans [2025-04-05T11:16:32.969Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-04-05T11:16:32.969Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_sanity.perf_ppc64_aix/aqa-tests/TKG/output_17438514615073/renaissance-scala-kmeans_0/launcher-111631-481640247988133209/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-04-05T11:16:32.969Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-04-05T11:16:32.969Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-04-05T11:16:34.567Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-04-05T11:16:34.567Z] GC before operation: completed in 117.938 ms, heap usage 29.111 MB -> 25.966 MB. [2025-04-05T11:16:35.340Z] ====== scala-kmeans (scala) [default], iteration 0 completed (851.700 ms) ====== [2025-04-05T11:16:35.340Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-04-05T11:16:35.340Z] GC before operation: completed in 53.894 ms, heap usage 30.307 MB -> 26.031 MB. [2025-04-05T11:16:36.114Z] ====== scala-kmeans (scala) [default], iteration 1 completed (293.439 ms) ====== [2025-04-05T11:16:36.114Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-04-05T11:16:36.114Z] GC before operation: completed in 53.460 ms, heap usage 58.031 MB -> 26.031 MB. [2025-04-05T11:16:36.114Z] ====== scala-kmeans (scala) [default], iteration 2 completed (293.768 ms) ====== [2025-04-05T11:16:36.114Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-04-05T11:16:36.114Z] GC before operation: completed in 53.616 ms, heap usage 56.518 MB -> 26.032 MB. [2025-04-05T11:16:36.887Z] ====== scala-kmeans (scala) [default], iteration 3 completed (289.072 ms) ====== [2025-04-05T11:16:36.887Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-04-05T11:16:36.887Z] GC before operation: completed in 55.959 ms, heap usage 56.531 MB -> 26.032 MB. [2025-04-05T11:16:36.887Z] ====== scala-kmeans (scala) [default], iteration 4 completed (286.652 ms) ====== [2025-04-05T11:16:36.887Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-04-05T11:16:36.887Z] GC before operation: completed in 54.417 ms, heap usage 56.523 MB -> 26.032 MB. [2025-04-05T11:16:37.658Z] ====== scala-kmeans (scala) [default], iteration 5 completed (288.086 ms) ====== [2025-04-05T11:16:37.658Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-04-05T11:16:37.658Z] GC before operation: completed in 52.790 ms, heap usage 56.508 MB -> 26.032 MB. [2025-04-05T11:16:37.658Z] ====== scala-kmeans (scala) [default], iteration 6 completed (287.158 ms) ====== [2025-04-05T11:16:37.658Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-04-05T11:16:37.658Z] GC before operation: completed in 55.102 ms, heap usage 56.498 MB -> 26.032 MB. [2025-04-05T11:16:37.658Z] ====== scala-kmeans (scala) [default], iteration 7 completed (286.935 ms) ====== [2025-04-05T11:16:37.658Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-04-05T11:16:38.433Z] GC before operation: completed in 56.638 ms, heap usage 56.491 MB -> 26.032 MB. [2025-04-05T11:16:38.433Z] ====== scala-kmeans (scala) [default], iteration 8 completed (287.500 ms) ====== [2025-04-05T11:16:38.433Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-04-05T11:16:38.433Z] GC before operation: completed in 53.281 ms, heap usage 56.487 MB -> 26.032 MB. [2025-04-05T11:16:38.433Z] ====== scala-kmeans (scala) [default], iteration 9 completed (287.270 ms) ====== [2025-04-05T11:16:38.433Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-04-05T11:16:38.433Z] GC before operation: completed in 52.946 ms, heap usage 56.484 MB -> 26.033 MB. [2025-04-05T11:16:39.206Z] ====== scala-kmeans (scala) [default], iteration 10 completed (288.524 ms) ====== [2025-04-05T11:16:39.206Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-04-05T11:16:39.206Z] GC before operation: completed in 52.650 ms, heap usage 56.483 MB -> 26.033 MB. [2025-04-05T11:16:39.206Z] ====== scala-kmeans (scala) [default], iteration 11 completed (286.598 ms) ====== [2025-04-05T11:16:39.206Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-04-05T11:16:39.206Z] GC before operation: completed in 57.987 ms, heap usage 56.482 MB -> 26.033 MB. [2025-04-05T11:16:39.980Z] ====== scala-kmeans (scala) [default], iteration 12 completed (286.113 ms) ====== [2025-04-05T11:16:39.980Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-04-05T11:16:39.980Z] GC before operation: completed in 52.851 ms, heap usage 56.481 MB -> 26.033 MB. [2025-04-05T11:16:39.980Z] ====== scala-kmeans (scala) [default], iteration 13 completed (288.106 ms) ====== [2025-04-05T11:16:39.980Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-04-05T11:16:39.980Z] GC before operation: completed in 52.360 ms, heap usage 56.476 MB -> 26.033 MB. [2025-04-05T11:16:40.752Z] ====== scala-kmeans (scala) [default], iteration 14 completed (289.981 ms) ====== [2025-04-05T11:16:40.752Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-04-05T11:16:40.752Z] GC before operation: completed in 57.555 ms, heap usage 56.483 MB -> 26.033 MB. [2025-04-05T11:16:40.752Z] ====== scala-kmeans (scala) [default], iteration 15 completed (287.152 ms) ====== [2025-04-05T11:16:40.752Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-04-05T11:16:40.752Z] GC before operation: completed in 54.731 ms, heap usage 56.482 MB -> 26.033 MB. [2025-04-05T11:16:40.752Z] ====== scala-kmeans (scala) [default], iteration 16 completed (287.632 ms) ====== [2025-04-05T11:16:40.752Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-04-05T11:16:40.752Z] GC before operation: completed in 59.374 ms, heap usage 56.481 MB -> 26.033 MB. [2025-04-05T11:16:41.524Z] ====== scala-kmeans (scala) [default], iteration 17 completed (286.169 ms) ====== [2025-04-05T11:16:41.524Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-04-05T11:16:41.524Z] GC before operation: completed in 54.039 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:41.524Z] ====== scala-kmeans (scala) [default], iteration 18 completed (288.113 ms) ====== [2025-04-05T11:16:41.524Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-04-05T11:16:41.524Z] GC before operation: completed in 53.096 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:42.295Z] ====== scala-kmeans (scala) [default], iteration 19 completed (285.951 ms) ====== [2025-04-05T11:16:42.295Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-04-05T11:16:42.295Z] GC before operation: completed in 52.630 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:42.295Z] ====== scala-kmeans (scala) [default], iteration 20 completed (287.365 ms) ====== [2025-04-05T11:16:42.295Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-04-05T11:16:42.295Z] GC before operation: completed in 55.197 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:43.069Z] ====== scala-kmeans (scala) [default], iteration 21 completed (284.981 ms) ====== [2025-04-05T11:16:43.069Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-04-05T11:16:43.069Z] GC before operation: completed in 52.633 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:43.069Z] ====== scala-kmeans (scala) [default], iteration 22 completed (287.868 ms) ====== [2025-04-05T11:16:43.069Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-04-05T11:16:43.069Z] GC before operation: completed in 56.612 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:43.842Z] ====== scala-kmeans (scala) [default], iteration 23 completed (291.067 ms) ====== [2025-04-05T11:16:43.842Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-04-05T11:16:43.843Z] GC before operation: completed in 54.207 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:43.843Z] ====== scala-kmeans (scala) [default], iteration 24 completed (288.523 ms) ====== [2025-04-05T11:16:43.843Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-04-05T11:16:43.843Z] GC before operation: completed in 56.309 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:43.843Z] ====== scala-kmeans (scala) [default], iteration 25 completed (287.231 ms) ====== [2025-04-05T11:16:43.843Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-04-05T11:16:43.843Z] GC before operation: completed in 55.841 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:44.620Z] ====== scala-kmeans (scala) [default], iteration 26 completed (286.921 ms) ====== [2025-04-05T11:16:44.620Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-04-05T11:16:44.620Z] GC before operation: completed in 53.468 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:44.621Z] ====== scala-kmeans (scala) [default], iteration 27 completed (287.732 ms) ====== [2025-04-05T11:16:44.621Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-04-05T11:16:44.621Z] GC before operation: completed in 56.337 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:45.392Z] ====== scala-kmeans (scala) [default], iteration 28 completed (287.292 ms) ====== [2025-04-05T11:16:45.392Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-04-05T11:16:45.392Z] GC before operation: completed in 51.814 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:45.392Z] ====== scala-kmeans (scala) [default], iteration 29 completed (285.612 ms) ====== [2025-04-05T11:16:45.392Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-04-05T11:16:45.392Z] GC before operation: completed in 56.101 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:46.164Z] ====== scala-kmeans (scala) [default], iteration 30 completed (286.015 ms) ====== [2025-04-05T11:16:46.164Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-04-05T11:16:46.164Z] GC before operation: completed in 56.394 ms, heap usage 56.481 MB -> 26.034 MB. [2025-04-05T11:16:46.164Z] ====== scala-kmeans (scala) [default], iteration 31 completed (286.754 ms) ====== [2025-04-05T11:16:46.164Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-04-05T11:16:46.164Z] GC before operation: completed in 55.691 ms, heap usage 56.482 MB -> 26.034 MB. [2025-04-05T11:16:46.935Z] ====== scala-kmeans (scala) [default], iteration 32 completed (288.652 ms) ====== [2025-04-05T11:16:46.936Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-04-05T11:16:46.936Z] GC before operation: completed in 53.240 ms, heap usage 56.481 MB -> 26.035 MB. [2025-04-05T11:16:46.936Z] ====== scala-kmeans (scala) [default], iteration 33 completed (285.515 ms) ====== [2025-04-05T11:16:46.936Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-04-05T11:16:46.936Z] GC before operation: completed in 52.677 ms, heap usage 56.482 MB -> 26.035 MB. [2025-04-05T11:16:46.936Z] ====== scala-kmeans (scala) [default], iteration 34 completed (285.888 ms) ====== [2025-04-05T11:16:46.936Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-04-05T11:16:46.936Z] GC before operation: completed in 61.657 ms, heap usage 56.482 MB -> 26.035 MB. [2025-04-05T11:16:47.708Z] ====== scala-kmeans (scala) [default], iteration 35 completed (287.316 ms) ====== [2025-04-05T11:16:47.708Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-04-05T11:16:47.708Z] GC before operation: completed in 54.137 ms, heap usage 56.482 MB -> 26.037 MB. [2025-04-05T11:16:47.708Z] ====== scala-kmeans (scala) [default], iteration 36 completed (285.892 ms) ====== [2025-04-05T11:16:47.708Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-04-05T11:16:47.708Z] GC before operation: completed in 60.111 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:48.481Z] ====== scala-kmeans (scala) [default], iteration 37 completed (286.462 ms) ====== [2025-04-05T11:16:48.481Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-04-05T11:16:48.481Z] GC before operation: completed in 54.580 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:48.481Z] ====== scala-kmeans (scala) [default], iteration 38 completed (287.259 ms) ====== [2025-04-05T11:16:48.481Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-04-05T11:16:48.481Z] GC before operation: completed in 53.708 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:49.263Z] ====== scala-kmeans (scala) [default], iteration 39 completed (285.436 ms) ====== [2025-04-05T11:16:49.263Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-04-05T11:16:49.263Z] GC before operation: completed in 53.576 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:49.263Z] ====== scala-kmeans (scala) [default], iteration 40 completed (287.914 ms) ====== [2025-04-05T11:16:49.263Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-04-05T11:16:49.263Z] GC before operation: completed in 60.523 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:50.040Z] ====== scala-kmeans (scala) [default], iteration 41 completed (287.394 ms) ====== [2025-04-05T11:16:50.040Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-04-05T11:16:50.040Z] GC before operation: completed in 56.152 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:50.040Z] ====== scala-kmeans (scala) [default], iteration 42 completed (286.520 ms) ====== [2025-04-05T11:16:50.040Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-04-05T11:16:50.040Z] GC before operation: completed in 53.070 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:50.040Z] ====== scala-kmeans (scala) [default], iteration 43 completed (287.918 ms) ====== [2025-04-05T11:16:50.040Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-04-05T11:16:50.040Z] GC before operation: completed in 57.901 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:50.812Z] ====== scala-kmeans (scala) [default], iteration 44 completed (287.257 ms) ====== [2025-04-05T11:16:50.812Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-04-05T11:16:50.812Z] GC before operation: completed in 53.099 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:50.812Z] ====== scala-kmeans (scala) [default], iteration 45 completed (288.667 ms) ====== [2025-04-05T11:16:50.812Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-04-05T11:16:50.812Z] GC before operation: completed in 59.206 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:51.584Z] ====== scala-kmeans (scala) [default], iteration 46 completed (287.842 ms) ====== [2025-04-05T11:16:51.584Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-04-05T11:16:51.584Z] GC before operation: completed in 53.154 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:51.584Z] ====== scala-kmeans (scala) [default], iteration 47 completed (285.653 ms) ====== [2025-04-05T11:16:51.584Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-04-05T11:16:51.584Z] GC before operation: completed in 54.880 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:52.355Z] ====== scala-kmeans (scala) [default], iteration 48 completed (285.868 ms) ====== [2025-04-05T11:16:52.355Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-04-05T11:16:52.355Z] GC before operation: completed in 58.205 ms, heap usage 56.484 MB -> 26.037 MB. [2025-04-05T11:16:52.355Z] ====== scala-kmeans (scala) [default], iteration 49 completed (286.915 ms) ====== [2025-04-05T11:16:52.355Z] ----------------------------------- [2025-04-05T11:16:52.355Z] renaissance-scala-kmeans_0_PASSED [2025-04-05T11:16:52.355Z] ----------------------------------- [2025-04-05T11:16:52.355Z] [2025-04-05T11:16:52.355Z] TEST TEARDOWN: [2025-04-05T11:16:52.355Z] Nothing to be done for teardown. [2025-04-05T11:16:52.355Z] renaissance-scala-kmeans_0 Finish Time: Sat Apr 5 11:16:52 2025 Epoch Time (ms): 1743851812211