renaissance-als_0
[2026-04-15T13:58:27.662Z] Running test renaissance-als_0 ...
[2026-04-15T13:58:27.662Z] ===============================================
[2026-04-15T13:58:27.662Z] renaissance-als_0 Start Time: Wed Apr 15 13:58:26 2026 Epoch Time (ms): 1776261506886
[2026-04-15T13:58:27.662Z] variation: NoOptions
[2026-04-15T13:58:27.662Z] JVM_OPTIONS:
[2026-04-15T13:58:27.662Z] { \
[2026-04-15T13:58:27.662Z] echo ""; echo "TEST SETUP:"; \
[2026-04-15T13:58:27.662Z] echo "Nothing to be done for setup."; \
[2026-04-15T13:58:27.662Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17762613308375/renaissance-als_0"; \
[2026-04-15T13:58:27.662Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17762613308375/renaissance-als_0"; \
[2026-04-15T13:58:27.662Z] echo ""; echo "TESTING:"; \
[2026-04-15T13:58:27.662Z] "/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_17762613308375/renaissance-als_0"/als.json" als; \
[2026-04-15T13:58:27.662Z] 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_17762613308375/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-04-15T13:58:27.662Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-04-15T13:58:27.662Z] echo "Nothing to be done for teardown."; \
[2026-04-15T13:58:27.662Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17762613308375/TestTargetResult";
[2026-04-15T13:58:27.662Z]
[2026-04-15T13:58:27.662Z] TEST SETUP:
[2026-04-15T13:58:27.662Z] Nothing to be done for setup.
[2026-04-15T13:58:27.662Z]
[2026-04-15T13:58:27.662Z] TESTING:
[2026-04-15T13:58:32.510Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-04-15T13:58:36.647Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-04-15T13:58:36.647Z] GC before operation: completed in 49.294 ms, heap usage 404.000 MB -> 35.120 MB.
[2026-04-15T13:58:54.955Z] ====== als (apache-spark) [default], iteration 0 completed (16814.022 ms) ======
[2026-04-15T13:58:54.955Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-04-15T13:58:54.955Z] GC before operation: completed in 93.616 ms, heap usage 343.991 MB -> 62.216 MB.
[2026-04-15T13:59:03.094Z] ====== als (apache-spark) [default], iteration 1 completed (7805.737 ms) ======
[2026-04-15T13:59:03.094Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-04-15T13:59:03.094Z] GC before operation: completed in 80.833 ms, heap usage 511.311 MB -> 63.379 MB.
[2026-04-15T13:59:09.818Z] ====== als (apache-spark) [default], iteration 2 completed (7365.129 ms) ======
[2026-04-15T13:59:09.818Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-04-15T13:59:09.818Z] GC before operation: completed in 80.854 ms, heap usage 616.747 MB -> 64.018 MB.
[2026-04-15T13:59:17.939Z] ====== als (apache-spark) [default], iteration 3 completed (6817.783 ms) ======
[2026-04-15T13:59:17.939Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-04-15T13:59:17.939Z] GC before operation: completed in 83.848 ms, heap usage 437.315 MB -> 64.334 MB.
[2026-04-15T13:59:25.304Z] ====== als (apache-spark) [default], iteration 4 completed (7103.013 ms) ======
[2026-04-15T13:59:25.304Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-04-15T13:59:25.304Z] GC before operation: completed in 87.573 ms, heap usage 525.026 MB -> 64.950 MB.
[2026-04-15T13:59:31.979Z] ====== als (apache-spark) [default], iteration 5 completed (6879.324 ms) ======
[2026-04-15T13:59:31.979Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-04-15T13:59:31.979Z] GC before operation: completed in 98.625 ms, heap usage 124.537 MB -> 65.151 MB.
[2026-04-15T13:59:38.735Z] ====== als (apache-spark) [default], iteration 6 completed (6901.340 ms) ======
[2026-04-15T13:59:38.735Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-04-15T13:59:39.684Z] GC before operation: completed in 86.861 ms, heap usage 156.932 MB -> 65.682 MB.
[2026-04-15T13:59:46.397Z] ====== als (apache-spark) [default], iteration 7 completed (6917.578 ms) ======
[2026-04-15T13:59:46.397Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-04-15T13:59:46.397Z] GC before operation: completed in 136.935 ms, heap usage 580.598 MB -> 66.671 MB.
[2026-04-15T13:59:54.537Z] ====== als (apache-spark) [default], iteration 8 completed (7003.881 ms) ======
[2026-04-15T13:59:54.537Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-04-15T13:59:54.537Z] GC before operation: completed in 87.051 ms, heap usage 203.725 MB -> 66.955 MB.
[2026-04-15T14:00:02.612Z] ====== als (apache-spark) [default], iteration 9 completed (7612.671 ms) ======
[2026-04-15T14:00:02.612Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-04-15T14:00:02.612Z] GC before operation: completed in 83.073 ms, heap usage 332.497 MB -> 67.192 MB.
[2026-04-15T14:00:09.281Z] ====== als (apache-spark) [default], iteration 10 completed (6876.788 ms) ======
[2026-04-15T14:00:09.281Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-04-15T14:00:09.281Z] GC before operation: completed in 96.993 ms, heap usage 237.013 MB -> 67.254 MB.
[2026-04-15T14:00:18.059Z] ====== als (apache-spark) [default], iteration 11 completed (7386.948 ms) ======
[2026-04-15T14:00:18.059Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-04-15T14:00:18.059Z] GC before operation: completed in 88.488 ms, heap usage 509.650 MB -> 67.846 MB.
[2026-04-15T14:00:23.412Z] ====== als (apache-spark) [default], iteration 12 completed (6856.710 ms) ======
[2026-04-15T14:00:23.412Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-04-15T14:00:23.412Z] GC before operation: completed in 92.503 ms, heap usage 225.446 MB -> 67.854 MB.
[2026-04-15T14:00:30.320Z] ====== als (apache-spark) [default], iteration 13 completed (6859.418 ms) ======
[2026-04-15T14:00:30.320Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-04-15T14:00:31.271Z] GC before operation: completed in 92.347 ms, heap usage 413.682 MB -> 68.353 MB.
[2026-04-15T14:00:38.216Z] ====== als (apache-spark) [default], iteration 14 completed (6868.571 ms) ======
[2026-04-15T14:00:38.216Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-04-15T14:00:38.216Z] GC before operation: completed in 113.073 ms, heap usage 474.839 MB -> 68.732 MB.
[2026-04-15T14:00:44.967Z] ====== als (apache-spark) [default], iteration 15 completed (6878.776 ms) ======
[2026-04-15T14:00:44.967Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-04-15T14:00:44.967Z] GC before operation: completed in 105.708 ms, heap usage 252.874 MB -> 68.604 MB.
[2026-04-15T14:00:53.098Z] ====== als (apache-spark) [default], iteration 16 completed (6707.655 ms) ======
[2026-04-15T14:00:53.098Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-04-15T14:00:53.098Z] GC before operation: completed in 80.678 ms, heap usage 257.231 MB -> 68.962 MB.
[2026-04-15T14:00:59.825Z] ====== als (apache-spark) [default], iteration 17 completed (6685.302 ms) ======
[2026-04-15T14:00:59.825Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-04-15T14:00:59.825Z] GC before operation: completed in 83.531 ms, heap usage 476.110 MB -> 69.463 MB.
[2026-04-15T14:01:07.195Z] ====== als (apache-spark) [default], iteration 18 completed (6774.237 ms) ======
[2026-04-15T14:01:07.195Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-04-15T14:01:07.195Z] GC before operation: completed in 89.336 ms, heap usage 540.911 MB -> 69.811 MB.
[2026-04-15T14:01:13.945Z] ====== als (apache-spark) [default], iteration 19 completed (6604.859 ms) ======
[2026-04-15T14:01:13.945Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-04-15T14:01:13.945Z] GC before operation: completed in 89.006 ms, heap usage 459.909 MB -> 70.011 MB.
[2026-04-15T14:01:20.640Z] ====== als (apache-spark) [default], iteration 20 completed (6803.748 ms) ======
[2026-04-15T14:01:20.640Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-04-15T14:01:20.640Z] GC before operation: completed in 86.775 ms, heap usage 286.473 MB -> 69.933 MB.
[2026-04-15T14:01:28.788Z] ====== als (apache-spark) [default], iteration 21 completed (7646.924 ms) ======
[2026-04-15T14:01:28.788Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-04-15T14:01:28.789Z] GC before operation: completed in 92.017 ms, heap usage 265.799 MB -> 70.427 MB.
[2026-04-15T14:01:35.527Z] ====== als (apache-spark) [default], iteration 22 completed (6575.919 ms) ======
[2026-04-15T14:01:35.527Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-04-15T14:01:35.527Z] GC before operation: completed in 94.224 ms, heap usage 110.543 MB -> 70.836 MB.
[2026-04-15T14:01:42.344Z] ====== als (apache-spark) [default], iteration 23 completed (6629.812 ms) ======
[2026-04-15T14:01:42.344Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-04-15T14:01:42.344Z] GC before operation: completed in 119.545 ms, heap usage 569.237 MB -> 71.172 MB.
[2026-04-15T14:01:49.027Z] ====== als (apache-spark) [default], iteration 24 completed (6757.216 ms) ======
[2026-04-15T14:01:49.027Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-04-15T14:01:49.027Z] GC before operation: completed in 109.648 ms, heap usage 159.226 MB -> 71.075 MB.
[2026-04-15T14:01:55.695Z] ====== als (apache-spark) [default], iteration 25 completed (6613.896 ms) ======
[2026-04-15T14:01:55.695Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-04-15T14:01:55.695Z] GC before operation: completed in 109.611 ms, heap usage 347.478 MB -> 71.480 MB.
[2026-04-15T14:02:03.236Z] ====== als (apache-spark) [default], iteration 26 completed (6752.268 ms) ======
[2026-04-15T14:02:03.236Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-04-15T14:02:03.236Z] GC before operation: completed in 92.976 ms, heap usage 182.744 MB -> 71.560 MB.
[2026-04-15T14:02:09.897Z] ====== als (apache-spark) [default], iteration 27 completed (6707.683 ms) ======
[2026-04-15T14:02:09.897Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-04-15T14:02:09.897Z] GC before operation: completed in 121.722 ms, heap usage 242.377 MB -> 71.921 MB.
[2026-04-15T14:02:16.577Z] ====== als (apache-spark) [default], iteration 28 completed (6701.292 ms) ======
[2026-04-15T14:02:16.577Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-04-15T14:02:17.527Z] GC before operation: completed in 118.106 ms, heap usage 304.543 MB -> 71.768 MB.
[2026-04-15T14:02:24.208Z] ====== als (apache-spark) [default], iteration 29 completed (6811.245 ms) ======
[2026-04-15T14:02:24.208Z] -----------------------------------
[2026-04-15T14:02:24.208Z] renaissance-als_0_PASSED
[2026-04-15T14:02:24.208Z] -----------------------------------
[2026-04-15T14:02:24.208Z]
[2026-04-15T14:02:24.208Z] TEST TEARDOWN:
[2026-04-15T14:02:24.208Z] Nothing to be done for teardown.
[2026-04-15T14:02:24.208Z] renaissance-als_0 Finish Time: Wed Apr 15 14:02:23 2026 Epoch Time (ms): 1776261743917