renaissance-als_0
[2026-02-04T22:54:59.263Z] Running test renaissance-als_0 ...
[2026-02-04T22:54:59.263Z] ===============================================
[2026-02-04T22:54:59.263Z] renaissance-als_0 Start Time: Wed Feb 4 22:54:59 2026 Epoch Time (ms): 1770245699050
[2026-02-04T22:54:59.263Z] variation: NoOptions
[2026-02-04T22:54:59.263Z] JVM_OPTIONS:
[2026-02-04T22:54:59.263Z] { \
[2026-02-04T22:54:59.263Z] echo ""; echo "TEST SETUP:"; \
[2026-02-04T22:54:59.263Z] echo "Nothing to be done for setup."; \
[2026-02-04T22:54:59.263Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702455344664/renaissance-als_0"; \
[2026-02-04T22:54:59.263Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702455344664/renaissance-als_0"; \
[2026-02-04T22:54:59.263Z] echo ""; echo "TESTING:"; \
[2026-02-04T22:54:59.263Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702455344664/renaissance-als_0"/als.json" als; \
[2026-02-04T22:54:59.263Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702455344664/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-04T22:54:59.263Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-04T22:54:59.263Z] echo "Nothing to be done for teardown."; \
[2026-02-04T22:54:59.263Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702455344664/TestTargetResult";
[2026-02-04T22:54:59.263Z]
[2026-02-04T22:54:59.263Z] TEST SETUP:
[2026-02-04T22:54:59.263Z] Nothing to be done for setup.
[2026-02-04T22:54:59.263Z]
[2026-02-04T22:54:59.263Z] TESTING:
[2026-02-04T22:55:04.780Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-02-04T22:55:08.997Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-02-04T22:55:08.997Z] GC before operation: completed in 47.855 ms, heap usage 160.000 MB -> 35.128 MB.
[2026-02-04T22:55:27.540Z] ====== als (apache-spark) [default], iteration 0 completed (16936.479 ms) ======
[2026-02-04T22:55:27.540Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-02-04T22:55:27.540Z] GC before operation: completed in 102.804 ms, heap usage 484.016 MB -> 62.270 MB.
[2026-02-04T22:55:35.823Z] ====== als (apache-spark) [default], iteration 1 completed (7880.160 ms) ======
[2026-02-04T22:55:35.823Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-02-04T22:55:35.823Z] GC before operation: completed in 78.450 ms, heap usage 557.281 MB -> 63.369 MB.
[2026-02-04T22:55:42.619Z] ====== als (apache-spark) [default], iteration 2 completed (7178.435 ms) ======
[2026-02-04T22:55:42.619Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-02-04T22:55:42.619Z] GC before operation: completed in 77.278 ms, heap usage 541.386 MB -> 63.989 MB.
[2026-02-04T22:55:49.398Z] ====== als (apache-spark) [default], iteration 3 completed (6825.511 ms) ======
[2026-02-04T22:55:49.398Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-02-04T22:55:49.398Z] GC before operation: completed in 79.972 ms, heap usage 224.399 MB -> 64.103 MB.
[2026-02-04T22:55:56.230Z] ====== als (apache-spark) [default], iteration 4 completed (6765.608 ms) ======
[2026-02-04T22:55:56.230Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-02-04T22:55:57.214Z] GC before operation: completed in 79.104 ms, heap usage 398.256 MB -> 64.978 MB.
[2026-02-04T22:56:04.058Z] ====== als (apache-spark) [default], iteration 5 completed (6688.201 ms) ======
[2026-02-04T22:56:04.058Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-02-04T22:56:04.058Z] GC before operation: completed in 83.601 ms, heap usage 694.756 MB -> 65.885 MB.
[2026-02-04T22:56:10.984Z] ====== als (apache-spark) [default], iteration 6 completed (6634.217 ms) ======
[2026-02-04T22:56:10.984Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-02-04T22:56:10.984Z] GC before operation: completed in 78.473 ms, heap usage 294.545 MB -> 65.912 MB.
[2026-02-04T22:56:17.830Z] ====== als (apache-spark) [default], iteration 7 completed (6646.834 ms) ======
[2026-02-04T22:56:17.830Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-02-04T22:56:17.830Z] GC before operation: completed in 90.303 ms, heap usage 275.181 MB -> 66.414 MB.
[2026-02-04T22:56:24.594Z] ====== als (apache-spark) [default], iteration 8 completed (6588.031 ms) ======
[2026-02-04T22:56:24.594Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-02-04T22:56:24.594Z] GC before operation: completed in 96.013 ms, heap usage 597.928 MB -> 67.484 MB.
[2026-02-04T22:56:31.350Z] ====== als (apache-spark) [default], iteration 9 completed (6656.280 ms) ======
[2026-02-04T22:56:31.350Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-02-04T22:56:31.350Z] GC before operation: completed in 92.463 ms, heap usage 608.307 MB -> 67.542 MB.
[2026-02-04T22:56:38.125Z] ====== als (apache-spark) [default], iteration 10 completed (6596.561 ms) ======
[2026-02-04T22:56:38.125Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-02-04T22:56:38.125Z] GC before operation: completed in 96.877 ms, heap usage 228.843 MB -> 67.430 MB.
[2026-02-04T22:56:44.951Z] ====== als (apache-spark) [default], iteration 11 completed (6591.107 ms) ======
[2026-02-04T22:56:44.951Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-02-04T22:56:44.951Z] GC before operation: completed in 88.130 ms, heap usage 638.906 MB -> 68.293 MB.
[2026-02-04T22:56:51.883Z] ====== als (apache-spark) [default], iteration 12 completed (6527.320 ms) ======
[2026-02-04T22:56:51.883Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-02-04T22:56:51.883Z] GC before operation: completed in 89.931 ms, heap usage 233.680 MB -> 68.022 MB.
[2026-02-04T22:56:58.672Z] ====== als (apache-spark) [default], iteration 13 completed (6516.404 ms) ======
[2026-02-04T22:56:58.672Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-02-04T22:56:58.672Z] GC before operation: completed in 96.412 ms, heap usage 714.168 MB -> 68.953 MB.
[2026-02-04T22:57:05.547Z] ====== als (apache-spark) [default], iteration 14 completed (6628.553 ms) ======
[2026-02-04T22:57:05.547Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-02-04T22:57:05.547Z] GC before operation: completed in 96.806 ms, heap usage 648.466 MB -> 68.970 MB.
[2026-02-04T22:57:12.320Z] ====== als (apache-spark) [default], iteration 15 completed (6567.819 ms) ======
[2026-02-04T22:57:12.320Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-02-04T22:57:12.320Z] GC before operation: completed in 84.650 ms, heap usage 477.707 MB -> 69.265 MB.
[2026-02-04T22:57:19.391Z] ====== als (apache-spark) [default], iteration 16 completed (6548.349 ms) ======
[2026-02-04T22:57:19.391Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-02-04T22:57:19.391Z] GC before operation: completed in 91.497 ms, heap usage 134.421 MB -> 69.073 MB.
[2026-02-04T22:57:26.228Z] ====== als (apache-spark) [default], iteration 17 completed (6512.217 ms) ======
[2026-02-04T22:57:26.228Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-02-04T22:57:26.228Z] GC before operation: completed in 86.657 ms, heap usage 262.517 MB -> 69.351 MB.
[2026-02-04T22:57:33.346Z] ====== als (apache-spark) [default], iteration 18 completed (6719.035 ms) ======
[2026-02-04T22:57:33.346Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-02-04T22:57:33.346Z] GC before operation: completed in 85.334 ms, heap usage 281.039 MB -> 69.665 MB.
[2026-02-04T22:57:40.289Z] ====== als (apache-spark) [default], iteration 19 completed (6742.480 ms) ======
[2026-02-04T22:57:40.289Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-02-04T22:57:40.289Z] GC before operation: completed in 96.177 ms, heap usage 181.489 MB -> 69.796 MB.
[2026-02-04T22:57:47.074Z] ====== als (apache-spark) [default], iteration 20 completed (6721.469 ms) ======
[2026-02-04T22:57:47.074Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-02-04T22:57:47.075Z] GC before operation: completed in 87.265 ms, heap usage 255.315 MB -> 70.094 MB.
[2026-02-04T22:57:55.495Z] ====== als (apache-spark) [default], iteration 21 completed (7008.502 ms) ======
[2026-02-04T22:57:55.495Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-02-04T22:57:55.495Z] GC before operation: completed in 103.346 ms, heap usage 381.573 MB -> 70.476 MB.
[2026-02-04T22:58:02.262Z] ====== als (apache-spark) [default], iteration 22 completed (6722.988 ms) ======
[2026-02-04T22:58:02.263Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-02-04T22:58:02.263Z] GC before operation: completed in 104.310 ms, heap usage 353.298 MB -> 70.671 MB.
[2026-02-04T22:58:09.059Z] ====== als (apache-spark) [default], iteration 23 completed (6715.786 ms) ======
[2026-02-04T22:58:09.059Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-02-04T22:58:09.059Z] GC before operation: completed in 106.183 ms, heap usage 170.918 MB -> 70.726 MB.
[2026-02-04T22:58:16.012Z] ====== als (apache-spark) [default], iteration 24 completed (6521.614 ms) ======
[2026-02-04T22:58:16.012Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-02-04T22:58:16.012Z] GC before operation: completed in 95.312 ms, heap usage 269.220 MB -> 71.278 MB.
[2026-02-04T22:58:22.772Z] ====== als (apache-spark) [default], iteration 25 completed (6725.730 ms) ======
[2026-02-04T22:58:22.772Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-02-04T22:58:22.772Z] GC before operation: completed in 97.740 ms, heap usage 490.986 MB -> 71.708 MB.
[2026-02-04T22:58:29.635Z] ====== als (apache-spark) [default], iteration 26 completed (6607.841 ms) ======
[2026-02-04T22:58:29.635Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-02-04T22:58:29.635Z] GC before operation: completed in 98.074 ms, heap usage 146.682 MB -> 71.462 MB.
[2026-02-04T22:58:36.570Z] ====== als (apache-spark) [default], iteration 27 completed (6539.569 ms) ======
[2026-02-04T22:58:36.570Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-02-04T22:58:36.570Z] GC before operation: completed in 96.597 ms, heap usage 283.029 MB -> 71.561 MB.
[2026-02-04T22:58:43.386Z] ====== als (apache-spark) [default], iteration 28 completed (6618.271 ms) ======
[2026-02-04T22:58:43.386Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-02-04T22:58:43.386Z] GC before operation: completed in 97.627 ms, heap usage 499.845 MB -> 72.219 MB.
[2026-02-04T22:58:50.175Z] ====== als (apache-spark) [default], iteration 29 completed (6646.466 ms) ======
[2026-02-04T22:58:50.175Z] -----------------------------------
[2026-02-04T22:58:50.175Z] renaissance-als_0_PASSED
[2026-02-04T22:58:50.175Z] -----------------------------------
[2026-02-04T22:58:50.175Z]
[2026-02-04T22:58:50.175Z] TEST TEARDOWN:
[2026-02-04T22:58:50.175Z] Nothing to be done for teardown.
[2026-02-04T22:58:50.175Z] renaissance-als_0 Finish Time: Wed Feb 4 22:58:49 2026 Epoch Time (ms): 1770245929936