[2026-02-25T23:25:11.991Z] Running test renaissance-als_0 ... [2026-02-25T23:25:11.991Z] =============================================== [2026-02-25T23:25:12.345Z] renaissance-als_0 Start Time: Wed Feb 25 23:25:11 2026 Epoch Time (ms): 1772061912000 [2026-02-25T23:25:12.345Z] variation: NoOptions [2026-02-25T23:25:12.345Z] JVM_OPTIONS: [2026-02-25T23:25:12.345Z] { \ [2026-02-25T23:25:12.345Z] echo ""; echo "TEST SETUP:"; \ [2026-02-25T23:25:12.345Z] echo "Nothing to be done for setup."; \ [2026-02-25T23:25:12.345Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17720616911226\\renaissance-als_0"; \ [2026-02-25T23:25:12.345Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17720616911226\\renaissance-als_0"; \ [2026-02-25T23:25:12.345Z] echo ""; echo "TESTING:"; \ [2026-02-25T23:25:12.345Z] "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_17720616911226\\renaissance-als_0"\\als.json" als; \ [2026-02-25T23:25:12.345Z] 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_17720616911226\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-25T23:25:12.345Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-25T23:25:12.345Z] echo "Nothing to be done for teardown."; \ [2026-02-25T23:25:12.345Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17720616911226\\TestTargetResult"; [2026-02-25T23:25:12.345Z] [2026-02-25T23:25:12.345Z] TEST SETUP: [2026-02-25T23:25:12.345Z] Nothing to be done for setup. [2026-02-25T23:25:12.345Z] [2026-02-25T23:25:12.345Z] TESTING: [2026-02-25T23:25:28.339Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-25T23:25:30.669Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-25T23:25:30.669Z] GC before operation: completed in 32.674 ms, heap usage 58.000 MB -> 35.212 MB. [2026-02-25T23:26:04.738Z] ====== als (apache-spark) [default], iteration 0 completed (28681.669 ms) ====== [2026-02-25T23:26:04.738Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-25T23:26:04.738Z] GC before operation: completed in 89.990 ms, heap usage 503.227 MB -> 62.833 MB. [2026-02-25T23:26:18.108Z] ====== als (apache-spark) [default], iteration 1 completed (16900.122 ms) ====== [2026-02-25T23:26:18.109Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-25T23:26:18.109Z] GC before operation: completed in 75.764 ms, heap usage 193.508 MB -> 63.108 MB. [2026-02-25T23:26:34.338Z] ====== als (apache-spark) [default], iteration 2 completed (16275.919 ms) ====== [2026-02-25T23:26:34.338Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-25T23:26:34.339Z] GC before operation: completed in 77.869 ms, heap usage 408.532 MB -> 64.029 MB. [2026-02-25T23:26:50.475Z] ====== als (apache-spark) [default], iteration 3 completed (16174.299 ms) ====== [2026-02-25T23:26:50.475Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-25T23:26:50.475Z] GC before operation: completed in 73.578 ms, heap usage 357.161 MB -> 64.611 MB. [2026-02-25T23:27:06.780Z] ====== als (apache-spark) [default], iteration 4 completed (16207.060 ms) ====== [2026-02-25T23:27:06.780Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-25T23:27:06.780Z] GC before operation: completed in 79.234 ms, heap usage 378.906 MB -> 65.158 MB. [2026-02-25T23:27:22.937Z] ====== als (apache-spark) [default], iteration 5 completed (15400.105 ms) ====== [2026-02-25T23:27:22.937Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-25T23:27:22.937Z] GC before operation: completed in 79.403 ms, heap usage 166.353 MB -> 65.043 MB. [2026-02-25T23:27:39.123Z] ====== als (apache-spark) [default], iteration 6 completed (16675.852 ms) ====== [2026-02-25T23:27:39.123Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-25T23:27:39.123Z] GC before operation: completed in 79.556 ms, heap usage 227.335 MB -> 66.085 MB. [2026-02-25T23:27:55.223Z] ====== als (apache-spark) [default], iteration 7 completed (15086.519 ms) ====== [2026-02-25T23:27:55.223Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-25T23:27:55.223Z] GC before operation: completed in 86.700 ms, heap usage 505.846 MB -> 67.181 MB. [2026-02-25T23:28:11.576Z] ====== als (apache-spark) [default], iteration 8 completed (16695.152 ms) ====== [2026-02-25T23:28:11.576Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-25T23:28:11.576Z] GC before operation: completed in 93.275 ms, heap usage 173.611 MB -> 67.163 MB. [2026-02-25T23:28:27.757Z] ====== als (apache-spark) [default], iteration 9 completed (15417.023 ms) ====== [2026-02-25T23:28:27.757Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-25T23:28:27.757Z] GC before operation: completed in 85.895 ms, heap usage 372.769 MB -> 67.712 MB. [2026-02-25T23:28:43.866Z] ====== als (apache-spark) [default], iteration 10 completed (15733.803 ms) ====== [2026-02-25T23:28:43.866Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-25T23:28:43.866Z] GC before operation: completed in 87.462 ms, heap usage 514.051 MB -> 68.081 MB. [2026-02-25T23:28:59.966Z] ====== als (apache-spark) [default], iteration 11 completed (15834.482 ms) ====== [2026-02-25T23:28:59.966Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-25T23:28:59.966Z] GC before operation: completed in 87.667 ms, heap usage 362.772 MB -> 68.169 MB. [2026-02-25T23:29:15.976Z] ====== als (apache-spark) [default], iteration 12 completed (15379.432 ms) ====== [2026-02-25T23:29:15.976Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-25T23:29:15.976Z] GC before operation: completed in 86.241 ms, heap usage 774.423 MB -> 68.964 MB. [2026-02-25T23:29:32.190Z] ====== als (apache-spark) [default], iteration 13 completed (16309.888 ms) ====== [2026-02-25T23:29:32.190Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-25T23:29:32.190Z] GC before operation: completed in 89.524 ms, heap usage 440.488 MB -> 68.736 MB. [2026-02-25T23:29:48.295Z] ====== als (apache-spark) [default], iteration 14 completed (15488.241 ms) ====== [2026-02-25T23:29:48.295Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-25T23:29:48.295Z] GC before operation: completed in 95.636 ms, heap usage 440.601 MB -> 68.907 MB. [2026-02-25T23:30:04.426Z] ====== als (apache-spark) [default], iteration 15 completed (16283.414 ms) ====== [2026-02-25T23:30:04.426Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-25T23:30:04.426Z] GC before operation: completed in 90.537 ms, heap usage 680.230 MB -> 69.662 MB. [2026-02-25T23:30:20.586Z] ====== als (apache-spark) [default], iteration 16 completed (15224.789 ms) ====== [2026-02-25T23:30:20.587Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-25T23:30:20.587Z] GC before operation: completed in 90.930 ms, heap usage 587.250 MB -> 69.813 MB. [2026-02-25T23:30:36.935Z] ====== als (apache-spark) [default], iteration 17 completed (15893.177 ms) ====== [2026-02-25T23:30:36.935Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-25T23:30:36.935Z] GC before operation: completed in 94.992 ms, heap usage 640.668 MB -> 70.131 MB. [2026-02-25T23:30:53.143Z] ====== als (apache-spark) [default], iteration 18 completed (15867.254 ms) ====== [2026-02-25T23:30:53.143Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-25T23:30:53.143Z] GC before operation: completed in 91.426 ms, heap usage 604.060 MB -> 70.349 MB. [2026-02-25T23:31:09.288Z] ====== als (apache-spark) [default], iteration 19 completed (15944.575 ms) ====== [2026-02-25T23:31:09.288Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-25T23:31:09.288Z] GC before operation: completed in 92.737 ms, heap usage 227.269 MB -> 70.099 MB. [2026-02-25T23:31:25.391Z] ====== als (apache-spark) [default], iteration 20 completed (16918.696 ms) ====== [2026-02-25T23:31:25.391Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-25T23:31:25.391Z] GC before operation: completed in 99.221 ms, heap usage 799.409 MB -> 71.010 MB. [2026-02-25T23:31:41.588Z] ====== als (apache-spark) [default], iteration 21 completed (15516.877 ms) ====== [2026-02-25T23:31:41.588Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-25T23:31:41.588Z] GC before operation: completed in 91.195 ms, heap usage 297.776 MB -> 70.608 MB. [2026-02-25T23:31:57.610Z] ====== als (apache-spark) [default], iteration 22 completed (16079.406 ms) ====== [2026-02-25T23:31:57.610Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-25T23:31:57.610Z] GC before operation: completed in 89.136 ms, heap usage 141.299 MB -> 70.774 MB. [2026-02-25T23:32:13.885Z] ====== als (apache-spark) [default], iteration 23 completed (15328.454 ms) ====== [2026-02-25T23:32:13.885Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-25T23:32:13.885Z] GC before operation: completed in 97.657 ms, heap usage 856.555 MB -> 71.892 MB. [2026-02-25T23:32:30.014Z] ====== als (apache-spark) [default], iteration 24 completed (15846.432 ms) ====== [2026-02-25T23:32:30.014Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-25T23:32:30.014Z] GC before operation: completed in 96.567 ms, heap usage 166.605 MB -> 71.262 MB. [2026-02-25T23:32:46.087Z] ====== als (apache-spark) [default], iteration 25 completed (15947.128 ms) ====== [2026-02-25T23:32:46.087Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-25T23:32:46.087Z] GC before operation: completed in 92.592 ms, heap usage 135.240 MB -> 71.598 MB. [2026-02-25T23:33:02.303Z] ====== als (apache-spark) [default], iteration 26 completed (15283.846 ms) ====== [2026-02-25T23:33:02.303Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-25T23:33:02.303Z] GC before operation: completed in 95.501 ms, heap usage 144.589 MB -> 71.894 MB. [2026-02-25T23:33:18.599Z] ====== als (apache-spark) [default], iteration 27 completed (16091.688 ms) ====== [2026-02-25T23:33:18.599Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-25T23:33:18.599Z] GC before operation: completed in 92.622 ms, heap usage 99.812 MB -> 71.939 MB. [2026-02-25T23:33:33.183Z] ====== als (apache-spark) [default], iteration 28 completed (15308.572 ms) ====== [2026-02-25T23:33:33.183Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-25T23:33:33.183Z] GC before operation: completed in 96.124 ms, heap usage 145.885 MB -> 72.013 MB. [2026-02-25T23:33:49.321Z] ====== als (apache-spark) [default], iteration 29 completed (15832.014 ms) ====== [2026-02-25T23:33:49.321Z] ----------------------------------- [2026-02-25T23:33:49.321Z] renaissance-als_0_PASSED [2026-02-25T23:33:49.321Z] ----------------------------------- [2026-02-25T23:33:49.321Z] [2026-02-25T23:33:49.321Z] TEST TEARDOWN: [2026-02-25T23:33:49.321Z] Nothing to be done for teardown. [2026-02-25T23:33:49.321Z] renaissance-als_0 Finish Time: Wed Feb 25 23:33:48 2026 Epoch Time (ms): 1772062428360