[2025-08-27T22:06:31.412Z] Running test renaissance-scala-kmeans_0 ... [2025-08-27T22:06:31.412Z] =============================================== [2025-08-27T22:06:31.706Z] renaissance-scala-kmeans_0 Start Time: Wed Aug 27 22:06:31 2025 Epoch Time (ms): 1756332391453 [2025-08-27T22:06:31.706Z] variation: NoOptions [2025-08-27T22:06:32.000Z] JVM_OPTIONS: [2025-08-27T22:06:32.000Z] { \ [2025-08-27T22:06:32.000Z] echo ""; echo "TEST SETUP:"; \ [2025-08-27T22:06:32.000Z] echo "Nothing to be done for setup."; \ [2025-08-27T22:06:32.001Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17563316525163\\renaissance-scala-kmeans_0"; \ [2025-08-27T22:06:32.001Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17563316525163\\renaissance-scala-kmeans_0"; \ [2025-08-27T22:06:32.001Z] echo ""; echo "TESTING:"; \ [2025-08-27T22:06:32.001Z] 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_17563316525163\\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-08-27T22:06:32.001Z] 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_17563316525163\\renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-27T22:06:32.001Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-27T22:06:32.001Z] echo "Nothing to be done for teardown."; \ [2025-08-27T22:06:32.001Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_17563316525163\\TestTargetResult"; [2025-08-27T22:06:32.001Z] [2025-08-27T22:06:32.001Z] TEST SETUP: [2025-08-27T22:06:32.001Z] Nothing to be done for setup. [2025-08-27T22:06:32.001Z] [2025-08-27T22:06:32.001Z] TESTING: [2025-08-27T22:06:42.413Z] 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_17563316525163\renaissance-scala-kmeans_0\scala-kmeans.json scala-kmeans [2025-08-27T22:06:42.765Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-08-27T22:06:42.765Z] GC before operation: completed in 35.865 ms, heap usage 28.552 MB -> 25.895 MB. [2025-08-27T22:06:43.407Z] ====== scala-kmeans (scala) [default], iteration 0 completed (518.783 ms) ====== [2025-08-27T22:06:43.407Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-08-27T22:06:43.407Z] GC before operation: completed in 32.302 ms, heap usage 56.662 MB -> 25.993 MB. [2025-08-27T22:06:43.701Z] ====== scala-kmeans (scala) [default], iteration 1 completed (310.973 ms) ====== [2025-08-27T22:06:43.701Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-08-27T22:06:43.701Z] GC before operation: completed in 32.468 ms, heap usage 35.440 MB -> 25.995 MB. [2025-08-27T22:06:43.998Z] ====== scala-kmeans (scala) [default], iteration 2 completed (310.255 ms) ====== [2025-08-27T22:06:43.998Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-08-27T22:06:43.998Z] GC before operation: completed in 31.491 ms, heap usage 46.754 MB -> 25.995 MB. [2025-08-27T22:06:44.292Z] ====== scala-kmeans (scala) [default], iteration 3 completed (304.544 ms) ====== [2025-08-27T22:06:44.292Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-08-27T22:06:44.292Z] GC before operation: completed in 31.252 ms, heap usage 42.227 MB -> 25.995 MB. [2025-08-27T22:06:44.933Z] ====== scala-kmeans (scala) [default], iteration 4 completed (323.795 ms) ====== [2025-08-27T22:06:44.933Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-08-27T22:06:44.933Z] GC before operation: completed in 31.748 ms, heap usage 94.270 MB -> 25.995 MB. [2025-08-27T22:06:45.227Z] ====== scala-kmeans (scala) [default], iteration 5 completed (397.064 ms) ====== [2025-08-27T22:06:45.227Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-08-27T22:06:45.227Z] GC before operation: completed in 30.861 ms, heap usage 42.047 MB -> 25.995 MB. [2025-08-27T22:06:45.522Z] ====== scala-kmeans (scala) [default], iteration 6 completed (303.959 ms) ====== [2025-08-27T22:06:45.522Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-08-27T22:06:45.522Z] GC before operation: completed in 31.157 ms, heap usage 42.243 MB -> 25.996 MB. [2025-08-27T22:06:45.817Z] ====== scala-kmeans (scala) [default], iteration 7 completed (301.321 ms) ====== [2025-08-27T22:06:45.817Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-08-27T22:06:45.817Z] GC before operation: completed in 34.344 ms, heap usage 42.031 MB -> 25.996 MB. [2025-08-27T22:06:46.111Z] ====== scala-kmeans (scala) [default], iteration 8 completed (313.534 ms) ====== [2025-08-27T22:06:46.111Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-08-27T22:06:46.111Z] GC before operation: completed in 33.478 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:46.406Z] ====== scala-kmeans (scala) [default], iteration 9 completed (298.574 ms) ====== [2025-08-27T22:06:46.406Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-08-27T22:06:46.704Z] GC before operation: completed in 32.243 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:46.999Z] ====== scala-kmeans (scala) [default], iteration 10 completed (305.070 ms) ====== [2025-08-27T22:06:46.999Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-08-27T22:06:46.999Z] GC before operation: completed in 32.667 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:47.293Z] ====== scala-kmeans (scala) [default], iteration 11 completed (302.856 ms) ====== [2025-08-27T22:06:47.293Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-08-27T22:06:47.293Z] GC before operation: completed in 32.310 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:47.617Z] ====== scala-kmeans (scala) [default], iteration 12 completed (305.267 ms) ====== [2025-08-27T22:06:47.617Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-08-27T22:06:47.617Z] GC before operation: completed in 33.622 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:47.911Z] ====== scala-kmeans (scala) [default], iteration 13 completed (297.251 ms) ====== [2025-08-27T22:06:47.911Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-08-27T22:06:47.911Z] GC before operation: completed in 31.734 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:48.207Z] ====== scala-kmeans (scala) [default], iteration 14 completed (329.614 ms) ====== [2025-08-27T22:06:48.207Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-08-27T22:06:48.207Z] GC before operation: completed in 33.167 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:48.503Z] ====== scala-kmeans (scala) [default], iteration 15 completed (299.751 ms) ====== [2025-08-27T22:06:48.503Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-08-27T22:06:48.503Z] GC before operation: completed in 30.978 ms, heap usage 42.210 MB -> 25.996 MB. [2025-08-27T22:06:48.797Z] ====== scala-kmeans (scala) [default], iteration 16 completed (304.217 ms) ====== [2025-08-27T22:06:48.797Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-08-27T22:06:48.797Z] GC before operation: completed in 31.937 ms, heap usage 42.210 MB -> 25.997 MB. [2025-08-27T22:06:49.094Z] ====== scala-kmeans (scala) [default], iteration 17 completed (299.933 ms) ====== [2025-08-27T22:06:49.094Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-08-27T22:06:49.390Z] GC before operation: completed in 32.104 ms, heap usage 42.032 MB -> 25.997 MB. [2025-08-27T22:06:49.693Z] ====== scala-kmeans (scala) [default], iteration 18 completed (306.844 ms) ====== [2025-08-27T22:06:49.694Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-08-27T22:06:49.694Z] GC before operation: completed in 33.497 ms, heap usage 42.211 MB -> 25.997 MB. [2025-08-27T22:06:49.998Z] ====== scala-kmeans (scala) [default], iteration 19 completed (300.436 ms) ====== [2025-08-27T22:06:49.998Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-08-27T22:06:49.998Z] GC before operation: completed in 32.405 ms, heap usage 42.211 MB -> 25.997 MB. [2025-08-27T22:06:50.292Z] ====== scala-kmeans (scala) [default], iteration 20 completed (304.134 ms) ====== [2025-08-27T22:06:50.292Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-08-27T22:06:50.292Z] GC before operation: completed in 35.950 ms, heap usage 42.211 MB -> 25.997 MB. [2025-08-27T22:06:50.587Z] ====== scala-kmeans (scala) [default], iteration 21 completed (300.128 ms) ====== [2025-08-27T22:06:50.587Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-08-27T22:06:50.587Z] GC before operation: completed in 31.183 ms, heap usage 42.212 MB -> 25.997 MB. [2025-08-27T22:06:50.881Z] ====== scala-kmeans (scala) [default], iteration 22 completed (304.131 ms) ====== [2025-08-27T22:06:50.881Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-08-27T22:06:50.881Z] GC before operation: completed in 36.235 ms, heap usage 42.211 MB -> 25.998 MB. [2025-08-27T22:06:51.176Z] ====== scala-kmeans (scala) [default], iteration 23 completed (311.433 ms) ====== [2025-08-27T22:06:51.176Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-08-27T22:06:51.176Z] GC before operation: completed in 50.067 ms, heap usage 42.212 MB -> 25.998 MB. [2025-08-27T22:06:51.830Z] ====== scala-kmeans (scala) [default], iteration 24 completed (305.160 ms) ====== [2025-08-27T22:06:51.830Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-08-27T22:06:51.830Z] GC before operation: completed in 33.083 ms, heap usage 42.212 MB -> 25.998 MB. [2025-08-27T22:06:51.830Z] ====== scala-kmeans (scala) [default], iteration 25 completed (298.789 ms) ====== [2025-08-27T22:06:51.830Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-08-27T22:06:52.127Z] GC before operation: completed in 31.825 ms, heap usage 42.212 MB -> 25.997 MB. [2025-08-27T22:06:52.426Z] ====== scala-kmeans (scala) [default], iteration 26 completed (305.660 ms) ====== [2025-08-27T22:06:52.426Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-08-27T22:06:52.426Z] GC before operation: completed in 32.935 ms, heap usage 42.211 MB -> 25.998 MB. [2025-08-27T22:06:52.725Z] ====== scala-kmeans (scala) [default], iteration 27 completed (301.649 ms) ====== [2025-08-27T22:06:52.725Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-08-27T22:06:52.725Z] GC before operation: completed in 31.292 ms, heap usage 42.212 MB -> 25.998 MB. [2025-08-27T22:06:53.021Z] ====== scala-kmeans (scala) [default], iteration 28 completed (314.235 ms) ====== [2025-08-27T22:06:53.021Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-08-27T22:06:53.021Z] GC before operation: completed in 37.704 ms, heap usage 42.212 MB -> 25.998 MB. [2025-08-27T22:06:53.318Z] ====== scala-kmeans (scala) [default], iteration 29 completed (310.006 ms) ====== [2025-08-27T22:06:53.319Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-08-27T22:06:53.319Z] GC before operation: completed in 35.683 ms, heap usage 42.212 MB -> 25.998 MB. [2025-08-27T22:06:53.614Z] ====== scala-kmeans (scala) [default], iteration 30 completed (305.623 ms) ====== [2025-08-27T22:06:53.614Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-08-27T22:06:53.614Z] GC before operation: completed in 33.070 ms, heap usage 42.212 MB -> 25.998 MB. [2025-08-27T22:06:53.911Z] ====== scala-kmeans (scala) [default], iteration 31 completed (308.624 ms) ====== [2025-08-27T22:06:53.911Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-08-27T22:06:53.911Z] GC before operation: completed in 32.571 ms, heap usage 42.212 MB -> 25.998 MB. [2025-08-27T22:06:54.550Z] ====== scala-kmeans (scala) [default], iteration 32 completed (331.300 ms) ====== [2025-08-27T22:06:54.550Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-08-27T22:06:54.550Z] GC before operation: completed in 33.783 ms, heap usage 42.212 MB -> 25.999 MB. [2025-08-27T22:06:54.848Z] ====== scala-kmeans (scala) [default], iteration 33 completed (297.292 ms) ====== [2025-08-27T22:06:54.848Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-08-27T22:06:54.848Z] GC before operation: completed in 31.123 ms, heap usage 42.213 MB -> 25.999 MB. [2025-08-27T22:06:55.143Z] ====== scala-kmeans (scala) [default], iteration 34 completed (308.940 ms) ====== [2025-08-27T22:06:55.143Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-08-27T22:06:55.143Z] GC before operation: completed in 31.935 ms, heap usage 42.213 MB -> 25.999 MB. [2025-08-27T22:06:55.440Z] ====== scala-kmeans (scala) [default], iteration 35 completed (296.256 ms) ====== [2025-08-27T22:06:55.440Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-08-27T22:06:55.440Z] GC before operation: completed in 32.997 ms, heap usage 42.213 MB -> 26.001 MB. [2025-08-27T22:06:55.734Z] ====== scala-kmeans (scala) [default], iteration 36 completed (302.760 ms) ====== [2025-08-27T22:06:55.734Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-08-27T22:06:55.734Z] GC before operation: completed in 32.722 ms, heap usage 42.215 MB -> 26.001 MB. [2025-08-27T22:06:56.032Z] ====== scala-kmeans (scala) [default], iteration 37 completed (318.675 ms) ====== [2025-08-27T22:06:56.032Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-08-27T22:06:56.032Z] GC before operation: completed in 31.227 ms, heap usage 42.215 MB -> 26.001 MB. [2025-08-27T22:06:56.328Z] ====== scala-kmeans (scala) [default], iteration 38 completed (304.065 ms) ====== [2025-08-27T22:06:56.328Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-08-27T22:06:56.328Z] GC before operation: completed in 31.657 ms, heap usage 42.215 MB -> 26.002 MB. [2025-08-27T22:06:56.623Z] ====== scala-kmeans (scala) [default], iteration 39 completed (297.525 ms) ====== [2025-08-27T22:06:56.623Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-08-27T22:06:56.918Z] GC before operation: completed in 32.473 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:57.218Z] ====== scala-kmeans (scala) [default], iteration 40 completed (306.100 ms) ====== [2025-08-27T22:06:57.218Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-08-27T22:06:57.218Z] GC before operation: completed in 33.647 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:57.513Z] ====== scala-kmeans (scala) [default], iteration 41 completed (300.787 ms) ====== [2025-08-27T22:06:57.513Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-08-27T22:06:57.513Z] GC before operation: completed in 32.795 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:57.809Z] ====== scala-kmeans (scala) [default], iteration 42 completed (310.089 ms) ====== [2025-08-27T22:06:57.809Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-08-27T22:06:57.809Z] GC before operation: completed in 32.463 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:58.105Z] ====== scala-kmeans (scala) [default], iteration 43 completed (302.915 ms) ====== [2025-08-27T22:06:58.105Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-08-27T22:06:58.105Z] GC before operation: completed in 31.486 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:58.400Z] ====== scala-kmeans (scala) [default], iteration 44 completed (303.825 ms) ====== [2025-08-27T22:06:58.400Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-08-27T22:06:58.400Z] GC before operation: completed in 34.230 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:58.697Z] ====== scala-kmeans (scala) [default], iteration 45 completed (296.282 ms) ====== [2025-08-27T22:06:58.697Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-08-27T22:06:58.697Z] GC before operation: completed in 31.247 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:58.995Z] ====== scala-kmeans (scala) [default], iteration 46 completed (312.668 ms) ====== [2025-08-27T22:06:58.995Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-08-27T22:06:58.995Z] GC before operation: completed in 33.443 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:59.289Z] ====== scala-kmeans (scala) [default], iteration 47 completed (300.265 ms) ====== [2025-08-27T22:06:59.289Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-08-27T22:06:59.586Z] GC before operation: completed in 31.473 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:06:59.884Z] ====== scala-kmeans (scala) [default], iteration 48 completed (300.865 ms) ====== [2025-08-27T22:06:59.884Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-08-27T22:06:59.884Z] GC before operation: completed in 33.139 ms, heap usage 42.216 MB -> 26.002 MB. [2025-08-27T22:07:00.181Z] ====== scala-kmeans (scala) [default], iteration 49 completed (297.654 ms) ====== [2025-08-27T22:07:00.181Z] [2025-08-27T22:07:00.138+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-08-27T22:07:00.181Z] WARNING: Error deleting scratch directory C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.perf_aarch64_windows\aqa-tests\TKG\output_17563316525163\renaissance-scala-kmeans_0\harness-220641-7942420488373641980: harness-220641-7942420488373641980\scala-stdlib\lib\scala-library-2.13.15.jar: The process cannot access the file because it is being used by another process [2025-08-27T22:07:00.477Z] ----------------------------------- [2025-08-27T22:07:00.477Z] renaissance-scala-kmeans_0_PASSED [2025-08-27T22:07:00.477Z] ----------------------------------- [2025-08-27T22:07:00.477Z] [2025-08-27T22:07:00.477Z] TEST TEARDOWN: [2025-08-27T22:07:00.477Z] Nothing to be done for teardown. [2025-08-27T22:07:00.477Z] renaissance-scala-kmeans_0 Finish Time: Wed Aug 27 22:07:00 2025 Epoch Time (ms): 1756332420420