[2026-01-21T01:16:08.058Z] Running test renaissance-als_0 ... [2026-01-21T01:16:08.058Z] =============================================== [2026-01-21T01:16:08.058Z] renaissance-als_0 Start Time: Wed Jan 21 01:16:07 2026 Epoch Time (ms): 1768958167847 [2026-01-21T01:16:08.058Z] variation: NoOptions [2026-01-21T01:16:08.058Z] JVM_OPTIONS: [2026-01-21T01:16:08.058Z] { \ [2026-01-21T01:16:08.058Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T01:16:08.058Z] echo "Nothing to be done for setup."; \ [2026-01-21T01:16:08.058Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-als_0"; \ [2026-01-21T01:16:08.058Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-als_0"; \ [2026-01-21T01:16:08.058Z] echo ""; echo "TESTING:"; \ [2026-01-21T01:16:08.058Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-als_0"/als.json" als; \ [2026-01-21T01:16:08.058Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T01:16:08.058Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T01:16:08.058Z] echo "Nothing to be done for teardown."; \ [2026-01-21T01:16:08.058Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17689579846604/TestTargetResult"; [2026-01-21T01:16:08.058Z] [2026-01-21T01:16:08.058Z] TEST SETUP: [2026-01-21T01:16:08.058Z] Nothing to be done for setup. [2026-01-21T01:16:08.058Z] [2026-01-21T01:16:08.058Z] TESTING: [2026-01-21T01:16:15.881Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-21T01:16:21.008Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-01-21T01:16:21.008Z] GC before operation: completed in 59.822 ms, heap usage 342.000 MB -> 35.239 MB. [2026-01-21T01:16:49.920Z] ====== als (apache-spark) [default], iteration 0 completed (23230.675 ms) ====== [2026-01-21T01:16:49.920Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-01-21T01:16:49.920Z] GC before operation: completed in 92.017 ms, heap usage 275.837 MB -> 62.096 MB. [2026-01-21T01:16:56.395Z] ====== als (apache-spark) [default], iteration 1 completed (9830.584 ms) ====== [2026-01-21T01:16:56.395Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-01-21T01:16:56.395Z] GC before operation: completed in 91.687 ms, heap usage 156.933 MB -> 62.892 MB. [2026-01-21T01:17:06.114Z] ====== als (apache-spark) [default], iteration 2 completed (9556.301 ms) ====== [2026-01-21T01:17:06.114Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-01-21T01:17:06.114Z] GC before operation: completed in 98.371 ms, heap usage 201.926 MB -> 63.487 MB. [2026-01-21T01:17:15.782Z] ====== als (apache-spark) [default], iteration 3 completed (9085.593 ms) ====== [2026-01-21T01:17:15.782Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-01-21T01:17:15.782Z] GC before operation: completed in 98.195 ms, heap usage 379.199 MB -> 64.285 MB. [2026-01-21T01:17:25.273Z] ====== als (apache-spark) [default], iteration 4 completed (8824.461 ms) ====== [2026-01-21T01:17:25.273Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-01-21T01:17:25.273Z] GC before operation: completed in 95.262 ms, heap usage 122.778 MB -> 64.666 MB. [2026-01-21T01:17:33.140Z] ====== als (apache-spark) [default], iteration 5 completed (8425.692 ms) ====== [2026-01-21T01:17:33.140Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-01-21T01:17:33.532Z] GC before operation: completed in 101.981 ms, heap usage 541.463 MB -> 65.677 MB. [2026-01-21T01:17:43.099Z] ====== als (apache-spark) [default], iteration 6 completed (8629.158 ms) ====== [2026-01-21T01:17:43.099Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-01-21T01:17:43.099Z] GC before operation: completed in 103.305 ms, heap usage 355.392 MB -> 65.942 MB. [2026-01-21T01:17:52.630Z] ====== als (apache-spark) [default], iteration 7 completed (8507.137 ms) ====== [2026-01-21T01:17:52.630Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-01-21T01:17:52.630Z] GC before operation: completed in 147.979 ms, heap usage 502.535 MB -> 66.685 MB. [2026-01-21T01:18:00.619Z] ====== als (apache-spark) [default], iteration 8 completed (8602.101 ms) ====== [2026-01-21T01:18:00.619Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-01-21T01:18:00.619Z] GC before operation: completed in 104.871 ms, heap usage 348.748 MB -> 67.041 MB. [2026-01-21T01:18:10.169Z] ====== als (apache-spark) [default], iteration 9 completed (8361.666 ms) ====== [2026-01-21T01:18:10.169Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-01-21T01:18:10.169Z] GC before operation: completed in 110.913 ms, heap usage 445.662 MB -> 67.531 MB. [2026-01-21T01:18:18.181Z] ====== als (apache-spark) [default], iteration 10 completed (8253.787 ms) ====== [2026-01-21T01:18:18.181Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-01-21T01:18:18.181Z] GC before operation: completed in 108.843 ms, heap usage 192.739 MB -> 67.327 MB. [2026-01-21T01:18:27.832Z] ====== als (apache-spark) [default], iteration 11 completed (8276.665 ms) ====== [2026-01-21T01:18:27.832Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-01-21T01:18:27.832Z] GC before operation: completed in 104.399 ms, heap usage 186.309 MB -> 67.758 MB. [2026-01-21T01:18:35.864Z] ====== als (apache-spark) [default], iteration 12 completed (8211.289 ms) ====== [2026-01-21T01:18:35.864Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-01-21T01:18:35.864Z] GC before operation: completed in 107.748 ms, heap usage 206.415 MB -> 67.967 MB. [2026-01-21T01:18:43.760Z] ====== als (apache-spark) [default], iteration 13 completed (8252.434 ms) ====== [2026-01-21T01:18:43.760Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-01-21T01:18:43.760Z] GC before operation: completed in 107.993 ms, heap usage 353.642 MB -> 68.433 MB. [2026-01-21T01:18:53.274Z] ====== als (apache-spark) [default], iteration 14 completed (8152.595 ms) ====== [2026-01-21T01:18:53.274Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-01-21T01:18:53.274Z] GC before operation: completed in 108.514 ms, heap usage 146.707 MB -> 68.467 MB. [2026-01-21T01:19:01.158Z] ====== als (apache-spark) [default], iteration 15 completed (7972.948 ms) ====== [2026-01-21T01:19:01.159Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-01-21T01:19:01.159Z] GC before operation: completed in 114.626 ms, heap usage 746.528 MB -> 69.377 MB. [2026-01-21T01:19:08.959Z] ====== als (apache-spark) [default], iteration 16 completed (8215.322 ms) ====== [2026-01-21T01:19:08.959Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-01-21T01:19:09.359Z] GC before operation: completed in 111.325 ms, heap usage 123.445 MB -> 69.297 MB. [2026-01-21T01:19:17.493Z] ====== als (apache-spark) [default], iteration 17 completed (8134.015 ms) ====== [2026-01-21T01:19:17.493Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-01-21T01:19:17.493Z] GC before operation: completed in 113.514 ms, heap usage 455.507 MB -> 69.669 MB. [2026-01-21T01:19:27.189Z] ====== als (apache-spark) [default], iteration 18 completed (8151.021 ms) ====== [2026-01-21T01:19:27.190Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-01-21T01:19:27.190Z] GC before operation: completed in 110.525 ms, heap usage 186.651 MB -> 69.458 MB. [2026-01-21T01:19:35.115Z] ====== als (apache-spark) [default], iteration 19 completed (8103.067 ms) ====== [2026-01-21T01:19:35.115Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-01-21T01:19:35.115Z] GC before operation: completed in 111.341 ms, heap usage 324.456 MB -> 69.969 MB. [2026-01-21T01:19:43.979Z] ====== als (apache-spark) [default], iteration 20 completed (8434.035 ms) ====== [2026-01-21T01:19:43.979Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-01-21T01:19:43.979Z] GC before operation: completed in 111.740 ms, heap usage 468.272 MB -> 70.468 MB. [2026-01-21T01:19:51.889Z] ====== als (apache-spark) [default], iteration 21 completed (8265.194 ms) ====== [2026-01-21T01:19:51.889Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-01-21T01:19:52.258Z] GC before operation: completed in 113.801 ms, heap usage 268.326 MB -> 70.438 MB. [2026-01-21T01:20:01.859Z] ====== als (apache-spark) [default], iteration 22 completed (8306.795 ms) ====== [2026-01-21T01:20:01.859Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-01-21T01:20:01.859Z] GC before operation: completed in 111.882 ms, heap usage 314.269 MB -> 70.758 MB. [2026-01-21T01:20:09.940Z] ====== als (apache-spark) [default], iteration 23 completed (8204.406 ms) ====== [2026-01-21T01:20:09.940Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-01-21T01:20:09.940Z] GC before operation: completed in 113.568 ms, heap usage 532.133 MB -> 71.356 MB. [2026-01-21T01:20:17.816Z] ====== als (apache-spark) [default], iteration 24 completed (8361.357 ms) ====== [2026-01-21T01:20:17.816Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-01-21T01:20:18.350Z] GC before operation: completed in 115.859 ms, heap usage 527.993 MB -> 71.531 MB. [2026-01-21T01:20:26.264Z] ====== als (apache-spark) [default], iteration 25 completed (8109.413 ms) ====== [2026-01-21T01:20:26.264Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-01-21T01:20:26.699Z] GC before operation: completed in 116.921 ms, heap usage 470.439 MB -> 71.698 MB. [2026-01-21T01:20:34.624Z] ====== als (apache-spark) [default], iteration 26 completed (7965.733 ms) ====== [2026-01-21T01:20:34.624Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-01-21T01:20:35.010Z] GC before operation: completed in 99.882 ms, heap usage 191.932 MB -> 71.618 MB. [2026-01-21T01:20:43.157Z] ====== als (apache-spark) [default], iteration 27 completed (8105.873 ms) ====== [2026-01-21T01:20:43.157Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-01-21T01:20:43.157Z] GC before operation: completed in 106.146 ms, heap usage 494.314 MB -> 72.263 MB. [2026-01-21T01:20:52.707Z] ====== als (apache-spark) [default], iteration 28 completed (8088.942 ms) ====== [2026-01-21T01:20:52.707Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-01-21T01:20:52.707Z] GC before operation: completed in 104.655 ms, heap usage 552.653 MB -> 72.591 MB. [2026-01-21T01:21:00.634Z] ====== als (apache-spark) [default], iteration 29 completed (8011.606 ms) ====== [2026-01-21T01:21:00.634Z] ----------------------------------- [2026-01-21T01:21:00.634Z] renaissance-als_0_PASSED [2026-01-21T01:21:00.634Z] ----------------------------------- [2026-01-21T01:21:00.634Z] [2026-01-21T01:21:00.634Z] TEST TEARDOWN: [2026-01-21T01:21:00.634Z] Nothing to be done for teardown. [2026-01-21T01:21:00.634Z] renaissance-als_0 Finish Time: Wed Jan 21 01:21:00 2026 Epoch Time (ms): 1768958460111