[2026-04-23T14:40:42.120Z] Running test renaissance-als_0 ... [2026-04-23T14:40:42.120Z] =============================================== [2026-04-23T14:40:42.120Z] renaissance-als_0 Start Time: Thu Apr 23 14:40:41 2026 Epoch Time (ms): 1776955241671 [2026-04-23T14:40:42.120Z] variation: NoOptions [2026-04-23T14:40:42.120Z] JVM_OPTIONS: [2026-04-23T14:40:42.120Z] { \ [2026-04-23T14:40:42.120Z] echo ""; echo "TEST SETUP:"; \ [2026-04-23T14:40:42.120Z] echo "Nothing to be done for setup."; \ [2026-04-23T14:40:42.120Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/renaissance-als_0"; \ [2026-04-23T14:40:42.120Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/renaissance-als_0"; \ [2026-04-23T14:40:42.120Z] echo ""; echo "TESTING:"; \ [2026-04-23T14:40:42.120Z] "/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_17769549632582/renaissance-als_0"/als.json" als; \ [2026-04-23T14:40:42.120Z] 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_17769549632582/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-23T14:40:42.120Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-23T14:40:42.120Z] echo "Nothing to be done for teardown."; \ [2026-04-23T14:40:42.120Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/TestTargetResult"; [2026-04-23T14:40:42.120Z] [2026-04-23T14:40:42.120Z] TEST SETUP: [2026-04-23T14:40:42.120Z] Nothing to be done for setup. [2026-04-23T14:40:42.120Z] [2026-04-23T14:40:42.120Z] TESTING: [2026-04-23T14:40:57.466Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-04-23T14:41:03.806Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-23T14:41:03.806Z] GC before operation: completed in 89.351 ms, heap usage 53.418 MB -> 34.967 MB. [2026-04-23T14:41:37.666Z] ====== als (apache-spark) [default], iteration 0 completed (29796.193 ms) ====== [2026-04-23T14:41:37.666Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-23T14:41:37.666Z] GC before operation: completed in 143.968 ms, heap usage 317.652 MB -> 61.867 MB. [2026-04-23T14:41:50.536Z] ====== als (apache-spark) [default], iteration 1 completed (15516.672 ms) ====== [2026-04-23T14:41:50.536Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-23T14:41:50.536Z] GC before operation: completed in 148.750 ms, heap usage 120.869 MB -> 62.713 MB. [2026-04-23T14:42:05.568Z] ====== als (apache-spark) [default], iteration 2 completed (13821.572 ms) ====== [2026-04-23T14:42:05.568Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-23T14:42:05.568Z] GC before operation: completed in 218.451 ms, heap usage 328.709 MB -> 63.594 MB. [2026-04-23T14:42:20.953Z] ====== als (apache-spark) [default], iteration 3 completed (13762.022 ms) ====== [2026-04-23T14:42:20.953Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-23T14:42:20.953Z] GC before operation: completed in 124.441 ms, heap usage 389.887 MB -> 64.386 MB. [2026-04-23T14:42:33.618Z] ====== als (apache-spark) [default], iteration 4 completed (13263.433 ms) ====== [2026-04-23T14:42:33.618Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-23T14:42:33.618Z] GC before operation: completed in 130.199 ms, heap usage 547.923 MB -> 64.965 MB. [2026-04-23T14:42:46.283Z] ====== als (apache-spark) [default], iteration 5 completed (12488.585 ms) ====== [2026-04-23T14:42:46.283Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-23T14:42:46.283Z] GC before operation: completed in 173.015 ms, heap usage 400.904 MB -> 65.288 MB. [2026-04-23T14:42:59.697Z] ====== als (apache-spark) [default], iteration 6 completed (13227.495 ms) ====== [2026-04-23T14:42:59.697Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-23T14:42:59.697Z] GC before operation: completed in 139.405 ms, heap usage 165.668 MB -> 65.511 MB. [2026-04-23T14:43:12.465Z] ====== als (apache-spark) [default], iteration 7 completed (12459.159 ms) ====== [2026-04-23T14:43:12.465Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-23T14:43:12.465Z] GC before operation: completed in 114.663 ms, heap usage 127.280 MB -> 66.074 MB. [2026-04-23T14:43:25.371Z] ====== als (apache-spark) [default], iteration 8 completed (12703.476 ms) ====== [2026-04-23T14:43:25.371Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-23T14:43:25.371Z] GC before operation: completed in 126.613 ms, heap usage 112.382 MB -> 66.610 MB. [2026-04-23T14:43:40.347Z] ====== als (apache-spark) [default], iteration 9 completed (12859.788 ms) ====== [2026-04-23T14:43:40.347Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-23T14:43:40.347Z] GC before operation: completed in 136.546 ms, heap usage 555.086 MB -> 67.733 MB. [2026-04-23T14:43:53.002Z] ====== als (apache-spark) [default], iteration 10 completed (12686.065 ms) ====== [2026-04-23T14:43:53.002Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-23T14:43:53.002Z] GC before operation: completed in 135.754 ms, heap usage 582.598 MB -> 67.576 MB. [2026-04-23T14:44:05.734Z] ====== als (apache-spark) [default], iteration 11 completed (12409.487 ms) ====== [2026-04-23T14:44:05.734Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-23T14:44:05.734Z] GC before operation: completed in 155.144 ms, heap usage 444.160 MB -> 67.864 MB. [2026-04-23T14:44:18.454Z] ====== als (apache-spark) [default], iteration 12 completed (12363.286 ms) ====== [2026-04-23T14:44:18.454Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-23T14:44:18.454Z] GC before operation: completed in 127.959 ms, heap usage 299.071 MB -> 67.680 MB. [2026-04-23T14:44:31.009Z] ====== als (apache-spark) [default], iteration 13 completed (12051.298 ms) ====== [2026-04-23T14:44:31.009Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-23T14:44:31.009Z] GC before operation: completed in 139.613 ms, heap usage 452.402 MB -> 68.371 MB. [2026-04-23T14:44:43.886Z] ====== als (apache-spark) [default], iteration 14 completed (12686.745 ms) ====== [2026-04-23T14:44:43.886Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-23T14:44:43.886Z] GC before operation: completed in 142.481 ms, heap usage 412.594 MB -> 68.354 MB. [2026-04-23T14:44:56.512Z] ====== als (apache-spark) [default], iteration 15 completed (11786.475 ms) ====== [2026-04-23T14:44:56.512Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-23T14:44:56.512Z] GC before operation: completed in 145.874 ms, heap usage 137.321 MB -> 68.402 MB. [2026-04-23T14:45:07.136Z] ====== als (apache-spark) [default], iteration 16 completed (11707.022 ms) ====== [2026-04-23T14:45:07.136Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-23T14:45:07.136Z] GC before operation: completed in 127.845 ms, heap usage 127.090 MB -> 68.602 MB. [2026-04-23T14:45:20.138Z] ====== als (apache-spark) [default], iteration 17 completed (11422.996 ms) ====== [2026-04-23T14:45:20.138Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-23T14:45:20.138Z] GC before operation: completed in 130.789 ms, heap usage 127.205 MB -> 68.900 MB. [2026-04-23T14:45:30.691Z] ====== als (apache-spark) [default], iteration 18 completed (11431.251 ms) ====== [2026-04-23T14:45:30.691Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-23T14:45:30.691Z] GC before operation: completed in 127.053 ms, heap usage 103.882 MB -> 69.167 MB. [2026-04-23T14:45:43.296Z] ====== als (apache-spark) [default], iteration 19 completed (11549.149 ms) ====== [2026-04-23T14:45:43.296Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-23T14:45:43.296Z] GC before operation: completed in 127.623 ms, heap usage 433.263 MB -> 69.729 MB. [2026-04-23T14:45:55.831Z] ====== als (apache-spark) [default], iteration 20 completed (11519.228 ms) ====== [2026-04-23T14:45:55.831Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-23T14:45:55.831Z] GC before operation: completed in 152.474 ms, heap usage 633.812 MB -> 70.245 MB. [2026-04-23T14:46:06.514Z] ====== als (apache-spark) [default], iteration 21 completed (11786.208 ms) ====== [2026-04-23T14:46:06.514Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-23T14:46:06.514Z] GC before operation: completed in 133.191 ms, heap usage 477.984 MB -> 70.342 MB. [2026-04-23T14:46:18.991Z] ====== als (apache-spark) [default], iteration 22 completed (11221.434 ms) ====== [2026-04-23T14:46:18.991Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-23T14:46:18.991Z] GC before operation: completed in 154.784 ms, heap usage 636.690 MB -> 70.696 MB. [2026-04-23T14:46:31.485Z] ====== als (apache-spark) [default], iteration 23 completed (11449.131 ms) ====== [2026-04-23T14:46:31.485Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-23T14:46:31.485Z] GC before operation: completed in 131.410 ms, heap usage 127.805 MB -> 70.477 MB. [2026-04-23T14:46:42.016Z] ====== als (apache-spark) [default], iteration 24 completed (11072.085 ms) ====== [2026-04-23T14:46:42.016Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-23T14:46:42.016Z] GC before operation: completed in 125.796 ms, heap usage 200.277 MB -> 70.632 MB. [2026-04-23T14:46:54.467Z] ====== als (apache-spark) [default], iteration 25 completed (11864.903 ms) ====== [2026-04-23T14:46:54.467Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-23T14:46:54.467Z] GC before operation: completed in 125.437 ms, heap usage 209.158 MB -> 70.928 MB. [2026-04-23T14:47:09.196Z] ====== als (apache-spark) [default], iteration 26 completed (13451.534 ms) ====== [2026-04-23T14:47:09.196Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-23T14:47:09.196Z] GC before operation: completed in 144.000 ms, heap usage 243.910 MB -> 71.411 MB. [2026-04-23T14:47:19.906Z] ====== als (apache-spark) [default], iteration 27 completed (11738.945 ms) ====== [2026-04-23T14:47:19.906Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-23T14:47:19.906Z] GC before operation: completed in 126.242 ms, heap usage 234.843 MB -> 71.436 MB. [2026-04-23T14:47:32.458Z] ====== als (apache-spark) [default], iteration 28 completed (12248.123 ms) ====== [2026-04-23T14:47:32.458Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-23T14:47:32.458Z] GC before operation: completed in 126.988 ms, heap usage 180.691 MB -> 71.689 MB. [2026-04-23T14:47:45.059Z] ====== als (apache-spark) [default], iteration 29 completed (12025.562 ms) ====== [2026-04-23T14:47:45.059Z] ----------------------------------- [2026-04-23T14:47:45.059Z] renaissance-als_0_PASSED [2026-04-23T14:47:45.059Z] ----------------------------------- [2026-04-23T14:47:45.059Z] [2026-04-23T14:47:45.059Z] TEST TEARDOWN: [2026-04-23T14:47:45.059Z] Nothing to be done for teardown. [2026-04-23T14:47:45.059Z] renaissance-als_0 Finish Time: Thu Apr 23 14:47:44 2026 Epoch Time (ms): 1776955664619