[2025-06-12T21:06:12.930Z] Running test renaissance-scala-kmeans_0 ... [2025-06-12T21:06:13.220Z] =============================================== [2025-06-12T21:06:13.510Z] renaissance-scala-kmeans_0 Start Time: Thu Jun 12 21:06:13 2025 Epoch Time (ms): 1749762373255 [2025-06-12T21:06:13.510Z] variation: NoOptions [2025-06-12T21:06:13.802Z] JVM_OPTIONS: [2025-06-12T21:06:13.802Z] { \ [2025-06-12T21:06:13.802Z] echo ""; echo "TEST SETUP:"; \ [2025-06-12T21:06:13.802Z] echo "Nothing to be done for setup."; \ [2025-06-12T21:06:13.802Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17497622001732\\renaissance-scala-kmeans_0"; \ [2025-06-12T21:06:13.802Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17497622001732\\renaissance-scala-kmeans_0"; \ [2025-06-12T21:06:13.802Z] echo ""; echo "TESTING:"; \ [2025-06-12T21:06:13.802Z] C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\perf\\run_with_affinity.sh --exec_cmd ""C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/jdkbinary/j2sdk-image\\bin\\java" -jar "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17497622001732\\renaissance-scala-kmeans_0"\\scala-kmeans.json" scala-kmeans" --test_root C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/; \ [2025-06-12T21:06:13.802Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_PASSED"; echo "-----------------------------------"; cd C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/; rm -f -r "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17497622001732\\renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-12T21:06:13.802Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-12T21:06:13.802Z] echo "Nothing to be done for teardown."; \ [2025-06-12T21:06:13.802Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17497622001732\\TestTargetResult"; [2025-06-12T21:06:13.802Z] [2025-06-12T21:06:13.802Z] TEST SETUP: [2025-06-12T21:06:13.802Z] Nothing to be done for setup. [2025-06-12T21:06:13.802Z] [2025-06-12T21:06:13.802Z] TESTING: [2025-06-12T21:06:22.278Z] Running EXEC_CMD_WITH_AFFINITY=cmd /C start /B /WAIT /AFFINITY 3 /NODE 0 C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/jdkbinary/j2sdk-image\bin\java -jar C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests///..//jvmtest\perf\renaissance\renaissance.jar --json C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\TKG\output_17497622001732\renaissance-scala-kmeans_0\scala-kmeans.json scala-kmeans [2025-06-12T21:06:24.408Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-06-12T21:06:24.408Z] GC before operation: completed in 39.830 ms, heap usage 29.856 MB -> 26.005 MB. [2025-06-12T21:06:24.408Z] ====== scala-kmeans (scala) [default], iteration 0 completed (543.534 ms) ====== [2025-06-12T21:06:24.408Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-06-12T21:06:24.408Z] GC before operation: completed in 31.407 ms, heap usage 30.941 MB -> 26.103 MB. [2025-06-12T21:06:24.700Z] ====== scala-kmeans (scala) [default], iteration 1 completed (345.555 ms) ====== [2025-06-12T21:06:24.700Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-06-12T21:06:24.700Z] GC before operation: completed in 32.631 ms, heap usage 89.077 MB -> 26.103 MB. [2025-06-12T21:06:24.992Z] ====== scala-kmeans (scala) [default], iteration 2 completed (330.201 ms) ====== [2025-06-12T21:06:24.992Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-06-12T21:06:25.283Z] GC before operation: completed in 31.165 ms, heap usage 36.019 MB -> 26.103 MB. [2025-06-12T21:06:25.574Z] ====== scala-kmeans (scala) [default], iteration 3 completed (315.696 ms) ====== [2025-06-12T21:06:25.574Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-06-12T21:06:25.574Z] GC before operation: completed in 31.461 ms, heap usage 32.744 MB -> 26.103 MB. [2025-06-12T21:06:25.865Z] ====== scala-kmeans (scala) [default], iteration 4 completed (314.407 ms) ====== [2025-06-12T21:06:25.865Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-06-12T21:06:25.865Z] GC before operation: completed in 31.159 ms, heap usage 32.613 MB -> 26.103 MB. [2025-06-12T21:06:26.155Z] ====== scala-kmeans (scala) [default], iteration 5 completed (316.336 ms) ====== [2025-06-12T21:06:26.155Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-06-12T21:06:26.155Z] GC before operation: completed in 31.892 ms, heap usage 32.614 MB -> 26.103 MB. [2025-06-12T21:06:26.446Z] ====== scala-kmeans (scala) [default], iteration 6 completed (313.030 ms) ====== [2025-06-12T21:06:26.447Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-06-12T21:06:26.447Z] GC before operation: completed in 30.927 ms, heap usage 32.614 MB -> 26.103 MB. [2025-06-12T21:06:26.738Z] ====== scala-kmeans (scala) [default], iteration 7 completed (314.563 ms) ====== [2025-06-12T21:06:26.738Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-06-12T21:06:27.030Z] GC before operation: completed in 32.658 ms, heap usage 32.612 MB -> 26.104 MB. [2025-06-12T21:06:27.320Z] ====== scala-kmeans (scala) [default], iteration 8 completed (335.264 ms) ====== [2025-06-12T21:06:27.320Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-06-12T21:06:27.320Z] GC before operation: completed in 31.081 ms, heap usage 32.614 MB -> 26.104 MB. [2025-06-12T21:06:27.611Z] ====== scala-kmeans (scala) [default], iteration 9 completed (312.856 ms) ====== [2025-06-12T21:06:27.611Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-06-12T21:06:27.611Z] GC before operation: completed in 31.903 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:27.902Z] ====== scala-kmeans (scala) [default], iteration 10 completed (317.111 ms) ====== [2025-06-12T21:06:27.902Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-06-12T21:06:27.902Z] GC before operation: completed in 31.638 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:28.193Z] ====== scala-kmeans (scala) [default], iteration 11 completed (315.682 ms) ====== [2025-06-12T21:06:28.193Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-06-12T21:06:28.193Z] GC before operation: completed in 32.108 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:28.484Z] ====== scala-kmeans (scala) [default], iteration 12 completed (315.909 ms) ====== [2025-06-12T21:06:28.484Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-06-12T21:06:28.775Z] GC before operation: completed in 31.563 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:29.067Z] ====== scala-kmeans (scala) [default], iteration 13 completed (319.240 ms) ====== [2025-06-12T21:06:29.067Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-06-12T21:06:29.067Z] GC before operation: completed in 33.114 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:29.357Z] ====== scala-kmeans (scala) [default], iteration 14 completed (315.594 ms) ====== [2025-06-12T21:06:29.357Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-06-12T21:06:29.357Z] GC before operation: completed in 31.261 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:29.648Z] ====== scala-kmeans (scala) [default], iteration 15 completed (317.580 ms) ====== [2025-06-12T21:06:29.648Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-06-12T21:06:29.648Z] GC before operation: completed in 32.752 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:29.940Z] ====== scala-kmeans (scala) [default], iteration 16 completed (316.262 ms) ====== [2025-06-12T21:06:29.940Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-06-12T21:06:29.940Z] GC before operation: completed in 31.053 ms, heap usage 32.615 MB -> 26.104 MB. [2025-06-12T21:06:30.573Z] ====== scala-kmeans (scala) [default], iteration 17 completed (328.353 ms) ====== [2025-06-12T21:06:30.573Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-06-12T21:06:30.573Z] GC before operation: completed in 32.342 ms, heap usage 32.616 MB -> 26.104 MB. [2025-06-12T21:06:30.865Z] ====== scala-kmeans (scala) [default], iteration 18 completed (313.180 ms) ====== [2025-06-12T21:06:30.865Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-06-12T21:06:30.865Z] GC before operation: completed in 31.092 ms, heap usage 32.616 MB -> 26.104 MB. [2025-06-12T21:06:31.155Z] ====== scala-kmeans (scala) [default], iteration 19 completed (313.619 ms) ====== [2025-06-12T21:06:31.155Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-06-12T21:06:31.155Z] GC before operation: completed in 32.268 ms, heap usage 32.232 MB -> 26.105 MB. [2025-06-12T21:06:31.447Z] ====== scala-kmeans (scala) [default], iteration 20 completed (311.893 ms) ====== [2025-06-12T21:06:31.447Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-06-12T21:06:31.447Z] GC before operation: completed in 32.222 ms, heap usage 32.616 MB -> 26.105 MB. [2025-06-12T21:06:31.739Z] ====== scala-kmeans (scala) [default], iteration 21 completed (315.896 ms) ====== [2025-06-12T21:06:31.739Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-06-12T21:06:31.739Z] GC before operation: completed in 32.347 ms, heap usage 32.617 MB -> 26.105 MB. [2025-06-12T21:06:32.031Z] ====== scala-kmeans (scala) [default], iteration 22 completed (314.564 ms) ====== [2025-06-12T21:06:32.032Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-06-12T21:06:32.032Z] GC before operation: completed in 31.348 ms, heap usage 32.617 MB -> 26.105 MB. [2025-06-12T21:06:32.323Z] ====== scala-kmeans (scala) [default], iteration 23 completed (311.953 ms) ====== [2025-06-12T21:06:32.323Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-06-12T21:06:32.614Z] GC before operation: completed in 32.284 ms, heap usage 32.617 MB -> 26.105 MB. [2025-06-12T21:06:32.906Z] ====== scala-kmeans (scala) [default], iteration 24 completed (313.730 ms) ====== [2025-06-12T21:06:32.906Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-06-12T21:06:32.906Z] GC before operation: completed in 34.652 ms, heap usage 32.617 MB -> 26.105 MB. [2025-06-12T21:06:33.197Z] ====== scala-kmeans (scala) [default], iteration 25 completed (316.917 ms) ====== [2025-06-12T21:06:33.197Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-06-12T21:06:33.197Z] GC before operation: completed in 31.806 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:33.490Z] ====== scala-kmeans (scala) [default], iteration 26 completed (327.336 ms) ====== [2025-06-12T21:06:33.490Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-06-12T21:06:33.490Z] GC before operation: completed in 31.804 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:33.782Z] ====== scala-kmeans (scala) [default], iteration 27 completed (313.881 ms) ====== [2025-06-12T21:06:33.782Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-06-12T21:06:33.782Z] GC before operation: completed in 32.183 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:34.416Z] ====== scala-kmeans (scala) [default], iteration 28 completed (317.487 ms) ====== [2025-06-12T21:06:34.416Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-06-12T21:06:34.416Z] GC before operation: completed in 31.850 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:34.707Z] ====== scala-kmeans (scala) [default], iteration 29 completed (314.479 ms) ====== [2025-06-12T21:06:34.707Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-06-12T21:06:34.707Z] GC before operation: completed in 32.254 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:34.999Z] ====== scala-kmeans (scala) [default], iteration 30 completed (315.390 ms) ====== [2025-06-12T21:06:34.999Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-06-12T21:06:34.999Z] GC before operation: completed in 31.126 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:35.292Z] ====== scala-kmeans (scala) [default], iteration 31 completed (317.660 ms) ====== [2025-06-12T21:06:35.292Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-06-12T21:06:35.292Z] GC before operation: completed in 31.980 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:35.584Z] ====== scala-kmeans (scala) [default], iteration 32 completed (317.544 ms) ====== [2025-06-12T21:06:35.584Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-06-12T21:06:35.584Z] GC before operation: completed in 31.887 ms, heap usage 32.617 MB -> 26.106 MB. [2025-06-12T21:06:35.875Z] ====== scala-kmeans (scala) [default], iteration 33 completed (316.548 ms) ====== [2025-06-12T21:06:35.875Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-06-12T21:06:35.875Z] GC before operation: completed in 33.087 ms, heap usage 32.618 MB -> 26.107 MB. [2025-06-12T21:06:36.509Z] ====== scala-kmeans (scala) [default], iteration 34 completed (325.917 ms) ====== [2025-06-12T21:06:36.509Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-06-12T21:06:36.509Z] GC before operation: completed in 34.877 ms, heap usage 32.618 MB -> 26.107 MB. [2025-06-12T21:06:36.800Z] ====== scala-kmeans (scala) [default], iteration 35 completed (315.602 ms) ====== [2025-06-12T21:06:36.800Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-06-12T21:06:36.800Z] GC before operation: completed in 32.238 ms, heap usage 32.618 MB -> 26.108 MB. [2025-06-12T21:06:37.092Z] ====== scala-kmeans (scala) [default], iteration 36 completed (316.277 ms) ====== [2025-06-12T21:06:37.092Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-06-12T21:06:37.092Z] GC before operation: completed in 35.488 ms, heap usage 32.620 MB -> 26.109 MB. [2025-06-12T21:06:37.382Z] ====== scala-kmeans (scala) [default], iteration 37 completed (314.678 ms) ====== [2025-06-12T21:06:37.383Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-06-12T21:06:37.383Z] GC before operation: completed in 32.358 ms, heap usage 32.620 MB -> 26.109 MB. [2025-06-12T21:06:37.673Z] ====== scala-kmeans (scala) [default], iteration 38 completed (312.563 ms) ====== [2025-06-12T21:06:37.673Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-06-12T21:06:37.673Z] GC before operation: completed in 31.630 ms, heap usage 32.365 MB -> 26.109 MB. [2025-06-12T21:06:37.965Z] ====== scala-kmeans (scala) [default], iteration 39 completed (313.480 ms) ====== [2025-06-12T21:06:37.965Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-06-12T21:06:37.965Z] GC before operation: completed in 32.060 ms, heap usage 32.620 MB -> 26.109 MB. [2025-06-12T21:06:38.599Z] ====== scala-kmeans (scala) [default], iteration 40 completed (313.907 ms) ====== [2025-06-12T21:06:38.599Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-06-12T21:06:38.599Z] GC before operation: completed in 31.224 ms, heap usage 32.620 MB -> 26.109 MB. [2025-06-12T21:06:38.891Z] ====== scala-kmeans (scala) [default], iteration 41 completed (312.688 ms) ====== [2025-06-12T21:06:38.891Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-06-12T21:06:38.891Z] GC before operation: completed in 32.393 ms, heap usage 32.620 MB -> 26.109 MB. [2025-06-12T21:06:39.183Z] ====== scala-kmeans (scala) [default], iteration 42 completed (320.178 ms) ====== [2025-06-12T21:06:39.183Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-06-12T21:06:39.183Z] GC before operation: completed in 32.346 ms, heap usage 32.620 MB -> 26.109 MB. [2025-06-12T21:06:39.475Z] ====== scala-kmeans (scala) [default], iteration 43 completed (320.289 ms) ====== [2025-06-12T21:06:39.475Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-06-12T21:06:39.475Z] GC before operation: completed in 33.013 ms, heap usage 32.620 MB -> 26.109 MB. [2025-06-12T21:06:39.766Z] ====== scala-kmeans (scala) [default], iteration 44 completed (313.473 ms) ====== [2025-06-12T21:06:39.766Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-06-12T21:06:39.766Z] GC before operation: completed in 32.144 ms, heap usage 32.621 MB -> 26.109 MB. [2025-06-12T21:06:40.057Z] ====== scala-kmeans (scala) [default], iteration 45 completed (319.913 ms) ====== [2025-06-12T21:06:40.057Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-06-12T21:06:40.349Z] GC before operation: completed in 32.037 ms, heap usage 32.621 MB -> 26.109 MB. [2025-06-12T21:06:40.641Z] ====== scala-kmeans (scala) [default], iteration 46 completed (314.537 ms) ====== [2025-06-12T21:06:40.641Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-06-12T21:06:40.641Z] GC before operation: completed in 31.921 ms, heap usage 32.621 MB -> 26.109 MB. [2025-06-12T21:06:40.933Z] ====== scala-kmeans (scala) [default], iteration 47 completed (312.662 ms) ====== [2025-06-12T21:06:40.933Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-06-12T21:06:40.933Z] GC before operation: completed in 32.225 ms, heap usage 32.621 MB -> 26.110 MB. [2025-06-12T21:06:41.224Z] ====== scala-kmeans (scala) [default], iteration 48 completed (312.288 ms) ====== [2025-06-12T21:06:41.224Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-06-12T21:06:41.224Z] GC before operation: completed in 31.335 ms, heap usage 32.621 MB -> 26.110 MB. [2025-06-12T21:06:41.515Z] ====== scala-kmeans (scala) [default], iteration 49 completed (311.269 ms) ====== [2025-06-12T21:06:41.806Z] [2025-06-12T21:06:41.576+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-06-12T21:06:41.806Z] WARNING: Error deleting scratch directory C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.perf_aarch64_windows\aqa-tests\TKG\output_17497622001732\renaissance-scala-kmeans_0\launcher-210622-732439194415960188: launcher-210622-732439194415960188\renaissance-harness_3\lib\renaissance-harness_3-0.16.0.jar: The process cannot access the file because it is being used by another process [2025-06-12T21:06:41.806Z] ----------------------------------- [2025-06-12T21:06:41.806Z] renaissance-scala-kmeans_0_PASSED [2025-06-12T21:06:41.806Z] ----------------------------------- [2025-06-12T21:06:41.806Z] [2025-06-12T21:06:41.806Z] TEST TEARDOWN: [2025-06-12T21:06:41.806Z] Nothing to be done for teardown. [2025-06-12T21:06:42.098Z] renaissance-scala-kmeans_0 Finish Time: Thu Jun 12 21:06:41 2025 Epoch Time (ms): 1749762401857