renaissance-als_0
[2026-02-18T22:05:15.854Z] Running test renaissance-als_0 ...
[2026-02-18T22:05:15.854Z] ===============================================
[2026-02-18T22:05:15.854Z] renaissance-als_0 Start Time: Wed Feb 18 22:05:15 2026 Epoch Time (ms): 1771452315038
[2026-02-18T22:05:15.854Z] variation: NoOptions
[2026-02-18T22:05:15.854Z] JVM_OPTIONS:
[2026-02-18T22:05:15.854Z] { \
[2026-02-18T22:05:15.854Z] echo ""; echo "TEST SETUP:"; \
[2026-02-18T22:05:15.854Z] echo "Nothing to be done for setup."; \
[2026-02-18T22:05:15.854Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17714521596665/renaissance-als_0"; \
[2026-02-18T22:05:15.854Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17714521596665/renaissance-als_0"; \
[2026-02-18T22:05:15.854Z] echo ""; echo "TESTING:"; \
[2026-02-18T22:05:15.854Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17714521596665/renaissance-als_0"/als.json" als; \
[2026-02-18T22:05:15.854Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17714521596665/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-18T22:05:15.854Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-18T22:05:15.854Z] echo "Nothing to be done for teardown."; \
[2026-02-18T22:05:15.855Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17714521596665/TestTargetResult";
[2026-02-18T22:05:15.855Z]
[2026-02-18T22:05:15.855Z] TEST SETUP:
[2026-02-18T22:05:15.855Z] Nothing to be done for setup.
[2026-02-18T22:05:15.855Z]
[2026-02-18T22:05:15.855Z] TESTING:
[2026-02-18T22:05:21.290Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-02-18T22:05:24.351Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-02-18T22:05:24.351Z] GC before operation: completed in 48.635 ms, heap usage 177.500 MB -> 35.129 MB.
[2026-02-18T22:05:42.976Z] ====== als (apache-spark) [default], iteration 0 completed (17044.742 ms) ======
[2026-02-18T22:05:42.976Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-02-18T22:05:42.976Z] GC before operation: completed in 101.406 ms, heap usage 405.939 MB -> 62.183 MB.
[2026-02-18T22:05:51.195Z] ====== als (apache-spark) [default], iteration 1 completed (7794.383 ms) ======
[2026-02-18T22:05:51.195Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-02-18T22:05:51.195Z] GC before operation: completed in 93.645 ms, heap usage 559.050 MB -> 63.400 MB.
[2026-02-18T22:05:57.572Z] ====== als (apache-spark) [default], iteration 2 completed (7228.592 ms) ======
[2026-02-18T22:05:57.572Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-02-18T22:05:58.533Z] GC before operation: completed in 88.602 ms, heap usage 351.092 MB -> 63.683 MB.
[2026-02-18T22:06:05.316Z] ====== als (apache-spark) [default], iteration 3 completed (7044.115 ms) ======
[2026-02-18T22:06:05.317Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-02-18T22:06:05.317Z] GC before operation: completed in 86.275 ms, heap usage 429.364 MB -> 64.534 MB.
[2026-02-18T22:06:12.164Z] ====== als (apache-spark) [default], iteration 4 completed (6699.788 ms) ======
[2026-02-18T22:06:12.164Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-02-18T22:06:12.164Z] GC before operation: completed in 90.916 ms, heap usage 272.310 MB -> 64.680 MB.
[2026-02-18T22:06:18.945Z] ====== als (apache-spark) [default], iteration 5 completed (6657.740 ms) ======
[2026-02-18T22:06:18.945Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-02-18T22:06:19.910Z] GC before operation: completed in 95.763 ms, heap usage 483.818 MB -> 65.616 MB.
[2026-02-18T22:06:26.701Z] ====== als (apache-spark) [default], iteration 6 completed (6619.003 ms) ======
[2026-02-18T22:06:26.701Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-02-18T22:06:26.701Z] GC before operation: completed in 96.050 ms, heap usage 432.287 MB -> 66.217 MB.
[2026-02-18T22:06:33.511Z] ====== als (apache-spark) [default], iteration 7 completed (6700.483 ms) ======
[2026-02-18T22:06:33.511Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-02-18T22:06:33.511Z] GC before operation: completed in 93.494 ms, heap usage 103.538 MB -> 66.166 MB.
[2026-02-18T22:06:40.428Z] ====== als (apache-spark) [default], iteration 8 completed (6649.582 ms) ======
[2026-02-18T22:06:40.428Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-02-18T22:06:40.428Z] GC before operation: completed in 90.426 ms, heap usage 342.469 MB -> 67.143 MB.
[2026-02-18T22:06:47.313Z] ====== als (apache-spark) [default], iteration 9 completed (6551.309 ms) ======
[2026-02-18T22:06:47.313Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-02-18T22:06:47.313Z] GC before operation: completed in 94.261 ms, heap usage 146.859 MB -> 67.020 MB.
[2026-02-18T22:06:54.205Z] ====== als (apache-spark) [default], iteration 10 completed (6662.079 ms) ======
[2026-02-18T22:06:54.205Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-02-18T22:06:54.205Z] GC before operation: completed in 93.336 ms, heap usage 433.512 MB -> 67.752 MB.
[2026-02-18T22:07:01.728Z] ====== als (apache-spark) [default], iteration 11 completed (6540.744 ms) ======
[2026-02-18T22:07:01.728Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-02-18T22:07:01.728Z] GC before operation: completed in 95.578 ms, heap usage 269.257 MB -> 67.644 MB.
[2026-02-18T22:07:08.560Z] ====== als (apache-spark) [default], iteration 12 completed (6519.158 ms) ======
[2026-02-18T22:07:08.560Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-02-18T22:07:08.560Z] GC before operation: completed in 89.686 ms, heap usage 296.508 MB -> 68.021 MB.
[2026-02-18T22:07:15.319Z] ====== als (apache-spark) [default], iteration 13 completed (6450.300 ms) ======
[2026-02-18T22:07:15.319Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-02-18T22:07:15.319Z] GC before operation: completed in 102.255 ms, heap usage 193.274 MB -> 68.176 MB.
[2026-02-18T22:07:22.207Z] ====== als (apache-spark) [default], iteration 14 completed (6543.382 ms) ======
[2026-02-18T22:07:22.207Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-02-18T22:07:22.207Z] GC before operation: completed in 112.893 ms, heap usage 229.291 MB -> 68.575 MB.
[2026-02-18T22:07:28.979Z] ====== als (apache-spark) [default], iteration 15 completed (6529.387 ms) ======
[2026-02-18T22:07:28.979Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-02-18T22:07:28.979Z] GC before operation: completed in 94.760 ms, heap usage 353.163 MB -> 68.933 MB.
[2026-02-18T22:07:34.409Z] ====== als (apache-spark) [default], iteration 16 completed (6281.410 ms) ======
[2026-02-18T22:07:34.409Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-02-18T22:07:35.367Z] GC before operation: completed in 95.482 ms, heap usage 574.711 MB -> 69.513 MB.
[2026-02-18T22:07:41.338Z] ====== als (apache-spark) [default], iteration 17 completed (6306.613 ms) ======
[2026-02-18T22:07:41.338Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-02-18T22:07:41.338Z] GC before operation: completed in 98.034 ms, heap usage 458.062 MB -> 69.614 MB.
[2026-02-18T22:07:48.178Z] ====== als (apache-spark) [default], iteration 18 completed (6515.520 ms) ======
[2026-02-18T22:07:48.178Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-02-18T22:07:48.178Z] GC before operation: completed in 114.285 ms, heap usage 501.903 MB -> 69.921 MB.
[2026-02-18T22:07:54.920Z] ====== als (apache-spark) [default], iteration 19 completed (6534.272 ms) ======
[2026-02-18T22:07:54.920Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-02-18T22:07:54.920Z] GC before operation: completed in 102.926 ms, heap usage 446.602 MB -> 70.064 MB.
[2026-02-18T22:08:01.650Z] ====== als (apache-spark) [default], iteration 20 completed (6553.510 ms) ======
[2026-02-18T22:08:01.650Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-02-18T22:08:01.650Z] GC before operation: completed in 117.958 ms, heap usage 380.360 MB -> 69.984 MB.
[2026-02-18T22:08:09.445Z] ====== als (apache-spark) [default], iteration 21 completed (6444.896 ms) ======
[2026-02-18T22:08:09.445Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-02-18T22:08:09.445Z] GC before operation: completed in 109.259 ms, heap usage 122.723 MB -> 70.026 MB.
[2026-02-18T22:08:14.847Z] ====== als (apache-spark) [default], iteration 22 completed (6405.377 ms) ======
[2026-02-18T22:08:14.847Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-02-18T22:08:15.806Z] GC before operation: completed in 103.417 ms, heap usage 363.330 MB -> 70.643 MB.
[2026-02-18T22:08:22.538Z] ====== als (apache-spark) [default], iteration 23 completed (6437.777 ms) ======
[2026-02-18T22:08:22.538Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-02-18T22:08:22.538Z] GC before operation: completed in 92.159 ms, heap usage 479.692 MB -> 71.098 MB.
[2026-02-18T22:08:29.324Z] ====== als (apache-spark) [default], iteration 24 completed (6466.250 ms) ======
[2026-02-18T22:08:29.324Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-02-18T22:08:29.324Z] GC before operation: completed in 89.241 ms, heap usage 209.117 MB -> 70.928 MB.
[2026-02-18T22:08:36.061Z] ====== als (apache-spark) [default], iteration 25 completed (6307.970 ms) ======
[2026-02-18T22:08:36.061Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-02-18T22:08:36.061Z] GC before operation: completed in 89.920 ms, heap usage 162.160 MB -> 71.195 MB.
[2026-02-18T22:08:42.799Z] ====== als (apache-spark) [default], iteration 26 completed (6383.252 ms) ======
[2026-02-18T22:08:42.799Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-02-18T22:08:42.799Z] GC before operation: completed in 80.333 ms, heap usage 335.381 MB -> 71.751 MB.
[2026-02-18T22:08:48.206Z] ====== als (apache-spark) [default], iteration 27 completed (6334.351 ms) ======
[2026-02-18T22:08:48.206Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-02-18T22:08:49.166Z] GC before operation: completed in 78.305 ms, heap usage 207.370 MB -> 71.695 MB.
[2026-02-18T22:08:55.893Z] ====== als (apache-spark) [default], iteration 28 completed (6374.263 ms) ======
[2026-02-18T22:08:55.893Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-02-18T22:08:55.893Z] GC before operation: completed in 84.006 ms, heap usage 261.325 MB -> 71.565 MB.
[2026-02-18T22:09:02.647Z] ====== als (apache-spark) [default], iteration 29 completed (6253.292 ms) ======
[2026-02-18T22:09:02.647Z] -----------------------------------
[2026-02-18T22:09:02.647Z] renaissance-als_0_PASSED
[2026-02-18T22:09:02.647Z] -----------------------------------
[2026-02-18T22:09:02.647Z]
[2026-02-18T22:09:02.647Z] TEST TEARDOWN:
[2026-02-18T22:09:02.647Z] Nothing to be done for teardown.
[2026-02-18T22:09:02.647Z] renaissance-als_0 Finish Time: Wed Feb 18 22:09:01 2026 Epoch Time (ms): 1771452541635