renaissance-als_0
[2026-02-11T23:11:33.779Z] Running test renaissance-als_0 ...
[2026-02-11T23:11:33.779Z] ===============================================
[2026-02-11T23:11:33.779Z] renaissance-als_0 Start Time: Wed Feb 11 23:11:33 2026 Epoch Time (ms): 1770851493259
[2026-02-11T23:11:33.779Z] variation: NoOptions
[2026-02-11T23:11:33.779Z] JVM_OPTIONS:
[2026-02-11T23:11:33.779Z] { \
[2026-02-11T23:11:33.779Z] echo ""; echo "TEST SETUP:"; \
[2026-02-11T23:11:33.779Z] echo "Nothing to be done for setup."; \
[2026-02-11T23:11:33.779Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17708514915483/renaissance-als_0"; \
[2026-02-11T23:11:33.779Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17708514915483/renaissance-als_0"; \
[2026-02-11T23:11:33.779Z] echo ""; echo "TESTING:"; \
[2026-02-11T23:11:33.779Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17708514915483/renaissance-als_0"/als.json" als; \
[2026-02-11T23:11:33.779Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17708514915483/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-11T23:11:33.779Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-11T23:11:33.779Z] echo "Nothing to be done for teardown."; \
[2026-02-11T23:11:33.779Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17708514915483/TestTargetResult";
[2026-02-11T23:11:33.779Z]
[2026-02-11T23:11:33.779Z] TEST SETUP:
[2026-02-11T23:11:33.779Z] Nothing to be done for setup.
[2026-02-11T23:11:33.779Z]
[2026-02-11T23:11:33.779Z] TESTING:
[2026-02-11T23:11:49.796Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-02-11T23:11:56.638Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-02-11T23:11:56.638Z] GC before operation: completed in 149.644 ms, heap usage 275.057 MB -> 35.022 MB.
[2026-02-11T23:12:53.566Z] ====== als (apache-spark) [default], iteration 0 completed (48810.958 ms) ======
[2026-02-11T23:12:53.566Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-02-11T23:12:53.566Z] GC before operation: completed in 211.988 ms, heap usage 161.803 MB -> 61.769 MB.
[2026-02-11T23:13:10.143Z] ====== als (apache-spark) [default], iteration 1 completed (21178.909 ms) ======
[2026-02-11T23:13:10.143Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-02-11T23:13:10.143Z] GC before operation: completed in 227.987 ms, heap usage 459.440 MB -> 63.085 MB.
[2026-02-11T23:13:26.263Z] ====== als (apache-spark) [default], iteration 2 completed (16688.284 ms) ======
[2026-02-11T23:13:26.263Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-02-11T23:13:26.263Z] GC before operation: completed in 238.782 ms, heap usage 440.217 MB -> 63.605 MB.
[2026-02-11T23:13:45.089Z] ====== als (apache-spark) [default], iteration 3 completed (16156.164 ms) ======
[2026-02-11T23:13:45.089Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-02-11T23:13:45.089Z] GC before operation: completed in 227.954 ms, heap usage 112.110 MB -> 63.705 MB.
[2026-02-11T23:14:01.179Z] ====== als (apache-spark) [default], iteration 4 completed (16830.687 ms) ======
[2026-02-11T23:14:01.179Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-02-11T23:14:01.179Z] GC before operation: completed in 243.787 ms, heap usage 257.637 MB -> 64.485 MB.
[2026-02-11T23:14:20.184Z] ====== als (apache-spark) [default], iteration 5 completed (16541.647 ms) ======
[2026-02-11T23:14:20.184Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-02-11T23:14:20.184Z] GC before operation: completed in 334.857 ms, heap usage 237.457 MB -> 65.008 MB.
[2026-02-11T23:14:36.308Z] ====== als (apache-spark) [default], iteration 6 completed (16807.494 ms) ======
[2026-02-11T23:14:36.308Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-02-11T23:14:36.308Z] GC before operation: completed in 179.681 ms, heap usage 356.683 MB -> 65.597 MB.
[2026-02-11T23:14:52.401Z] ====== als (apache-spark) [default], iteration 7 completed (14965.854 ms) ======
[2026-02-11T23:14:52.401Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-02-11T23:14:52.401Z] GC before operation: completed in 264.972 ms, heap usage 543.825 MB -> 66.498 MB.
[2026-02-11T23:15:08.490Z] ====== als (apache-spark) [default], iteration 8 completed (15231.991 ms) ======
[2026-02-11T23:15:08.490Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-02-11T23:15:08.490Z] GC before operation: completed in 240.291 ms, heap usage 532.390 MB -> 67.573 MB.
[2026-02-11T23:15:22.776Z] ====== als (apache-spark) [default], iteration 9 completed (14877.152 ms) ======
[2026-02-11T23:15:22.776Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-02-11T23:15:22.776Z] GC before operation: completed in 266.613 ms, heap usage 434.519 MB -> 67.615 MB.
[2026-02-11T23:15:41.708Z] ====== als (apache-spark) [default], iteration 10 completed (17131.895 ms) ======
[2026-02-11T23:15:41.708Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-02-11T23:15:41.708Z] GC before operation: completed in 230.709 ms, heap usage 492.382 MB -> 67.418 MB.
[2026-02-11T23:15:55.402Z] ====== als (apache-spark) [default], iteration 11 completed (14539.485 ms) ======
[2026-02-11T23:15:55.402Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-02-11T23:15:56.180Z] GC before operation: completed in 357.544 ms, heap usage 451.008 MB -> 67.699 MB.
[2026-02-11T23:16:12.276Z] ====== als (apache-spark) [default], iteration 12 completed (15659.260 ms) ======
[2026-02-11T23:16:12.276Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-02-11T23:16:12.276Z] GC before operation: completed in 270.443 ms, heap usage 351.146 MB -> 67.733 MB.
[2026-02-11T23:16:28.809Z] ====== als (apache-spark) [default], iteration 13 completed (15314.347 ms) ======
[2026-02-11T23:16:28.809Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-02-11T23:16:28.809Z] GC before operation: completed in 274.431 ms, heap usage 116.010 MB -> 67.709 MB.
[2026-02-11T23:16:45.073Z] ====== als (apache-spark) [default], iteration 14 completed (15793.801 ms) ======
[2026-02-11T23:16:45.073Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-02-11T23:16:45.073Z] GC before operation: completed in 253.143 ms, heap usage 271.767 MB -> 68.158 MB.
[2026-02-11T23:17:01.220Z] ====== als (apache-spark) [default], iteration 15 completed (14908.083 ms) ======
[2026-02-11T23:17:01.220Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-02-11T23:17:01.220Z] GC before operation: completed in 226.283 ms, heap usage 179.362 MB -> 68.239 MB.
[2026-02-11T23:17:17.301Z] ====== als (apache-spark) [default], iteration 16 completed (15280.825 ms) ======
[2026-02-11T23:17:17.301Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-02-11T23:17:17.301Z] GC before operation: completed in 214.261 ms, heap usage 545.843 MB -> 68.988 MB.
[2026-02-11T23:17:31.117Z] ====== als (apache-spark) [default], iteration 17 completed (14718.566 ms) ======
[2026-02-11T23:17:31.117Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-02-11T23:17:31.886Z] GC before operation: completed in 266.731 ms, heap usage 442.767 MB -> 69.149 MB.
[2026-02-11T23:17:46.165Z] ====== als (apache-spark) [default], iteration 18 completed (13313.094 ms) ======
[2026-02-11T23:17:46.165Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-02-11T23:17:46.165Z] GC before operation: completed in 262.158 ms, heap usage 210.496 MB -> 69.176 MB.
[2026-02-11T23:17:59.979Z] ====== als (apache-spark) [default], iteration 19 completed (13458.360 ms) ======
[2026-02-11T23:17:59.979Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-02-11T23:17:59.979Z] GC before operation: completed in 291.508 ms, heap usage 559.749 MB -> 69.879 MB.
[2026-02-11T23:18:16.103Z] ====== als (apache-spark) [default], iteration 20 completed (15409.879 ms) ======
[2026-02-11T23:18:16.103Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-02-11T23:18:16.103Z] GC before operation: completed in 208.873 ms, heap usage 321.915 MB -> 69.769 MB.
[2026-02-11T23:18:32.179Z] ====== als (apache-spark) [default], iteration 21 completed (15804.061 ms) ======
[2026-02-11T23:18:32.179Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-02-11T23:18:32.969Z] GC before operation: completed in 214.760 ms, heap usage 486.334 MB -> 70.323 MB.
[2026-02-11T23:18:49.570Z] ====== als (apache-spark) [default], iteration 22 completed (14593.232 ms) ======
[2026-02-11T23:18:49.570Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-02-11T23:18:49.570Z] GC before operation: completed in 199.285 ms, heap usage 367.114 MB -> 70.286 MB.
[2026-02-11T23:19:03.296Z] ====== als (apache-spark) [default], iteration 23 completed (14627.033 ms) ======
[2026-02-11T23:19:03.296Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-02-11T23:19:03.296Z] GC before operation: completed in 218.530 ms, heap usage 234.581 MB -> 70.429 MB.
[2026-02-11T23:19:17.013Z] ====== als (apache-spark) [default], iteration 24 completed (13365.077 ms) ======
[2026-02-11T23:19:17.013Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-02-11T23:19:17.013Z] GC before operation: completed in 236.948 ms, heap usage 286.049 MB -> 70.679 MB.
[2026-02-11T23:19:30.774Z] ====== als (apache-spark) [default], iteration 25 completed (13053.845 ms) ======
[2026-02-11T23:19:30.774Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-02-11T23:19:30.774Z] GC before operation: completed in 192.799 ms, heap usage 520.135 MB -> 71.344 MB.
[2026-02-11T23:19:44.434Z] ====== als (apache-spark) [default], iteration 26 completed (13576.648 ms) ======
[2026-02-11T23:19:44.434Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-02-11T23:19:44.434Z] GC before operation: completed in 187.255 ms, heap usage 160.248 MB -> 71.132 MB.
[2026-02-11T23:19:58.439Z] ====== als (apache-spark) [default], iteration 27 completed (13662.072 ms) ======
[2026-02-11T23:19:58.439Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-02-11T23:19:59.227Z] GC before operation: completed in 229.581 ms, heap usage 465.589 MB -> 71.351 MB.
[2026-02-11T23:20:15.420Z] ====== als (apache-spark) [default], iteration 28 completed (14250.425 ms) ======
[2026-02-11T23:20:15.420Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-02-11T23:20:15.420Z] GC before operation: completed in 236.832 ms, heap usage 289.524 MB -> 71.292 MB.
[2026-02-11T23:20:27.093Z] ====== als (apache-spark) [default], iteration 29 completed (13171.984 ms) ======
[2026-02-11T23:20:27.853Z] -----------------------------------
[2026-02-11T23:20:27.853Z] renaissance-als_0_PASSED
[2026-02-11T23:20:27.853Z] -----------------------------------
[2026-02-11T23:20:27.853Z]
[2026-02-11T23:20:27.853Z] TEST TEARDOWN:
[2026-02-11T23:20:27.853Z] Nothing to be done for teardown.
[2026-02-11T23:20:27.853Z] renaissance-als_0 Finish Time: Wed Feb 11 23:20:27 2026 Epoch Time (ms): 1770852027555