renaissance-als_0
[2026-04-23T14:24:48.461Z] Running test renaissance-als_0 ...
[2026-04-23T14:24:48.461Z] ===============================================
[2026-04-23T14:24:48.461Z] renaissance-als_0 Start Time: Thu Apr 23 14:24:47 2026 Epoch Time (ms): 1776954287733
[2026-04-23T14:24:48.461Z] variation: NoOptions
[2026-04-23T14:24:48.461Z] JVM_OPTIONS:
[2026-04-23T14:24:48.461Z] { \
[2026-04-23T14:24:48.461Z] echo ""; echo "TEST SETUP:"; \
[2026-04-23T14:24:48.461Z] echo "Nothing to be done for setup."; \
[2026-04-23T14:24:48.461Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769542876697/renaissance-als_0"; \
[2026-04-23T14:24:48.461Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769542876697/renaissance-als_0"; \
[2026-04-23T14:24:48.462Z] echo ""; echo "TESTING:"; \
[2026-04-23T14:24:48.462Z] "/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_17769542876697/renaissance-als_0"/als.json" als; \
[2026-04-23T14:24:48.462Z] 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_17769542876697/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-04-23T14:24:48.462Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-04-23T14:24:48.462Z] echo "Nothing to be done for teardown."; \
[2026-04-23T14:24:48.462Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769542876697/TestTargetResult";
[2026-04-23T14:24:48.462Z]
[2026-04-23T14:24:48.462Z] TEST SETUP:
[2026-04-23T14:24:48.462Z] Nothing to be done for setup.
[2026-04-23T14:24:48.462Z]
[2026-04-23T14:24:48.462Z] TESTING:
[2026-04-23T14:24:55.337Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-04-23T14:25:02.099Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-04-23T14:25:02.099Z] GC before operation: completed in 57.801 ms, heap usage 59.759 MB -> 35.146 MB.
[2026-04-23T14:25:27.109Z] ====== als (apache-spark) [default], iteration 0 completed (24835.098 ms) ======
[2026-04-23T14:25:27.109Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-04-23T14:25:27.109Z] GC before operation: completed in 133.255 ms, heap usage 604.029 MB -> 62.450 MB.
[2026-04-23T14:25:35.888Z] ====== als (apache-spark) [default], iteration 1 completed (7998.457 ms) ======
[2026-04-23T14:25:35.888Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-04-23T14:25:35.888Z] GC before operation: completed in 99.783 ms, heap usage 284.573 MB -> 63.091 MB.
[2026-04-23T14:25:45.308Z] ====== als (apache-spark) [default], iteration 2 completed (6785.438 ms) ======
[2026-04-23T14:25:45.308Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-04-23T14:25:45.308Z] GC before operation: completed in 105.279 ms, heap usage 489.408 MB -> 63.996 MB.
[2026-04-23T14:25:50.547Z] ====== als (apache-spark) [default], iteration 3 completed (6394.223 ms) ======
[2026-04-23T14:25:50.547Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-04-23T14:25:50.547Z] GC before operation: completed in 111.712 ms, heap usage 577.096 MB -> 64.657 MB.
[2026-04-23T14:25:59.440Z] ====== als (apache-spark) [default], iteration 4 completed (6497.527 ms) ======
[2026-04-23T14:25:59.440Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-04-23T14:25:59.440Z] GC before operation: completed in 107.517 ms, heap usage 526.440 MB -> 65.170 MB.
[2026-04-23T14:26:03.010Z] ====== als (apache-spark) [default], iteration 5 completed (6131.371 ms) ======
[2026-04-23T14:26:03.010Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-04-23T14:26:03.010Z] GC before operation: completed in 382.378 ms, heap usage 349.594 MB -> 65.482 MB.
[2026-04-23T14:26:11.578Z] ====== als (apache-spark) [default], iteration 6 completed (7465.799 ms) ======
[2026-04-23T14:26:11.578Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-04-23T14:26:11.578Z] GC before operation: completed in 164.908 ms, heap usage 603.740 MB -> 66.351 MB.
[2026-04-23T14:26:18.694Z] ====== als (apache-spark) [default], iteration 7 completed (7403.746 ms) ======
[2026-04-23T14:26:18.694Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-04-23T14:26:19.958Z] GC before operation: completed in 154.673 ms, heap usage 467.853 MB -> 66.745 MB.
[2026-04-23T14:26:27.501Z] ====== als (apache-spark) [default], iteration 8 completed (7020.734 ms) ======
[2026-04-23T14:26:27.501Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-04-23T14:26:27.501Z] GC before operation: completed in 134.694 ms, heap usage 1.039 GB -> 68.024 MB.
[2026-04-23T14:26:33.179Z] ====== als (apache-spark) [default], iteration 9 completed (6280.044 ms) ======
[2026-04-23T14:26:33.179Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-04-23T14:26:33.179Z] GC before operation: completed in 130.232 ms, heap usage 786.014 MB -> 67.864 MB.
[2026-04-23T14:26:40.387Z] ====== als (apache-spark) [default], iteration 10 completed (6318.154 ms) ======
[2026-04-23T14:26:40.387Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-04-23T14:26:40.387Z] GC before operation: completed in 124.534 ms, heap usage 687.757 MB -> 68.016 MB.
[2026-04-23T14:26:47.163Z] ====== als (apache-spark) [default], iteration 11 completed (6462.196 ms) ======
[2026-04-23T14:26:47.163Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-04-23T14:26:47.163Z] GC before operation: completed in 143.908 ms, heap usage 390.637 MB -> 67.867 MB.
[2026-04-23T14:26:52.939Z] ====== als (apache-spark) [default], iteration 12 completed (5947.100 ms) ======
[2026-04-23T14:26:52.939Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-04-23T14:26:52.939Z] GC before operation: completed in 119.187 ms, heap usage 470.919 MB -> 68.316 MB.
[2026-04-23T14:26:58.434Z] ====== als (apache-spark) [default], iteration 13 completed (5367.069 ms) ======
[2026-04-23T14:26:58.434Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-04-23T14:26:58.434Z] GC before operation: completed in 129.012 ms, heap usage 550.138 MB -> 68.654 MB.
[2026-04-23T14:27:03.877Z] ====== als (apache-spark) [default], iteration 14 completed (5285.093 ms) ======
[2026-04-23T14:27:03.877Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-04-23T14:27:03.877Z] GC before operation: completed in 123.274 ms, heap usage 568.005 MB -> 69.019 MB.
[2026-04-23T14:27:09.307Z] ====== als (apache-spark) [default], iteration 15 completed (5348.333 ms) ======
[2026-04-23T14:27:09.307Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-04-23T14:27:10.278Z] GC before operation: completed in 121.875 ms, heap usage 789.713 MB -> 69.485 MB.
[2026-04-23T14:27:15.713Z] ====== als (apache-spark) [default], iteration 16 completed (5443.853 ms) ======
[2026-04-23T14:27:15.713Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-04-23T14:27:15.713Z] GC before operation: completed in 127.087 ms, heap usage 727.443 MB -> 69.739 MB.
[2026-04-23T14:27:21.153Z] ====== als (apache-spark) [default], iteration 17 completed (5531.240 ms) ======
[2026-04-23T14:27:21.153Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-04-23T14:27:21.153Z] GC before operation: completed in 141.562 ms, heap usage 263.655 MB -> 69.420 MB.
[2026-04-23T14:27:27.939Z] ====== als (apache-spark) [default], iteration 18 completed (6055.890 ms) ======
[2026-04-23T14:27:27.939Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-04-23T14:27:27.939Z] GC before operation: completed in 147.261 ms, heap usage 161.292 MB -> 69.551 MB.
[2026-04-23T14:27:34.725Z] ====== als (apache-spark) [default], iteration 19 completed (5889.925 ms) ======
[2026-04-23T14:27:34.725Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-04-23T14:27:34.725Z] GC before operation: completed in 151.960 ms, heap usage 617.924 MB -> 70.281 MB.
[2026-04-23T14:27:40.159Z] ====== als (apache-spark) [default], iteration 20 completed (6120.899 ms) ======
[2026-04-23T14:27:40.159Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-04-23T14:27:40.159Z] GC before operation: completed in 132.242 ms, heap usage 361.627 MB -> 70.290 MB.
[2026-04-23T14:27:45.690Z] ====== als (apache-spark) [default], iteration 21 completed (5146.340 ms) ======
[2026-04-23T14:27:45.690Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-04-23T14:27:45.690Z] GC before operation: completed in 129.764 ms, heap usage 264.872 MB -> 70.494 MB.
[2026-04-23T14:27:51.178Z] ====== als (apache-spark) [default], iteration 22 completed (5056.667 ms) ======
[2026-04-23T14:27:51.178Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-04-23T14:27:51.178Z] GC before operation: completed in 128.284 ms, heap usage 235.825 MB -> 70.662 MB.
[2026-04-23T14:27:56.712Z] ====== als (apache-spark) [default], iteration 23 completed (5139.973 ms) ======
[2026-04-23T14:27:56.712Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-04-23T14:27:56.712Z] GC before operation: completed in 132.349 ms, heap usage 195.599 MB -> 70.837 MB.
[2026-04-23T14:28:02.182Z] ====== als (apache-spark) [default], iteration 24 completed (5223.362 ms) ======
[2026-04-23T14:28:02.182Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-04-23T14:28:02.182Z] GC before operation: completed in 136.843 ms, heap usage 219.234 MB -> 71.037 MB.
[2026-04-23T14:28:07.621Z] ====== als (apache-spark) [default], iteration 25 completed (5131.362 ms) ======
[2026-04-23T14:28:07.621Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-04-23T14:28:07.621Z] GC before operation: completed in 128.644 ms, heap usage 205.468 MB -> 71.461 MB.
[2026-04-23T14:28:13.071Z] ====== als (apache-spark) [default], iteration 26 completed (5106.399 ms) ======
[2026-04-23T14:28:13.071Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-04-23T14:28:13.071Z] GC before operation: completed in 142.696 ms, heap usage 676.244 MB -> 72.330 MB.
[2026-04-23T14:28:18.505Z] ====== als (apache-spark) [default], iteration 27 completed (5116.731 ms) ======
[2026-04-23T14:28:18.505Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-04-23T14:28:18.505Z] GC before operation: completed in 134.498 ms, heap usage 822.365 MB -> 72.818 MB.
[2026-04-23T14:28:23.938Z] ====== als (apache-spark) [default], iteration 28 completed (5104.206 ms) ======
[2026-04-23T14:28:23.938Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-04-23T14:28:23.938Z] GC before operation: completed in 137.600 ms, heap usage 636.827 MB -> 72.342 MB.
[2026-04-23T14:28:29.384Z] ====== als (apache-spark) [default], iteration 29 completed (5015.743 ms) ======
[2026-04-23T14:28:30.343Z] -----------------------------------
[2026-04-23T14:28:30.343Z] renaissance-als_0_PASSED
[2026-04-23T14:28:30.343Z] -----------------------------------
[2026-04-23T14:28:30.343Z]
[2026-04-23T14:28:30.343Z] TEST TEARDOWN:
[2026-04-23T14:28:30.343Z] Nothing to be done for teardown.
[2026-04-23T14:28:30.343Z] renaissance-als_0 Finish Time: Thu Apr 23 14:28:29 2026 Epoch Time (ms): 1776954509370