renaissance-als_0
[2026-04-14T14:23:20.142Z] Running test renaissance-als_0 ...
[2026-04-14T14:23:20.142Z] ===============================================
[2026-04-14T14:23:20.142Z] renaissance-als_0 Start Time: Tue Apr 14 14:23:19 2026 Epoch Time (ms): 1776176599375
[2026-04-14T14:23:20.142Z] variation: NoOptions
[2026-04-14T14:23:20.142Z] JVM_OPTIONS:
[2026-04-14T14:23:20.142Z] { \
[2026-04-14T14:23:20.142Z] echo ""; echo "TEST SETUP:"; \
[2026-04-14T14:23:20.142Z] echo "Nothing to be done for setup."; \
[2026-04-14T14:23:20.142Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17761765995271/renaissance-als_0"; \
[2026-04-14T14:23:20.142Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17761765995271/renaissance-als_0"; \
[2026-04-14T14:23:20.142Z] echo ""; echo "TESTING:"; \
[2026-04-14T14:23:20.142Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-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_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17761765995271/renaissance-als_0"/als.json" als; \
[2026-04-14T14:23:20.142Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17761765995271/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-04-14T14:23:20.142Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-04-14T14:23:20.142Z] echo "Nothing to be done for teardown."; \
[2026-04-14T14:23:20.142Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17761765995271/TestTargetResult";
[2026-04-14T14:23:20.142Z]
[2026-04-14T14:23:20.142Z] TEST SETUP:
[2026-04-14T14:23:20.142Z] Nothing to be done for setup.
[2026-04-14T14:23:20.142Z]
[2026-04-14T14:23:20.142Z] TESTING:
[2026-04-14T14:23:24.548Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-04-14T14:23:28.911Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-04-14T14:23:28.911Z] GC before operation: completed in 42.227 ms, heap usage 49.051 MB -> 34.955 MB.
[2026-04-14T14:23:50.712Z] ====== als (apache-spark) [default], iteration 0 completed (21618.646 ms) ======
[2026-04-14T14:23:50.712Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-04-14T14:23:50.712Z] GC before operation: completed in 82.134 ms, heap usage 118.277 MB -> 61.572 MB.
[2026-04-14T14:24:00.436Z] ====== als (apache-spark) [default], iteration 1 completed (9752.508 ms) ======
[2026-04-14T14:24:00.436Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-04-14T14:24:00.436Z] GC before operation: completed in 78.812 ms, heap usage 559.515 MB -> 63.307 MB.
[2026-04-14T14:24:13.996Z] ====== als (apache-spark) [default], iteration 2 completed (12279.132 ms) ======
[2026-04-14T14:24:13.996Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-04-14T14:24:13.996Z] GC before operation: completed in 86.007 ms, heap usage 592.540 MB -> 64.044 MB.
[2026-04-14T14:24:20.746Z] ====== als (apache-spark) [default], iteration 3 completed (7393.135 ms) ======
[2026-04-14T14:24:20.746Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-04-14T14:24:20.746Z] GC before operation: completed in 85.414 ms, heap usage 731.421 MB -> 64.794 MB.
[2026-04-14T14:24:28.947Z] ====== als (apache-spark) [default], iteration 4 completed (7277.940 ms) ======
[2026-04-14T14:24:28.947Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-04-14T14:24:28.947Z] GC before operation: completed in 81.481 ms, heap usage 403.289 MB -> 64.758 MB.
[2026-04-14T14:24:35.721Z] ====== als (apache-spark) [default], iteration 5 completed (7409.146 ms) ======
[2026-04-14T14:24:35.721Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-04-14T14:24:36.474Z] GC before operation: completed in 87.184 ms, heap usage 705.907 MB -> 65.783 MB.
[2026-04-14T14:24:46.081Z] ====== als (apache-spark) [default], iteration 6 completed (10034.692 ms) ======
[2026-04-14T14:24:46.081Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-04-14T14:24:46.081Z] GC before operation: completed in 85.663 ms, heap usage 178.398 MB -> 65.618 MB.
[2026-04-14T14:24:54.229Z] ====== als (apache-spark) [default], iteration 7 completed (7030.765 ms) ======
[2026-04-14T14:24:54.229Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-04-14T14:24:54.229Z] GC before operation: completed in 87.589 ms, heap usage 232.215 MB -> 66.274 MB.
[2026-04-14T14:25:00.985Z] ====== als (apache-spark) [default], iteration 8 completed (7103.406 ms) ======
[2026-04-14T14:25:00.985Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-04-14T14:25:00.985Z] GC before operation: completed in 85.197 ms, heap usage 498.629 MB -> 67.223 MB.
[2026-04-14T14:25:09.169Z] ====== als (apache-spark) [default], iteration 9 completed (6964.447 ms) ======
[2026-04-14T14:25:09.169Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-04-14T14:25:09.169Z] GC before operation: completed in 91.510 ms, heap usage 434.001 MB -> 67.403 MB.
[2026-04-14T14:25:15.916Z] ====== als (apache-spark) [default], iteration 10 completed (7221.723 ms) ======
[2026-04-14T14:25:15.916Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-04-14T14:25:15.916Z] GC before operation: completed in 89.159 ms, heap usage 176.206 MB -> 67.290 MB.
[2026-04-14T14:25:22.667Z] ====== als (apache-spark) [default], iteration 11 completed (7057.836 ms) ======
[2026-04-14T14:25:22.667Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-04-14T14:25:22.667Z] GC before operation: completed in 84.306 ms, heap usage 203.920 MB -> 67.518 MB.
[2026-04-14T14:25:30.805Z] ====== als (apache-spark) [default], iteration 12 completed (6783.027 ms) ======
[2026-04-14T14:25:30.805Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-04-14T14:25:30.805Z] GC before operation: completed in 84.730 ms, heap usage 118.880 MB -> 67.806 MB.
[2026-04-14T14:25:37.547Z] ====== als (apache-spark) [default], iteration 13 completed (6862.944 ms) ======
[2026-04-14T14:25:37.547Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-04-14T14:25:37.547Z] GC before operation: completed in 92.937 ms, heap usage 523.197 MB -> 68.550 MB.
[2026-04-14T14:25:44.345Z] ====== als (apache-spark) [default], iteration 14 completed (6717.036 ms) ======
[2026-04-14T14:25:44.345Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-04-14T14:25:44.345Z] GC before operation: completed in 89.480 ms, heap usage 253.096 MB -> 68.401 MB.
[2026-04-14T14:25:51.096Z] ====== als (apache-spark) [default], iteration 15 completed (6570.709 ms) ======
[2026-04-14T14:25:51.096Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-04-14T14:25:51.096Z] GC before operation: completed in 89.655 ms, heap usage 156.915 MB -> 68.629 MB.
[2026-04-14T14:25:57.841Z] ====== als (apache-spark) [default], iteration 16 completed (6733.927 ms) ======
[2026-04-14T14:25:57.841Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-04-14T14:25:57.841Z] GC before operation: completed in 89.877 ms, heap usage 296.328 MB -> 68.893 MB.
[2026-04-14T14:26:04.591Z] ====== als (apache-spark) [default], iteration 17 completed (6915.671 ms) ======
[2026-04-14T14:26:04.591Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-04-14T14:26:05.352Z] GC before operation: completed in 92.589 ms, heap usage 549.987 MB -> 69.693 MB.
[2026-04-14T14:26:13.496Z] ====== als (apache-spark) [default], iteration 18 completed (7925.864 ms) ======
[2026-04-14T14:26:13.496Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-04-14T14:26:13.496Z] GC before operation: completed in 92.144 ms, heap usage 410.470 MB -> 69.629 MB.
[2026-04-14T14:26:26.715Z] ====== als (apache-spark) [default], iteration 19 completed (6715.262 ms) ======
[2026-04-14T14:26:26.715Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-04-14T14:26:26.715Z] GC before operation: completed in 111.072 ms, heap usage 630.646 MB -> 70.217 MB.
[2026-04-14T14:26:36.455Z] ====== als (apache-spark) [default], iteration 20 completed (15178.519 ms) ======
[2026-04-14T14:26:36.455Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-04-14T14:26:36.455Z] GC before operation: completed in 94.067 ms, heap usage 511.426 MB -> 70.354 MB.
[2026-04-14T14:26:43.198Z] ====== als (apache-spark) [default], iteration 21 completed (6818.637 ms) ======
[2026-04-14T14:26:43.198Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-04-14T14:26:43.198Z] GC before operation: completed in 95.949 ms, heap usage 726.688 MB -> 70.936 MB.
[2026-04-14T14:26:49.940Z] ====== als (apache-spark) [default], iteration 22 completed (7392.072 ms) ======
[2026-04-14T14:26:49.940Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-04-14T14:26:50.692Z] GC before operation: completed in 112.298 ms, heap usage 404.172 MB -> 70.782 MB.
[2026-04-14T14:26:57.447Z] ====== als (apache-spark) [default], iteration 23 completed (6506.662 ms) ======
[2026-04-14T14:26:57.447Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-04-14T14:26:57.447Z] GC before operation: completed in 86.152 ms, heap usage 325.880 MB -> 70.858 MB.
[2026-04-14T14:27:04.196Z] ====== als (apache-spark) [default], iteration 24 completed (7001.748 ms) ======
[2026-04-14T14:27:04.196Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-04-14T14:27:04.196Z] GC before operation: completed in 87.509 ms, heap usage 339.356 MB -> 71.128 MB.
[2026-04-14T14:27:12.331Z] ====== als (apache-spark) [default], iteration 25 completed (6914.658 ms) ======
[2026-04-14T14:27:12.331Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-04-14T14:27:12.331Z] GC before operation: completed in 92.822 ms, heap usage 482.906 MB -> 71.730 MB.
[2026-04-14T14:27:19.946Z] ====== als (apache-spark) [default], iteration 26 completed (7628.185 ms) ======
[2026-04-14T14:27:19.946Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-04-14T14:27:19.946Z] GC before operation: completed in 98.016 ms, heap usage 711.119 MB -> 72.276 MB.
[2026-04-14T14:27:26.700Z] ====== als (apache-spark) [default], iteration 27 completed (7632.027 ms) ======
[2026-04-14T14:27:26.700Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-04-14T14:27:27.450Z] GC before operation: completed in 97.309 ms, heap usage 454.413 MB -> 71.755 MB.
[2026-04-14T14:27:34.188Z] ====== als (apache-spark) [default], iteration 28 completed (6582.686 ms) ======
[2026-04-14T14:27:34.188Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-04-14T14:27:34.188Z] GC before operation: completed in 95.527 ms, heap usage 334.534 MB -> 71.644 MB.
[2026-04-14T14:27:44.514Z] ====== als (apache-spark) [default], iteration 29 completed (9503.124 ms) ======
[2026-04-14T14:27:44.514Z] -----------------------------------
[2026-04-14T14:27:44.514Z] renaissance-als_0_PASSED
[2026-04-14T14:27:44.514Z] -----------------------------------
[2026-04-14T14:27:44.514Z]
[2026-04-14T14:27:44.514Z] TEST TEARDOWN:
[2026-04-14T14:27:44.514Z] Nothing to be done for teardown.
[2026-04-14T14:27:44.514Z] renaissance-als_0 Finish Time: Tue Apr 14 14:27:43 2026 Epoch Time (ms): 1776176863527