[2026-02-27T22:00:50.145Z] Running test renaissance-als_0 ... [2026-02-27T22:00:50.145Z] =============================================== [2026-02-27T22:00:50.145Z] renaissance-als_0 Start Time: Fri Feb 27 16:00:49 2026 Epoch Time (ms): 1772229649768 [2026-02-27T22:00:50.145Z] variation: NoOptions [2026-02-27T22:00:50.145Z] JVM_OPTIONS: [2026-02-27T22:00:50.145Z] { \ [2026-02-27T22:00:50.145Z] echo ""; echo "TEST SETUP:"; \ [2026-02-27T22:00:50.145Z] echo "Nothing to be done for setup."; \ [2026-02-27T22:00:50.145Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17722294195566/renaissance-als_0"; \ [2026-02-27T22:00:50.145Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17722294195566/renaissance-als_0"; \ [2026-02-27T22:00:50.145Z] echo ""; echo "TESTING:"; \ [2026-02-27T22:00:50.145Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17722294195566/renaissance-als_0"/als.json" als; \ [2026-02-27T22:00:50.146Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17722294195566/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-27T22:00:50.146Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-27T22:00:50.146Z] echo "Nothing to be done for teardown."; \ [2026-02-27T22:00:50.146Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17722294195566/TestTargetResult"; [2026-02-27T22:00:50.146Z] [2026-02-27T22:00:50.146Z] TEST SETUP: [2026-02-27T22:00:50.146Z] Nothing to be done for setup. [2026-02-27T22:00:50.146Z] [2026-02-27T22:00:50.146Z] TESTING: [2026-02-27T22:00:55.088Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-02-27T22:00:59.010Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-27T22:00:59.010Z] GC before operation: completed in 47.994 ms, heap usage 51.000 MB -> 35.067 MB. [2026-02-27T22:01:28.579Z] ====== als (apache-spark) [default], iteration 0 completed (26243.229 ms) ====== [2026-02-27T22:01:28.579Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-27T22:01:28.579Z] GC before operation: completed in 111.245 ms, heap usage 170.759 MB -> 61.650 MB. [2026-02-27T22:01:43.620Z] ====== als (apache-spark) [default], iteration 1 completed (16171.916 ms) ====== [2026-02-27T22:01:43.620Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-27T22:01:43.620Z] GC before operation: completed in 288.180 ms, heap usage 133.740 MB -> 62.579 MB. [2026-02-27T22:01:58.781Z] ====== als (apache-spark) [default], iteration 2 completed (14798.716 ms) ====== [2026-02-27T22:01:58.781Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-27T22:01:58.781Z] GC before operation: completed in 105.932 ms, heap usage 200.333 MB -> 63.337 MB. [2026-02-27T22:02:13.956Z] ====== als (apache-spark) [default], iteration 3 completed (14032.691 ms) ====== [2026-02-27T22:02:13.956Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-27T22:02:13.956Z] GC before operation: completed in 124.349 ms, heap usage 94.712 MB -> 63.757 MB. [2026-02-27T22:02:27.191Z] ====== als (apache-spark) [default], iteration 4 completed (13872.894 ms) ====== [2026-02-27T22:02:27.191Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-27T22:02:27.191Z] GC before operation: completed in 147.204 ms, heap usage 219.836 MB -> 64.400 MB. [2026-02-27T22:02:42.245Z] ====== als (apache-spark) [default], iteration 5 completed (13037.748 ms) ====== [2026-02-27T22:02:42.246Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-27T22:02:42.246Z] GC before operation: completed in 243.346 ms, heap usage 108.290 MB -> 64.863 MB. [2026-02-27T22:02:55.160Z] ====== als (apache-spark) [default], iteration 6 completed (14183.797 ms) ====== [2026-02-27T22:02:55.160Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-27T22:02:55.160Z] GC before operation: completed in 116.385 ms, heap usage 219.204 MB -> 65.559 MB. [2026-02-27T22:03:10.289Z] ====== als (apache-spark) [default], iteration 7 completed (13296.017 ms) ====== [2026-02-27T22:03:10.289Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-27T22:03:10.289Z] GC before operation: completed in 143.965 ms, heap usage 201.973 MB -> 65.911 MB. [2026-02-27T22:03:25.452Z] ====== als (apache-spark) [default], iteration 8 completed (14310.189 ms) ====== [2026-02-27T22:03:25.452Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-27T22:03:25.452Z] GC before operation: completed in 141.390 ms, heap usage 210.639 MB -> 66.598 MB. [2026-02-27T22:03:38.908Z] ====== als (apache-spark) [default], iteration 9 completed (13720.134 ms) ====== [2026-02-27T22:03:38.908Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-27T22:03:38.908Z] GC before operation: completed in 151.230 ms, heap usage 361.467 MB -> 67.188 MB. [2026-02-27T22:03:54.226Z] ====== als (apache-spark) [default], iteration 10 completed (15189.223 ms) ====== [2026-02-27T22:03:54.226Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-27T22:03:54.226Z] GC before operation: completed in 196.442 ms, heap usage 261.996 MB -> 66.970 MB. [2026-02-27T22:04:12.416Z] ====== als (apache-spark) [default], iteration 11 completed (17199.734 ms) ====== [2026-02-27T22:04:12.416Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-27T22:04:12.416Z] GC before operation: completed in 192.888 ms, heap usage 421.817 MB -> 67.467 MB. [2026-02-27T22:04:27.907Z] ====== als (apache-spark) [default], iteration 12 completed (15444.633 ms) ====== [2026-02-27T22:04:27.907Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-27T22:04:27.907Z] GC before operation: completed in 124.968 ms, heap usage 271.588 MB -> 67.549 MB. [2026-02-27T22:04:44.123Z] ====== als (apache-spark) [default], iteration 13 completed (15043.625 ms) ====== [2026-02-27T22:04:44.123Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-27T22:04:44.123Z] GC before operation: completed in 158.429 ms, heap usage 380.453 MB -> 67.912 MB. [2026-02-27T22:04:57.026Z] ====== als (apache-spark) [default], iteration 14 completed (14000.762 ms) ====== [2026-02-27T22:04:57.026Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-27T22:04:57.026Z] GC before operation: completed in 156.247 ms, heap usage 243.646 MB -> 68.082 MB. [2026-02-27T22:05:12.226Z] ====== als (apache-spark) [default], iteration 15 completed (14789.333 ms) ====== [2026-02-27T22:05:12.226Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-27T22:05:12.226Z] GC before operation: completed in 124.680 ms, heap usage 193.853 MB -> 68.218 MB. [2026-02-27T22:05:27.234Z] ====== als (apache-spark) [default], iteration 16 completed (13480.967 ms) ====== [2026-02-27T22:05:27.234Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-27T22:05:27.234Z] GC before operation: completed in 148.834 ms, heap usage 137.052 MB -> 68.623 MB. [2026-02-27T22:05:40.237Z] ====== als (apache-spark) [default], iteration 17 completed (13631.739 ms) ====== [2026-02-27T22:05:40.237Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-27T22:05:40.237Z] GC before operation: completed in 118.042 ms, heap usage 468.909 MB -> 69.239 MB. [2026-02-27T22:05:56.156Z] ====== als (apache-spark) [default], iteration 18 completed (14201.437 ms) ====== [2026-02-27T22:05:56.156Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-27T22:05:56.156Z] GC before operation: completed in 118.254 ms, heap usage 83.808 MB -> 68.486 MB. [2026-02-27T22:06:08.907Z] ====== als (apache-spark) [default], iteration 19 completed (13042.398 ms) ====== [2026-02-27T22:06:08.907Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-27T22:06:08.907Z] GC before operation: completed in 128.564 ms, heap usage 299.128 MB -> 69.440 MB. [2026-02-27T22:06:21.709Z] ====== als (apache-spark) [default], iteration 20 completed (12888.074 ms) ====== [2026-02-27T22:06:21.709Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-27T22:06:21.709Z] GC before operation: completed in 133.400 ms, heap usage 178.834 MB -> 69.524 MB. [2026-02-27T22:06:36.956Z] ====== als (apache-spark) [default], iteration 21 completed (15369.997 ms) ====== [2026-02-27T22:06:36.956Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-27T22:06:36.956Z] GC before operation: completed in 163.045 ms, heap usage 182.191 MB -> 69.738 MB. [2026-02-27T22:06:54.956Z] ====== als (apache-spark) [default], iteration 22 completed (17393.991 ms) ====== [2026-02-27T22:06:54.956Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-27T22:06:54.956Z] GC before operation: completed in 169.134 ms, heap usage 100.607 MB -> 69.961 MB. [2026-02-27T22:07:11.536Z] ====== als (apache-spark) [default], iteration 23 completed (15696.935 ms) ====== [2026-02-27T22:07:11.536Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-27T22:07:11.536Z] GC before operation: completed in 172.757 ms, heap usage 328.443 MB -> 70.540 MB. [2026-02-27T22:07:29.446Z] ====== als (apache-spark) [default], iteration 24 completed (16895.693 ms) ====== [2026-02-27T22:07:29.446Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-27T22:07:29.446Z] GC before operation: completed in 179.350 ms, heap usage 218.711 MB -> 70.620 MB. [2026-02-27T22:07:47.634Z] ====== als (apache-spark) [default], iteration 25 completed (17127.212 ms) ====== [2026-02-27T22:07:47.634Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-27T22:07:47.634Z] GC before operation: completed in 278.655 ms, heap usage 185.335 MB -> 70.830 MB. [2026-02-27T22:08:05.716Z] ====== als (apache-spark) [default], iteration 26 completed (17058.195 ms) ====== [2026-02-27T22:08:05.716Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-27T22:08:05.716Z] GC before operation: completed in 201.256 ms, heap usage 92.246 MB -> 70.641 MB. [2026-02-27T22:08:19.750Z] ====== als (apache-spark) [default], iteration 27 completed (15739.587 ms) ====== [2026-02-27T22:08:19.750Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-27T22:08:19.750Z] GC before operation: completed in 137.636 ms, heap usage 488.432 MB -> 71.759 MB. [2026-02-27T22:08:37.616Z] ====== als (apache-spark) [default], iteration 28 completed (16358.785 ms) ====== [2026-02-27T22:08:37.616Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-27T22:08:37.616Z] GC before operation: completed in 185.937 ms, heap usage 216.639 MB -> 71.095 MB. [2026-02-27T22:08:52.935Z] ====== als (apache-spark) [default], iteration 29 completed (16158.361 ms) ====== [2026-02-27T22:08:53.671Z] ----------------------------------- [2026-02-27T22:08:53.671Z] renaissance-als_0_PASSED [2026-02-27T22:08:53.671Z] ----------------------------------- [2026-02-27T22:08:53.671Z] [2026-02-27T22:08:53.671Z] TEST TEARDOWN: [2026-02-27T22:08:53.671Z] Nothing to be done for teardown. [2026-02-27T22:08:53.671Z] renaissance-als_0 Finish Time: Fri Feb 27 16:08:53 2026 Epoch Time (ms): 1772230133536