[2026-04-02T01:23:18.386Z] Running test renaissance-als_0 ... [2026-04-02T01:23:18.386Z] =============================================== [2026-04-02T01:23:18.386Z] renaissance-als_0 Start Time: Thu Apr 2 01:23:18 2026 Epoch Time (ms): 1775092998180 [2026-04-02T01:23:18.386Z] variation: NoOptions [2026-04-02T01:23:18.386Z] JVM_OPTIONS: [2026-04-02T01:23:18.386Z] { \ [2026-04-02T01:23:18.386Z] echo ""; echo "TEST SETUP:"; \ [2026-04-02T01:23:18.386Z] echo "Nothing to be done for setup."; \ [2026-04-02T01:23:18.386Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-als_0"; \ [2026-04-02T01:23:18.386Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-als_0"; \ [2026-04-02T01:23:18.386Z] echo ""; echo "TESTING:"; \ [2026-04-02T01:23:18.386Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-als_0"/als.json" als; \ [2026-04-02T01:23:18.386Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-02T01:23:18.386Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-02T01:23:18.386Z] echo "Nothing to be done for teardown."; \ [2026-04-02T01:23:18.386Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/TestTargetResult"; [2026-04-02T01:23:18.386Z] [2026-04-02T01:23:18.386Z] TEST SETUP: [2026-04-02T01:23:18.386Z] Nothing to be done for setup. [2026-04-02T01:23:18.386Z] [2026-04-02T01:23:18.386Z] TESTING: [2026-04-02T01:23:29.990Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-02T01:23:38.974Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-02T01:23:38.974Z] GC before operation: completed in 64.614 ms, heap usage 53.342 MB -> 35.243 MB. [2026-04-02T01:24:23.957Z] ====== als (apache-spark) [default], iteration 0 completed (41049.625 ms) ====== [2026-04-02T01:24:23.957Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-02T01:24:23.958Z] GC before operation: completed in 267.891 ms, heap usage 140.840 MB -> 61.653 MB. [2026-04-02T01:24:35.709Z] ====== als (apache-spark) [default], iteration 1 completed (14395.107 ms) ====== [2026-04-02T01:24:35.709Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-02T01:24:35.709Z] GC before operation: completed in 174.440 ms, heap usage 755.166 MB -> 63.656 MB. [2026-04-02T01:24:49.602Z] ====== als (apache-spark) [default], iteration 2 completed (12981.131 ms) ====== [2026-04-02T01:24:49.602Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-02T01:24:49.602Z] GC before operation: completed in 334.983 ms, heap usage 413.377 MB -> 63.826 MB. [2026-04-02T01:25:08.190Z] ====== als (apache-spark) [default], iteration 3 completed (16295.891 ms) ====== [2026-04-02T01:25:08.190Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-02T01:25:08.190Z] GC before operation: completed in 325.974 ms, heap usage 637.392 MB -> 64.831 MB. [2026-04-02T01:25:21.975Z] ====== als (apache-spark) [default], iteration 4 completed (13782.906 ms) ====== [2026-04-02T01:25:21.975Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-02T01:25:21.975Z] GC before operation: completed in 250.817 ms, heap usage 133.092 MB -> 64.983 MB. [2026-04-02T01:25:35.704Z] ====== als (apache-spark) [default], iteration 5 completed (12308.865 ms) ====== [2026-04-02T01:25:35.704Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-02T01:25:35.704Z] GC before operation: completed in 178.272 ms, heap usage 151.811 MB -> 65.194 MB. [2026-04-02T01:25:42.526Z] ====== als (apache-spark) [default], iteration 6 completed (7341.727 ms) ====== [2026-04-02T01:25:42.526Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-02T01:25:42.526Z] GC before operation: completed in 174.029 ms, heap usage 590.931 MB -> 66.367 MB. [2026-04-02T01:25:50.779Z] ====== als (apache-spark) [default], iteration 7 completed (8282.464 ms) ====== [2026-04-02T01:25:50.779Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-02T01:25:51.748Z] GC before operation: completed in 186.285 ms, heap usage 706.393 MB -> 66.962 MB. [2026-04-02T01:26:02.632Z] ====== als (apache-spark) [default], iteration 8 completed (10714.150 ms) ====== [2026-04-02T01:26:02.632Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-02T01:26:02.632Z] GC before operation: completed in 258.315 ms, heap usage 138.851 MB -> 67.293 MB. [2026-04-02T01:26:16.348Z] ====== als (apache-spark) [default], iteration 9 completed (13031.279 ms) ====== [2026-04-02T01:26:16.348Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-02T01:26:17.326Z] GC before operation: completed in 290.081 ms, heap usage 870.929 MB -> 68.097 MB. [2026-04-02T01:26:31.095Z] ====== als (apache-spark) [default], iteration 10 completed (13903.822 ms) ====== [2026-04-02T01:26:31.095Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-02T01:26:32.070Z] GC before operation: completed in 371.341 ms, heap usage 982.979 MB -> 68.494 MB. [2026-04-02T01:26:45.976Z] ====== als (apache-spark) [default], iteration 11 completed (12745.491 ms) ====== [2026-04-02T01:26:45.976Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-02T01:26:45.976Z] GC before operation: completed in 235.652 ms, heap usage 228.921 MB -> 67.672 MB. [2026-04-02T01:26:57.700Z] ====== als (apache-spark) [default], iteration 12 completed (11868.297 ms) ====== [2026-04-02T01:26:57.700Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-02T01:26:57.700Z] GC before operation: completed in 207.350 ms, heap usage 106.348 MB -> 67.988 MB. [2026-04-02T01:27:07.586Z] ====== als (apache-spark) [default], iteration 13 completed (8594.545 ms) ====== [2026-04-02T01:27:07.586Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-02T01:27:07.586Z] GC before operation: completed in 221.204 ms, heap usage 232.732 MB -> 68.222 MB. [2026-04-02T01:27:19.289Z] ====== als (apache-spark) [default], iteration 14 completed (11035.827 ms) ====== [2026-04-02T01:27:19.289Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-02T01:27:19.289Z] GC before operation: completed in 227.659 ms, heap usage 397.403 MB -> 68.647 MB. [2026-04-02T01:27:27.595Z] ====== als (apache-spark) [default], iteration 15 completed (9132.362 ms) ====== [2026-04-02T01:27:27.595Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-02T01:27:28.572Z] GC before operation: completed in 299.830 ms, heap usage 526.955 MB -> 69.097 MB. [2026-04-02T01:27:40.322Z] ====== als (apache-spark) [default], iteration 16 completed (11471.272 ms) ====== [2026-04-02T01:27:40.322Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-02T01:27:40.322Z] GC before operation: completed in 339.794 ms, heap usage 551.615 MB -> 69.494 MB. [2026-04-02T01:27:52.738Z] ====== als (apache-spark) [default], iteration 17 completed (12057.993 ms) ====== [2026-04-02T01:27:52.738Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-02T01:27:53.715Z] GC before operation: completed in 335.586 ms, heap usage 647.043 MB -> 69.874 MB. [2026-04-02T01:28:05.463Z] ====== als (apache-spark) [default], iteration 18 completed (11541.947 ms) ====== [2026-04-02T01:28:05.463Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-02T01:28:05.463Z] GC before operation: completed in 265.287 ms, heap usage 576.874 MB -> 70.079 MB. [2026-04-02T01:28:19.257Z] ====== als (apache-spark) [default], iteration 19 completed (12098.797 ms) ====== [2026-04-02T01:28:19.257Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-02T01:28:19.257Z] GC before operation: completed in 320.718 ms, heap usage 704.554 MB -> 70.438 MB. [2026-04-02T01:28:33.193Z] ====== als (apache-spark) [default], iteration 20 completed (13410.961 ms) ====== [2026-04-02T01:28:33.193Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-02T01:28:33.193Z] GC before operation: completed in 359.714 ms, heap usage 923.209 MB -> 70.937 MB. [2026-04-02T01:28:44.972Z] ====== als (apache-spark) [default], iteration 21 completed (12150.297 ms) ====== [2026-04-02T01:28:44.972Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-02T01:28:46.009Z] GC before operation: completed in 369.601 ms, heap usage 143.482 MB -> 69.780 MB. [2026-04-02T01:28:59.817Z] ====== als (apache-spark) [default], iteration 22 completed (12647.933 ms) ====== [2026-04-02T01:28:59.817Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-02T01:28:59.817Z] GC before operation: completed in 322.552 ms, heap usage 256.047 MB -> 70.605 MB. [2026-04-02T01:29:11.576Z] ====== als (apache-spark) [default], iteration 23 completed (11729.997 ms) ====== [2026-04-02T01:29:11.576Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-02T01:29:11.576Z] GC before operation: completed in 342.743 ms, heap usage 692.892 MB -> 71.500 MB. [2026-04-02T01:29:25.343Z] ====== als (apache-spark) [default], iteration 24 completed (12142.294 ms) ====== [2026-04-02T01:29:25.343Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-02T01:29:25.343Z] GC before operation: completed in 277.259 ms, heap usage 653.188 MB -> 71.664 MB. [2026-04-02T01:29:37.085Z] ====== als (apache-spark) [default], iteration 25 completed (12249.373 ms) ====== [2026-04-02T01:29:37.085Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-02T01:29:37.085Z] GC before operation: completed in 294.060 ms, heap usage 562.120 MB -> 71.928 MB. [2026-04-02T01:29:49.528Z] ====== als (apache-spark) [default], iteration 26 completed (10686.852 ms) ====== [2026-04-02T01:29:49.528Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-02T01:29:49.528Z] GC before operation: completed in 343.528 ms, heap usage 372.651 MB -> 71.774 MB. [2026-04-02T01:30:01.307Z] ====== als (apache-spark) [default], iteration 27 completed (11870.886 ms) ====== [2026-04-02T01:30:01.307Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-02T01:30:01.307Z] GC before operation: completed in 381.254 ms, heap usage 169.169 MB -> 71.949 MB. [2026-04-02T01:30:15.239Z] ====== als (apache-spark) [default], iteration 28 completed (12236.341 ms) ====== [2026-04-02T01:30:15.239Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-02T01:30:15.239Z] GC before operation: completed in 373.943 ms, heap usage 623.071 MB -> 72.570 MB. [2026-04-02T01:30:27.016Z] ====== als (apache-spark) [default], iteration 29 completed (11655.975 ms) ====== [2026-04-02T01:30:27.978Z] ----------------------------------- [2026-04-02T01:30:27.978Z] renaissance-als_0_PASSED [2026-04-02T01:30:27.978Z] ----------------------------------- [2026-04-02T01:30:27.978Z] [2026-04-02T01:30:27.978Z] TEST TEARDOWN: [2026-04-02T01:30:27.978Z] Nothing to be done for teardown. [2026-04-02T01:30:27.978Z] renaissance-als_0 Finish Time: Thu Apr 2 01:30:27 2026 Epoch Time (ms): 1775093427202