[2026-02-11T23:25:14.678Z] Running test renaissance-als_0 ... [2026-02-11T23:25:14.678Z] =============================================== [2026-02-11T23:25:14.678Z] renaissance-als_0 Start Time: Wed Feb 11 23:25:13 2026 Epoch Time (ms): 1770852313787 [2026-02-11T23:25:14.678Z] variation: NoOptions [2026-02-11T23:25:14.678Z] JVM_OPTIONS: [2026-02-11T23:25:14.678Z] { \ [2026-02-11T23:25:14.678Z] echo ""; echo "TEST SETUP:"; \ [2026-02-11T23:25:14.678Z] echo "Nothing to be done for setup."; \ [2026-02-11T23:25:14.678Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1770852145164/renaissance-als_0"; \ [2026-02-11T23:25:14.678Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1770852145164/renaissance-als_0"; \ [2026-02-11T23:25:14.678Z] echo ""; echo "TESTING:"; \ [2026-02-11T23:25:14.678Z] "/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_1770852145164/renaissance-als_0"/als.json" als; \ [2026-02-11T23:25:14.679Z] 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_1770852145164/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-11T23:25:14.679Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-11T23:25:14.679Z] echo "Nothing to be done for teardown."; \ [2026-02-11T23:25:14.679Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1770852145164/TestTargetResult"; [2026-02-11T23:25:14.679Z] [2026-02-11T23:25:14.679Z] TEST SETUP: [2026-02-11T23:25:14.679Z] Nothing to be done for setup. [2026-02-11T23:25:14.679Z] [2026-02-11T23:25:14.679Z] TESTING: [2026-02-11T23:25:20.134Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-11T23:25:24.351Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-11T23:25:24.351Z] GC before operation: completed in 46.980 ms, heap usage 87.500 MB -> 35.074 MB. [2026-02-11T23:25:42.910Z] ====== als (apache-spark) [default], iteration 0 completed (16545.071 ms) ====== [2026-02-11T23:25:42.910Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-11T23:25:42.910Z] GC before operation: completed in 95.987 ms, heap usage 225.555 MB -> 62.065 MB. [2026-02-11T23:25:49.720Z] ====== als (apache-spark) [default], iteration 1 completed (7828.243 ms) ====== [2026-02-11T23:25:49.720Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-11T23:25:49.720Z] GC before operation: completed in 82.499 ms, heap usage 229.741 MB -> 62.991 MB. [2026-02-11T23:25:56.531Z] ====== als (apache-spark) [default], iteration 2 completed (7219.023 ms) ====== [2026-02-11T23:25:56.531Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-11T23:25:56.531Z] GC before operation: completed in 85.391 ms, heap usage 724.429 MB -> 64.246 MB. [2026-02-11T23:26:04.798Z] ====== als (apache-spark) [default], iteration 3 completed (6843.987 ms) ====== [2026-02-11T23:26:04.798Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-11T23:26:04.798Z] GC before operation: completed in 121.789 ms, heap usage 430.071 MB -> 64.339 MB. [2026-02-11T23:26:11.599Z] ====== als (apache-spark) [default], iteration 4 completed (6929.630 ms) ====== [2026-02-11T23:26:11.600Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-11T23:26:11.600Z] GC before operation: completed in 95.920 ms, heap usage 605.328 MB -> 65.301 MB. [2026-02-11T23:26:18.399Z] ====== als (apache-spark) [default], iteration 5 completed (6744.477 ms) ====== [2026-02-11T23:26:18.399Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-11T23:26:18.399Z] GC before operation: completed in 95.291 ms, heap usage 660.782 MB -> 65.783 MB. [2026-02-11T23:26:25.215Z] ====== als (apache-spark) [default], iteration 6 completed (6751.620 ms) ====== [2026-02-11T23:26:25.215Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-11T23:26:25.215Z] GC before operation: completed in 94.483 ms, heap usage 235.714 MB -> 65.849 MB. [2026-02-11T23:26:32.016Z] ====== als (apache-spark) [default], iteration 7 completed (6767.450 ms) ====== [2026-02-11T23:26:32.016Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-11T23:26:32.016Z] GC before operation: completed in 89.575 ms, heap usage 605.848 MB -> 67.009 MB. [2026-02-11T23:26:40.284Z] ====== als (apache-spark) [default], iteration 8 completed (6743.763 ms) ====== [2026-02-11T23:26:40.284Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-11T23:26:40.284Z] GC before operation: completed in 98.759 ms, heap usage 448.926 MB -> 67.109 MB. [2026-02-11T23:26:45.970Z] ====== als (apache-spark) [default], iteration 9 completed (6645.581 ms) ====== [2026-02-11T23:26:45.970Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-11T23:26:46.945Z] GC before operation: completed in 100.448 ms, heap usage 353.837 MB -> 67.284 MB. [2026-02-11T23:26:53.746Z] ====== als (apache-spark) [default], iteration 10 completed (6662.604 ms) ====== [2026-02-11T23:26:53.746Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-11T23:26:53.746Z] GC before operation: completed in 127.811 ms, heap usage 695.365 MB -> 67.971 MB. [2026-02-11T23:27:00.541Z] ====== als (apache-spark) [default], iteration 11 completed (6610.182 ms) ====== [2026-02-11T23:27:00.541Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-11T23:27:00.541Z] GC before operation: completed in 115.692 ms, heap usage 299.625 MB -> 67.791 MB. [2026-02-11T23:27:07.411Z] ====== als (apache-spark) [default], iteration 12 completed (6492.212 ms) ====== [2026-02-11T23:27:07.411Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-11T23:27:07.411Z] GC before operation: completed in 93.362 ms, heap usage 594.243 MB -> 68.452 MB. [2026-02-11T23:27:14.217Z] ====== als (apache-spark) [default], iteration 13 completed (6514.502 ms) ====== [2026-02-11T23:27:14.217Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-11T23:27:14.217Z] GC before operation: completed in 95.131 ms, heap usage 437.676 MB -> 68.401 MB. [2026-02-11T23:27:21.024Z] ====== als (apache-spark) [default], iteration 14 completed (6565.872 ms) ====== [2026-02-11T23:27:21.024Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-11T23:27:21.024Z] GC before operation: completed in 90.776 ms, heap usage 417.899 MB -> 68.699 MB. [2026-02-11T23:27:28.000Z] ====== als (apache-spark) [default], iteration 15 completed (6496.543 ms) ====== [2026-02-11T23:27:28.000Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-11T23:27:28.000Z] GC before operation: completed in 106.838 ms, heap usage 400.473 MB -> 68.911 MB. [2026-02-11T23:27:34.837Z] ====== als (apache-spark) [default], iteration 16 completed (6450.962 ms) ====== [2026-02-11T23:27:34.837Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-11T23:27:34.837Z] GC before operation: completed in 104.820 ms, heap usage 392.939 MB -> 69.221 MB. [2026-02-11T23:27:41.642Z] ====== als (apache-spark) [default], iteration 17 completed (6471.079 ms) ====== [2026-02-11T23:27:41.642Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-11T23:27:41.642Z] GC before operation: completed in 94.889 ms, heap usage 436.285 MB -> 69.433 MB. [2026-02-11T23:27:48.447Z] ====== als (apache-spark) [default], iteration 18 completed (6496.734 ms) ====== [2026-02-11T23:27:48.447Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-11T23:27:48.447Z] GC before operation: completed in 103.411 ms, heap usage 552.992 MB -> 70.050 MB. [2026-02-11T23:27:55.248Z] ====== als (apache-spark) [default], iteration 19 completed (6605.606 ms) ====== [2026-02-11T23:27:55.248Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-11T23:27:55.248Z] GC before operation: completed in 99.248 ms, heap usage 945.491 MB -> 70.691 MB. [2026-02-11T23:28:02.051Z] ====== als (apache-spark) [default], iteration 20 completed (6471.629 ms) ====== [2026-02-11T23:28:02.051Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-11T23:28:02.051Z] GC before operation: completed in 97.320 ms, heap usage 151.146 MB -> 70.027 MB. [2026-02-11T23:28:08.840Z] ====== als (apache-spark) [default], iteration 21 completed (6639.221 ms) ====== [2026-02-11T23:28:08.840Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-11T23:28:08.840Z] GC before operation: completed in 97.961 ms, heap usage 190.870 MB -> 70.217 MB. [2026-02-11T23:28:17.190Z] ====== als (apache-spark) [default], iteration 22 completed (7865.028 ms) ====== [2026-02-11T23:28:17.190Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-11T23:28:17.190Z] GC before operation: completed in 94.187 ms, heap usage 378.177 MB -> 70.738 MB. [2026-02-11T23:28:23.989Z] ====== als (apache-spark) [default], iteration 23 completed (6684.962 ms) ====== [2026-02-11T23:28:23.989Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-11T23:28:23.989Z] GC before operation: completed in 103.170 ms, heap usage 449.770 MB -> 71.040 MB. [2026-02-11T23:28:30.784Z] ====== als (apache-spark) [default], iteration 24 completed (6648.817 ms) ====== [2026-02-11T23:28:30.784Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-11T23:28:30.784Z] GC before operation: completed in 96.971 ms, heap usage 658.680 MB -> 71.645 MB. [2026-02-11T23:28:37.580Z] ====== als (apache-spark) [default], iteration 25 completed (6945.838 ms) ====== [2026-02-11T23:28:37.580Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-11T23:28:37.580Z] GC before operation: completed in 96.020 ms, heap usage 492.585 MB -> 71.674 MB. [2026-02-11T23:28:45.828Z] ====== als (apache-spark) [default], iteration 26 completed (7334.657 ms) ====== [2026-02-11T23:28:45.828Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-11T23:28:45.828Z] GC before operation: completed in 88.595 ms, heap usage 384.848 MB -> 71.701 MB. [2026-02-11T23:28:52.624Z] ====== als (apache-spark) [default], iteration 27 completed (6691.214 ms) ====== [2026-02-11T23:28:52.624Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-11T23:28:52.624Z] GC before operation: completed in 94.869 ms, heap usage 193.380 MB -> 71.967 MB. [2026-02-11T23:28:59.419Z] ====== als (apache-spark) [default], iteration 28 completed (6517.095 ms) ====== [2026-02-11T23:28:59.419Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-11T23:28:59.419Z] GC before operation: completed in 95.992 ms, heap usage 189.008 MB -> 72.211 MB. [2026-02-11T23:29:06.318Z] ====== als (apache-spark) [default], iteration 29 completed (6711.857 ms) ====== [2026-02-11T23:29:06.318Z] ----------------------------------- [2026-02-11T23:29:06.318Z] renaissance-als_0_PASSED [2026-02-11T23:29:06.318Z] ----------------------------------- [2026-02-11T23:29:06.318Z] [2026-02-11T23:29:06.318Z] TEST TEARDOWN: [2026-02-11T23:29:06.318Z] Nothing to be done for teardown. [2026-02-11T23:29:06.318Z] renaissance-als_0 Finish Time: Wed Feb 11 23:29:05 2026 Epoch Time (ms): 1770852545887