[2026-01-14T02:13:36.423Z] Running test renaissance-als_0 ... [2026-01-14T02:13:36.423Z] =============================================== [2026-01-14T02:13:36.423Z] renaissance-als_0 Start Time: Wed Jan 14 02:13:36 2026 Epoch Time (ms): 1768356816142 [2026-01-14T02:13:36.423Z] variation: NoOptions [2026-01-14T02:13:36.423Z] JVM_OPTIONS: [2026-01-14T02:13:36.423Z] { \ [2026-01-14T02:13:36.423Z] echo ""; echo "TEST SETUP:"; \ [2026-01-14T02:13:36.423Z] echo "Nothing to be done for setup."; \ [2026-01-14T02:13:36.423Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17683566153720/renaissance-als_0"; \ [2026-01-14T02:13:36.423Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17683566153720/renaissance-als_0"; \ [2026-01-14T02:13:36.423Z] echo ""; echo "TESTING:"; \ [2026-01-14T02:13:36.423Z] "/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_17683566153720/renaissance-als_0"/als.json" als; \ [2026-01-14T02:13:36.423Z] 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_17683566153720/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-14T02:13:36.423Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-14T02:13:36.423Z] echo "Nothing to be done for teardown."; \ [2026-01-14T02:13:36.423Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17683566153720/TestTargetResult"; [2026-01-14T02:13:36.423Z] [2026-01-14T02:13:36.423Z] TEST SETUP: [2026-01-14T02:13:36.423Z] Nothing to be done for setup. [2026-01-14T02:13:36.423Z] [2026-01-14T02:13:36.423Z] TESTING: [2026-01-14T02:13:44.030Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-14T02:13:49.072Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-01-14T02:13:49.072Z] GC before operation: completed in 48.842 ms, heap usage 59.934 MB -> 34.917 MB. [2026-01-14T02:14:17.643Z] ====== als (apache-spark) [default], iteration 0 completed (23476.642 ms) ====== [2026-01-14T02:14:17.643Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-01-14T02:14:17.643Z] GC before operation: completed in 84.740 ms, heap usage 263.469 MB -> 61.927 MB. [2026-01-14T02:14:24.230Z] ====== als (apache-spark) [default], iteration 1 completed (10071.969 ms) ====== [2026-01-14T02:14:24.230Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-01-14T02:14:24.230Z] GC before operation: completed in 86.094 ms, heap usage 459.510 MB -> 63.258 MB. [2026-01-14T02:14:33.689Z] ====== als (apache-spark) [default], iteration 2 completed (8885.655 ms) ====== [2026-01-14T02:14:33.689Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-01-14T02:14:33.689Z] GC before operation: completed in 84.922 ms, heap usage 257.649 MB -> 63.420 MB. [2026-01-14T02:14:43.339Z] ====== als (apache-spark) [default], iteration 3 completed (9026.014 ms) ====== [2026-01-14T02:14:43.339Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-01-14T02:14:43.339Z] GC before operation: completed in 85.938 ms, heap usage 377.424 MB -> 64.264 MB. [2026-01-14T02:14:53.059Z] ====== als (apache-spark) [default], iteration 4 completed (8745.676 ms) ====== [2026-01-14T02:14:53.059Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-01-14T02:14:53.059Z] GC before operation: completed in 103.901 ms, heap usage 472.548 MB -> 65.040 MB. [2026-01-14T02:15:00.885Z] ====== als (apache-spark) [default], iteration 5 completed (8576.366 ms) ====== [2026-01-14T02:15:00.885Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-01-14T02:15:01.268Z] GC before operation: completed in 99.226 ms, heap usage 897.051 MB -> 66.118 MB. [2026-01-14T02:15:10.678Z] ====== als (apache-spark) [default], iteration 6 completed (8943.169 ms) ====== [2026-01-14T02:15:10.678Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-01-14T02:15:10.678Z] GC before operation: completed in 94.572 ms, heap usage 157.164 MB -> 65.527 MB. [2026-01-14T02:15:20.159Z] ====== als (apache-spark) [default], iteration 7 completed (8553.832 ms) ====== [2026-01-14T02:15:20.159Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-01-14T02:15:20.159Z] GC before operation: completed in 91.715 ms, heap usage 127.844 MB -> 66.142 MB. [2026-01-14T02:15:29.519Z] ====== als (apache-spark) [default], iteration 8 completed (8680.345 ms) ====== [2026-01-14T02:15:29.519Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-01-14T02:15:29.519Z] GC before operation: completed in 101.635 ms, heap usage 251.651 MB -> 66.891 MB. [2026-01-14T02:15:38.966Z] ====== als (apache-spark) [default], iteration 9 completed (8712.450 ms) ====== [2026-01-14T02:15:38.966Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-01-14T02:15:38.966Z] GC before operation: completed in 101.906 ms, heap usage 277.029 MB -> 66.997 MB. [2026-01-14T02:15:46.687Z] ====== als (apache-spark) [default], iteration 10 completed (8589.366 ms) ====== [2026-01-14T02:15:46.687Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-01-14T02:15:46.687Z] GC before operation: completed in 101.149 ms, heap usage 376.832 MB -> 67.457 MB. [2026-01-14T02:15:56.309Z] ====== als (apache-spark) [default], iteration 11 completed (8644.735 ms) ====== [2026-01-14T02:15:56.309Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-01-14T02:15:56.309Z] GC before operation: completed in 93.549 ms, heap usage 126.482 MB -> 67.569 MB. [2026-01-14T02:16:04.118Z] ====== als (apache-spark) [default], iteration 12 completed (8382.824 ms) ====== [2026-01-14T02:16:04.118Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-01-14T02:16:04.118Z] GC before operation: completed in 99.632 ms, heap usage 419.991 MB -> 68.040 MB. [2026-01-14T02:16:13.566Z] ====== als (apache-spark) [default], iteration 13 completed (8520.847 ms) ====== [2026-01-14T02:16:13.566Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-01-14T02:16:13.566Z] GC before operation: completed in 101.014 ms, heap usage 287.450 MB -> 68.136 MB. [2026-01-14T02:16:23.101Z] ====== als (apache-spark) [default], iteration 14 completed (8459.500 ms) ====== [2026-01-14T02:16:23.101Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-01-14T02:16:23.101Z] GC before operation: completed in 106.931 ms, heap usage 292.441 MB -> 68.375 MB. [2026-01-14T02:16:30.939Z] ====== als (apache-spark) [default], iteration 15 completed (8539.310 ms) ====== [2026-01-14T02:16:30.939Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-01-14T02:16:30.939Z] GC before operation: completed in 102.195 ms, heap usage 335.512 MB -> 68.626 MB. [2026-01-14T02:16:40.465Z] ====== als (apache-spark) [default], iteration 16 completed (8671.695 ms) ====== [2026-01-14T02:16:40.465Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-01-14T02:16:40.465Z] GC before operation: completed in 110.495 ms, heap usage 252.350 MB -> 68.974 MB. [2026-01-14T02:16:50.011Z] ====== als (apache-spark) [default], iteration 17 completed (8702.437 ms) ====== [2026-01-14T02:16:50.011Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-01-14T02:16:50.011Z] GC before operation: completed in 98.679 ms, heap usage 328.044 MB -> 69.187 MB. [2026-01-14T02:16:59.651Z] ====== als (apache-spark) [default], iteration 18 completed (8848.430 ms) ====== [2026-01-14T02:16:59.651Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-01-14T02:16:59.651Z] GC before operation: completed in 104.997 ms, heap usage 237.773 MB -> 69.530 MB. [2026-01-14T02:17:07.667Z] ====== als (apache-spark) [default], iteration 19 completed (8643.867 ms) ====== [2026-01-14T02:17:07.667Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-01-14T02:17:07.667Z] GC before operation: completed in 96.261 ms, heap usage 572.511 MB -> 70.088 MB. [2026-01-14T02:17:17.248Z] ====== als (apache-spark) [default], iteration 20 completed (8925.139 ms) ====== [2026-01-14T02:17:17.248Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-01-14T02:17:17.248Z] GC before operation: completed in 100.460 ms, heap usage 329.990 MB -> 70.035 MB. [2026-01-14T02:17:26.798Z] ====== als (apache-spark) [default], iteration 21 completed (8567.720 ms) ====== [2026-01-14T02:17:26.798Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-01-14T02:17:26.798Z] GC before operation: completed in 99.522 ms, heap usage 239.796 MB -> 70.161 MB. [2026-01-14T02:17:34.693Z] ====== als (apache-spark) [default], iteration 22 completed (8489.465 ms) ====== [2026-01-14T02:17:34.693Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-01-14T02:17:34.693Z] GC before operation: completed in 97.943 ms, heap usage 320.348 MB -> 70.483 MB. [2026-01-14T02:17:44.122Z] ====== als (apache-spark) [default], iteration 23 completed (8592.320 ms) ====== [2026-01-14T02:17:44.122Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-01-14T02:17:44.122Z] GC before operation: completed in 105.539 ms, heap usage 210.331 MB -> 70.640 MB. [2026-01-14T02:17:53.589Z] ====== als (apache-spark) [default], iteration 24 completed (8709.373 ms) ====== [2026-01-14T02:17:53.590Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-01-14T02:17:53.590Z] GC before operation: completed in 107.093 ms, heap usage 489.629 MB -> 71.237 MB. [2026-01-14T02:18:01.586Z] ====== als (apache-spark) [default], iteration 25 completed (8518.763 ms) ====== [2026-01-14T02:18:01.586Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-01-14T02:18:01.586Z] GC before operation: completed in 98.222 ms, heap usage 245.498 MB -> 71.186 MB. [2026-01-14T02:18:11.146Z] ====== als (apache-spark) [default], iteration 26 completed (8477.945 ms) ====== [2026-01-14T02:18:11.146Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-01-14T02:18:11.146Z] GC before operation: completed in 98.104 ms, heap usage 413.940 MB -> 71.796 MB. [2026-01-14T02:18:19.199Z] ====== als (apache-spark) [default], iteration 27 completed (8688.010 ms) ====== [2026-01-14T02:18:19.199Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-01-14T02:18:19.199Z] GC before operation: completed in 96.902 ms, heap usage 560.736 MB -> 71.775 MB. [2026-01-14T02:18:28.678Z] ====== als (apache-spark) [default], iteration 28 completed (8620.130 ms) ====== [2026-01-14T02:18:28.678Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-01-14T02:18:28.678Z] GC before operation: completed in 98.810 ms, heap usage 259.772 MB -> 72.154 MB. [2026-01-14T02:18:36.596Z] ====== als (apache-spark) [default], iteration 29 completed (8379.632 ms) ====== [2026-01-14T02:18:36.957Z] ----------------------------------- [2026-01-14T02:18:36.957Z] renaissance-als_0_PASSED [2026-01-14T02:18:36.957Z] ----------------------------------- [2026-01-14T02:18:36.957Z] [2026-01-14T02:18:36.957Z] TEST TEARDOWN: [2026-01-14T02:18:36.957Z] Nothing to be done for teardown. [2026-01-14T02:18:36.957Z] renaissance-als_0 Finish Time: Wed Jan 14 02:18:36 2026 Epoch Time (ms): 1768357116835