[2026-04-22T14:28:11.915Z] Running test renaissance-als_0 ... [2026-04-22T14:28:11.915Z] =============================================== [2026-04-22T14:28:12.280Z] renaissance-als_0 Start Time: Wed Apr 22 14:28:11 2026 Epoch Time (ms): 1776868091954 [2026-04-22T14:28:12.280Z] variation: NoOptions [2026-04-22T14:28:12.280Z] JVM_OPTIONS: [2026-04-22T14:28:12.280Z] { \ [2026-04-22T14:28:12.280Z] echo ""; echo "TEST SETUP:"; \ [2026-04-22T14:28:12.280Z] echo "Nothing to be done for setup."; \ [2026-04-22T14:28:12.280Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-als_0"; \ [2026-04-22T14:28:12.280Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-als_0"; \ [2026-04-22T14:28:12.280Z] echo ""; echo "TESTING:"; \ [2026-04-22T14:28:12.280Z] "c:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-als_0"\\als.json" als; \ [2026-04-22T14:28:12.280Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-22T14:28:12.280Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-22T14:28:12.280Z] echo "Nothing to be done for teardown."; \ [2026-04-22T14:28:12.280Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\TestTargetResult"; [2026-04-22T14:28:12.280Z] [2026-04-22T14:28:12.280Z] TEST SETUP: [2026-04-22T14:28:12.280Z] Nothing to be done for setup. [2026-04-22T14:28:12.280Z] [2026-04-22T14:28:12.280Z] TESTING: [2026-04-22T14:28:25.576Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-22T14:28:28.620Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-22T14:28:28.620Z] GC before operation: completed in 31.844 ms, heap usage 81.000 MB -> 35.228 MB. [2026-04-22T14:28:56.862Z] ====== als (apache-spark) [default], iteration 0 completed (26833.245 ms) ====== [2026-04-22T14:28:56.862Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-22T14:28:56.863Z] GC before operation: completed in 78.768 ms, heap usage 261.822 MB -> 62.632 MB. [2026-04-22T14:29:13.326Z] ====== als (apache-spark) [default], iteration 1 completed (15558.840 ms) ====== [2026-04-22T14:29:13.326Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-22T14:29:13.326Z] GC before operation: completed in 75.464 ms, heap usage 379.506 MB -> 63.355 MB. [2026-04-22T14:29:29.356Z] ====== als (apache-spark) [default], iteration 2 completed (15300.949 ms) ====== [2026-04-22T14:29:29.356Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-22T14:29:29.356Z] GC before operation: completed in 74.428 ms, heap usage 330.301 MB -> 63.896 MB. [2026-04-22T14:29:42.795Z] ====== als (apache-spark) [default], iteration 3 completed (14724.325 ms) ====== [2026-04-22T14:29:42.795Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-22T14:29:42.795Z] GC before operation: completed in 77.633 ms, heap usage 227.318 MB -> 64.398 MB. [2026-04-22T14:29:59.141Z] ====== als (apache-spark) [default], iteration 4 completed (14993.495 ms) ====== [2026-04-22T14:29:59.141Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-22T14:29:59.141Z] GC before operation: completed in 75.713 ms, heap usage 187.567 MB -> 64.676 MB. [2026-04-22T14:30:15.330Z] ====== als (apache-spark) [default], iteration 5 completed (15307.328 ms) ====== [2026-04-22T14:30:15.330Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-22T14:30:15.330Z] GC before operation: completed in 73.729 ms, heap usage 174.187 MB -> 65.422 MB. [2026-04-22T14:30:28.767Z] ====== als (apache-spark) [default], iteration 6 completed (15011.554 ms) ====== [2026-04-22T14:30:28.767Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-22T14:30:28.767Z] GC before operation: completed in 85.559 ms, heap usage 498.643 MB -> 66.359 MB. [2026-04-22T14:30:44.933Z] ====== als (apache-spark) [default], iteration 7 completed (15245.623 ms) ====== [2026-04-22T14:30:44.933Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-22T14:30:44.933Z] GC before operation: completed in 86.340 ms, heap usage 192.851 MB -> 66.046 MB. [2026-04-22T14:31:01.157Z] ====== als (apache-spark) [default], iteration 8 completed (14978.508 ms) ====== [2026-04-22T14:31:01.157Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-22T14:31:01.157Z] GC before operation: completed in 77.955 ms, heap usage 269.060 MB -> 67.169 MB. [2026-04-22T14:31:14.755Z] ====== als (apache-spark) [default], iteration 9 completed (15027.275 ms) ====== [2026-04-22T14:31:14.755Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-22T14:31:14.755Z] GC before operation: completed in 87.605 ms, heap usage 146.648 MB -> 67.369 MB. [2026-04-22T14:31:30.952Z] ====== als (apache-spark) [default], iteration 10 completed (14852.000 ms) ====== [2026-04-22T14:31:30.952Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-22T14:31:30.952Z] GC before operation: completed in 87.016 ms, heap usage 231.159 MB -> 67.786 MB. [2026-04-22T14:31:47.100Z] ====== als (apache-spark) [default], iteration 11 completed (15289.190 ms) ====== [2026-04-22T14:31:47.100Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-22T14:31:47.100Z] GC before operation: completed in 102.748 ms, heap usage 168.175 MB -> 67.436 MB. [2026-04-22T14:32:00.541Z] ====== als (apache-spark) [default], iteration 12 completed (14580.809 ms) ====== [2026-04-22T14:32:00.541Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-22T14:32:00.541Z] GC before operation: completed in 80.659 ms, heap usage 319.169 MB -> 68.217 MB. [2026-04-22T14:32:16.965Z] ====== als (apache-spark) [default], iteration 13 completed (14503.754 ms) ====== [2026-04-22T14:32:16.965Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-22T14:32:16.965Z] GC before operation: completed in 86.962 ms, heap usage 109.665 MB -> 68.206 MB. [2026-04-22T14:32:30.738Z] ====== als (apache-spark) [default], iteration 14 completed (15040.394 ms) ====== [2026-04-22T14:32:30.738Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-22T14:32:30.738Z] GC before operation: completed in 81.361 ms, heap usage 368.795 MB -> 68.694 MB. [2026-04-22T14:32:46.859Z] ====== als (apache-spark) [default], iteration 15 completed (14571.859 ms) ====== [2026-04-22T14:32:46.859Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-22T14:32:46.859Z] GC before operation: completed in 82.715 ms, heap usage 180.433 MB -> 68.956 MB. [2026-04-22T14:33:00.559Z] ====== als (apache-spark) [default], iteration 16 completed (14889.627 ms) ====== [2026-04-22T14:33:00.559Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-22T14:33:00.559Z] GC before operation: completed in 83.484 ms, heap usage 248.033 MB -> 69.229 MB. [2026-04-22T14:33:16.824Z] ====== als (apache-spark) [default], iteration 17 completed (14649.766 ms) ====== [2026-04-22T14:33:16.824Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-22T14:33:16.824Z] GC before operation: completed in 84.305 ms, heap usage 445.163 MB -> 69.762 MB. [2026-04-22T14:33:30.400Z] ====== als (apache-spark) [default], iteration 18 completed (14845.159 ms) ====== [2026-04-22T14:33:30.400Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-22T14:33:30.400Z] GC before operation: completed in 86.413 ms, heap usage 268.481 MB -> 69.836 MB. [2026-04-22T14:33:46.752Z] ====== als (apache-spark) [default], iteration 19 completed (14602.725 ms) ====== [2026-04-22T14:33:46.752Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-22T14:33:46.752Z] GC before operation: completed in 86.776 ms, heap usage 329.344 MB -> 70.102 MB. [2026-04-22T14:34:00.270Z] ====== als (apache-spark) [default], iteration 20 completed (14914.885 ms) ====== [2026-04-22T14:34:00.270Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-22T14:34:00.270Z] GC before operation: completed in 85.109 ms, heap usage 502.686 MB -> 70.478 MB. [2026-04-22T14:34:16.653Z] ====== als (apache-spark) [default], iteration 21 completed (14849.971 ms) ====== [2026-04-22T14:34:16.653Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-22T14:34:16.653Z] GC before operation: completed in 84.561 ms, heap usage 218.190 MB -> 70.391 MB. [2026-04-22T14:34:30.355Z] ====== als (apache-spark) [default], iteration 22 completed (14614.552 ms) ====== [2026-04-22T14:34:30.355Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-22T14:34:30.355Z] GC before operation: completed in 83.755 ms, heap usage 333.992 MB -> 70.835 MB. [2026-04-22T14:34:47.524Z] ====== als (apache-spark) [default], iteration 23 completed (14945.904 ms) ====== [2026-04-22T14:34:47.525Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-22T14:34:47.525Z] GC before operation: completed in 91.632 ms, heap usage 163.767 MB -> 70.998 MB. [2026-04-22T14:35:02.351Z] ====== als (apache-spark) [default], iteration 24 completed (14526.214 ms) ====== [2026-04-22T14:35:02.351Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-22T14:35:02.351Z] GC before operation: completed in 87.129 ms, heap usage 289.691 MB -> 71.565 MB. [2026-04-22T14:35:15.437Z] ====== als (apache-spark) [default], iteration 25 completed (14858.459 ms) ====== [2026-04-22T14:35:15.437Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-22T14:35:15.437Z] GC before operation: completed in 93.805 ms, heap usage 325.984 MB -> 71.825 MB. [2026-04-22T14:35:31.719Z] ====== als (apache-spark) [default], iteration 26 completed (14326.486 ms) ====== [2026-04-22T14:35:31.719Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-22T14:35:31.719Z] GC before operation: completed in 94.814 ms, heap usage 318.478 MB -> 71.854 MB. [2026-04-22T14:35:45.326Z] ====== als (apache-spark) [default], iteration 27 completed (14432.408 ms) ====== [2026-04-22T14:35:45.326Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-22T14:35:45.326Z] GC before operation: completed in 93.612 ms, heap usage 597.322 MB -> 72.626 MB. [2026-04-22T14:36:00.926Z] ====== als (apache-spark) [default], iteration 28 completed (14556.644 ms) ====== [2026-04-22T14:36:00.926Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-22T14:36:00.926Z] GC before operation: completed in 85.750 ms, heap usage 265.202 MB -> 72.496 MB. [2026-04-22T14:36:14.592Z] ====== als (apache-spark) [default], iteration 29 completed (14449.114 ms) ====== [2026-04-22T14:36:14.592Z] ----------------------------------- [2026-04-22T14:36:14.592Z] renaissance-als_0_PASSED [2026-04-22T14:36:14.592Z] ----------------------------------- [2026-04-22T14:36:14.592Z] [2026-04-22T14:36:14.592Z] TEST TEARDOWN: [2026-04-22T14:36:14.592Z] Nothing to be done for teardown. [2026-04-22T14:36:14.592Z] renaissance-als_0 Finish Time: Wed Apr 22 14:36:14 2026 Epoch Time (ms): 1776868574274