renaissance-als_0
[2026-03-05T02:05:52.173Z] Running test renaissance-als_0 ...
[2026-03-05T02:05:52.173Z] ===============================================
[2026-03-05T02:05:52.173Z] renaissance-als_0 Start Time: Thu Mar 5 02:05:52 2026 Epoch Time (ms): 1772676352122
[2026-03-05T02:05:52.173Z] variation: NoOptions
[2026-03-05T02:05:52.173Z] JVM_OPTIONS:
[2026-03-05T02:05:52.173Z] { \
[2026-03-05T02:05:52.173Z] echo ""; echo "TEST SETUP:"; \
[2026-03-05T02:05:52.173Z] echo "Nothing to be done for setup."; \
[2026-03-05T02:05:52.173Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17726761534492/renaissance-als_0"; \
[2026-03-05T02:05:52.173Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17726761534492/renaissance-als_0"; \
[2026-03-05T02:05:52.173Z] echo ""; echo "TESTING:"; \
[2026-03-05T02:05:52.173Z] "/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_17726761534492/renaissance-als_0"/als.json" als; \
[2026-03-05T02:05:52.173Z] 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_17726761534492/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-03-05T02:05:52.173Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-03-05T02:05:52.173Z] echo "Nothing to be done for teardown."; \
[2026-03-05T02:05:52.173Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17726761534492/TestTargetResult";
[2026-03-05T02:05:52.173Z]
[2026-03-05T02:05:52.173Z] TEST SETUP:
[2026-03-05T02:05:52.173Z] Nothing to be done for setup.
[2026-03-05T02:05:52.173Z]
[2026-03-05T02:05:52.173Z] TESTING:
[2026-03-05T02:05:59.708Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-03-05T02:06:06.047Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-03-05T02:06:06.047Z] GC before operation: completed in 48.586 ms, heap usage 54.121 MB -> 35.010 MB.
[2026-03-05T02:06:34.697Z] ====== als (apache-spark) [default], iteration 0 completed (26106.810 ms) ======
[2026-03-05T02:06:34.697Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-03-05T02:06:34.697Z] GC before operation: completed in 88.598 ms, heap usage 174.432 MB -> 61.766 MB.
[2026-03-05T02:06:44.139Z] ====== als (apache-spark) [default], iteration 1 completed (10459.023 ms) ======
[2026-03-05T02:06:44.139Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-03-05T02:06:44.139Z] GC before operation: completed in 91.785 ms, heap usage 317.165 MB -> 62.856 MB.
[2026-03-05T02:06:53.822Z] ====== als (apache-spark) [default], iteration 2 completed (9336.321 ms) ======
[2026-03-05T02:06:53.822Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-03-05T02:06:53.822Z] GC before operation: completed in 85.838 ms, heap usage 521.434 MB -> 63.785 MB.
[2026-03-05T02:07:03.406Z] ====== als (apache-spark) [default], iteration 3 completed (9166.377 ms) ======
[2026-03-05T02:07:03.406Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-03-05T02:07:03.406Z] GC before operation: completed in 85.792 ms, heap usage 258.843 MB -> 63.915 MB.
[2026-03-05T02:07:12.833Z] ====== als (apache-spark) [default], iteration 4 completed (8884.525 ms) ======
[2026-03-05T02:07:12.833Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-03-05T02:07:12.833Z] GC before operation: completed in 93.902 ms, heap usage 242.155 MB -> 64.590 MB.
[2026-03-05T02:07:22.359Z] ====== als (apache-spark) [default], iteration 5 completed (9061.427 ms) ======
[2026-03-05T02:07:22.359Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-03-05T02:07:22.359Z] GC before operation: completed in 85.944 ms, heap usage 179.708 MB -> 65.118 MB.
[2026-03-05T02:07:31.853Z] ====== als (apache-spark) [default], iteration 6 completed (8836.955 ms) ======
[2026-03-05T02:07:31.853Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-03-05T02:07:31.853Z] GC before operation: completed in 92.295 ms, heap usage 255.364 MB -> 65.749 MB.
[2026-03-05T02:07:41.350Z] ====== als (apache-spark) [default], iteration 7 completed (8733.187 ms) ======
[2026-03-05T02:07:41.350Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-03-05T02:07:41.350Z] GC before operation: completed in 98.072 ms, heap usage 204.730 MB -> 66.221 MB.
[2026-03-05T02:07:49.157Z] ====== als (apache-spark) [default], iteration 8 completed (8694.634 ms) ======
[2026-03-05T02:07:49.157Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-03-05T02:07:49.157Z] GC before operation: completed in 94.144 ms, heap usage 199.042 MB -> 66.671 MB.
[2026-03-05T02:07:58.807Z] ====== als (apache-spark) [default], iteration 9 completed (8667.646 ms) ======
[2026-03-05T02:07:58.807Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-03-05T02:07:58.807Z] GC before operation: completed in 96.665 ms, heap usage 245.621 MB -> 66.957 MB.
[2026-03-05T02:08:08.183Z] ====== als (apache-spark) [default], iteration 10 completed (8538.503 ms) ======
[2026-03-05T02:08:08.183Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-03-05T02:08:08.183Z] GC before operation: completed in 97.172 ms, heap usage 285.225 MB -> 67.259 MB.
[2026-03-05T02:08:17.528Z] ====== als (apache-spark) [default], iteration 11 completed (8849.343 ms) ======
[2026-03-05T02:08:17.528Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-03-05T02:08:17.528Z] GC before operation: completed in 96.058 ms, heap usage 361.372 MB -> 67.609 MB.
[2026-03-05T02:08:25.327Z] ====== als (apache-spark) [default], iteration 12 completed (8597.729 ms) ======
[2026-03-05T02:08:25.327Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-03-05T02:08:25.327Z] GC before operation: completed in 94.900 ms, heap usage 178.009 MB -> 67.831 MB.
[2026-03-05T02:08:34.688Z] ====== als (apache-spark) [default], iteration 13 completed (8651.778 ms) ======
[2026-03-05T02:08:34.688Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-03-05T02:08:34.688Z] GC before operation: completed in 95.157 ms, heap usage 251.054 MB -> 68.189 MB.
[2026-03-05T02:08:44.147Z] ====== als (apache-spark) [default], iteration 14 completed (8695.388 ms) ======
[2026-03-05T02:08:44.147Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-03-05T02:08:44.147Z] GC before operation: completed in 117.186 ms, heap usage 363.903 MB -> 68.387 MB.
[2026-03-05T02:08:53.554Z] ====== als (apache-spark) [default], iteration 15 completed (8726.288 ms) ======
[2026-03-05T02:08:53.554Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-03-05T02:08:53.554Z] GC before operation: completed in 95.597 ms, heap usage 275.949 MB -> 68.552 MB.
[2026-03-05T02:09:01.433Z] ====== als (apache-spark) [default], iteration 16 completed (8625.552 ms) ======
[2026-03-05T02:09:01.433Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-03-05T02:09:01.433Z] GC before operation: completed in 98.760 ms, heap usage 306.649 MB -> 68.960 MB.
[2026-03-05T02:09:11.065Z] ====== als (apache-spark) [default], iteration 17 completed (8589.826 ms) ======
[2026-03-05T02:09:11.065Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-03-05T02:09:11.065Z] GC before operation: completed in 102.227 ms, heap usage 572.159 MB -> 69.379 MB.
[2026-03-05T02:09:20.572Z] ====== als (apache-spark) [default], iteration 18 completed (8721.467 ms) ======
[2026-03-05T02:09:20.572Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-03-05T02:09:20.572Z] GC before operation: completed in 97.449 ms, heap usage 553.618 MB -> 69.690 MB.
[2026-03-05T02:09:28.317Z] ====== als (apache-spark) [default], iteration 19 completed (8477.389 ms) ======
[2026-03-05T02:09:28.317Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-03-05T02:09:28.317Z] GC before operation: completed in 100.232 ms, heap usage 266.787 MB -> 69.674 MB.
[2026-03-05T02:09:37.809Z] ====== als (apache-spark) [default], iteration 20 completed (8567.604 ms) ======
[2026-03-05T02:09:37.809Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-03-05T02:09:37.809Z] GC before operation: completed in 101.639 ms, heap usage 352.063 MB -> 69.959 MB.
[2026-03-05T02:09:47.210Z] ====== als (apache-spark) [default], iteration 21 completed (8625.876 ms) ======
[2026-03-05T02:09:47.210Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-03-05T02:09:47.210Z] GC before operation: completed in 101.688 ms, heap usage 250.844 MB -> 70.068 MB.
[2026-03-05T02:09:54.922Z] ====== als (apache-spark) [default], iteration 22 completed (8549.037 ms) ======
[2026-03-05T02:09:54.922Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-03-05T02:09:55.288Z] GC before operation: completed in 103.170 ms, heap usage 456.021 MB -> 70.709 MB.
[2026-03-05T02:10:04.857Z] ====== als (apache-spark) [default], iteration 23 completed (8621.301 ms) ======
[2026-03-05T02:10:04.857Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-03-05T02:10:04.857Z] GC before operation: completed in 100.174 ms, heap usage 689.459 MB -> 71.169 MB.
[2026-03-05T02:10:14.235Z] ====== als (apache-spark) [default], iteration 24 completed (8551.775 ms) ======
[2026-03-05T02:10:14.235Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-03-05T02:10:14.235Z] GC before operation: completed in 103.585 ms, heap usage 462.830 MB -> 71.209 MB.
[2026-03-05T02:10:23.733Z] ====== als (apache-spark) [default], iteration 25 completed (10009.132 ms) ======
[2026-03-05T02:10:23.734Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-03-05T02:10:23.734Z] GC before operation: completed in 101.337 ms, heap usage 363.657 MB -> 71.316 MB.
[2026-03-05T02:10:31.718Z] ====== als (apache-spark) [default], iteration 26 completed (8151.542 ms) ======
[2026-03-05T02:10:31.718Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-03-05T02:10:31.718Z] GC before operation: completed in 97.959 ms, heap usage 262.607 MB -> 71.555 MB.
[2026-03-05T02:10:41.207Z] ====== als (apache-spark) [default], iteration 27 completed (8556.390 ms) ======
[2026-03-05T02:10:41.208Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-03-05T02:10:41.208Z] GC before operation: completed in 98.434 ms, heap usage 362.225 MB -> 71.892 MB.
[2026-03-05T02:10:51.333Z] ====== als (apache-spark) [default], iteration 28 completed (8683.485 ms) ======
[2026-03-05T02:10:51.333Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-03-05T02:10:51.333Z] GC before operation: completed in 108.012 ms, heap usage 506.795 MB -> 72.254 MB.
[2026-03-05T02:10:59.201Z] ====== als (apache-spark) [default], iteration 29 completed (8449.718 ms) ======
[2026-03-05T02:10:59.201Z] -----------------------------------
[2026-03-05T02:10:59.201Z] renaissance-als_0_PASSED
[2026-03-05T02:10:59.201Z] -----------------------------------
[2026-03-05T02:10:59.201Z]
[2026-03-05T02:10:59.201Z] TEST TEARDOWN:
[2026-03-05T02:10:59.201Z] Nothing to be done for teardown.
[2026-03-05T02:10:59.201Z] renaissance-als_0 Finish Time: Thu Mar 5 02:10:58 2026 Epoch Time (ms): 1772676658556