[2025-06-19T04:46:49.130Z] Running test renaissance-scala-kmeans_0 ... [2025-06-19T04:46:49.130Z] =============================================== [2025-06-19T04:46:49.422Z] renaissance-scala-kmeans_0 Start Time: Thu Jun 19 04:46:49 2025 Epoch Time (ms): 1750308409303 [2025-06-19T04:46:49.713Z] variation: NoOptions [2025-06-19T04:46:49.713Z] JVM_OPTIONS: [2025-06-19T04:46:49.713Z] { \ [2025-06-19T04:46:49.713Z] echo ""; echo "TEST SETUP:"; \ [2025-06-19T04:46:49.713Z] echo "Nothing to be done for setup."; \ [2025-06-19T04:46:49.713Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17503082408005\\renaissance-scala-kmeans_0"; \ [2025-06-19T04:46:49.713Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17503082408005\\renaissance-scala-kmeans_0"; \ [2025-06-19T04:46:49.713Z] echo ""; echo "TESTING:"; \ [2025-06-19T04:46:49.713Z] 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_17503082408005\\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-19T04:46:49.713Z] 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_17503082408005\\renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-19T04:46:49.713Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-19T04:46:49.713Z] echo "Nothing to be done for teardown."; \ [2025-06-19T04:46:49.713Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17503082408005\\TestTargetResult"; [2025-06-19T04:46:50.005Z] [2025-06-19T04:46:50.005Z] TEST SETUP: [2025-06-19T04:46:50.005Z] Nothing to be done for setup. [2025-06-19T04:46:50.005Z] [2025-06-19T04:46:50.005Z] TESTING: [2025-06-19T04:46:58.506Z] 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_17503082408005\renaissance-scala-kmeans_0\scala-kmeans.json scala-kmeans [2025-06-19T04:47:00.010Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-06-19T04:47:00.010Z] GC before operation: completed in 38.030 ms, heap usage 29.836 MB -> 26.091 MB. [2025-06-19T04:47:00.646Z] ====== scala-kmeans (scala) [default], iteration 0 completed (478.306 ms) ====== [2025-06-19T04:47:00.646Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-06-19T04:47:00.646Z] GC before operation: completed in 32.544 ms, heap usage 39.780 MB -> 26.112 MB. [2025-06-19T04:47:00.937Z] ====== scala-kmeans (scala) [default], iteration 1 completed (320.991 ms) ====== [2025-06-19T04:47:00.937Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-06-19T04:47:00.937Z] GC before operation: completed in 32.016 ms, heap usage 51.113 MB -> 26.112 MB. [2025-06-19T04:47:01.231Z] ====== scala-kmeans (scala) [default], iteration 2 completed (321.168 ms) ====== [2025-06-19T04:47:01.231Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-06-19T04:47:01.231Z] GC before operation: completed in 31.789 ms, heap usage 41.691 MB -> 26.112 MB. [2025-06-19T04:47:01.521Z] ====== scala-kmeans (scala) [default], iteration 3 completed (312.627 ms) ====== [2025-06-19T04:47:01.521Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-06-19T04:47:01.521Z] GC before operation: completed in 31.221 ms, heap usage 40.169 MB -> 26.112 MB. [2025-06-19T04:47:02.152Z] ====== scala-kmeans (scala) [default], iteration 4 completed (327.346 ms) ====== [2025-06-19T04:47:02.152Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-06-19T04:47:02.152Z] GC before operation: completed in 33.816 ms, heap usage 39.928 MB -> 26.112 MB. [2025-06-19T04:47:02.443Z] ====== scala-kmeans (scala) [default], iteration 5 completed (315.309 ms) ====== [2025-06-19T04:47:02.443Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-06-19T04:47:02.443Z] GC before operation: completed in 32.104 ms, heap usage 39.937 MB -> 26.112 MB. [2025-06-19T04:47:02.734Z] ====== scala-kmeans (scala) [default], iteration 6 completed (319.751 ms) ====== [2025-06-19T04:47:02.734Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-06-19T04:47:02.734Z] GC before operation: completed in 33.064 ms, heap usage 39.736 MB -> 26.112 MB. [2025-06-19T04:47:03.025Z] ====== scala-kmeans (scala) [default], iteration 7 completed (318.079 ms) ====== [2025-06-19T04:47:03.025Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-06-19T04:47:03.025Z] GC before operation: completed in 31.288 ms, heap usage 39.725 MB -> 26.113 MB. [2025-06-19T04:47:03.316Z] ====== scala-kmeans (scala) [default], iteration 8 completed (319.268 ms) ====== [2025-06-19T04:47:03.316Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-06-19T04:47:03.316Z] GC before operation: completed in 32.058 ms, heap usage 39.936 MB -> 26.113 MB. [2025-06-19T04:47:03.610Z] ====== scala-kmeans (scala) [default], iteration 9 completed (314.970 ms) ====== [2025-06-19T04:47:03.610Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-06-19T04:47:03.901Z] GC before operation: completed in 31.462 ms, heap usage 39.737 MB -> 26.113 MB. [2025-06-19T04:47:04.193Z] ====== scala-kmeans (scala) [default], iteration 10 completed (323.716 ms) ====== [2025-06-19T04:47:04.193Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-06-19T04:47:04.193Z] GC before operation: completed in 32.107 ms, heap usage 39.737 MB -> 26.113 MB. [2025-06-19T04:47:04.485Z] ====== scala-kmeans (scala) [default], iteration 11 completed (312.918 ms) ====== [2025-06-19T04:47:04.485Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-06-19T04:47:04.485Z] GC before operation: completed in 33.216 ms, heap usage 39.737 MB -> 26.113 MB. [2025-06-19T04:47:04.789Z] ====== scala-kmeans (scala) [default], iteration 12 completed (322.492 ms) ====== [2025-06-19T04:47:04.789Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-06-19T04:47:04.789Z] GC before operation: completed in 36.038 ms, heap usage 39.737 MB -> 26.113 MB. [2025-06-19T04:47:05.081Z] ====== scala-kmeans (scala) [default], iteration 13 completed (331.122 ms) ====== [2025-06-19T04:47:05.081Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-06-19T04:47:05.081Z] GC before operation: completed in 31.108 ms, heap usage 39.739 MB -> 26.115 MB. [2025-06-19T04:47:05.372Z] ====== scala-kmeans (scala) [default], iteration 14 completed (311.944 ms) ====== [2025-06-19T04:47:05.372Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-06-19T04:47:05.664Z] GC before operation: completed in 32.985 ms, heap usage 39.739 MB -> 26.115 MB. [2025-06-19T04:47:05.956Z] ====== scala-kmeans (scala) [default], iteration 15 completed (342.013 ms) ====== [2025-06-19T04:47:05.956Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-06-19T04:47:05.956Z] GC before operation: completed in 32.296 ms, heap usage 92.992 MB -> 26.115 MB. [2025-06-19T04:47:06.248Z] ====== scala-kmeans (scala) [default], iteration 16 completed (314.364 ms) ====== [2025-06-19T04:47:06.248Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-06-19T04:47:06.248Z] GC before operation: completed in 31.734 ms, heap usage 39.921 MB -> 26.115 MB. [2025-06-19T04:47:06.539Z] ====== scala-kmeans (scala) [default], iteration 17 completed (316.096 ms) ====== [2025-06-19T04:47:06.539Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-06-19T04:47:06.539Z] GC before operation: completed in 31.992 ms, heap usage 39.727 MB -> 26.115 MB. [2025-06-19T04:47:06.831Z] ====== scala-kmeans (scala) [default], iteration 18 completed (320.126 ms) ====== [2025-06-19T04:47:06.831Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-06-19T04:47:06.831Z] GC before operation: completed in 31.512 ms, heap usage 39.738 MB -> 26.115 MB. [2025-06-19T04:47:07.463Z] ====== scala-kmeans (scala) [default], iteration 19 completed (314.907 ms) ====== [2025-06-19T04:47:07.463Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-06-19T04:47:07.463Z] GC before operation: completed in 32.779 ms, heap usage 39.739 MB -> 26.115 MB. [2025-06-19T04:47:07.758Z] ====== scala-kmeans (scala) [default], iteration 20 completed (316.832 ms) ====== [2025-06-19T04:47:07.758Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-06-19T04:47:07.758Z] GC before operation: completed in 33.658 ms, heap usage 39.740 MB -> 26.116 MB. [2025-06-19T04:47:08.047Z] ====== scala-kmeans (scala) [default], iteration 21 completed (315.450 ms) ====== [2025-06-19T04:47:08.048Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-06-19T04:47:08.048Z] GC before operation: completed in 32.875 ms, heap usage 39.740 MB -> 26.116 MB. [2025-06-19T04:47:08.339Z] ====== scala-kmeans (scala) [default], iteration 22 completed (320.692 ms) ====== [2025-06-19T04:47:08.339Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-06-19T04:47:08.339Z] GC before operation: completed in 35.070 ms, heap usage 39.740 MB -> 26.116 MB. [2025-06-19T04:47:08.631Z] ====== scala-kmeans (scala) [default], iteration 23 completed (314.463 ms) ====== [2025-06-19T04:47:08.631Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-06-19T04:47:08.631Z] GC before operation: completed in 32.948 ms, heap usage 39.943 MB -> 26.116 MB. [2025-06-19T04:47:08.923Z] ====== scala-kmeans (scala) [default], iteration 24 completed (315.820 ms) ====== [2025-06-19T04:47:08.923Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-06-19T04:47:08.923Z] GC before operation: completed in 35.317 ms, heap usage 39.740 MB -> 26.116 MB. [2025-06-19T04:47:09.554Z] ====== scala-kmeans (scala) [default], iteration 25 completed (309.120 ms) ====== [2025-06-19T04:47:09.554Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-06-19T04:47:09.554Z] GC before operation: completed in 31.140 ms, heap usage 39.740 MB -> 26.116 MB. [2025-06-19T04:47:09.846Z] ====== scala-kmeans (scala) [default], iteration 26 completed (337.115 ms) ====== [2025-06-19T04:47:09.846Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-06-19T04:47:09.846Z] GC before operation: completed in 32.652 ms, heap usage 92.993 MB -> 26.116 MB. [2025-06-19T04:47:10.137Z] ====== scala-kmeans (scala) [default], iteration 27 completed (309.878 ms) ====== [2025-06-19T04:47:10.137Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-06-19T04:47:10.137Z] GC before operation: completed in 35.363 ms, heap usage 39.923 MB -> 26.116 MB. [2025-06-19T04:47:10.429Z] ====== scala-kmeans (scala) [default], iteration 28 completed (314.970 ms) ====== [2025-06-19T04:47:10.429Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-06-19T04:47:10.429Z] GC before operation: completed in 37.276 ms, heap usage 39.930 MB -> 26.116 MB. [2025-06-19T04:47:10.719Z] ====== scala-kmeans (scala) [default], iteration 29 completed (311.509 ms) ====== [2025-06-19T04:47:10.719Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-06-19T04:47:10.719Z] GC before operation: completed in 33.669 ms, heap usage 39.739 MB -> 26.116 MB. [2025-06-19T04:47:11.011Z] ====== scala-kmeans (scala) [default], iteration 30 completed (321.442 ms) ====== [2025-06-19T04:47:11.011Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-06-19T04:47:11.302Z] GC before operation: completed in 34.053 ms, heap usage 39.740 MB -> 26.116 MB. [2025-06-19T04:47:11.593Z] ====== scala-kmeans (scala) [default], iteration 31 completed (308.500 ms) ====== [2025-06-19T04:47:11.593Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-06-19T04:47:11.593Z] GC before operation: completed in 35.765 ms, heap usage 39.740 MB -> 26.116 MB. [2025-06-19T04:47:11.883Z] ====== scala-kmeans (scala) [default], iteration 32 completed (318.132 ms) ====== [2025-06-19T04:47:11.883Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-06-19T04:47:11.883Z] GC before operation: completed in 35.954 ms, heap usage 39.740 MB -> 26.117 MB. [2025-06-19T04:47:12.174Z] ====== scala-kmeans (scala) [default], iteration 33 completed (309.033 ms) ====== [2025-06-19T04:47:12.174Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-06-19T04:47:12.174Z] GC before operation: completed in 35.399 ms, heap usage 39.741 MB -> 26.117 MB. [2025-06-19T04:47:12.470Z] ====== scala-kmeans (scala) [default], iteration 34 completed (313.496 ms) ====== [2025-06-19T04:47:12.471Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-06-19T04:47:12.471Z] GC before operation: completed in 33.104 ms, heap usage 39.741 MB -> 26.117 MB. [2025-06-19T04:47:12.762Z] ====== scala-kmeans (scala) [default], iteration 35 completed (308.499 ms) ====== [2025-06-19T04:47:12.762Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-06-19T04:47:13.054Z] GC before operation: completed in 33.665 ms, heap usage 39.741 MB -> 26.119 MB. [2025-06-19T04:47:13.346Z] ====== scala-kmeans (scala) [default], iteration 36 completed (314.871 ms) ====== [2025-06-19T04:47:13.346Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-06-19T04:47:13.346Z] GC before operation: completed in 33.038 ms, heap usage 39.743 MB -> 26.120 MB. [2025-06-19T04:47:13.638Z] ====== scala-kmeans (scala) [default], iteration 37 completed (311.548 ms) ====== [2025-06-19T04:47:13.638Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-06-19T04:47:13.638Z] GC before operation: completed in 31.485 ms, heap usage 39.743 MB -> 26.120 MB. [2025-06-19T04:47:13.929Z] ====== scala-kmeans (scala) [default], iteration 38 completed (315.425 ms) ====== [2025-06-19T04:47:13.929Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-06-19T04:47:13.929Z] GC before operation: completed in 32.026 ms, heap usage 39.743 MB -> 26.120 MB. [2025-06-19T04:47:14.220Z] ====== scala-kmeans (scala) [default], iteration 39 completed (315.226 ms) ====== [2025-06-19T04:47:14.220Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-06-19T04:47:14.220Z] GC before operation: completed in 41.283 ms, heap usage 39.743 MB -> 26.120 MB. [2025-06-19T04:47:14.512Z] ====== scala-kmeans (scala) [default], iteration 40 completed (316.492 ms) ====== [2025-06-19T04:47:14.512Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-06-19T04:47:14.802Z] GC before operation: completed in 32.436 ms, heap usage 39.743 MB -> 26.120 MB. [2025-06-19T04:47:15.093Z] ====== scala-kmeans (scala) [default], iteration 41 completed (312.189 ms) ====== [2025-06-19T04:47:15.093Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-06-19T04:47:15.093Z] GC before operation: completed in 31.509 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:15.384Z] ====== scala-kmeans (scala) [default], iteration 42 completed (316.018 ms) ====== [2025-06-19T04:47:15.384Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-06-19T04:47:15.384Z] GC before operation: completed in 32.371 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:15.675Z] ====== scala-kmeans (scala) [default], iteration 43 completed (308.308 ms) ====== [2025-06-19T04:47:15.675Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-06-19T04:47:15.675Z] GC before operation: completed in 31.364 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:15.965Z] ====== scala-kmeans (scala) [default], iteration 44 completed (319.561 ms) ====== [2025-06-19T04:47:15.965Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-06-19T04:47:15.965Z] GC before operation: completed in 35.305 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:16.256Z] ====== scala-kmeans (scala) [default], iteration 45 completed (310.803 ms) ====== [2025-06-19T04:47:16.256Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-06-19T04:47:16.256Z] GC before operation: completed in 40.057 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:16.887Z] ====== scala-kmeans (scala) [default], iteration 46 completed (319.133 ms) ====== [2025-06-19T04:47:16.887Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-06-19T04:47:16.887Z] GC before operation: completed in 32.244 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:17.179Z] ====== scala-kmeans (scala) [default], iteration 47 completed (311.513 ms) ====== [2025-06-19T04:47:17.179Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-06-19T04:47:17.179Z] GC before operation: completed in 31.364 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:17.470Z] ====== scala-kmeans (scala) [default], iteration 48 completed (332.383 ms) ====== [2025-06-19T04:47:17.470Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-06-19T04:47:17.470Z] GC before operation: completed in 32.126 ms, heap usage 39.744 MB -> 26.120 MB. [2025-06-19T04:47:17.781Z] ====== scala-kmeans (scala) [default], iteration 49 completed (308.306 ms) ====== [2025-06-19T04:47:18.071Z] [2025-06-19T04:47:17.797+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-06-19T04:47:18.071Z] WARNING: Error deleting scratch directory C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.perf_aarch64_windows\aqa-tests\TKG\output_17503082408005\renaissance-scala-kmeans_0\launcher-044658-13870151979950763195: launcher-044658-13870151979950763195\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-19T04:47:18.071Z] ----------------------------------- [2025-06-19T04:47:18.071Z] renaissance-scala-kmeans_0_PASSED [2025-06-19T04:47:18.071Z] ----------------------------------- [2025-06-19T04:47:18.071Z] [2025-06-19T04:47:18.071Z] TEST TEARDOWN: [2025-06-19T04:47:18.071Z] Nothing to be done for teardown. [2025-06-19T04:47:18.362Z] renaissance-scala-kmeans_0 Finish Time: Thu Jun 19 04:47:18 2025 Epoch Time (ms): 1750308438094