[2026-03-04T21:58:08.440Z] Running test renaissance-als_0 ... [2026-03-04T21:58:08.440Z] =============================================== [2026-03-04T21:58:08.440Z] renaissance-als_0 Start Time: Wed Mar 4 16:58:07 2026 Epoch Time (ms): 1772661487906 [2026-03-04T21:58:08.440Z] variation: NoOptions [2026-03-04T21:58:08.440Z] JVM_OPTIONS: [2026-03-04T21:58:08.440Z] { \ [2026-03-04T21:58:08.440Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T21:58:08.440Z] echo "Nothing to be done for setup."; \ [2026-03-04T21:58:08.440Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17726614874414/renaissance-als_0"; \ [2026-03-04T21:58:08.440Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17726614874414/renaissance-als_0"; \ [2026-03-04T21:58:08.440Z] echo ""; echo "TESTING:"; \ [2026-03-04T21:58:08.440Z] "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//bin/java" --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.util=ALL-UNNAMED --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.base/java.lang.invoke=ALL-UNNAMED -jar "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17726614874414/renaissance-als_0"/als.json" als; \ [2026-03-04T21:58:08.440Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17726614874414/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T21:58:08.440Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T21:58:08.440Z] echo "Nothing to be done for teardown."; \ [2026-03-04T21:58:08.440Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17726614874414/TestTargetResult"; [2026-03-04T21:58:08.440Z] [2026-03-04T21:58:08.440Z] TEST SETUP: [2026-03-04T21:58:08.440Z] Nothing to be done for setup. [2026-03-04T21:58:08.440Z] [2026-03-04T21:58:08.440Z] TESTING: [2026-03-04T21:58:11.983Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-03-04T21:58:13.399Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-03-04T21:58:13.399Z] GC before operation: completed in 17.411 ms, heap usage 51.000 MB -> 35.321 MB. [2026-03-04T21:58:21.710Z] ====== als (apache-spark) [default], iteration 0 completed (7560.050 ms) ====== [2026-03-04T21:58:21.710Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-03-04T21:58:21.710Z] GC before operation: completed in 36.752 ms, heap usage 110.473 MB -> 61.955 MB. [2026-03-04T21:58:25.128Z] ====== als (apache-spark) [default], iteration 1 completed (3244.876 ms) ====== [2026-03-04T21:58:25.128Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-03-04T21:58:25.128Z] GC before operation: completed in 43.117 ms, heap usage 292.245 MB -> 63.186 MB. [2026-03-04T21:58:28.154Z] ====== als (apache-spark) [default], iteration 2 completed (3028.301 ms) ====== [2026-03-04T21:58:28.154Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-03-04T21:58:28.154Z] GC before operation: completed in 49.532 ms, heap usage 104.745 MB -> 63.657 MB. [2026-03-04T21:58:31.024Z] ====== als (apache-spark) [default], iteration 3 completed (2902.605 ms) ====== [2026-03-04T21:58:31.024Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-03-04T21:58:31.024Z] GC before operation: completed in 43.760 ms, heap usage 250.511 MB -> 64.333 MB. [2026-03-04T21:58:33.855Z] ====== als (apache-spark) [default], iteration 4 completed (3000.579 ms) ====== [2026-03-04T21:58:33.855Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-03-04T21:58:33.855Z] GC before operation: completed in 37.748 ms, heap usage 462.776 MB -> 65.252 MB. [2026-03-04T21:58:37.394Z] ====== als (apache-spark) [default], iteration 5 completed (2951.614 ms) ====== [2026-03-04T21:58:37.394Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-03-04T21:58:37.394Z] GC before operation: completed in 41.207 ms, heap usage 180.932 MB -> 65.341 MB. [2026-03-04T21:58:39.979Z] ====== als (apache-spark) [default], iteration 6 completed (2786.442 ms) ====== [2026-03-04T21:58:39.979Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-03-04T21:58:39.979Z] GC before operation: completed in 34.874 ms, heap usage 285.807 MB -> 65.999 MB. [2026-03-04T21:58:42.804Z] ====== als (apache-spark) [default], iteration 7 completed (2575.880 ms) ====== [2026-03-04T21:58:42.805Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-03-04T21:58:42.805Z] GC before operation: completed in 43.171 ms, heap usage 113.876 MB -> 66.488 MB. [2026-03-04T21:58:46.164Z] ====== als (apache-spark) [default], iteration 8 completed (2960.664 ms) ====== [2026-03-04T21:58:46.165Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-03-04T21:58:46.165Z] GC before operation: completed in 68.693 ms, heap usage 99.706 MB -> 66.572 MB. [2026-03-04T21:58:48.784Z] ====== als (apache-spark) [default], iteration 9 completed (2948.308 ms) ====== [2026-03-04T21:58:48.785Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-03-04T21:58:48.785Z] GC before operation: completed in 38.588 ms, heap usage 130.406 MB -> 67.261 MB. [2026-03-04T21:58:51.626Z] ====== als (apache-spark) [default], iteration 10 completed (2794.724 ms) ====== [2026-03-04T21:58:51.626Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-03-04T21:58:52.015Z] GC before operation: completed in 81.035 ms, heap usage 139.391 MB -> 67.585 MB. [2026-03-04T21:58:55.552Z] ====== als (apache-spark) [default], iteration 11 completed (3490.024 ms) ====== [2026-03-04T21:58:55.552Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-03-04T21:58:55.552Z] GC before operation: completed in 67.361 ms, heap usage 419.807 MB -> 68.089 MB. [2026-03-04T21:58:59.106Z] ====== als (apache-spark) [default], iteration 12 completed (2997.245 ms) ====== [2026-03-04T21:58:59.106Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-03-04T21:58:59.106Z] GC before operation: completed in 60.295 ms, heap usage 246.864 MB -> 68.302 MB. [2026-03-04T21:59:02.035Z] ====== als (apache-spark) [default], iteration 13 completed (3064.739 ms) ====== [2026-03-04T21:59:02.035Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-03-04T21:59:02.035Z] GC before operation: completed in 33.979 ms, heap usage 313.459 MB -> 68.569 MB. [2026-03-04T21:59:05.434Z] ====== als (apache-spark) [default], iteration 14 completed (3063.853 ms) ====== [2026-03-04T21:59:05.434Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-03-04T21:59:05.434Z] GC before operation: completed in 33.362 ms, heap usage 282.258 MB -> 68.625 MB. [2026-03-04T21:59:08.225Z] ====== als (apache-spark) [default], iteration 15 completed (2797.663 ms) ====== [2026-03-04T21:59:08.225Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-03-04T21:59:08.225Z] GC before operation: completed in 39.571 ms, heap usage 240.688 MB -> 68.876 MB. [2026-03-04T21:59:11.123Z] ====== als (apache-spark) [default], iteration 16 completed (2898.799 ms) ====== [2026-03-04T21:59:11.123Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-03-04T21:59:11.123Z] GC before operation: completed in 33.287 ms, heap usage 163.852 MB -> 69.128 MB. [2026-03-04T21:59:13.758Z] ====== als (apache-spark) [default], iteration 17 completed (3009.453 ms) ====== [2026-03-04T21:59:13.758Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-03-04T21:59:14.153Z] GC before operation: completed in 35.299 ms, heap usage 461.916 MB -> 69.770 MB. [2026-03-04T21:59:16.833Z] ====== als (apache-spark) [default], iteration 18 completed (2849.964 ms) ====== [2026-03-04T21:59:16.833Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-03-04T21:59:16.833Z] GC before operation: completed in 43.434 ms, heap usage 455.826 MB -> 70.086 MB. [2026-03-04T21:59:20.205Z] ====== als (apache-spark) [default], iteration 19 completed (2846.961 ms) ====== [2026-03-04T21:59:20.205Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-03-04T21:59:20.205Z] GC before operation: completed in 35.010 ms, heap usage 498.952 MB -> 70.322 MB. [2026-03-04T21:59:22.883Z] ====== als (apache-spark) [default], iteration 20 completed (2903.312 ms) ====== [2026-03-04T21:59:22.884Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-03-04T21:59:22.884Z] GC before operation: completed in 35.974 ms, heap usage 449.310 MB -> 70.618 MB. [2026-03-04T21:59:25.641Z] ====== als (apache-spark) [default], iteration 21 completed (2505.836 ms) ====== [2026-03-04T21:59:25.641Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-03-04T21:59:25.641Z] GC before operation: completed in 38.981 ms, heap usage 171.483 MB -> 70.427 MB. [2026-03-04T21:59:28.298Z] ====== als (apache-spark) [default], iteration 22 completed (2509.681 ms) ====== [2026-03-04T21:59:28.298Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-03-04T21:59:28.298Z] GC before operation: completed in 41.606 ms, heap usage 362.430 MB -> 70.959 MB. [2026-03-04T21:59:31.066Z] ====== als (apache-spark) [default], iteration 23 completed (2474.883 ms) ====== [2026-03-04T21:59:31.066Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-03-04T21:59:31.066Z] GC before operation: completed in 36.747 ms, heap usage 533.015 MB -> 71.585 MB. [2026-03-04T21:59:33.668Z] ====== als (apache-spark) [default], iteration 24 completed (2525.112 ms) ====== [2026-03-04T21:59:33.669Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-03-04T21:59:33.669Z] GC before operation: completed in 35.992 ms, heap usage 464.241 MB -> 71.627 MB. [2026-03-04T21:59:36.367Z] ====== als (apache-spark) [default], iteration 25 completed (2515.163 ms) ====== [2026-03-04T21:59:36.367Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-03-04T21:59:36.367Z] GC before operation: completed in 36.266 ms, heap usage 439.979 MB -> 71.841 MB. [2026-03-04T21:59:38.661Z] ====== als (apache-spark) [default], iteration 26 completed (2445.025 ms) ====== [2026-03-04T21:59:38.661Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-03-04T21:59:38.661Z] GC before operation: completed in 39.471 ms, heap usage 163.617 MB -> 71.761 MB. [2026-03-04T21:59:40.762Z] ====== als (apache-spark) [default], iteration 27 completed (2404.978 ms) ====== [2026-03-04T21:59:40.762Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-03-04T21:59:41.165Z] GC before operation: completed in 35.106 ms, heap usage 495.873 MB -> 72.006 MB. [2026-03-04T21:59:44.346Z] ====== als (apache-spark) [default], iteration 28 completed (2661.704 ms) ====== [2026-03-04T21:59:44.346Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-03-04T21:59:44.346Z] GC before operation: completed in 35.376 ms, heap usage 513.358 MB -> 72.235 MB. [2026-03-04T21:59:46.237Z] ====== als (apache-spark) [default], iteration 29 completed (2361.095 ms) ====== [2026-03-04T21:59:46.237Z] ----------------------------------- [2026-03-04T21:59:46.237Z] renaissance-als_0_PASSED [2026-03-04T21:59:46.237Z] ----------------------------------- [2026-03-04T21:59:46.237Z] [2026-03-04T21:59:46.237Z] TEST TEARDOWN: [2026-03-04T21:59:46.237Z] Nothing to be done for teardown. [2026-03-04T21:59:46.237Z] renaissance-als_0 Finish Time: Wed Mar 4 16:59:46 2026 Epoch Time (ms): 1772661586049