[2026-04-21T22:25:09.098Z] Running test renaissance-als_0 ... [2026-04-21T22:25:09.098Z] =============================================== [2026-04-21T22:25:09.098Z] renaissance-als_0 Start Time: Tue Apr 21 22:25:08 2026 Epoch Time (ms): 1776810308462 [2026-04-21T22:25:09.098Z] variation: NoOptions [2026-04-21T22:25:09.098Z] JVM_OPTIONS: [2026-04-21T22:25:09.098Z] { \ [2026-04-21T22:25:09.098Z] echo ""; echo "TEST SETUP:"; \ [2026-04-21T22:25:09.098Z] echo "Nothing to be done for setup."; \ [2026-04-21T22:25:09.098Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768103079138/renaissance-als_0"; \ [2026-04-21T22:25:09.098Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768103079138/renaissance-als_0"; \ [2026-04-21T22:25:09.098Z] echo ""; echo "TESTING:"; \ [2026-04-21T22:25:09.098Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-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_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768103079138/renaissance-als_0"/als.json" als; \ [2026-04-21T22:25:09.098Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768103079138/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-21T22:25:09.098Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-21T22:25:09.098Z] echo "Nothing to be done for teardown."; \ [2026-04-21T22:25:09.098Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768103079138/TestTargetResult"; [2026-04-21T22:25:09.098Z] [2026-04-21T22:25:09.098Z] TEST SETUP: [2026-04-21T22:25:09.098Z] Nothing to be done for setup. [2026-04-21T22:25:09.098Z] [2026-04-21T22:25:09.098Z] TESTING: [2026-04-21T22:25:20.860Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-21T22:25:27.760Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-21T22:25:27.760Z] GC before operation: completed in 102.700 ms, heap usage 51.926 MB -> 34.963 MB. [2026-04-21T22:26:03.339Z] ====== als (apache-spark) [default], iteration 0 completed (32619.039 ms) ====== [2026-04-21T22:26:03.339Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-21T22:26:03.339Z] GC before operation: completed in 89.906 ms, heap usage 369.292 MB -> 61.945 MB. [2026-04-21T22:26:10.771Z] ====== als (apache-spark) [default], iteration 1 completed (9428.806 ms) ====== [2026-04-21T22:26:10.771Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-21T22:26:10.771Z] GC before operation: completed in 79.624 ms, heap usage 152.053 MB -> 62.593 MB. [2026-04-21T22:26:22.433Z] ====== als (apache-spark) [default], iteration 2 completed (11118.285 ms) ====== [2026-04-21T22:26:22.433Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-21T22:26:22.433Z] GC before operation: completed in 76.989 ms, heap usage 233.050 MB -> 63.252 MB. [2026-04-21T22:26:30.738Z] ====== als (apache-spark) [default], iteration 3 completed (7789.166 ms) ====== [2026-04-21T22:26:30.738Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-21T22:26:30.738Z] GC before operation: completed in 92.309 ms, heap usage 503.076 MB -> 64.239 MB. [2026-04-21T22:26:37.615Z] ====== als (apache-spark) [default], iteration 4 completed (7369.606 ms) ====== [2026-04-21T22:26:37.615Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-21T22:26:38.397Z] GC before operation: completed in 91.036 ms, heap usage 358.866 MB -> 64.470 MB. [2026-04-21T22:26:48.217Z] ====== als (apache-spark) [default], iteration 5 completed (10154.895 ms) ====== [2026-04-21T22:26:48.217Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-21T22:26:48.217Z] GC before operation: completed in 92.012 ms, heap usage 730.006 MB -> 65.676 MB. [2026-04-21T22:26:56.498Z] ====== als (apache-spark) [default], iteration 6 completed (7165.824 ms) ====== [2026-04-21T22:26:56.498Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-21T22:26:56.498Z] GC before operation: completed in 89.920 ms, heap usage 529.981 MB -> 65.928 MB. [2026-04-21T22:27:03.594Z] ====== als (apache-spark) [default], iteration 7 completed (7538.825 ms) ====== [2026-04-21T22:27:03.594Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-21T22:27:03.594Z] GC before operation: completed in 115.098 ms, heap usage 281.695 MB -> 66.113 MB. [2026-04-21T22:27:17.941Z] ====== als (apache-spark) [default], iteration 8 completed (13819.486 ms) ====== [2026-04-21T22:27:17.941Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-21T22:27:17.941Z] GC before operation: completed in 120.258 ms, heap usage 410.294 MB -> 66.824 MB. [2026-04-21T22:27:43.519Z] ====== als (apache-spark) [default], iteration 9 completed (24950.455 ms) ====== [2026-04-21T22:27:43.519Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-21T22:27:43.519Z] GC before operation: completed in 94.874 ms, heap usage 145.519 MB -> 66.819 MB. [2026-04-21T22:28:18.488Z] ====== als (apache-spark) [default], iteration 10 completed (30630.772 ms) ====== [2026-04-21T22:28:18.488Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-21T22:28:18.488Z] GC before operation: completed in 86.102 ms, heap usage 129.472 MB -> 66.967 MB. [2026-04-21T22:28:37.700Z] ====== als (apache-spark) [default], iteration 11 completed (21484.150 ms) ====== [2026-04-21T22:28:37.700Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-21T22:28:37.700Z] GC before operation: completed in 256.416 ms, heap usage 714.528 MB -> 67.992 MB. [2026-04-21T22:29:18.694Z] ====== als (apache-spark) [default], iteration 12 completed (40337.446 ms) ====== [2026-04-21T22:29:18.694Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-21T22:29:18.694Z] GC before operation: completed in 206.847 ms, heap usage 302.778 MB -> 67.685 MB. [2026-04-21T22:29:32.308Z] ====== als (apache-spark) [default], iteration 13 completed (14909.680 ms) ====== [2026-04-21T22:29:32.308Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-21T22:29:32.308Z] GC before operation: completed in 213.614 ms, heap usage 247.288 MB -> 68.080 MB. [2026-04-21T22:29:46.306Z] ====== als (apache-spark) [default], iteration 14 completed (12858.300 ms) ====== [2026-04-21T22:29:46.306Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-21T22:29:46.306Z] GC before operation: completed in 193.991 ms, heap usage 585.479 MB -> 68.720 MB. [2026-04-21T22:30:08.183Z] ====== als (apache-spark) [default], iteration 15 completed (20198.050 ms) ====== [2026-04-21T22:30:08.183Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-21T22:30:08.183Z] GC before operation: completed in 244.375 ms, heap usage 134.218 MB -> 68.374 MB. [2026-04-21T22:30:27.106Z] ====== als (apache-spark) [default], iteration 16 completed (20154.917 ms) ====== [2026-04-21T22:30:27.106Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-21T22:30:27.106Z] GC before operation: completed in 230.443 ms, heap usage 616.983 MB -> 69.213 MB. [2026-04-21T22:30:45.852Z] ====== als (apache-spark) [default], iteration 17 completed (16485.379 ms) ====== [2026-04-21T22:30:45.852Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-21T22:30:45.852Z] GC before operation: completed in 230.755 ms, heap usage 276.816 MB -> 69.104 MB. [2026-04-21T22:31:01.868Z] ====== als (apache-spark) [default], iteration 18 completed (16046.544 ms) ====== [2026-04-21T22:31:01.868Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-21T22:31:01.868Z] GC before operation: completed in 175.550 ms, heap usage 270.134 MB -> 69.406 MB. [2026-04-21T22:31:18.448Z] ====== als (apache-spark) [default], iteration 19 completed (15730.538 ms) ====== [2026-04-21T22:31:18.448Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-21T22:31:18.448Z] GC before operation: completed in 239.809 ms, heap usage 236.523 MB -> 69.558 MB. [2026-04-21T22:31:34.458Z] ====== als (apache-spark) [default], iteration 20 completed (16324.047 ms) ====== [2026-04-21T22:31:34.458Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-21T22:31:34.458Z] GC before operation: completed in 241.714 ms, heap usage 457.562 MB -> 70.267 MB. [2026-04-21T22:31:50.506Z] ====== als (apache-spark) [default], iteration 21 completed (15544.321 ms) ====== [2026-04-21T22:31:50.506Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-21T22:31:50.506Z] GC before operation: completed in 291.776 ms, heap usage 660.425 MB -> 70.627 MB. [2026-04-21T22:32:06.611Z] ====== als (apache-spark) [default], iteration 22 completed (16215.612 ms) ====== [2026-04-21T22:32:06.611Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-21T22:32:07.376Z] GC before operation: completed in 326.248 ms, heap usage 512.567 MB -> 70.707 MB. [2026-04-21T22:32:23.885Z] ====== als (apache-spark) [default], iteration 23 completed (16424.887 ms) ====== [2026-04-21T22:32:23.885Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-21T22:32:24.644Z] GC before operation: completed in 228.658 ms, heap usage 221.962 MB -> 70.597 MB. [2026-04-21T22:32:40.592Z] ====== als (apache-spark) [default], iteration 24 completed (15471.280 ms) ====== [2026-04-21T22:32:40.592Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-21T22:32:40.592Z] GC before operation: completed in 249.663 ms, heap usage 200.443 MB -> 70.803 MB. [2026-04-21T22:32:56.558Z] ====== als (apache-spark) [default], iteration 25 completed (15102.738 ms) ====== [2026-04-21T22:32:56.558Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-21T22:32:56.558Z] GC before operation: completed in 301.764 ms, heap usage 566.197 MB -> 71.635 MB. [2026-04-21T22:33:12.579Z] ====== als (apache-spark) [default], iteration 26 completed (15757.057 ms) ====== [2026-04-21T22:33:12.579Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-21T22:33:12.579Z] GC before operation: completed in 218.459 ms, heap usage 134.414 MB -> 71.361 MB. [2026-04-21T22:33:28.543Z] ====== als (apache-spark) [default], iteration 27 completed (13900.853 ms) ====== [2026-04-21T22:33:28.543Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-21T22:33:28.543Z] GC before operation: completed in 322.304 ms, heap usage 412.375 MB -> 71.798 MB. [2026-04-21T22:33:44.499Z] ====== als (apache-spark) [default], iteration 28 completed (16016.034 ms) ====== [2026-04-21T22:33:44.499Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-21T22:33:44.499Z] GC before operation: completed in 338.104 ms, heap usage 717.055 MB -> 72.590 MB. [2026-04-21T22:34:00.375Z] ====== als (apache-spark) [default], iteration 29 completed (16357.204 ms) ====== [2026-04-21T22:34:01.130Z] ----------------------------------- [2026-04-21T22:34:01.130Z] renaissance-als_0_PASSED [2026-04-21T22:34:01.130Z] ----------------------------------- [2026-04-21T22:34:01.130Z] [2026-04-21T22:34:01.130Z] TEST TEARDOWN: [2026-04-21T22:34:01.130Z] Nothing to be done for teardown. [2026-04-21T22:34:02.180Z] renaissance-als_0 Finish Time: Tue Apr 21 22:34:01 2026 Epoch Time (ms): 1776810841077