[2026-02-26T15:09:05.996Z] Running test renaissance-als_0 ... [2026-02-26T15:09:05.996Z] =============================================== [2026-02-26T15:09:05.996Z] renaissance-als_0 Start Time: Thu Feb 26 15:09:05 2026 Epoch Time (ms): 1772118545786 [2026-02-26T15:09:05.996Z] variation: NoOptions [2026-02-26T15:09:05.996Z] JVM_OPTIONS: [2026-02-26T15:09:05.996Z] { \ [2026-02-26T15:09:05.996Z] echo ""; echo "TEST SETUP:"; \ [2026-02-26T15:09:05.996Z] echo "Nothing to be done for setup."; \ [2026-02-26T15:09:05.996Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17721185453427/renaissance-als_0"; \ [2026-02-26T15:09:05.996Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17721185453427/renaissance-als_0"; \ [2026-02-26T15:09:05.996Z] echo ""; echo "TESTING:"; \ [2026-02-26T15:09:05.996Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17721185453427/renaissance-als_0"/als.json" als; \ [2026-02-26T15:09:05.996Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17721185453427/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-26T15:09:05.996Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-26T15:09:05.996Z] echo "Nothing to be done for teardown."; \ [2026-02-26T15:09:05.996Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17721185453427/TestTargetResult"; [2026-02-26T15:09:05.996Z] [2026-02-26T15:09:05.996Z] TEST SETUP: [2026-02-26T15:09:05.996Z] Nothing to be done for setup. [2026-02-26T15:09:05.996Z] [2026-02-26T15:09:05.996Z] TESTING: [2026-02-26T15:09:15.794Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-26T15:09:22.461Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-26T15:09:22.461Z] GC before operation: completed in 134.621 ms, heap usage 49.525 MB -> 35.115 MB. [2026-02-26T15:10:10.964Z] ====== als (apache-spark) [default], iteration 0 completed (43744.416 ms) ====== [2026-02-26T15:10:10.964Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-26T15:10:10.964Z] GC before operation: completed in 263.401 ms, heap usage 219.235 MB -> 61.943 MB. [2026-02-26T15:10:25.219Z] ====== als (apache-spark) [default], iteration 1 completed (16474.890 ms) ====== [2026-02-26T15:10:25.219Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-26T15:10:25.219Z] GC before operation: completed in 184.571 ms, heap usage 506.137 MB -> 63.163 MB. [2026-02-26T15:10:47.694Z] ====== als (apache-spark) [default], iteration 2 completed (22206.848 ms) ====== [2026-02-26T15:10:47.694Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-26T15:10:47.694Z] GC before operation: completed in 161.204 ms, heap usage 552.861 MB -> 63.783 MB. [2026-02-26T15:11:04.671Z] ====== als (apache-spark) [default], iteration 3 completed (15985.692 ms) ====== [2026-02-26T15:11:04.671Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-26T15:11:04.671Z] GC before operation: completed in 208.662 ms, heap usage 200.806 MB -> 63.880 MB. [2026-02-26T15:11:18.208Z] ====== als (apache-spark) [default], iteration 4 completed (13271.923 ms) ====== [2026-02-26T15:11:18.208Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-26T15:11:18.208Z] GC before operation: completed in 208.386 ms, heap usage 374.125 MB -> 64.694 MB. [2026-02-26T15:11:31.731Z] ====== als (apache-spark) [default], iteration 5 completed (12704.538 ms) ====== [2026-02-26T15:11:31.731Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-26T15:11:31.731Z] GC before operation: completed in 180.095 ms, heap usage 517.333 MB -> 65.486 MB. [2026-02-26T15:11:45.264Z] ====== als (apache-spark) [default], iteration 6 completed (12503.612 ms) ====== [2026-02-26T15:11:45.264Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-26T15:11:45.264Z] GC before operation: completed in 193.446 ms, heap usage 187.043 MB -> 65.537 MB. [2026-02-26T15:11:56.704Z] ====== als (apache-spark) [default], iteration 7 completed (12254.389 ms) ====== [2026-02-26T15:11:56.704Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-26T15:11:56.704Z] GC before operation: completed in 204.782 ms, heap usage 506.146 MB -> 66.473 MB. [2026-02-26T15:12:10.203Z] ====== als (apache-spark) [default], iteration 8 completed (12900.860 ms) ====== [2026-02-26T15:12:10.203Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-26T15:12:10.203Z] GC before operation: completed in 195.172 ms, heap usage 318.162 MB -> 66.806 MB. [2026-02-26T15:12:23.721Z] ====== als (apache-spark) [default], iteration 9 completed (12402.020 ms) ====== [2026-02-26T15:12:23.721Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-26T15:12:23.721Z] GC before operation: completed in 182.173 ms, heap usage 490.347 MB -> 67.275 MB. [2026-02-26T15:12:37.922Z] ====== als (apache-spark) [default], iteration 10 completed (12490.228 ms) ====== [2026-02-26T15:12:37.922Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-26T15:12:37.922Z] GC before operation: completed in 213.318 ms, heap usage 352.525 MB -> 67.393 MB. [2026-02-26T15:12:51.401Z] ====== als (apache-spark) [default], iteration 11 completed (14313.491 ms) ====== [2026-02-26T15:12:51.401Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-26T15:12:51.401Z] GC before operation: completed in 188.159 ms, heap usage 227.482 MB -> 67.290 MB. [2026-02-26T15:13:11.571Z] ====== als (apache-spark) [default], iteration 12 completed (18024.212 ms) ====== [2026-02-26T15:13:11.571Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-26T15:13:11.571Z] GC before operation: completed in 257.514 ms, heap usage 499.932 MB -> 68.072 MB. [2026-02-26T15:13:25.155Z] ====== als (apache-spark) [default], iteration 13 completed (13474.637 ms) ====== [2026-02-26T15:13:25.155Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-26T15:13:25.155Z] GC before operation: completed in 197.543 ms, heap usage 305.288 MB -> 68.109 MB. [2026-02-26T15:13:36.595Z] ====== als (apache-spark) [default], iteration 14 completed (12134.121 ms) ====== [2026-02-26T15:13:36.595Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-26T15:13:36.595Z] GC before operation: completed in 177.110 ms, heap usage 164.948 MB -> 68.244 MB. [2026-02-26T15:13:48.111Z] ====== als (apache-spark) [default], iteration 15 completed (11789.612 ms) ====== [2026-02-26T15:13:48.111Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-26T15:13:48.863Z] GC before operation: completed in 201.994 ms, heap usage 163.663 MB -> 68.370 MB. [2026-02-26T15:13:56.994Z] ====== als (apache-spark) [default], iteration 16 completed (7529.816 ms) ====== [2026-02-26T15:13:56.994Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-26T15:13:56.994Z] GC before operation: completed in 86.100 ms, heap usage 580.886 MB -> 69.251 MB. [2026-02-26T15:14:03.682Z] ====== als (apache-spark) [default], iteration 17 completed (7293.309 ms) ====== [2026-02-26T15:14:03.682Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-26T15:14:03.682Z] GC before operation: completed in 110.176 ms, heap usage 577.330 MB -> 69.519 MB. [2026-02-26T15:14:14.685Z] ====== als (apache-spark) [default], iteration 18 completed (10168.979 ms) ====== [2026-02-26T15:14:14.685Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-26T15:14:14.685Z] GC before operation: completed in 80.471 ms, heap usage 493.975 MB -> 70.241 MB. [2026-02-26T15:14:26.041Z] ====== als (apache-spark) [default], iteration 19 completed (10880.785 ms) ====== [2026-02-26T15:14:26.041Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-26T15:14:26.041Z] GC before operation: completed in 82.425 ms, heap usage 221.296 MB -> 69.570 MB. [2026-02-26T15:14:31.952Z] ====== als (apache-spark) [default], iteration 20 completed (6539.154 ms) ====== [2026-02-26T15:14:31.952Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-26T15:14:31.952Z] GC before operation: completed in 80.919 ms, heap usage 194.829 MB -> 69.768 MB. [2026-02-26T15:14:40.008Z] ====== als (apache-spark) [default], iteration 21 completed (6753.973 ms) ====== [2026-02-26T15:14:40.008Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-26T15:14:40.008Z] GC before operation: completed in 78.559 ms, heap usage 561.716 MB -> 70.636 MB. [2026-02-26T15:14:48.059Z] ====== als (apache-spark) [default], iteration 22 completed (8100.082 ms) ====== [2026-02-26T15:14:48.059Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-26T15:14:48.059Z] GC before operation: completed in 87.557 ms, heap usage 264.090 MB -> 70.439 MB. [2026-02-26T15:14:54.754Z] ====== als (apache-spark) [default], iteration 23 completed (6242.555 ms) ====== [2026-02-26T15:14:54.754Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-26T15:14:54.754Z] GC before operation: completed in 82.625 ms, heap usage 110.394 MB -> 70.627 MB. [2026-02-26T15:15:01.409Z] ====== als (apache-spark) [default], iteration 24 completed (6421.314 ms) ====== [2026-02-26T15:15:01.409Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-26T15:15:01.409Z] GC before operation: completed in 80.165 ms, heap usage 364.148 MB -> 71.077 MB. [2026-02-26T15:15:06.823Z] ====== als (apache-spark) [default], iteration 25 completed (6282.453 ms) ====== [2026-02-26T15:15:06.823Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-26T15:15:07.564Z] GC before operation: completed in 86.300 ms, heap usage 512.238 MB -> 72.016 MB. [2026-02-26T15:15:14.226Z] ====== als (apache-spark) [default], iteration 26 completed (6344.223 ms) ====== [2026-02-26T15:15:14.226Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-26T15:15:14.226Z] GC before operation: completed in 80.115 ms, heap usage 329.971 MB -> 71.573 MB. [2026-02-26T15:15:20.868Z] ====== als (apache-spark) [default], iteration 27 completed (6274.736 ms) ====== [2026-02-26T15:15:20.868Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-26T15:15:20.868Z] GC before operation: completed in 84.345 ms, heap usage 248.296 MB -> 71.732 MB. [2026-02-26T15:15:27.511Z] ====== als (apache-spark) [default], iteration 28 completed (6385.456 ms) ====== [2026-02-26T15:15:27.511Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-26T15:15:27.511Z] GC before operation: completed in 79.228 ms, heap usage 263.338 MB -> 71.913 MB. [2026-02-26T15:15:34.178Z] ====== als (apache-spark) [default], iteration 29 completed (6293.974 ms) ====== [2026-02-26T15:15:34.178Z] ----------------------------------- [2026-02-26T15:15:34.178Z] renaissance-als_0_PASSED [2026-02-26T15:15:34.178Z] ----------------------------------- [2026-02-26T15:15:34.178Z] [2026-02-26T15:15:34.178Z] TEST TEARDOWN: [2026-02-26T15:15:34.178Z] Nothing to be done for teardown. [2026-02-26T15:15:34.178Z] renaissance-als_0 Finish Time: Thu Feb 26 15:15:33 2026 Epoch Time (ms): 1772118933296