[2026-04-21T22:21:07.990Z] Running test renaissance-als_0 ... [2026-04-21T22:21:07.990Z] =============================================== [2026-04-21T22:21:07.990Z] renaissance-als_0 Start Time: Tue Apr 21 22:21:07 2026 Epoch Time (ms): 1776810067586 [2026-04-21T22:21:07.990Z] variation: NoOptions [2026-04-21T22:21:07.990Z] JVM_OPTIONS: [2026-04-21T22:21:07.990Z] { \ [2026-04-21T22:21:07.990Z] echo ""; echo "TEST SETUP:"; \ [2026-04-21T22:21:07.990Z] echo "Nothing to be done for setup."; \ [2026-04-21T22:21:07.990Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1776809920337/renaissance-als_0"; \ [2026-04-21T22:21:07.990Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1776809920337/renaissance-als_0"; \ [2026-04-21T22:21:07.990Z] echo ""; echo "TESTING:"; \ [2026-04-21T22:21:07.990Z] "/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_1776809920337/renaissance-als_0"/als.json" als; \ [2026-04-21T22:21:07.990Z] 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_1776809920337/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-21T22:21:07.990Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-21T22:21:07.990Z] echo "Nothing to be done for teardown."; \ [2026-04-21T22:21:07.990Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1776809920337/TestTargetResult"; [2026-04-21T22:21:07.990Z] [2026-04-21T22:21:07.990Z] TEST SETUP: [2026-04-21T22:21:07.990Z] Nothing to be done for setup. [2026-04-21T22:21:07.990Z] [2026-04-21T22:21:07.990Z] TESTING: [2026-04-21T22:21:10.985Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-04-21T22:21:13.625Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-21T22:21:13.625Z] GC before operation: completed in 42.369 ms, heap usage 283.418 MB -> 34.853 MB. [2026-04-21T22:21:31.073Z] ====== als (apache-spark) [default], iteration 0 completed (15987.518 ms) ====== [2026-04-21T22:21:31.073Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-21T22:21:31.073Z] GC before operation: completed in 76.477 ms, heap usage 282.985 MB -> 61.270 MB. [2026-04-21T22:21:39.833Z] ====== als (apache-spark) [default], iteration 1 completed (9147.748 ms) ====== [2026-04-21T22:21:39.833Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-21T22:21:39.833Z] GC before operation: completed in 64.673 ms, heap usage 287.112 MB -> 62.551 MB. [2026-04-21T22:21:48.532Z] ====== als (apache-spark) [default], iteration 2 completed (8188.989 ms) ====== [2026-04-21T22:21:48.532Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-21T22:21:48.532Z] GC before operation: completed in 69.648 ms, heap usage 283.941 MB -> 63.226 MB. [2026-04-21T22:21:55.692Z] ====== als (apache-spark) [default], iteration 3 completed (8161.913 ms) ====== [2026-04-21T22:21:55.692Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-21T22:21:55.692Z] GC before operation: completed in 67.378 ms, heap usage 225.138 MB -> 63.645 MB. [2026-04-21T22:22:05.947Z] ====== als (apache-spark) [default], iteration 4 completed (8726.767 ms) ====== [2026-04-21T22:22:05.948Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-21T22:22:05.948Z] GC before operation: completed in 77.979 ms, heap usage 282.727 MB -> 64.400 MB. [2026-04-21T22:22:13.108Z] ====== als (apache-spark) [default], iteration 5 completed (8007.722 ms) ====== [2026-04-21T22:22:13.108Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-21T22:22:13.108Z] GC before operation: completed in 77.323 ms, heap usage 232.320 MB -> 64.759 MB. [2026-04-21T22:22:23.703Z] ====== als (apache-spark) [default], iteration 6 completed (9375.272 ms) ====== [2026-04-21T22:22:23.703Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-21T22:22:23.703Z] GC before operation: completed in 72.491 ms, heap usage 204.332 MB -> 65.444 MB. [2026-04-21T22:22:30.944Z] ====== als (apache-spark) [default], iteration 7 completed (7981.638 ms) ====== [2026-04-21T22:22:30.944Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-21T22:22:30.944Z] GC before operation: completed in 68.946 ms, heap usage 170.459 MB -> 65.894 MB. [2026-04-21T22:22:39.530Z] ====== als (apache-spark) [default], iteration 8 completed (7645.603 ms) ====== [2026-04-21T22:22:39.530Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-21T22:22:39.530Z] GC before operation: completed in 71.584 ms, heap usage 233.580 MB -> 66.599 MB. [2026-04-21T22:22:48.090Z] ====== als (apache-spark) [default], iteration 9 completed (8195.831 ms) ====== [2026-04-21T22:22:48.090Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-21T22:22:48.090Z] GC before operation: completed in 67.372 ms, heap usage 129.892 MB -> 66.683 MB. [2026-04-21T22:22:56.643Z] ====== als (apache-spark) [default], iteration 10 completed (8342.162 ms) ====== [2026-04-21T22:22:56.643Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-21T22:22:56.643Z] GC before operation: completed in 84.969 ms, heap usage 261.140 MB -> 66.998 MB. [2026-04-21T22:23:03.789Z] ====== als (apache-spark) [default], iteration 11 completed (7942.015 ms) ====== [2026-04-21T22:23:03.789Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-21T22:23:03.789Z] GC before operation: completed in 102.160 ms, heap usage 154.626 MB -> 67.343 MB. [2026-04-21T22:23:12.771Z] ====== als (apache-spark) [default], iteration 12 completed (7693.064 ms) ====== [2026-04-21T22:23:12.771Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-21T22:23:12.771Z] GC before operation: completed in 94.809 ms, heap usage 149.448 MB -> 67.482 MB. [2026-04-21T22:23:21.317Z] ====== als (apache-spark) [default], iteration 13 completed (8884.434 ms) ====== [2026-04-21T22:23:21.317Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-21T22:23:21.317Z] GC before operation: completed in 87.017 ms, heap usage 186.798 MB -> 67.618 MB. [2026-04-21T22:23:29.889Z] ====== als (apache-spark) [default], iteration 14 completed (8603.839 ms) ====== [2026-04-21T22:23:29.889Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-21T22:23:29.889Z] GC before operation: completed in 97.547 ms, heap usage 308.956 MB -> 68.071 MB. [2026-04-21T22:23:40.273Z] ====== als (apache-spark) [default], iteration 15 completed (9203.797 ms) ====== [2026-04-21T22:23:40.273Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-21T22:23:40.273Z] GC before operation: completed in 149.527 ms, heap usage 149.267 MB -> 68.194 MB. [2026-04-21T22:23:49.074Z] ====== als (apache-spark) [default], iteration 16 completed (9086.716 ms) ====== [2026-04-21T22:23:49.074Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-21T22:23:49.074Z] GC before operation: completed in 68.777 ms, heap usage 150.896 MB -> 68.528 MB. [2026-04-21T22:23:57.784Z] ====== als (apache-spark) [default], iteration 17 completed (9006.255 ms) ====== [2026-04-21T22:23:57.784Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-21T22:23:57.784Z] GC before operation: completed in 77.957 ms, heap usage 180.693 MB -> 68.614 MB. [2026-04-21T22:24:06.397Z] ====== als (apache-spark) [default], iteration 18 completed (8520.488 ms) ====== [2026-04-21T22:24:06.397Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-21T22:24:07.029Z] GC before operation: completed in 87.102 ms, heap usage 177.562 MB -> 68.917 MB. [2026-04-21T22:24:17.856Z] ====== als (apache-spark) [default], iteration 19 completed (9964.453 ms) ====== [2026-04-21T22:24:17.856Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-21T22:24:17.856Z] GC before operation: completed in 69.576 ms, heap usage 113.071 MB -> 69.228 MB. [2026-04-21T22:24:28.057Z] ====== als (apache-spark) [default], iteration 20 completed (10709.032 ms) ====== [2026-04-21T22:24:28.057Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-21T22:24:28.057Z] GC before operation: completed in 113.420 ms, heap usage 492.612 MB -> 69.831 MB. [2026-04-21T22:24:38.732Z] ====== als (apache-spark) [default], iteration 21 completed (9648.993 ms) ====== [2026-04-21T22:24:38.733Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-21T22:24:38.733Z] GC before operation: completed in 81.497 ms, heap usage 148.757 MB -> 69.651 MB. [2026-04-21T22:24:49.290Z] ====== als (apache-spark) [default], iteration 22 completed (10032.320 ms) ====== [2026-04-21T22:24:49.290Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-21T22:24:49.290Z] GC before operation: completed in 106.284 ms, heap usage 388.403 MB -> 70.187 MB. [2026-04-21T22:24:59.667Z] ====== als (apache-spark) [default], iteration 23 completed (10388.781 ms) ====== [2026-04-21T22:24:59.667Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-21T22:24:59.667Z] GC before operation: completed in 92.238 ms, heap usage 189.447 MB -> 70.447 MB. [2026-04-21T22:25:10.783Z] ====== als (apache-spark) [default], iteration 24 completed (10983.552 ms) ====== [2026-04-21T22:25:10.783Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-21T22:25:10.783Z] GC before operation: completed in 91.627 ms, heap usage 229.660 MB -> 70.413 MB. [2026-04-21T22:25:21.085Z] ====== als (apache-spark) [default], iteration 25 completed (9757.807 ms) ====== [2026-04-21T22:25:21.085Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-21T22:25:21.085Z] GC before operation: completed in 90.243 ms, heap usage 162.160 MB -> 70.804 MB. [2026-04-21T22:25:31.370Z] ====== als (apache-spark) [default], iteration 26 completed (10352.611 ms) ====== [2026-04-21T22:25:31.370Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-21T22:25:31.370Z] GC before operation: completed in 99.436 ms, heap usage 262.297 MB -> 71.175 MB. [2026-04-21T22:25:41.713Z] ====== als (apache-spark) [default], iteration 27 completed (10442.265 ms) ====== [2026-04-21T22:25:41.713Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-21T22:25:41.713Z] GC before operation: completed in 108.146 ms, heap usage 311.252 MB -> 71.449 MB. [2026-04-21T22:25:52.096Z] ====== als (apache-spark) [default], iteration 28 completed (10284.009 ms) ====== [2026-04-21T22:25:52.096Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-21T22:25:52.096Z] GC before operation: completed in 91.336 ms, heap usage 580.159 MB -> 72.013 MB. [2026-04-21T22:26:02.833Z] ====== als (apache-spark) [default], iteration 29 completed (10568.280 ms) ====== [2026-04-21T22:26:02.833Z] ----------------------------------- [2026-04-21T22:26:02.833Z] renaissance-als_0_PASSED [2026-04-21T22:26:02.833Z] ----------------------------------- [2026-04-21T22:26:02.833Z] [2026-04-21T22:26:02.833Z] TEST TEARDOWN: [2026-04-21T22:26:02.833Z] Nothing to be done for teardown. [2026-04-21T22:26:02.833Z] renaissance-als_0 Finish Time: Tue Apr 21 22:26:02 2026 Epoch Time (ms): 1776810362570