renaissance-als_0
[2026-04-23T15:05:15.584Z] Running test renaissance-als_0 ...
[2026-04-23T15:05:15.584Z] ===============================================
[2026-04-23T15:05:15.584Z] renaissance-als_0 Start Time: Thu Apr 23 15:05:15 2026 Epoch Time (ms): 1776956715310
[2026-04-23T15:05:15.584Z] variation: NoOptions
[2026-04-23T15:05:15.584Z] JVM_OPTIONS:
[2026-04-23T15:05:15.584Z] { \
[2026-04-23T15:05:15.584Z] echo ""; echo "TEST SETUP:"; \
[2026-04-23T15:05:15.584Z] echo "Nothing to be done for setup."; \
[2026-04-23T15:05:15.584Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769565303866/renaissance-als_0"; \
[2026-04-23T15:05:15.584Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769565303866/renaissance-als_0"; \
[2026-04-23T15:05:15.584Z] echo ""; echo "TESTING:"; \
[2026-04-23T15:05:15.584Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769565303866/renaissance-als_0"/als.json" als; \
[2026-04-23T15:05:15.584Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769565303866/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-04-23T15:05:15.584Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-04-23T15:05:15.584Z] echo "Nothing to be done for teardown."; \
[2026-04-23T15:05:15.584Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17769565303866/TestTargetResult";
[2026-04-23T15:05:15.584Z]
[2026-04-23T15:05:15.584Z] TEST SETUP:
[2026-04-23T15:05:15.584Z] Nothing to be done for setup.
[2026-04-23T15:05:15.584Z]
[2026-04-23T15:05:15.584Z] TESTING:
[2026-04-23T15:05:23.073Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-04-23T15:05:29.217Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-04-23T15:05:29.217Z] GC before operation: completed in 46.146 ms, heap usage 272.500 MB -> 35.055 MB.
[2026-04-23T15:05:57.583Z] ====== als (apache-spark) [default], iteration 0 completed (24102.971 ms) ======
[2026-04-23T15:05:57.583Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-04-23T15:05:57.583Z] GC before operation: completed in 100.789 ms, heap usage 440.082 MB -> 62.142 MB.
[2026-04-23T15:06:03.940Z] ====== als (apache-spark) [default], iteration 1 completed (9775.268 ms) ======
[2026-04-23T15:06:03.941Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-04-23T15:06:03.941Z] GC before operation: completed in 88.191 ms, heap usage 179.679 MB -> 62.685 MB.
[2026-04-23T15:06:13.440Z] ====== als (apache-spark) [default], iteration 2 completed (9006.999 ms) ======
[2026-04-23T15:06:13.440Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-04-23T15:06:13.440Z] GC before operation: completed in 108.802 ms, heap usage 92.734 MB -> 63.291 MB.
[2026-04-23T15:06:22.792Z] ====== als (apache-spark) [default], iteration 3 completed (8946.176 ms) ======
[2026-04-23T15:06:22.792Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-04-23T15:06:22.792Z] GC before operation: completed in 114.951 ms, heap usage 505.730 MB -> 64.254 MB.
[2026-04-23T15:06:32.237Z] ====== als (apache-spark) [default], iteration 4 completed (8708.699 ms) ======
[2026-04-23T15:06:32.237Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-04-23T15:06:32.237Z] GC before operation: completed in 98.698 ms, heap usage 336.196 MB -> 64.599 MB.
[2026-04-23T15:06:41.604Z] ====== als (apache-spark) [default], iteration 5 completed (8676.690 ms) ======
[2026-04-23T15:06:41.604Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-04-23T15:06:41.604Z] GC before operation: completed in 108.204 ms, heap usage 465.347 MB -> 65.388 MB.
[2026-04-23T15:06:51.142Z] ====== als (apache-spark) [default], iteration 6 completed (8384.731 ms) ======
[2026-04-23T15:06:51.142Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-04-23T15:06:51.142Z] GC before operation: completed in 106.254 ms, heap usage 217.604 MB -> 65.608 MB.
[2026-04-23T15:06:58.768Z] ====== als (apache-spark) [default], iteration 7 completed (8300.900 ms) ======
[2026-04-23T15:06:58.768Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-04-23T15:06:58.768Z] GC before operation: completed in 118.647 ms, heap usage 251.949 MB -> 66.275 MB.
[2026-04-23T15:07:08.259Z] ====== als (apache-spark) [default], iteration 8 completed (8516.284 ms) ======
[2026-04-23T15:07:08.259Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-04-23T15:07:08.259Z] GC before operation: completed in 102.880 ms, heap usage 259.839 MB -> 66.702 MB.
[2026-04-23T15:07:17.735Z] ====== als (apache-spark) [default], iteration 9 completed (8297.867 ms) ======
[2026-04-23T15:07:17.735Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-04-23T15:07:17.735Z] GC before operation: completed in 105.948 ms, heap usage 192.640 MB -> 66.953 MB.
[2026-04-23T15:07:25.386Z] ====== als (apache-spark) [default], iteration 10 completed (8328.903 ms) ======
[2026-04-23T15:07:25.386Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-04-23T15:07:25.386Z] GC before operation: completed in 103.387 ms, heap usage 175.159 MB -> 67.150 MB.
[2026-04-23T15:07:34.818Z] ====== als (apache-spark) [default], iteration 11 completed (8108.843 ms) ======
[2026-04-23T15:07:34.818Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-04-23T15:07:34.818Z] GC before operation: completed in 109.092 ms, heap usage 293.944 MB -> 67.609 MB.
[2026-04-23T15:07:42.517Z] ====== als (apache-spark) [default], iteration 12 completed (8220.618 ms) ======
[2026-04-23T15:07:42.517Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-04-23T15:07:42.517Z] GC before operation: completed in 117.027 ms, heap usage 471.850 MB -> 68.082 MB.
[2026-04-23T15:07:51.960Z] ====== als (apache-spark) [default], iteration 13 completed (8198.117 ms) ======
[2026-04-23T15:07:51.960Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-04-23T15:07:51.960Z] GC before operation: completed in 127.211 ms, heap usage 522.944 MB -> 68.338 MB.
[2026-04-23T15:07:59.866Z] ====== als (apache-spark) [default], iteration 14 completed (8115.230 ms) ======
[2026-04-23T15:07:59.866Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-04-23T15:07:59.866Z] GC before operation: completed in 112.491 ms, heap usage 219.157 MB -> 68.345 MB.
[2026-04-23T15:08:09.246Z] ====== als (apache-spark) [default], iteration 15 completed (8169.011 ms) ======
[2026-04-23T15:08:09.246Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-04-23T15:08:09.246Z] GC before operation: completed in 107.268 ms, heap usage 366.441 MB -> 68.741 MB.
[2026-04-23T15:08:16.906Z] ====== als (apache-spark) [default], iteration 16 completed (8062.552 ms) ======
[2026-04-23T15:08:16.906Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-04-23T15:08:16.906Z] GC before operation: completed in 108.944 ms, heap usage 161.784 MB -> 68.808 MB.
[2026-04-23T15:08:26.216Z] ====== als (apache-spark) [default], iteration 17 completed (8132.794 ms) ======
[2026-04-23T15:08:26.217Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-04-23T15:08:26.217Z] GC before operation: completed in 112.428 ms, heap usage 290.267 MB -> 69.124 MB.
[2026-04-23T15:08:33.886Z] ====== als (apache-spark) [default], iteration 18 completed (8204.939 ms) ======
[2026-04-23T15:08:33.887Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-04-23T15:08:33.887Z] GC before operation: completed in 112.952 ms, heap usage 498.141 MB -> 69.747 MB.
[2026-04-23T15:08:41.707Z] ====== als (apache-spark) [default], iteration 19 completed (8170.241 ms) ======
[2026-04-23T15:08:41.707Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-04-23T15:08:42.083Z] GC before operation: completed in 108.753 ms, heap usage 119.505 MB -> 69.487 MB.
[2026-04-23T15:08:51.497Z] ====== als (apache-spark) [default], iteration 20 completed (8254.943 ms) ======
[2026-04-23T15:08:51.497Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-04-23T15:08:51.497Z] GC before operation: completed in 117.694 ms, heap usage 458.508 MB -> 70.245 MB.
[2026-04-23T15:08:59.305Z] ====== als (apache-spark) [default], iteration 21 completed (8024.420 ms) ======
[2026-04-23T15:08:59.305Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-04-23T15:08:59.305Z] GC before operation: completed in 107.406 ms, heap usage 227.357 MB -> 70.167 MB.
[2026-04-23T15:09:08.582Z] ====== als (apache-spark) [default], iteration 22 completed (8233.428 ms) ======
[2026-04-23T15:09:08.582Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-04-23T15:09:08.582Z] GC before operation: completed in 110.997 ms, heap usage 356.128 MB -> 70.541 MB.
[2026-04-23T15:09:16.437Z] ====== als (apache-spark) [default], iteration 23 completed (7974.859 ms) ======
[2026-04-23T15:09:16.437Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-04-23T15:09:16.437Z] GC before operation: completed in 110.233 ms, heap usage 410.087 MB -> 70.837 MB.
[2026-04-23T15:09:24.214Z] ====== als (apache-spark) [default], iteration 24 completed (8107.554 ms) ======
[2026-04-23T15:09:24.214Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-04-23T15:09:24.214Z] GC before operation: completed in 108.900 ms, heap usage 216.449 MB -> 70.931 MB.
[2026-04-23T15:09:33.662Z] ====== als (apache-spark) [default], iteration 25 completed (8245.720 ms) ======
[2026-04-23T15:09:33.662Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-04-23T15:09:33.662Z] GC before operation: completed in 102.585 ms, heap usage 364.460 MB -> 71.320 MB.
[2026-04-23T15:09:41.276Z] ====== als (apache-spark) [default], iteration 26 completed (7909.832 ms) ======
[2026-04-23T15:09:41.276Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-04-23T15:09:41.276Z] GC before operation: completed in 102.442 ms, heap usage 102.295 MB -> 71.360 MB.
[2026-04-23T15:09:50.615Z] ====== als (apache-spark) [default], iteration 27 completed (8250.318 ms) ======
[2026-04-23T15:09:50.615Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-04-23T15:09:50.615Z] GC before operation: completed in 103.346 ms, heap usage 483.722 MB -> 71.630 MB.
[2026-04-23T15:09:58.541Z] ====== als (apache-spark) [default], iteration 28 completed (8117.679 ms) ======
[2026-04-23T15:09:58.541Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-04-23T15:09:58.541Z] GC before operation: completed in 108.095 ms, heap usage 268.872 MB -> 71.571 MB.
[2026-04-23T15:10:07.910Z] ====== als (apache-spark) [default], iteration 29 completed (7938.987 ms) ======
[2026-04-23T15:10:07.910Z] -----------------------------------
[2026-04-23T15:10:07.910Z] renaissance-als_0_PASSED
[2026-04-23T15:10:07.910Z] -----------------------------------
[2026-04-23T15:10:07.910Z]
[2026-04-23T15:10:07.910Z] TEST TEARDOWN:
[2026-04-23T15:10:07.910Z] Nothing to be done for teardown.
[2026-04-23T15:10:07.910Z] renaissance-als_0 Finish Time: Thu Apr 23 15:10:06 2026 Epoch Time (ms): 1776957006766