[2026-03-02T14:55:52.823Z] Running test renaissance-als_0 ... [2026-03-02T14:55:52.823Z] =============================================== [2026-03-02T14:55:52.823Z] renaissance-als_0 Start Time: Mon Mar 2 14:55:52 2026 Epoch Time (ms): 1772463352143 [2026-03-02T14:55:52.823Z] variation: NoOptions [2026-03-02T14:55:52.823Z] JVM_OPTIONS: [2026-03-02T14:55:52.823Z] { \ [2026-03-02T14:55:52.823Z] echo ""; echo "TEST SETUP:"; \ [2026-03-02T14:55:52.823Z] echo "Nothing to be done for setup."; \ [2026-03-02T14:55:52.823Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/renaissance-als_0"; \ [2026-03-02T14:55:52.823Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/renaissance-als_0"; \ [2026-03-02T14:55:52.823Z] echo ""; echo "TESTING:"; \ [2026-03-02T14:55:52.823Z] "/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_17724632062130/renaissance-als_0"/als.json" als; \ [2026-03-02T14:55:52.823Z] 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_17724632062130/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-02T14:55:52.823Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-02T14:55:52.823Z] echo "Nothing to be done for teardown."; \ [2026-03-02T14:55:52.823Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17724632062130/TestTargetResult"; [2026-03-02T14:55:52.823Z] [2026-03-02T14:55:52.823Z] TEST SETUP: [2026-03-02T14:55:52.823Z] Nothing to be done for setup. [2026-03-02T14:55:52.823Z] [2026-03-02T14:55:52.823Z] TESTING: [2026-03-02T14:55:58.171Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-03-02T14:56:02.333Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-03-02T14:56:02.333Z] GC before operation: completed in 39.783 ms, heap usage 304.500 MB -> 35.186 MB. [2026-03-02T14:56:21.115Z] ====== als (apache-spark) [default], iteration 0 completed (16615.969 ms) ====== [2026-03-02T14:56:21.115Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-03-02T14:56:21.115Z] GC before operation: completed in 105.556 ms, heap usage 243.134 MB -> 61.977 MB. [2026-03-02T14:56:27.782Z] ====== als (apache-spark) [default], iteration 1 completed (7921.036 ms) ====== [2026-03-02T14:56:27.782Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-03-02T14:56:27.782Z] GC before operation: completed in 88.829 ms, heap usage 305.132 MB -> 62.903 MB. [2026-03-02T14:56:35.907Z] ====== als (apache-spark) [default], iteration 2 completed (7021.309 ms) ====== [2026-03-02T14:56:35.907Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-03-02T14:56:35.907Z] GC before operation: completed in 79.837 ms, heap usage 319.387 MB -> 63.527 MB. [2026-03-02T14:56:42.584Z] ====== als (apache-spark) [default], iteration 3 completed (7081.674 ms) ====== [2026-03-02T14:56:42.584Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-03-02T14:56:42.584Z] GC before operation: completed in 95.633 ms, heap usage 151.040 MB -> 63.844 MB. [2026-03-02T14:56:50.870Z] ====== als (apache-spark) [default], iteration 4 completed (6974.483 ms) ====== [2026-03-02T14:56:50.870Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-03-02T14:56:50.870Z] GC before operation: completed in 111.124 ms, heap usage 502.564 MB -> 64.831 MB. [2026-03-02T14:56:57.542Z] ====== als (apache-spark) [default], iteration 5 completed (6807.904 ms) ====== [2026-03-02T14:56:57.542Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-03-02T14:56:57.542Z] GC before operation: completed in 111.252 ms, heap usage 297.531 MB -> 65.131 MB. [2026-03-02T14:57:04.233Z] ====== als (apache-spark) [default], iteration 6 completed (6888.099 ms) ====== [2026-03-02T14:57:04.233Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-03-02T14:57:04.233Z] GC before operation: completed in 113.841 ms, heap usage 310.221 MB -> 65.823 MB. [2026-03-02T14:57:10.897Z] ====== als (apache-spark) [default], iteration 7 completed (6637.070 ms) ====== [2026-03-02T14:57:10.897Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-03-02T14:57:11.844Z] GC before operation: completed in 116.137 ms, heap usage 511.491 MB -> 66.475 MB. [2026-03-02T14:57:18.529Z] ====== als (apache-spark) [default], iteration 8 completed (6782.392 ms) ====== [2026-03-02T14:57:18.529Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-03-02T14:57:18.529Z] GC before operation: completed in 107.729 ms, heap usage 205.869 MB -> 66.657 MB. [2026-03-02T14:57:25.196Z] ====== als (apache-spark) [default], iteration 9 completed (6896.692 ms) ====== [2026-03-02T14:57:25.196Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-03-02T14:57:26.144Z] GC before operation: completed in 101.485 ms, heap usage 358.283 MB -> 67.030 MB. [2026-03-02T14:57:32.808Z] ====== als (apache-spark) [default], iteration 10 completed (6751.032 ms) ====== [2026-03-02T14:57:32.808Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-03-02T14:57:32.808Z] GC before operation: completed in 109.337 ms, heap usage 163.418 MB -> 67.069 MB. [2026-03-02T14:57:39.619Z] ====== als (apache-spark) [default], iteration 11 completed (6750.830 ms) ====== [2026-03-02T14:57:39.619Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-03-02T14:57:39.619Z] GC before operation: completed in 103.990 ms, heap usage 486.694 MB -> 67.841 MB. [2026-03-02T14:57:46.806Z] ====== als (apache-spark) [default], iteration 12 completed (6597.801 ms) ====== [2026-03-02T14:57:46.806Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-03-02T14:57:46.806Z] GC before operation: completed in 112.856 ms, heap usage 572.645 MB -> 68.287 MB. [2026-03-02T14:57:53.911Z] ====== als (apache-spark) [default], iteration 13 completed (6723.950 ms) ====== [2026-03-02T14:57:53.911Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-03-02T14:57:53.911Z] GC before operation: completed in 109.922 ms, heap usage 561.225 MB -> 68.480 MB. [2026-03-02T14:58:00.588Z] ====== als (apache-spark) [default], iteration 14 completed (6744.978 ms) ====== [2026-03-02T14:58:00.589Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-03-02T14:58:00.589Z] GC before operation: completed in 110.692 ms, heap usage 203.387 MB -> 68.152 MB. [2026-03-02T14:58:08.705Z] ====== als (apache-spark) [default], iteration 15 completed (6795.707 ms) ====== [2026-03-02T14:58:08.705Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-03-02T14:58:08.705Z] GC before operation: completed in 105.304 ms, heap usage 359.432 MB -> 68.658 MB. [2026-03-02T14:58:15.373Z] ====== als (apache-spark) [default], iteration 16 completed (6621.637 ms) ====== [2026-03-02T14:58:15.373Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-03-02T14:58:15.373Z] GC before operation: completed in 101.653 ms, heap usage 512.354 MB -> 69.185 MB. [2026-03-02T14:58:22.046Z] ====== als (apache-spark) [default], iteration 17 completed (6569.331 ms) ====== [2026-03-02T14:58:22.046Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-03-02T14:58:22.046Z] GC before operation: completed in 107.136 ms, heap usage 281.516 MB -> 69.212 MB. [2026-03-02T14:58:28.713Z] ====== als (apache-spark) [default], iteration 18 completed (6587.791 ms) ====== [2026-03-02T14:58:28.713Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-03-02T14:58:28.713Z] GC before operation: completed in 87.567 ms, heap usage 151.935 MB -> 69.382 MB. [2026-03-02T14:58:35.559Z] ====== als (apache-spark) [default], iteration 19 completed (6552.385 ms) ====== [2026-03-02T14:58:35.559Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-03-02T14:58:35.559Z] GC before operation: completed in 83.895 ms, heap usage 155.673 MB -> 69.768 MB. [2026-03-02T14:58:42.229Z] ====== als (apache-spark) [default], iteration 20 completed (6543.667 ms) ====== [2026-03-02T14:58:42.229Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-03-02T14:58:42.229Z] GC before operation: completed in 90.007 ms, heap usage 285.652 MB -> 69.916 MB. [2026-03-02T14:58:48.983Z] ====== als (apache-spark) [default], iteration 21 completed (6625.723 ms) ====== [2026-03-02T14:58:48.983Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-03-02T14:58:48.983Z] GC before operation: completed in 89.282 ms, heap usage 292.852 MB -> 70.092 MB. [2026-03-02T14:58:55.657Z] ====== als (apache-spark) [default], iteration 22 completed (6702.635 ms) ====== [2026-03-02T14:58:55.657Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-03-02T14:58:56.605Z] GC before operation: completed in 92.652 ms, heap usage 360.144 MB -> 70.487 MB. [2026-03-02T14:59:03.281Z] ====== als (apache-spark) [default], iteration 23 completed (6637.343 ms) ====== [2026-03-02T14:59:03.281Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-03-02T14:59:03.281Z] GC before operation: completed in 86.989 ms, heap usage 105.024 MB -> 70.544 MB. [2026-03-02T14:59:09.951Z] ====== als (apache-spark) [default], iteration 24 completed (6641.858 ms) ====== [2026-03-02T14:59:09.951Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-03-02T14:59:09.951Z] GC before operation: completed in 84.751 ms, heap usage 311.055 MB -> 71.036 MB. [2026-03-02T14:59:16.512Z] ====== als (apache-spark) [default], iteration 25 completed (6583.916 ms) ====== [2026-03-02T14:59:16.512Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-03-02T14:59:16.512Z] GC before operation: completed in 98.864 ms, heap usage 227.722 MB -> 70.998 MB. [2026-03-02T14:59:23.181Z] ====== als (apache-spark) [default], iteration 26 completed (6488.380 ms) ====== [2026-03-02T14:59:23.181Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-03-02T14:59:24.130Z] GC before operation: completed in 101.506 ms, heap usage 167.616 MB -> 71.161 MB. [2026-03-02T14:59:30.801Z] ====== als (apache-spark) [default], iteration 27 completed (6514.266 ms) ====== [2026-03-02T14:59:30.801Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-03-02T14:59:30.801Z] GC before operation: completed in 96.481 ms, heap usage 235.952 MB -> 71.095 MB. [2026-03-02T14:59:37.476Z] ====== als (apache-spark) [default], iteration 28 completed (6643.532 ms) ====== [2026-03-02T14:59:37.476Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-03-02T14:59:37.476Z] GC before operation: completed in 108.029 ms, heap usage 378.705 MB -> 71.491 MB. [2026-03-02T14:59:44.147Z] ====== als (apache-spark) [default], iteration 29 completed (6597.049 ms) ====== [2026-03-02T14:59:45.099Z] ----------------------------------- [2026-03-02T14:59:45.099Z] renaissance-als_0_PASSED [2026-03-02T14:59:45.099Z] ----------------------------------- [2026-03-02T14:59:45.099Z] [2026-03-02T14:59:45.099Z] TEST TEARDOWN: [2026-03-02T14:59:45.099Z] Nothing to be done for teardown. [2026-03-02T14:59:45.099Z] renaissance-als_0 Finish Time: Mon Mar 2 14:59:44 2026 Epoch Time (ms): 1772463584101