[2026-04-25T09:37:47.680Z] Running test renaissance-als_0 ... [2026-04-25T09:37:47.680Z] =============================================== [2026-04-25T09:37:47.681Z] renaissance-als_0 Start Time: Sat Apr 25 09:37:47 2026 Epoch Time (ms): 1777109867131 [2026-04-25T09:37:47.681Z] variation: NoOptions [2026-04-25T09:37:47.681Z] JVM_OPTIONS: [2026-04-25T09:37:47.681Z] { \ [2026-04-25T09:37:47.681Z] echo ""; echo "TEST SETUP:"; \ [2026-04-25T09:37:47.681Z] echo "Nothing to be done for setup."; \ [2026-04-25T09:37:47.681Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17771091177395/renaissance-als_0"; \ [2026-04-25T09:37:47.681Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17771091177395/renaissance-als_0"; \ [2026-04-25T09:37:47.681Z] echo ""; echo "TESTING:"; \ [2026-04-25T09:37:47.681Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17771091177395/renaissance-als_0"/als.json" als; \ [2026-04-25T09:37:47.681Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17771091177395/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-25T09:37:47.681Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-25T09:37:47.681Z] echo "Nothing to be done for teardown."; \ [2026-04-25T09:37:47.681Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17771091177395/TestTargetResult"; [2026-04-25T09:37:47.681Z] [2026-04-25T09:37:47.681Z] TEST SETUP: [2026-04-25T09:37:47.681Z] Nothing to be done for setup. [2026-04-25T09:37:47.681Z] [2026-04-25T09:37:47.681Z] TESTING: [2026-04-25T09:37:54.913Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-04-25T09:38:00.884Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-25T09:38:00.884Z] GC before operation: completed in 76.612 ms, heap usage 149.918 MB -> 35.020 MB. [2026-04-25T09:38:36.604Z] ====== als (apache-spark) [default], iteration 0 completed (35010.027 ms) ====== [2026-04-25T09:38:36.604Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-25T09:38:36.604Z] GC before operation: completed in 208.193 ms, heap usage 232.171 MB -> 61.774 MB. [2026-04-25T09:38:59.198Z] ====== als (apache-spark) [default], iteration 1 completed (19653.040 ms) ====== [2026-04-25T09:38:59.198Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-25T09:38:59.198Z] GC before operation: completed in 192.429 ms, heap usage 218.599 MB -> 62.565 MB. [2026-04-25T09:39:14.920Z] ====== als (apache-spark) [default], iteration 2 completed (17457.955 ms) ====== [2026-04-25T09:39:14.920Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-25T09:39:14.920Z] GC before operation: completed in 160.377 ms, heap usage 474.986 MB -> 63.707 MB. [2026-04-25T09:39:34.002Z] ====== als (apache-spark) [default], iteration 3 completed (18475.867 ms) ====== [2026-04-25T09:39:34.002Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-25T09:39:34.002Z] GC before operation: completed in 179.055 ms, heap usage 442.494 MB -> 64.249 MB. [2026-04-25T09:39:53.073Z] ====== als (apache-spark) [default], iteration 4 completed (17581.834 ms) ====== [2026-04-25T09:39:53.073Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-25T09:39:53.073Z] GC before operation: completed in 194.999 ms, heap usage 282.015 MB -> 64.361 MB. [2026-04-25T09:40:09.786Z] ====== als (apache-spark) [default], iteration 5 completed (17494.658 ms) ====== [2026-04-25T09:40:09.786Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-25T09:40:09.786Z] GC before operation: completed in 198.662 ms, heap usage 104.093 MB -> 64.680 MB. [2026-04-25T09:40:29.243Z] ====== als (apache-spark) [default], iteration 6 completed (18815.946 ms) ====== [2026-04-25T09:40:29.243Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-25T09:40:29.243Z] GC before operation: completed in 146.275 ms, heap usage 507.808 MB -> 65.803 MB. [2026-04-25T09:40:45.404Z] ====== als (apache-spark) [default], iteration 7 completed (15544.403 ms) ====== [2026-04-25T09:40:45.404Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-25T09:40:45.404Z] GC before operation: completed in 179.684 ms, heap usage 111.217 MB -> 66.258 MB. [2026-04-25T09:41:04.386Z] ====== als (apache-spark) [default], iteration 8 completed (17064.201 ms) ====== [2026-04-25T09:41:04.386Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-25T09:41:04.386Z] GC before operation: completed in 292.065 ms, heap usage 362.590 MB -> 66.661 MB. [2026-04-25T09:41:20.595Z] ====== als (apache-spark) [default], iteration 9 completed (16871.732 ms) ====== [2026-04-25T09:41:20.595Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-25T09:41:20.595Z] GC before operation: completed in 217.888 ms, heap usage 348.895 MB -> 66.869 MB. [2026-04-25T09:41:36.764Z] ====== als (apache-spark) [default], iteration 10 completed (15983.837 ms) ====== [2026-04-25T09:41:36.764Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-25T09:41:36.764Z] GC before operation: completed in 155.598 ms, heap usage 428.211 MB -> 67.258 MB. [2026-04-25T09:41:52.789Z] ====== als (apache-spark) [default], iteration 11 completed (14778.238 ms) ====== [2026-04-25T09:41:52.789Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-25T09:41:52.789Z] GC before operation: completed in 163.034 ms, heap usage 293.620 MB -> 67.361 MB. [2026-04-25T09:42:11.135Z] ====== als (apache-spark) [default], iteration 12 completed (17116.708 ms) ====== [2026-04-25T09:42:11.135Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-25T09:42:11.135Z] GC before operation: completed in 216.971 ms, heap usage 483.204 MB -> 67.907 MB. [2026-04-25T09:42:27.606Z] ====== als (apache-spark) [default], iteration 13 completed (16686.978 ms) ====== [2026-04-25T09:42:27.606Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-25T09:42:27.606Z] GC before operation: completed in 229.122 ms, heap usage 445.309 MB -> 68.207 MB. [2026-04-25T09:42:46.786Z] ====== als (apache-spark) [default], iteration 14 completed (18143.998 ms) ====== [2026-04-25T09:42:46.786Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-25T09:42:46.786Z] GC before operation: completed in 173.091 ms, heap usage 395.912 MB -> 68.249 MB. [2026-04-25T09:43:03.254Z] ====== als (apache-spark) [default], iteration 15 completed (16063.397 ms) ====== [2026-04-25T09:43:03.254Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-25T09:43:03.254Z] GC before operation: completed in 229.453 ms, heap usage 252.284 MB -> 68.418 MB. [2026-04-25T09:43:19.449Z] ====== als (apache-spark) [default], iteration 16 completed (16053.235 ms) ====== [2026-04-25T09:43:19.449Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-25T09:43:19.449Z] GC before operation: completed in 169.026 ms, heap usage 533.067 MB -> 69.051 MB. [2026-04-25T09:43:38.435Z] ====== als (apache-spark) [default], iteration 17 completed (17146.960 ms) ====== [2026-04-25T09:43:38.435Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-25T09:43:38.435Z] GC before operation: completed in 160.559 ms, heap usage 541.263 MB -> 69.261 MB. [2026-04-25T09:43:54.697Z] ====== als (apache-spark) [default], iteration 18 completed (15858.158 ms) ====== [2026-04-25T09:43:54.697Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-25T09:43:54.697Z] GC before operation: completed in 205.618 ms, heap usage 589.069 MB -> 69.548 MB. [2026-04-25T09:44:10.809Z] ====== als (apache-spark) [default], iteration 19 completed (15764.751 ms) ====== [2026-04-25T09:44:10.809Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-25T09:44:10.809Z] GC before operation: completed in 157.151 ms, heap usage 526.807 MB -> 69.800 MB. [2026-04-25T09:44:26.834Z] ====== als (apache-spark) [default], iteration 20 completed (15815.980 ms) ====== [2026-04-25T09:44:26.834Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-25T09:44:26.834Z] GC before operation: completed in 147.912 ms, heap usage 519.171 MB -> 69.881 MB. [2026-04-25T09:44:40.824Z] ====== als (apache-spark) [default], iteration 21 completed (14917.592 ms) ====== [2026-04-25T09:44:40.824Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-25T09:44:40.824Z] GC before operation: completed in 187.365 ms, heap usage 479.254 MB -> 70.227 MB. [2026-04-25T09:44:57.064Z] ====== als (apache-spark) [default], iteration 22 completed (14035.633 ms) ====== [2026-04-25T09:44:57.064Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-25T09:44:57.064Z] GC before operation: completed in 181.687 ms, heap usage 354.612 MB -> 70.522 MB. [2026-04-25T09:45:11.378Z] ====== als (apache-spark) [default], iteration 23 completed (14147.375 ms) ====== [2026-04-25T09:45:11.378Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-25T09:45:11.378Z] GC before operation: completed in 130.461 ms, heap usage 530.370 MB -> 70.816 MB. [2026-04-25T09:45:25.255Z] ====== als (apache-spark) [default], iteration 24 completed (15098.838 ms) ====== [2026-04-25T09:45:25.255Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-25T09:45:26.003Z] GC before operation: completed in 203.856 ms, heap usage 165.916 MB -> 70.722 MB. [2026-04-25T09:45:42.444Z] ====== als (apache-spark) [default], iteration 25 completed (15972.178 ms) ====== [2026-04-25T09:45:42.444Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-25T09:45:42.444Z] GC before operation: completed in 177.691 ms, heap usage 117.593 MB -> 70.871 MB. [2026-04-25T09:45:58.646Z] ====== als (apache-spark) [default], iteration 26 completed (15175.511 ms) ====== [2026-04-25T09:45:58.646Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-25T09:45:58.646Z] GC before operation: completed in 218.044 ms, heap usage 506.600 MB -> 71.516 MB. [2026-04-25T09:46:14.623Z] ====== als (apache-spark) [default], iteration 27 completed (14700.176 ms) ====== [2026-04-25T09:46:14.623Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-25T09:46:14.623Z] GC before operation: completed in 255.447 ms, heap usage 383.825 MB -> 71.591 MB. [2026-04-25T09:46:28.277Z] ====== als (apache-spark) [default], iteration 28 completed (15047.737 ms) ====== [2026-04-25T09:46:28.277Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-25T09:46:28.277Z] GC before operation: completed in 134.640 ms, heap usage 376.709 MB -> 71.824 MB. [2026-04-25T09:46:44.712Z] ====== als (apache-spark) [default], iteration 29 completed (14194.295 ms) ====== [2026-04-25T09:46:44.712Z] ----------------------------------- [2026-04-25T09:46:44.712Z] renaissance-als_0_PASSED [2026-04-25T09:46:44.712Z] ----------------------------------- [2026-04-25T09:46:44.712Z] [2026-04-25T09:46:44.712Z] TEST TEARDOWN: [2026-04-25T09:46:44.713Z] Nothing to be done for teardown. [2026-04-25T09:46:44.713Z] renaissance-als_0 Finish Time: Sat Apr 25 09:46:43 2026 Epoch Time (ms): 1777110403267