renaissance-als_0
[2026-02-25T22:25:33.064Z] Running test renaissance-als_0 ...
[2026-02-25T22:25:33.064Z] ===============================================
[2026-02-25T22:25:33.064Z] renaissance-als_0 Start Time: Wed Feb 25 16:25:32 2026 Epoch Time (ms): 1772058332375
[2026-02-25T22:25:33.064Z] variation: NoOptions
[2026-02-25T22:25:33.064Z] JVM_OPTIONS:
[2026-02-25T22:25:33.064Z] { \
[2026-02-25T22:25:33.064Z] echo ""; echo "TEST SETUP:"; \
[2026-02-25T22:25:33.064Z] echo "Nothing to be done for setup."; \
[2026-02-25T22:25:33.064Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17720580082828/renaissance-als_0"; \
[2026-02-25T22:25:33.064Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17720580082828/renaissance-als_0"; \
[2026-02-25T22:25:33.064Z] echo ""; echo "TESTING:"; \
[2026-02-25T22:25:33.064Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17720580082828/renaissance-als_0"/als.json" als; \
[2026-02-25T22:25:33.064Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17720580082828/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-25T22:25:33.064Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-25T22:25:33.064Z] echo "Nothing to be done for teardown."; \
[2026-02-25T22:25:33.064Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17720580082828/TestTargetResult";
[2026-02-25T22:25:33.064Z]
[2026-02-25T22:25:33.064Z] TEST SETUP:
[2026-02-25T22:25:33.064Z] Nothing to be done for setup.
[2026-02-25T22:25:33.064Z]
[2026-02-25T22:25:33.064Z] TESTING:
[2026-02-25T22:25:39.530Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads.
[2026-02-25T22:25:44.009Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-02-25T22:25:44.009Z] GC before operation: completed in 131.583 ms, heap usage 236.780 MB -> 35.000 MB.
[2026-02-25T22:26:15.577Z] ====== als (apache-spark) [default], iteration 0 completed (30505.854 ms) ======
[2026-02-25T22:26:15.577Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-02-25T22:26:15.577Z] GC before operation: completed in 200.558 ms, heap usage 350.159 MB -> 62.016 MB.
[2026-02-25T22:26:33.547Z] ====== als (apache-spark) [default], iteration 1 completed (17444.824 ms) ======
[2026-02-25T22:26:33.547Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-02-25T22:26:33.547Z] GC before operation: completed in 109.993 ms, heap usage 112.911 MB -> 63.004 MB.
[2026-02-25T22:26:48.878Z] ====== als (apache-spark) [default], iteration 2 completed (15642.442 ms) ======
[2026-02-25T22:26:48.878Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-02-25T22:26:49.577Z] GC before operation: completed in 164.522 ms, heap usage 449.332 MB -> 63.818 MB.
[2026-02-25T22:27:07.398Z] ====== als (apache-spark) [default], iteration 3 completed (15829.621 ms) ======
[2026-02-25T22:27:07.398Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-02-25T22:27:07.398Z] GC before operation: completed in 139.062 ms, heap usage 249.112 MB -> 64.087 MB.
[2026-02-25T22:27:23.037Z] ====== als (apache-spark) [default], iteration 4 completed (16582.606 ms) ======
[2026-02-25T22:27:23.038Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-02-25T22:27:23.038Z] GC before operation: completed in 168.358 ms, heap usage 167.203 MB -> 64.562 MB.
[2026-02-25T22:27:41.037Z] ====== als (apache-spark) [default], iteration 5 completed (16382.470 ms) ======
[2026-02-25T22:27:41.037Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-02-25T22:27:41.037Z] GC before operation: completed in 134.123 ms, heap usage 246.226 MB -> 65.254 MB.
[2026-02-25T22:27:56.456Z] ====== als (apache-spark) [default], iteration 6 completed (16139.705 ms) ======
[2026-02-25T22:27:56.456Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-02-25T22:27:56.456Z] GC before operation: completed in 165.405 ms, heap usage 386.313 MB -> 65.810 MB.
[2026-02-25T22:28:13.839Z] ====== als (apache-spark) [default], iteration 7 completed (16446.754 ms) ======
[2026-02-25T22:28:13.839Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-02-25T22:28:13.839Z] GC before operation: completed in 253.523 ms, heap usage 263.713 MB -> 66.234 MB.
[2026-02-25T22:28:31.868Z] ====== als (apache-spark) [default], iteration 8 completed (18383.842 ms) ======
[2026-02-25T22:28:31.868Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-02-25T22:28:31.868Z] GC before operation: completed in 205.671 ms, heap usage 366.807 MB -> 66.951 MB.
[2026-02-25T22:28:53.147Z] ====== als (apache-spark) [default], iteration 9 completed (19252.453 ms) ======
[2026-02-25T22:28:53.147Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-02-25T22:28:53.147Z] GC before operation: completed in 150.076 ms, heap usage 390.312 MB -> 67.587 MB.
[2026-02-25T22:29:11.182Z] ====== als (apache-spark) [default], iteration 10 completed (18237.756 ms) ======
[2026-02-25T22:29:11.182Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-02-25T22:29:11.182Z] GC before operation: completed in 244.491 ms, heap usage 400.688 MB -> 67.353 MB.
[2026-02-25T22:29:29.892Z] ====== als (apache-spark) [default], iteration 11 completed (17438.680 ms) ======
[2026-02-25T22:29:29.892Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-02-25T22:29:29.892Z] GC before operation: completed in 158.404 ms, heap usage 393.526 MB -> 67.555 MB.
[2026-02-25T22:29:45.387Z] ====== als (apache-spark) [default], iteration 12 completed (16826.654 ms) ======
[2026-02-25T22:29:45.387Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-02-25T22:29:46.061Z] GC before operation: completed in 236.185 ms, heap usage 272.197 MB -> 67.753 MB.
[2026-02-25T22:30:01.322Z] ====== als (apache-spark) [default], iteration 13 completed (15524.919 ms) ======
[2026-02-25T22:30:01.322Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-02-25T22:30:02.171Z] GC before operation: completed in 168.367 ms, heap usage 167.610 MB -> 67.888 MB.
[2026-02-25T22:30:20.544Z] ====== als (apache-spark) [default], iteration 14 completed (17330.130 ms) ======
[2026-02-25T22:30:20.544Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-02-25T22:30:20.544Z] GC before operation: completed in 173.085 ms, heap usage 513.472 MB -> 68.649 MB.
[2026-02-25T22:30:36.211Z] ====== als (apache-spark) [default], iteration 15 completed (15151.214 ms) ======
[2026-02-25T22:30:36.211Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-02-25T22:30:36.211Z] GC before operation: completed in 167.560 ms, heap usage 139.613 MB -> 68.165 MB.
[2026-02-25T22:30:51.617Z] ====== als (apache-spark) [default], iteration 16 completed (15805.989 ms) ======
[2026-02-25T22:30:51.617Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-02-25T22:30:51.617Z] GC before operation: completed in 148.562 ms, heap usage 455.334 MB -> 69.157 MB.
[2026-02-25T22:31:09.477Z] ====== als (apache-spark) [default], iteration 17 completed (15962.765 ms) ======
[2026-02-25T22:31:09.477Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-02-25T22:31:09.477Z] GC before operation: completed in 218.451 ms, heap usage 120.234 MB -> 69.017 MB.
[2026-02-25T22:31:24.801Z] ====== als (apache-spark) [default], iteration 18 completed (16472.612 ms) ======
[2026-02-25T22:31:24.801Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-02-25T22:31:24.801Z] GC before operation: completed in 184.529 ms, heap usage 127.368 MB -> 68.744 MB.
[2026-02-25T22:31:43.026Z] ====== als (apache-spark) [default], iteration 19 completed (17631.135 ms) ======
[2026-02-25T22:31:43.026Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-02-25T22:31:43.026Z] GC before operation: completed in 186.369 ms, heap usage 124.552 MB -> 69.147 MB.
[2026-02-25T22:32:03.137Z] ====== als (apache-spark) [default], iteration 20 completed (17692.464 ms) ======
[2026-02-25T22:32:03.137Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-02-25T22:32:03.137Z] GC before operation: completed in 169.329 ms, heap usage 159.776 MB -> 69.780 MB.
[2026-02-25T22:32:18.747Z] ====== als (apache-spark) [default], iteration 21 completed (16383.274 ms) ======
[2026-02-25T22:32:18.747Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-02-25T22:32:18.747Z] GC before operation: completed in 254.787 ms, heap usage 522.244 MB -> 70.301 MB.
[2026-02-25T22:32:36.815Z] ====== als (apache-spark) [default], iteration 22 completed (16579.964 ms) ======
[2026-02-25T22:32:36.815Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-02-25T22:32:36.815Z] GC before operation: completed in 140.108 ms, heap usage 373.148 MB -> 70.371 MB.
[2026-02-25T22:32:52.060Z] ====== als (apache-spark) [default], iteration 23 completed (14964.843 ms) ======
[2026-02-25T22:32:52.060Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-02-25T22:32:52.060Z] GC before operation: completed in 175.695 ms, heap usage 179.596 MB -> 70.437 MB.
[2026-02-25T22:33:08.324Z] ====== als (apache-spark) [default], iteration 24 completed (15503.132 ms) ======
[2026-02-25T22:33:08.324Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-02-25T22:33:08.324Z] GC before operation: completed in 368.609 ms, heap usage 184.773 MB -> 70.668 MB.
[2026-02-25T22:33:23.567Z] ====== als (apache-spark) [default], iteration 25 completed (15885.944 ms) ======
[2026-02-25T22:33:23.567Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-02-25T22:33:23.567Z] GC before operation: completed in 176.272 ms, heap usage 327.169 MB -> 71.122 MB.
[2026-02-25T22:33:41.602Z] ====== als (apache-spark) [default], iteration 26 completed (17080.874 ms) ======
[2026-02-25T22:33:41.602Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-02-25T22:33:41.602Z] GC before operation: completed in 132.905 ms, heap usage 269.012 MB -> 71.306 MB.
[2026-02-25T22:33:58.578Z] ====== als (apache-spark) [default], iteration 27 completed (16358.802 ms) ======
[2026-02-25T22:33:58.578Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-02-25T22:33:58.578Z] GC before operation: completed in 280.001 ms, heap usage 407.097 MB -> 71.723 MB.
[2026-02-25T22:34:16.504Z] ====== als (apache-spark) [default], iteration 28 completed (17998.732 ms) ======
[2026-02-25T22:34:16.504Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-02-25T22:34:16.504Z] GC before operation: completed in 168.124 ms, heap usage 174.918 MB -> 71.740 MB.
[2026-02-25T22:34:37.197Z] ====== als (apache-spark) [default], iteration 29 completed (18485.511 ms) ======
[2026-02-25T22:34:37.197Z] -----------------------------------
[2026-02-25T22:34:37.197Z] renaissance-als_0_PASSED
[2026-02-25T22:34:37.197Z] -----------------------------------
[2026-02-25T22:34:37.197Z]
[2026-02-25T22:34:37.197Z] TEST TEARDOWN:
[2026-02-25T22:34:37.197Z] Nothing to be done for teardown.
[2026-02-25T22:34:37.197Z] renaissance-als_0 Finish Time: Wed Feb 25 16:34:35 2026 Epoch Time (ms): 1772058875064