renaissance-als_0
[2026-01-18T20:34:22.110Z] Running test renaissance-als_0 ...
[2026-01-18T20:34:22.110Z] ===============================================
[2026-01-18T20:34:22.110Z] renaissance-als_0 Start Time: Sun Jan 18 20:34:21 2026 Epoch Time (ms): 1768768461338
[2026-01-18T20:34:22.110Z] variation: NoOptions
[2026-01-18T20:34:22.110Z] JVM_OPTIONS:
[2026-01-18T20:34:22.110Z] { \
[2026-01-18T20:34:22.110Z] echo ""; echo "TEST SETUP:"; \
[2026-01-18T20:34:22.110Z] echo "Nothing to be done for setup."; \
[2026-01-18T20:34:22.110Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17687682282681/renaissance-als_0"; \
[2026-01-18T20:34:22.110Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17687682282681/renaissance-als_0"; \
[2026-01-18T20:34:22.110Z] echo ""; echo "TESTING:"; \
[2026-01-18T20:34:22.110Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/jdkbinary/j2sdk-image/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 "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17687682282681/renaissance-als_0"/als.json" als; \
[2026-01-18T20:34:22.110Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17687682282681/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-01-18T20:34:22.110Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-01-18T20:34:22.110Z] echo "Nothing to be done for teardown."; \
[2026-01-18T20:34:22.110Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17687682282681/TestTargetResult";
[2026-01-18T20:34:22.110Z]
[2026-01-18T20:34:22.110Z] TEST SETUP:
[2026-01-18T20:34:22.110Z] Nothing to be done for setup.
[2026-01-18T20:34:22.110Z]
[2026-01-18T20:34:22.110Z] TESTING:
[2026-01-18T20:34:31.861Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-01-18T20:34:37.247Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-01-18T20:34:37.247Z] GC before operation: completed in 65.767 ms, heap usage 51.825 MB -> 35.122 MB.
[2026-01-18T20:35:10.400Z] ====== als (apache-spark) [default], iteration 0 completed (29629.827 ms) ======
[2026-01-18T20:35:10.400Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-01-18T20:35:10.400Z] GC before operation: completed in 121.926 ms, heap usage 778.288 MB -> 62.728 MB.
[2026-01-18T20:35:20.215Z] ====== als (apache-spark) [default], iteration 1 completed (11707.139 ms) ======
[2026-01-18T20:35:20.215Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-01-18T20:35:20.215Z] GC before operation: completed in 100.552 ms, heap usage 174.465 MB -> 62.838 MB.
[2026-01-18T20:35:30.196Z] ====== als (apache-spark) [default], iteration 2 completed (9531.877 ms) ======
[2026-01-18T20:35:30.196Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-01-18T20:35:30.197Z] GC before operation: completed in 101.148 ms, heap usage 155.875 MB -> 63.472 MB.
[2026-01-18T20:35:39.216Z] ====== als (apache-spark) [default], iteration 3 completed (9099.827 ms) ======
[2026-01-18T20:35:39.216Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-01-18T20:35:39.216Z] GC before operation: completed in 112.245 ms, heap usage 650.699 MB -> 64.653 MB.
[2026-01-18T20:35:49.063Z] ====== als (apache-spark) [default], iteration 4 completed (8989.528 ms) ======
[2026-01-18T20:35:49.063Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-01-18T20:35:49.063Z] GC before operation: completed in 102.349 ms, heap usage 401.812 MB -> 64.813 MB.
[2026-01-18T20:35:58.845Z] ====== als (apache-spark) [default], iteration 5 completed (8756.016 ms) ======
[2026-01-18T20:35:58.845Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-01-18T20:35:58.845Z] GC before operation: completed in 107.085 ms, heap usage 196.439 MB -> 65.108 MB.
[2026-01-18T20:36:07.050Z] ====== als (apache-spark) [default], iteration 6 completed (8696.191 ms) ======
[2026-01-18T20:36:07.050Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-01-18T20:36:07.050Z] GC before operation: completed in 111.020 ms, heap usage 554.743 MB -> 66.251 MB.
[2026-01-18T20:36:16.879Z] ====== als (apache-spark) [default], iteration 7 completed (8687.545 ms) ======
[2026-01-18T20:36:16.879Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-01-18T20:36:16.879Z] GC before operation: completed in 127.536 ms, heap usage 186.846 MB -> 66.261 MB.
[2026-01-18T20:36:26.682Z] ====== als (apache-spark) [default], iteration 8 completed (9229.096 ms) ======
[2026-01-18T20:36:26.682Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-01-18T20:36:26.682Z] GC before operation: completed in 120.892 ms, heap usage 798.572 MB -> 67.590 MB.
[2026-01-18T20:36:34.866Z] ====== als (apache-spark) [default], iteration 9 completed (8775.537 ms) ======
[2026-01-18T20:36:34.866Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-01-18T20:36:34.866Z] GC before operation: completed in 130.338 ms, heap usage 577.303 MB -> 67.654 MB.
[2026-01-18T20:36:45.376Z] ====== als (apache-spark) [default], iteration 10 completed (9022.757 ms) ======
[2026-01-18T20:36:45.376Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-01-18T20:36:45.376Z] GC before operation: completed in 118.632 ms, heap usage 720.657 MB -> 68.128 MB.
[2026-01-18T20:36:53.582Z] ====== als (apache-spark) [default], iteration 11 completed (8886.639 ms) ======
[2026-01-18T20:36:53.582Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-01-18T20:36:53.582Z] GC before operation: completed in 118.043 ms, heap usage 860.453 MB -> 68.452 MB.
[2026-01-18T20:37:03.413Z] ====== als (apache-spark) [default], iteration 12 completed (8931.884 ms) ======
[2026-01-18T20:37:03.413Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-01-18T20:37:03.413Z] GC before operation: completed in 119.884 ms, heap usage 397.935 MB -> 68.195 MB.
[2026-01-18T20:37:13.242Z] ====== als (apache-spark) [default], iteration 13 completed (8744.705 ms) ======
[2026-01-18T20:37:13.242Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-01-18T20:37:13.242Z] GC before operation: completed in 123.709 ms, heap usage 673.080 MB -> 68.878 MB.
[2026-01-18T20:37:21.504Z] ====== als (apache-spark) [default], iteration 14 completed (8943.955 ms) ======
[2026-01-18T20:37:21.504Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-01-18T20:37:21.504Z] GC before operation: completed in 132.315 ms, heap usage 1.070 GB -> 69.530 MB.
[2026-01-18T20:37:31.427Z] ====== als (apache-spark) [default], iteration 15 completed (8559.106 ms) ======
[2026-01-18T20:37:31.427Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-01-18T20:37:31.427Z] GC before operation: completed in 121.894 ms, heap usage 245.043 MB -> 68.841 MB.
[2026-01-18T20:37:43.677Z] ====== als (apache-spark) [default], iteration 16 completed (8410.134 ms) ======
[2026-01-18T20:37:43.677Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-01-18T20:37:43.677Z] GC before operation: completed in 119.677 ms, heap usage 159.958 MB -> 68.910 MB.
[2026-01-18T20:37:47.903Z] ====== als (apache-spark) [default], iteration 17 completed (8358.324 ms) ======
[2026-01-18T20:37:47.903Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-01-18T20:37:47.903Z] GC before operation: completed in 124.069 ms, heap usage 546.466 MB -> 69.731 MB.
[2026-01-18T20:37:57.687Z] ====== als (apache-spark) [default], iteration 18 completed (8483.792 ms) ======
[2026-01-18T20:37:57.688Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-01-18T20:37:57.688Z] GC before operation: completed in 129.743 ms, heap usage 155.844 MB -> 69.451 MB.
[2026-01-18T20:38:06.590Z] ====== als (apache-spark) [default], iteration 19 completed (8597.115 ms) ======
[2026-01-18T20:38:06.590Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-01-18T20:38:06.590Z] GC before operation: completed in 127.872 ms, heap usage 577.943 MB -> 70.222 MB.
[2026-01-18T20:38:16.373Z] ====== als (apache-spark) [default], iteration 20 completed (8984.615 ms) ======
[2026-01-18T20:38:16.373Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-01-18T20:38:16.373Z] GC before operation: completed in 138.455 ms, heap usage 496.103 MB -> 70.411 MB.
[2026-01-18T20:38:24.666Z] ====== als (apache-spark) [default], iteration 21 completed (8588.698 ms) ======
[2026-01-18T20:38:24.666Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-01-18T20:38:24.666Z] GC before operation: completed in 130.180 ms, heap usage 751.519 MB -> 70.963 MB.
[2026-01-18T20:38:32.981Z] ====== als (apache-spark) [default], iteration 22 completed (8554.510 ms) ======
[2026-01-18T20:38:32.981Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-01-18T20:38:33.942Z] GC before operation: completed in 124.393 ms, heap usage 406.813 MB -> 70.802 MB.
[2026-01-18T20:38:42.156Z] ====== als (apache-spark) [default], iteration 23 completed (8536.513 ms) ======
[2026-01-18T20:38:42.156Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-01-18T20:38:42.156Z] GC before operation: completed in 124.895 ms, heap usage 611.905 MB -> 71.226 MB.
[2026-01-18T20:38:52.099Z] ====== als (apache-spark) [default], iteration 24 completed (8520.033 ms) ======
[2026-01-18T20:38:52.099Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-01-18T20:38:52.099Z] GC before operation: completed in 123.365 ms, heap usage 248.745 MB -> 71.083 MB.
[2026-01-18T20:39:00.296Z] ====== als (apache-spark) [default], iteration 25 completed (8464.151 ms) ======
[2026-01-18T20:39:00.296Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-01-18T20:39:00.296Z] GC before operation: completed in 125.084 ms, heap usage 245.219 MB -> 71.458 MB.
[2026-01-18T20:39:08.467Z] ====== als (apache-spark) [default], iteration 26 completed (8394.071 ms) ======
[2026-01-18T20:39:08.467Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-01-18T20:39:09.427Z] GC before operation: completed in 134.344 ms, heap usage 231.002 MB -> 71.593 MB.
[2026-01-18T20:39:18.538Z] ====== als (apache-spark) [default], iteration 27 completed (8500.687 ms) ======
[2026-01-18T20:39:18.538Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-01-18T20:39:18.538Z] GC before operation: completed in 125.155 ms, heap usage 170.913 MB -> 71.382 MB.
[2026-01-18T20:39:26.736Z] ====== als (apache-spark) [default], iteration 28 completed (8614.550 ms) ======
[2026-01-18T20:39:26.736Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-01-18T20:39:26.736Z] GC before operation: completed in 127.998 ms, heap usage 820.904 MB -> 72.409 MB.
[2026-01-18T20:39:36.517Z] ====== als (apache-spark) [default], iteration 29 completed (8488.294 ms) ======
[2026-01-18T20:39:36.517Z] -----------------------------------
[2026-01-18T20:39:36.517Z] renaissance-als_0_PASSED
[2026-01-18T20:39:36.517Z] -----------------------------------
[2026-01-18T20:39:36.517Z]
[2026-01-18T20:39:36.517Z] TEST TEARDOWN:
[2026-01-18T20:39:36.517Z] Nothing to be done for teardown.
[2026-01-18T20:39:36.517Z] renaissance-als_0 Finish Time: Sun Jan 18 20:39:35 2026 Epoch Time (ms): 1768768775922