[2026-02-18T21:45:20.756Z] Running test renaissance-als_0 ... [2026-02-18T21:45:20.756Z] =============================================== [2026-02-18T21:45:20.756Z] renaissance-als_0 Start Time: Wed Feb 18 21:45:20 2026 Epoch Time (ms): 1771451120652 [2026-02-18T21:45:20.756Z] variation: NoOptions [2026-02-18T21:45:20.756Z] JVM_OPTIONS: [2026-02-18T21:45:20.756Z] { \ [2026-02-18T21:45:20.756Z] echo ""; echo "TEST SETUP:"; \ [2026-02-18T21:45:20.756Z] echo "Nothing to be done for setup."; \ [2026-02-18T21:45:20.756Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17714511206738/renaissance-als_0"; \ [2026-02-18T21:45:20.756Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17714511206738/renaissance-als_0"; \ [2026-02-18T21:45:20.756Z] echo ""; echo "TESTING:"; \ [2026-02-18T21:45:20.756Z] "/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_17714511206738/renaissance-als_0"/als.json" als; \ [2026-02-18T21:45:20.756Z] 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_17714511206738/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-18T21:45:20.756Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-18T21:45:20.756Z] echo "Nothing to be done for teardown."; \ [2026-02-18T21:45:20.756Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17714511206738/TestTargetResult"; [2026-02-18T21:45:20.756Z] [2026-02-18T21:45:20.756Z] TEST SETUP: [2026-02-18T21:45:20.756Z] Nothing to be done for setup. [2026-02-18T21:45:20.756Z] [2026-02-18T21:45:20.756Z] TESTING: [2026-02-18T21:45:29.634Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-18T21:45:34.111Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-18T21:45:34.111Z] GC before operation: completed in 68.955 ms, heap usage 53.500 MB -> 35.142 MB. [2026-02-18T21:46:01.594Z] ====== als (apache-spark) [default], iteration 0 completed (24040.534 ms) ====== [2026-02-18T21:46:01.594Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-18T21:46:01.594Z] GC before operation: completed in 84.088 ms, heap usage 229.964 MB -> 61.752 MB. [2026-02-18T21:46:07.462Z] ====== als (apache-spark) [default], iteration 1 completed (8098.424 ms) ====== [2026-02-18T21:46:07.462Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-18T21:46:07.462Z] GC before operation: completed in 80.463 ms, heap usage 263.501 MB -> 62.697 MB. [2026-02-18T21:46:14.762Z] ====== als (apache-spark) [default], iteration 2 completed (7353.125 ms) ====== [2026-02-18T21:46:14.762Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-18T21:46:14.762Z] GC before operation: completed in 83.926 ms, heap usage 525.149 MB -> 63.710 MB. [2026-02-18T21:46:26.804Z] ====== als (apache-spark) [default], iteration 3 completed (11459.614 ms) ====== [2026-02-18T21:46:26.804Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-18T21:46:26.804Z] GC before operation: completed in 102.558 ms, heap usage 303.828 MB -> 64.021 MB. [2026-02-18T21:46:41.685Z] ====== als (apache-spark) [default], iteration 4 completed (12032.607 ms) ====== [2026-02-18T21:46:41.685Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-18T21:46:41.685Z] GC before operation: completed in 102.919 ms, heap usage 281.419 MB -> 64.501 MB. [2026-02-18T21:46:55.573Z] ====== als (apache-spark) [default], iteration 5 completed (16599.749 ms) ====== [2026-02-18T21:46:55.573Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-18T21:46:55.573Z] GC before operation: completed in 86.394 ms, heap usage 350.604 MB -> 65.119 MB. [2026-02-18T21:47:04.163Z] ====== als (apache-spark) [default], iteration 6 completed (6995.109 ms) ====== [2026-02-18T21:47:04.163Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-18T21:47:04.163Z] GC before operation: completed in 93.158 ms, heap usage 96.129 MB -> 65.414 MB. [2026-02-18T21:47:14.149Z] ====== als (apache-spark) [default], iteration 7 completed (10369.544 ms) ====== [2026-02-18T21:47:14.149Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-18T21:47:14.149Z] GC before operation: completed in 91.576 ms, heap usage 504.839 MB -> 66.420 MB. [2026-02-18T21:47:22.527Z] ====== als (apache-spark) [default], iteration 8 completed (7976.579 ms) ====== [2026-02-18T21:47:22.527Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-18T21:47:22.527Z] GC before operation: completed in 92.011 ms, heap usage 335.555 MB -> 66.830 MB. [2026-02-18T21:47:29.444Z] ====== als (apache-spark) [default], iteration 9 completed (6952.500 ms) ====== [2026-02-18T21:47:29.444Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-18T21:47:29.444Z] GC before operation: completed in 90.219 ms, heap usage 121.260 MB -> 66.832 MB. [2026-02-18T21:47:36.382Z] ====== als (apache-spark) [default], iteration 10 completed (7088.248 ms) ====== [2026-02-18T21:47:36.382Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-18T21:47:36.382Z] GC before operation: completed in 93.370 ms, heap usage 190.453 MB -> 67.117 MB. [2026-02-18T21:47:46.238Z] ====== als (apache-spark) [default], iteration 11 completed (8785.511 ms) ====== [2026-02-18T21:47:46.238Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-18T21:47:46.238Z] GC before operation: completed in 98.613 ms, heap usage 230.454 MB -> 67.265 MB. [2026-02-18T21:47:58.137Z] ====== als (apache-spark) [default], iteration 12 completed (12448.463 ms) ====== [2026-02-18T21:47:58.137Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-18T21:47:58.137Z] GC before operation: completed in 106.436 ms, heap usage 409.070 MB -> 67.825 MB. [2026-02-18T21:48:11.112Z] ====== als (apache-spark) [default], iteration 13 completed (11475.027 ms) ====== [2026-02-18T21:48:11.112Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-18T21:48:11.112Z] GC before operation: completed in 94.546 ms, heap usage 181.374 MB -> 67.776 MB. [2026-02-18T21:48:21.285Z] ====== als (apache-spark) [default], iteration 14 completed (9421.950 ms) ====== [2026-02-18T21:48:21.285Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-18T21:48:21.285Z] GC before operation: completed in 90.415 ms, heap usage 463.320 MB -> 68.557 MB. [2026-02-18T21:48:31.007Z] ====== als (apache-spark) [default], iteration 15 completed (10659.385 ms) ====== [2026-02-18T21:48:31.007Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-18T21:48:31.007Z] GC before operation: completed in 84.206 ms, heap usage 226.499 MB -> 68.347 MB. [2026-02-18T21:48:42.584Z] ====== als (apache-spark) [default], iteration 16 completed (10585.163 ms) ====== [2026-02-18T21:48:42.584Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-18T21:48:42.584Z] GC before operation: completed in 92.700 ms, heap usage 357.576 MB -> 68.828 MB. [2026-02-18T21:48:58.442Z] ====== als (apache-spark) [default], iteration 17 completed (14959.516 ms) ====== [2026-02-18T21:48:58.442Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-18T21:48:58.442Z] GC before operation: completed in 82.670 ms, heap usage 245.529 MB -> 69.049 MB. [2026-02-18T21:49:12.572Z] ====== als (apache-spark) [default], iteration 18 completed (14990.065 ms) ====== [2026-02-18T21:49:12.572Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-18T21:49:12.572Z] GC before operation: completed in 86.773 ms, heap usage 556.100 MB -> 69.678 MB. [2026-02-18T21:49:26.611Z] ====== als (apache-spark) [default], iteration 19 completed (14630.135 ms) ====== [2026-02-18T21:49:26.611Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-18T21:49:29.942Z] GC before operation: completed in 95.516 ms, heap usage 283.811 MB -> 69.418 MB. [2026-02-18T21:49:45.235Z] ====== als (apache-spark) [default], iteration 20 completed (15191.232 ms) ====== [2026-02-18T21:49:45.235Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-18T21:49:45.235Z] GC before operation: completed in 82.710 ms, heap usage 265.410 MB -> 69.736 MB. [2026-02-18T21:50:07.056Z] ====== als (apache-spark) [default], iteration 21 completed (24239.032 ms) ====== [2026-02-18T21:50:07.056Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-18T21:50:07.056Z] GC before operation: completed in 225.986 ms, heap usage 462.046 MB -> 70.305 MB. [2026-02-18T21:50:23.008Z] ====== als (apache-spark) [default], iteration 22 completed (14067.225 ms) ====== [2026-02-18T21:50:23.008Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-18T21:50:23.008Z] GC before operation: completed in 109.142 ms, heap usage 343.641 MB -> 70.423 MB. [2026-02-18T21:50:56.686Z] ====== als (apache-spark) [default], iteration 23 completed (32786.578 ms) ====== [2026-02-18T21:50:56.686Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-18T21:50:56.686Z] GC before operation: completed in 105.786 ms, heap usage 382.474 MB -> 70.676 MB. [2026-02-18T21:51:11.142Z] ====== als (apache-spark) [default], iteration 24 completed (14950.160 ms) ====== [2026-02-18T21:51:11.142Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-18T21:51:11.142Z] GC before operation: completed in 233.441 ms, heap usage 182.687 MB -> 70.831 MB. [2026-02-18T21:51:27.046Z] ====== als (apache-spark) [default], iteration 25 completed (16616.546 ms) ====== [2026-02-18T21:51:27.046Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-18T21:51:27.809Z] GC before operation: completed in 303.585 ms, heap usage 476.603 MB -> 71.491 MB. [2026-02-18T21:51:49.534Z] ====== als (apache-spark) [default], iteration 26 completed (18889.852 ms) ====== [2026-02-18T21:51:49.534Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-18T21:51:49.534Z] GC before operation: completed in 244.839 ms, heap usage 121.787 MB -> 71.284 MB. [2026-02-18T21:52:14.802Z] ====== als (apache-spark) [default], iteration 27 completed (24622.100 ms) ====== [2026-02-18T21:52:14.802Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-18T21:52:14.802Z] GC before operation: completed in 311.611 ms, heap usage 446.982 MB -> 72.062 MB. [2026-02-18T21:52:33.426Z] ====== als (apache-spark) [default], iteration 28 completed (18621.323 ms) ====== [2026-02-18T21:52:33.426Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-18T21:52:33.426Z] GC before operation: completed in 218.511 ms, heap usage 475.757 MB -> 71.684 MB. [2026-02-18T21:52:52.548Z] ====== als (apache-spark) [default], iteration 29 completed (18948.307 ms) ====== [2026-02-18T21:52:52.548Z] ----------------------------------- [2026-02-18T21:52:52.548Z] renaissance-als_0_PASSED [2026-02-18T21:52:52.548Z] ----------------------------------- [2026-02-18T21:52:52.548Z] [2026-02-18T21:52:52.548Z] TEST TEARDOWN: [2026-02-18T21:52:52.548Z] Nothing to be done for teardown. [2026-02-18T21:52:52.548Z] renaissance-als_0 Finish Time: Wed Feb 18 21:52:51 2026 Epoch Time (ms): 1771451571486