[2026-03-04T22:25:11.773Z] Running test renaissance-als_0 ... [2026-03-04T22:25:11.773Z] =============================================== [2026-03-04T22:25:11.773Z] renaissance-als_0 Start Time: Wed Mar 4 17:25:11 2026 Epoch Time (ms): 1772663111207 [2026-03-04T22:25:11.773Z] variation: NoOptions [2026-03-04T22:25:11.773Z] JVM_OPTIONS: [2026-03-04T22:25:11.773Z] { \ [2026-03-04T22:25:11.773Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T22:25:11.773Z] echo "Nothing to be done for setup."; \ [2026-03-04T22:25:11.773Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1772662928868/renaissance-als_0"; \ [2026-03-04T22:25:11.773Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1772662928868/renaissance-als_0"; \ [2026-03-04T22:25:11.774Z] echo ""; echo "TESTING:"; \ [2026-03-04T22:25:11.774Z] "/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_1772662928868/renaissance-als_0"/als.json" als; \ [2026-03-04T22:25:11.774Z] 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_1772662928868/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T22:25:11.774Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T22:25:11.774Z] echo "Nothing to be done for teardown."; \ [2026-03-04T22:25:11.774Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1772662928868/TestTargetResult"; [2026-03-04T22:25:11.774Z] [2026-03-04T22:25:11.774Z] TEST SETUP: [2026-03-04T22:25:11.774Z] Nothing to be done for setup. [2026-03-04T22:25:11.774Z] [2026-03-04T22:25:11.774Z] TESTING: [2026-03-04T22:25:16.775Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-03-04T22:25:20.625Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-03-04T22:25:20.625Z] GC before operation: completed in 80.072 ms, heap usage 465.418 MB -> 34.946 MB. [2026-03-04T22:25:44.695Z] ====== als (apache-spark) [default], iteration 0 completed (21786.101 ms) ====== [2026-03-04T22:25:44.695Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-03-04T22:25:44.695Z] GC before operation: completed in 127.718 ms, heap usage 125.601 MB -> 62.015 MB. [2026-03-04T22:25:57.145Z] ====== als (apache-spark) [default], iteration 1 completed (12913.235 ms) ====== [2026-03-04T22:25:57.145Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-03-04T22:25:57.145Z] GC before operation: completed in 113.936 ms, heap usage 289.687 MB -> 62.707 MB. [2026-03-04T22:26:09.634Z] ====== als (apache-spark) [default], iteration 2 completed (11734.528 ms) ====== [2026-03-04T22:26:09.634Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-03-04T22:26:09.634Z] GC before operation: completed in 143.075 ms, heap usage 122.137 MB -> 63.520 MB. [2026-03-04T22:26:20.373Z] ====== als (apache-spark) [default], iteration 3 completed (11248.975 ms) ====== [2026-03-04T22:26:20.373Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-03-04T22:26:20.373Z] GC before operation: completed in 105.060 ms, heap usage 199.375 MB -> 64.263 MB. [2026-03-04T22:26:32.996Z] ====== als (apache-spark) [default], iteration 4 completed (11581.059 ms) ====== [2026-03-04T22:26:32.996Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-03-04T22:26:32.996Z] GC before operation: completed in 113.692 ms, heap usage 352.107 MB -> 64.521 MB. [2026-03-04T22:26:43.654Z] ====== als (apache-spark) [default], iteration 5 completed (11134.482 ms) ====== [2026-03-04T22:26:43.654Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-03-04T22:26:43.654Z] GC before operation: completed in 117.306 ms, heap usage 544.670 MB -> 65.478 MB. [2026-03-04T22:26:54.302Z] ====== als (apache-spark) [default], iteration 6 completed (10988.291 ms) ====== [2026-03-04T22:26:54.302Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-03-04T22:26:54.302Z] GC before operation: completed in 106.738 ms, heap usage 249.313 MB -> 65.509 MB. [2026-03-04T22:27:06.987Z] ====== als (apache-spark) [default], iteration 7 completed (10768.887 ms) ====== [2026-03-04T22:27:06.987Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-03-04T22:27:06.987Z] GC before operation: completed in 117.005 ms, heap usage 253.987 MB -> 66.090 MB. [2026-03-04T22:27:18.055Z] ====== als (apache-spark) [default], iteration 8 completed (11160.900 ms) ====== [2026-03-04T22:27:18.055Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-03-04T22:27:18.055Z] GC before operation: completed in 121.424 ms, heap usage 129.297 MB -> 66.177 MB. [2026-03-04T22:27:28.795Z] ====== als (apache-spark) [default], iteration 9 completed (11471.529 ms) ====== [2026-03-04T22:27:28.795Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-03-04T22:27:28.795Z] GC before operation: completed in 147.888 ms, heap usage 462.336 MB -> 67.593 MB. [2026-03-04T22:27:41.445Z] ====== als (apache-spark) [default], iteration 10 completed (10970.326 ms) ====== [2026-03-04T22:27:41.445Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-03-04T22:27:41.445Z] GC before operation: completed in 123.470 ms, heap usage 187.983 MB -> 66.979 MB. [2026-03-04T22:27:51.178Z] ====== als (apache-spark) [default], iteration 11 completed (10655.611 ms) ====== [2026-03-04T22:27:51.178Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-03-04T22:27:51.178Z] GC before operation: completed in 132.079 ms, heap usage 384.950 MB -> 67.525 MB. [2026-03-04T22:28:03.837Z] ====== als (apache-spark) [default], iteration 12 completed (10893.866 ms) ====== [2026-03-04T22:28:03.837Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-03-04T22:28:03.837Z] GC before operation: completed in 153.441 ms, heap usage 424.675 MB -> 67.746 MB. [2026-03-04T22:28:14.588Z] ====== als (apache-spark) [default], iteration 13 completed (10934.181 ms) ====== [2026-03-04T22:28:14.588Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-03-04T22:28:14.588Z] GC before operation: completed in 141.902 ms, heap usage 359.232 MB -> 68.028 MB. [2026-03-04T22:28:26.977Z] ====== als (apache-spark) [default], iteration 14 completed (11347.493 ms) ====== [2026-03-04T22:28:26.977Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-03-04T22:28:26.977Z] GC before operation: completed in 123.356 ms, heap usage 256.439 MB -> 68.159 MB. [2026-03-04T22:28:37.597Z] ====== als (apache-spark) [default], iteration 15 completed (11458.103 ms) ====== [2026-03-04T22:28:37.597Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-03-04T22:28:37.597Z] GC before operation: completed in 133.422 ms, heap usage 560.259 MB -> 68.849 MB. [2026-03-04T22:28:48.201Z] ====== als (apache-spark) [default], iteration 16 completed (10980.513 ms) ====== [2026-03-04T22:28:48.201Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-03-04T22:28:48.845Z] GC before operation: completed in 118.349 ms, heap usage 507.797 MB -> 69.022 MB. [2026-03-04T22:28:59.604Z] ====== als (apache-spark) [default], iteration 17 completed (10568.562 ms) ====== [2026-03-04T22:28:59.604Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-03-04T22:28:59.604Z] GC before operation: completed in 136.317 ms, heap usage 558.496 MB -> 69.418 MB. [2026-03-04T22:29:10.127Z] ====== als (apache-spark) [default], iteration 18 completed (10691.024 ms) ====== [2026-03-04T22:29:10.127Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-03-04T22:29:10.816Z] GC before operation: completed in 121.805 ms, heap usage 136.381 MB -> 69.157 MB. [2026-03-04T22:29:21.730Z] ====== als (apache-spark) [default], iteration 19 completed (10978.212 ms) ====== [2026-03-04T22:29:21.730Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-03-04T22:29:21.730Z] GC before operation: completed in 123.645 ms, heap usage 437.026 MB -> 69.743 MB. [2026-03-04T22:29:34.341Z] ====== als (apache-spark) [default], iteration 20 completed (10945.801 ms) ====== [2026-03-04T22:29:34.341Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-03-04T22:29:34.341Z] GC before operation: completed in 127.301 ms, heap usage 270.992 MB -> 69.636 MB. [2026-03-04T22:29:44.864Z] ====== als (apache-spark) [default], iteration 21 completed (10727.688 ms) ====== [2026-03-04T22:29:44.864Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-03-04T22:29:44.864Z] GC before operation: completed in 127.509 ms, heap usage 243.451 MB -> 69.968 MB. [2026-03-04T22:29:55.565Z] ====== als (apache-spark) [default], iteration 22 completed (10531.438 ms) ====== [2026-03-04T22:29:55.565Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-03-04T22:29:55.565Z] GC before operation: completed in 114.463 ms, heap usage 262.898 MB -> 70.168 MB. [2026-03-04T22:30:06.178Z] ====== als (apache-spark) [default], iteration 23 completed (10217.326 ms) ====== [2026-03-04T22:30:06.178Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-03-04T22:30:06.178Z] GC before operation: completed in 119.289 ms, heap usage 132.745 MB -> 70.628 MB. [2026-03-04T22:30:17.289Z] ====== als (apache-spark) [default], iteration 24 completed (10824.939 ms) ====== [2026-03-04T22:30:17.289Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-03-04T22:30:17.289Z] GC before operation: completed in 133.789 ms, heap usage 241.829 MB -> 70.703 MB. [2026-03-04T22:30:27.982Z] ====== als (apache-spark) [default], iteration 25 completed (10527.316 ms) ====== [2026-03-04T22:30:27.982Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-03-04T22:30:27.982Z] GC before operation: completed in 129.434 ms, heap usage 212.534 MB -> 70.859 MB. [2026-03-04T22:30:38.498Z] ====== als (apache-spark) [default], iteration 26 completed (10814.810 ms) ====== [2026-03-04T22:30:38.498Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-03-04T22:30:38.498Z] GC before operation: completed in 126.005 ms, heap usage 394.516 MB -> 71.328 MB. [2026-03-04T22:30:48.994Z] ====== als (apache-spark) [default], iteration 27 completed (10424.952 ms) ====== [2026-03-04T22:30:48.994Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-03-04T22:30:49.634Z] GC before operation: completed in 118.032 ms, heap usage 147.982 MB -> 71.477 MB. [2026-03-04T22:31:00.152Z] ====== als (apache-spark) [default], iteration 28 completed (10759.829 ms) ====== [2026-03-04T22:31:00.152Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-03-04T22:31:00.153Z] GC before operation: completed in 119.291 ms, heap usage 421.065 MB -> 71.992 MB. [2026-03-04T22:31:10.600Z] ====== als (apache-spark) [default], iteration 29 completed (10090.225 ms) ====== [2026-03-04T22:31:11.219Z] ----------------------------------- [2026-03-04T22:31:11.219Z] renaissance-als_0_PASSED [2026-03-04T22:31:11.219Z] ----------------------------------- [2026-03-04T22:31:11.219Z] [2026-03-04T22:31:11.219Z] TEST TEARDOWN: [2026-03-04T22:31:11.219Z] Nothing to be done for teardown. [2026-03-04T22:31:11.219Z] renaissance-als_0 Finish Time: Wed Mar 4 17:31:10 2026 Epoch Time (ms): 1772663470796