[2025-02-08T05:18:02.345Z] Running test renaissance-scala-kmeans_0 ... [2025-02-08T05:18:02.643Z] =============================================== [2025-02-08T05:18:02.643Z] renaissance-scala-kmeans_0 Start Time: Sat Feb 8 05:18:02 2025 Epoch Time (ms): 1738991882519 [2025-02-08T05:18:02.937Z] variation: NoOptions [2025-02-08T05:18:02.937Z] JVM_OPTIONS: [2025-02-08T05:18:02.937Z] { \ [2025-02-08T05:18:02.937Z] echo ""; echo "TEST SETUP:"; \ [2025-02-08T05:18:02.937Z] echo "Nothing to be done for setup."; \ [2025-02-08T05:18:02.937Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_1738991713902\\renaissance-scala-kmeans_0"; \ [2025-02-08T05:18:02.937Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_1738991713902\\renaissance-scala-kmeans_0"; \ [2025-02-08T05:18:02.937Z] echo ""; echo "TESTING:"; \ [2025-02-08T05:18:02.938Z] 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_1738991713902\\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-02-08T05:18:02.938Z] 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_1738991713902\\renaissance-scala-kmeans_0"; else echo "-----------------------------------"; echo "renaissance-scala-kmeans_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-08T05:18:02.938Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-08T05:18:02.938Z] echo "Nothing to be done for teardown."; \ [2025-02-08T05:18:02.938Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.perf_aarch64_windows/aqa-tests/\\TKG\\output_1738991713902\\TestTargetResult"; [2025-02-08T05:18:03.232Z] [2025-02-08T05:18:03.232Z] TEST SETUP: [2025-02-08T05:18:03.232Z] Nothing to be done for setup. [2025-02-08T05:18:03.232Z] [2025-02-08T05:18:03.232Z] TESTING: [2025-02-08T05:18:11.762Z] 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_1738991713902\renaissance-scala-kmeans_0\scala-kmeans.json scala-kmeans [2025-02-08T05:18:13.309Z] ====== scala-kmeans (scala) [default], iteration 0 started ====== [2025-02-08T05:18:13.309Z] GC before operation: completed in 72.376 ms, heap usage 42.169 MB -> 25.723 MB. [2025-02-08T05:18:13.607Z] ====== scala-kmeans (scala) [default], iteration 0 completed (412.901 ms) ====== [2025-02-08T05:18:13.607Z] ====== scala-kmeans (scala) [default], iteration 1 started ====== [2025-02-08T05:18:13.607Z] GC before operation: completed in 32.529 ms, heap usage 53.723 MB -> 25.789 MB. [2025-02-08T05:18:13.904Z] ====== scala-kmeans (scala) [default], iteration 1 completed (218.483 ms) ====== [2025-02-08T05:18:13.904Z] ====== scala-kmeans (scala) [default], iteration 2 started ====== [2025-02-08T05:18:13.904Z] GC before operation: completed in 30.221 ms, heap usage 55.789 MB -> 25.788 MB. [2025-02-08T05:18:13.904Z] ====== scala-kmeans (scala) [default], iteration 2 completed (214.624 ms) ====== [2025-02-08T05:18:13.904Z] ====== scala-kmeans (scala) [default], iteration 3 started ====== [2025-02-08T05:18:14.239Z] GC before operation: completed in 29.782 ms, heap usage 55.848 MB -> 25.788 MB. [2025-02-08T05:18:14.239Z] ====== scala-kmeans (scala) [default], iteration 3 completed (214.784 ms) ====== [2025-02-08T05:18:14.239Z] ====== scala-kmeans (scala) [default], iteration 4 started ====== [2025-02-08T05:18:14.239Z] GC before operation: completed in 29.608 ms, heap usage 55.788 MB -> 25.788 MB. [2025-02-08T05:18:14.535Z] ====== scala-kmeans (scala) [default], iteration 4 completed (233.851 ms) ====== [2025-02-08T05:18:14.535Z] ====== scala-kmeans (scala) [default], iteration 5 started ====== [2025-02-08T05:18:14.535Z] GC before operation: completed in 30.195 ms, heap usage 55.788 MB -> 25.788 MB. [2025-02-08T05:18:14.833Z] ====== scala-kmeans (scala) [default], iteration 5 completed (238.359 ms) ====== [2025-02-08T05:18:14.833Z] ====== scala-kmeans (scala) [default], iteration 6 started ====== [2025-02-08T05:18:14.833Z] GC before operation: completed in 31.025 ms, heap usage 55.788 MB -> 25.788 MB. [2025-02-08T05:18:15.134Z] ====== scala-kmeans (scala) [default], iteration 6 completed (220.354 ms) ====== [2025-02-08T05:18:15.134Z] ====== scala-kmeans (scala) [default], iteration 7 started ====== [2025-02-08T05:18:15.134Z] GC before operation: completed in 32.369 ms, heap usage 55.788 MB -> 25.788 MB. [2025-02-08T05:18:15.432Z] ====== scala-kmeans (scala) [default], iteration 7 completed (255.588 ms) ====== [2025-02-08T05:18:15.432Z] ====== scala-kmeans (scala) [default], iteration 8 started ====== [2025-02-08T05:18:15.432Z] GC before operation: completed in 30.898 ms, heap usage 55.788 MB -> 25.789 MB. [2025-02-08T05:18:15.729Z] ====== scala-kmeans (scala) [default], iteration 8 completed (216.023 ms) ====== [2025-02-08T05:18:15.729Z] ====== scala-kmeans (scala) [default], iteration 9 started ====== [2025-02-08T05:18:15.729Z] GC before operation: completed in 30.210 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:15.729Z] ====== scala-kmeans (scala) [default], iteration 9 completed (213.209 ms) ====== [2025-02-08T05:18:15.729Z] ====== scala-kmeans (scala) [default], iteration 10 started ====== [2025-02-08T05:18:16.027Z] GC before operation: completed in 29.658 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:16.027Z] ====== scala-kmeans (scala) [default], iteration 10 completed (214.186 ms) ====== [2025-02-08T05:18:16.027Z] ====== scala-kmeans (scala) [default], iteration 11 started ====== [2025-02-08T05:18:16.027Z] GC before operation: completed in 29.516 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:16.323Z] ====== scala-kmeans (scala) [default], iteration 11 completed (210.127 ms) ====== [2025-02-08T05:18:16.323Z] ====== scala-kmeans (scala) [default], iteration 12 started ====== [2025-02-08T05:18:16.323Z] GC before operation: completed in 29.780 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:16.619Z] ====== scala-kmeans (scala) [default], iteration 12 completed (214.556 ms) ====== [2025-02-08T05:18:16.619Z] ====== scala-kmeans (scala) [default], iteration 13 started ====== [2025-02-08T05:18:16.619Z] GC before operation: completed in 31.073 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:16.915Z] ====== scala-kmeans (scala) [default], iteration 13 completed (218.714 ms) ====== [2025-02-08T05:18:16.915Z] ====== scala-kmeans (scala) [default], iteration 14 started ====== [2025-02-08T05:18:16.915Z] GC before operation: completed in 30.351 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:17.211Z] ====== scala-kmeans (scala) [default], iteration 14 completed (213.414 ms) ====== [2025-02-08T05:18:17.211Z] ====== scala-kmeans (scala) [default], iteration 15 started ====== [2025-02-08T05:18:17.211Z] GC before operation: completed in 29.988 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:17.211Z] ====== scala-kmeans (scala) [default], iteration 15 completed (213.415 ms) ====== [2025-02-08T05:18:17.211Z] ====== scala-kmeans (scala) [default], iteration 16 started ====== [2025-02-08T05:18:17.211Z] GC before operation: completed in 29.809 ms, heap usage 55.789 MB -> 25.789 MB. [2025-02-08T05:18:17.509Z] ====== scala-kmeans (scala) [default], iteration 16 completed (213.524 ms) ====== [2025-02-08T05:18:17.509Z] ====== scala-kmeans (scala) [default], iteration 17 started ====== [2025-02-08T05:18:17.509Z] GC before operation: completed in 29.802 ms, heap usage 55.789 MB -> 25.791 MB. [2025-02-08T05:18:17.806Z] ====== scala-kmeans (scala) [default], iteration 17 completed (215.015 ms) ====== [2025-02-08T05:18:17.806Z] ====== scala-kmeans (scala) [default], iteration 18 started ====== [2025-02-08T05:18:17.806Z] GC before operation: completed in 29.962 ms, heap usage 55.791 MB -> 25.791 MB. [2025-02-08T05:18:18.102Z] ====== scala-kmeans (scala) [default], iteration 18 completed (211.291 ms) ====== [2025-02-08T05:18:18.102Z] ====== scala-kmeans (scala) [default], iteration 19 started ====== [2025-02-08T05:18:18.102Z] GC before operation: completed in 30.078 ms, heap usage 55.791 MB -> 25.791 MB. [2025-02-08T05:18:18.400Z] ====== scala-kmeans (scala) [default], iteration 19 completed (247.759 ms) ====== [2025-02-08T05:18:18.400Z] ====== scala-kmeans (scala) [default], iteration 20 started ====== [2025-02-08T05:18:18.400Z] GC before operation: completed in 31.722 ms, heap usage 55.791 MB -> 25.791 MB. [2025-02-08T05:18:18.697Z] ====== scala-kmeans (scala) [default], iteration 20 completed (222.238 ms) ====== [2025-02-08T05:18:18.697Z] ====== scala-kmeans (scala) [default], iteration 21 started ====== [2025-02-08T05:18:18.697Z] GC before operation: completed in 31.221 ms, heap usage 55.791 MB -> 25.792 MB. [2025-02-08T05:18:18.994Z] ====== scala-kmeans (scala) [default], iteration 21 completed (220.039 ms) ====== [2025-02-08T05:18:18.994Z] ====== scala-kmeans (scala) [default], iteration 22 started ====== [2025-02-08T05:18:18.994Z] GC before operation: completed in 30.998 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:18.994Z] ====== scala-kmeans (scala) [default], iteration 22 completed (215.222 ms) ====== [2025-02-08T05:18:18.994Z] ====== scala-kmeans (scala) [default], iteration 23 started ====== [2025-02-08T05:18:18.994Z] GC before operation: completed in 30.029 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:19.291Z] ====== scala-kmeans (scala) [default], iteration 23 completed (212.414 ms) ====== [2025-02-08T05:18:19.291Z] ====== scala-kmeans (scala) [default], iteration 24 started ====== [2025-02-08T05:18:19.291Z] GC before operation: completed in 29.651 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:19.588Z] ====== scala-kmeans (scala) [default], iteration 24 completed (215.571 ms) ====== [2025-02-08T05:18:19.588Z] ====== scala-kmeans (scala) [default], iteration 25 started ====== [2025-02-08T05:18:19.588Z] GC before operation: completed in 29.927 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:19.885Z] ====== scala-kmeans (scala) [default], iteration 25 completed (211.560 ms) ====== [2025-02-08T05:18:19.885Z] ====== scala-kmeans (scala) [default], iteration 26 started ====== [2025-02-08T05:18:19.885Z] GC before operation: completed in 30.203 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:20.182Z] ====== scala-kmeans (scala) [default], iteration 26 completed (215.323 ms) ====== [2025-02-08T05:18:20.182Z] ====== scala-kmeans (scala) [default], iteration 27 started ====== [2025-02-08T05:18:20.182Z] GC before operation: completed in 30.127 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:20.182Z] ====== scala-kmeans (scala) [default], iteration 27 completed (212.103 ms) ====== [2025-02-08T05:18:20.182Z] ====== scala-kmeans (scala) [default], iteration 28 started ====== [2025-02-08T05:18:20.479Z] GC before operation: completed in 30.078 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:20.479Z] ====== scala-kmeans (scala) [default], iteration 28 completed (216.948 ms) ====== [2025-02-08T05:18:20.479Z] ====== scala-kmeans (scala) [default], iteration 29 started ====== [2025-02-08T05:18:20.479Z] GC before operation: completed in 29.893 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:20.775Z] ====== scala-kmeans (scala) [default], iteration 29 completed (213.678 ms) ====== [2025-02-08T05:18:20.775Z] ====== scala-kmeans (scala) [default], iteration 30 started ====== [2025-02-08T05:18:20.775Z] GC before operation: completed in 33.014 ms, heap usage 55.792 MB -> 25.792 MB. [2025-02-08T05:18:21.072Z] ====== scala-kmeans (scala) [default], iteration 30 completed (213.394 ms) ====== [2025-02-08T05:18:21.072Z] ====== scala-kmeans (scala) [default], iteration 31 started ====== [2025-02-08T05:18:21.072Z] GC before operation: completed in 30.335 ms, heap usage 55.792 MB -> 25.793 MB. [2025-02-08T05:18:21.370Z] ====== scala-kmeans (scala) [default], iteration 31 completed (212.831 ms) ====== [2025-02-08T05:18:21.370Z] ====== scala-kmeans (scala) [default], iteration 32 started ====== [2025-02-08T05:18:21.370Z] GC before operation: completed in 30.108 ms, heap usage 55.793 MB -> 25.793 MB. [2025-02-08T05:18:21.667Z] ====== scala-kmeans (scala) [default], iteration 32 completed (214.779 ms) ====== [2025-02-08T05:18:21.667Z] ====== scala-kmeans (scala) [default], iteration 33 started ====== [2025-02-08T05:18:21.667Z] GC before operation: completed in 29.499 ms, heap usage 55.793 MB -> 25.793 MB. [2025-02-08T05:18:21.667Z] ====== scala-kmeans (scala) [default], iteration 33 completed (212.776 ms) ====== [2025-02-08T05:18:21.667Z] ====== scala-kmeans (scala) [default], iteration 34 started ====== [2025-02-08T05:18:21.963Z] GC before operation: completed in 30.152 ms, heap usage 55.793 MB -> 25.793 MB. [2025-02-08T05:18:21.963Z] ====== scala-kmeans (scala) [default], iteration 34 completed (222.369 ms) ====== [2025-02-08T05:18:21.963Z] ====== scala-kmeans (scala) [default], iteration 35 started ====== [2025-02-08T05:18:21.963Z] GC before operation: completed in 30.336 ms, heap usage 55.793 MB -> 25.793 MB. [2025-02-08T05:18:22.259Z] ====== scala-kmeans (scala) [default], iteration 35 completed (223.467 ms) ====== [2025-02-08T05:18:22.259Z] ====== scala-kmeans (scala) [default], iteration 36 started ====== [2025-02-08T05:18:22.259Z] GC before operation: completed in 31.029 ms, heap usage 55.793 MB -> 25.793 MB. [2025-02-08T05:18:22.556Z] ====== scala-kmeans (scala) [default], iteration 36 completed (223.821 ms) ====== [2025-02-08T05:18:22.556Z] ====== scala-kmeans (scala) [default], iteration 37 started ====== [2025-02-08T05:18:22.556Z] GC before operation: completed in 30.758 ms, heap usage 55.793 MB -> 25.795 MB. [2025-02-08T05:18:22.853Z] ====== scala-kmeans (scala) [default], iteration 37 completed (215.560 ms) ====== [2025-02-08T05:18:22.853Z] ====== scala-kmeans (scala) [default], iteration 38 started ====== [2025-02-08T05:18:22.854Z] GC before operation: completed in 37.741 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:23.149Z] ====== scala-kmeans (scala) [default], iteration 38 completed (213.763 ms) ====== [2025-02-08T05:18:23.149Z] ====== scala-kmeans (scala) [default], iteration 39 started ====== [2025-02-08T05:18:23.149Z] GC before operation: completed in 30.568 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:23.445Z] ====== scala-kmeans (scala) [default], iteration 39 completed (213.032 ms) ====== [2025-02-08T05:18:23.445Z] ====== scala-kmeans (scala) [default], iteration 40 started ====== [2025-02-08T05:18:23.445Z] GC before operation: completed in 31.176 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:23.445Z] ====== scala-kmeans (scala) [default], iteration 40 completed (212.180 ms) ====== [2025-02-08T05:18:23.445Z] ====== scala-kmeans (scala) [default], iteration 41 started ====== [2025-02-08T05:18:23.445Z] GC before operation: completed in 33.330 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:23.758Z] ====== scala-kmeans (scala) [default], iteration 41 completed (212.669 ms) ====== [2025-02-08T05:18:23.758Z] ====== scala-kmeans (scala) [default], iteration 42 started ====== [2025-02-08T05:18:23.758Z] GC before operation: completed in 33.385 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:24.055Z] ====== scala-kmeans (scala) [default], iteration 42 completed (211.020 ms) ====== [2025-02-08T05:18:24.055Z] ====== scala-kmeans (scala) [default], iteration 43 started ====== [2025-02-08T05:18:24.055Z] GC before operation: completed in 33.573 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:24.351Z] ====== scala-kmeans (scala) [default], iteration 43 completed (212.988 ms) ====== [2025-02-08T05:18:24.351Z] ====== scala-kmeans (scala) [default], iteration 44 started ====== [2025-02-08T05:18:24.351Z] GC before operation: completed in 33.776 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:24.647Z] ====== scala-kmeans (scala) [default], iteration 44 completed (248.758 ms) ====== [2025-02-08T05:18:24.647Z] ====== scala-kmeans (scala) [default], iteration 45 started ====== [2025-02-08T05:18:24.647Z] GC before operation: completed in 33.771 ms, heap usage 55.795 MB -> 25.795 MB. [2025-02-08T05:18:24.950Z] ====== scala-kmeans (scala) [default], iteration 45 completed (215.012 ms) ====== [2025-02-08T05:18:24.950Z] ====== scala-kmeans (scala) [default], iteration 46 started ====== [2025-02-08T05:18:24.950Z] GC before operation: completed in 33.998 ms, heap usage 55.795 MB -> 25.796 MB. [2025-02-08T05:18:24.950Z] ====== scala-kmeans (scala) [default], iteration 46 completed (212.393 ms) ====== [2025-02-08T05:18:24.950Z] ====== scala-kmeans (scala) [default], iteration 47 started ====== [2025-02-08T05:18:25.247Z] GC before operation: completed in 30.350 ms, heap usage 55.796 MB -> 25.796 MB. [2025-02-08T05:18:25.247Z] ====== scala-kmeans (scala) [default], iteration 47 completed (210.950 ms) ====== [2025-02-08T05:18:25.247Z] ====== scala-kmeans (scala) [default], iteration 48 started ====== [2025-02-08T05:18:25.247Z] GC before operation: completed in 33.560 ms, heap usage 55.796 MB -> 25.796 MB. [2025-02-08T05:18:25.544Z] ====== scala-kmeans (scala) [default], iteration 48 completed (245.002 ms) ====== [2025-02-08T05:18:25.544Z] ====== scala-kmeans (scala) [default], iteration 49 started ====== [2025-02-08T05:18:25.544Z] GC before operation: completed in 31.336 ms, heap usage 55.796 MB -> 25.796 MB. [2025-02-08T05:18:25.841Z] ====== scala-kmeans (scala) [default], iteration 49 completed (217.426 ms) ====== [2025-02-08T05:18:26.137Z] [2025-02-08T05:18:25.872+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-02-08T05:18:26.137Z] WARNING: Error deleting scratch directory C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.perf_aarch64_windows\aqa-tests\TKG\output_1738991713902\renaissance-scala-kmeans_0\launcher-051811-229430305070740344: launcher-051811-229430305070740344\renaissance-harness_2.13\lib\renaissance-harness_2.13-0.14.0.jar: The process cannot access the file because it is being used by another process [2025-02-08T05:18:26.137Z] ----------------------------------- [2025-02-08T05:18:26.137Z] renaissance-scala-kmeans_0_PASSED [2025-02-08T05:18:26.137Z] ----------------------------------- [2025-02-08T05:18:26.137Z] [2025-02-08T05:18:26.137Z] TEST TEARDOWN: [2025-02-08T05:18:26.137Z] Nothing to be done for teardown. [2025-02-08T05:18:26.433Z] renaissance-scala-kmeans_0 Finish Time: Sat Feb 8 05:18:26 2025 Epoch Time (ms): 1738991906122