[2026-02-12T00:54:51.234Z] Running test renaissance-als_0 ... [2026-02-12T00:54:51.234Z] =============================================== [2026-02-12T00:54:51.576Z] renaissance-als_0 Start Time: Thu Feb 12 00:54:51 2026 Epoch Time (ms): 1770857691281 [2026-02-12T00:54:51.576Z] variation: NoOptions [2026-02-12T00:54:51.576Z] JVM_OPTIONS: [2026-02-12T00:54:51.576Z] { \ [2026-02-12T00:54:51.576Z] echo ""; echo "TEST SETUP:"; \ [2026-02-12T00:54:51.576Z] echo "Nothing to be done for setup."; \ [2026-02-12T00:54:51.576Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17708574748279\\renaissance-als_0"; \ [2026-02-12T00:54:51.576Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17708574748279\\renaissance-als_0"; \ [2026-02-12T00:54:51.576Z] echo ""; echo "TESTING:"; \ [2026-02-12T00:54:51.576Z] "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_17708574748279\\renaissance-als_0"\\als.json" als; \ [2026-02-12T00:54:51.576Z] 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_17708574748279\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-12T00:54:51.576Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-12T00:54:51.576Z] echo "Nothing to be done for teardown."; \ [2026-02-12T00:54:51.576Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17708574748279\\TestTargetResult"; [2026-02-12T00:54:51.576Z] [2026-02-12T00:54:51.576Z] TEST SETUP: [2026-02-12T00:54:51.576Z] Nothing to be done for setup. [2026-02-12T00:54:51.576Z] [2026-02-12T00:54:51.576Z] TESTING: [2026-02-12T00:55:07.346Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-12T00:55:09.625Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-12T00:55:09.625Z] GC before operation: completed in 31.729 ms, heap usage 80.500 MB -> 35.301 MB. [2026-02-12T00:55:43.268Z] ====== als (apache-spark) [default], iteration 0 completed (28660.874 ms) ====== [2026-02-12T00:55:43.268Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-12T00:55:43.268Z] GC before operation: completed in 86.793 ms, heap usage 629.997 MB -> 62.713 MB. [2026-02-12T00:55:56.681Z] ====== als (apache-spark) [default], iteration 1 completed (16322.675 ms) ====== [2026-02-12T00:55:56.682Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-12T00:55:56.682Z] GC before operation: completed in 84.829 ms, heap usage 140.153 MB -> 62.741 MB. [2026-02-12T00:56:12.617Z] ====== als (apache-spark) [default], iteration 2 completed (16008.452 ms) ====== [2026-02-12T00:56:12.618Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-12T00:56:12.618Z] GC before operation: completed in 75.415 ms, heap usage 129.993 MB -> 63.808 MB. [2026-02-12T00:56:28.568Z] ====== als (apache-spark) [default], iteration 3 completed (15931.105 ms) ====== [2026-02-12T00:56:28.568Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-12T00:56:28.568Z] GC before operation: completed in 87.865 ms, heap usage 637.044 MB -> 64.969 MB. [2026-02-12T00:56:44.683Z] ====== als (apache-spark) [default], iteration 4 completed (16545.815 ms) ====== [2026-02-12T00:56:44.683Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-12T00:56:44.683Z] GC before operation: completed in 88.254 ms, heap usage 836.038 MB -> 65.922 MB. [2026-02-12T00:57:00.751Z] ====== als (apache-spark) [default], iteration 5 completed (15451.741 ms) ====== [2026-02-12T00:57:00.751Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-12T00:57:00.751Z] GC before operation: completed in 90.156 ms, heap usage 587.242 MB -> 66.055 MB. [2026-02-12T00:57:17.428Z] ====== als (apache-spark) [default], iteration 6 completed (16014.627 ms) ====== [2026-02-12T00:57:17.429Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-12T00:57:17.429Z] GC before operation: completed in 111.175 ms, heap usage 884.315 MB -> 66.988 MB. [2026-02-12T00:57:33.460Z] ====== als (apache-spark) [default], iteration 7 completed (15812.845 ms) ====== [2026-02-12T00:57:33.460Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-12T00:57:33.460Z] GC before operation: completed in 93.849 ms, heap usage 590.007 MB -> 67.215 MB. [2026-02-12T00:57:49.551Z] ====== als (apache-spark) [default], iteration 8 completed (15808.007 ms) ====== [2026-02-12T00:57:49.551Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-12T00:57:49.551Z] GC before operation: completed in 83.418 ms, heap usage 141.371 MB -> 67.227 MB. [2026-02-12T00:58:05.447Z] ====== als (apache-spark) [default], iteration 9 completed (16048.687 ms) ====== [2026-02-12T00:58:05.447Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-12T00:58:05.447Z] GC before operation: completed in 84.342 ms, heap usage 631.671 MB -> 67.933 MB. [2026-02-12T00:58:21.418Z] ====== als (apache-spark) [default], iteration 10 completed (15473.038 ms) ====== [2026-02-12T00:58:21.418Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-12T00:58:21.418Z] GC before operation: completed in 85.294 ms, heap usage 664.419 MB -> 68.376 MB. [2026-02-12T00:58:37.323Z] ====== als (apache-spark) [default], iteration 11 completed (16210.684 ms) ====== [2026-02-12T00:58:37.323Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-12T00:58:37.323Z] GC before operation: completed in 81.505 ms, heap usage 203.550 MB -> 67.922 MB. [2026-02-12T00:58:53.224Z] ====== als (apache-spark) [default], iteration 12 completed (15141.669 ms) ====== [2026-02-12T00:58:53.224Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-12T00:58:53.224Z] GC before operation: completed in 83.228 ms, heap usage 358.617 MB -> 68.489 MB. [2026-02-12T00:59:09.333Z] ====== als (apache-spark) [default], iteration 13 completed (16526.451 ms) ====== [2026-02-12T00:59:09.333Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-12T00:59:09.333Z] GC before operation: completed in 86.106 ms, heap usage 708.365 MB -> 69.166 MB. [2026-02-12T00:59:25.312Z] ====== als (apache-spark) [default], iteration 14 completed (15140.647 ms) ====== [2026-02-12T00:59:25.312Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-12T00:59:25.312Z] GC before operation: completed in 92.804 ms, heap usage 739.980 MB -> 69.532 MB. [2026-02-12T00:59:41.275Z] ====== als (apache-spark) [default], iteration 15 completed (15224.867 ms) ====== [2026-02-12T00:59:41.275Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-12T00:59:41.275Z] GC before operation: completed in 87.078 ms, heap usage 186.186 MB -> 69.003 MB. [2026-02-12T00:59:57.292Z] ====== als (apache-spark) [default], iteration 16 completed (15599.185 ms) ====== [2026-02-12T00:59:57.292Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-12T00:59:57.292Z] GC before operation: completed in 95.702 ms, heap usage 230.323 MB -> 69.321 MB. [2026-02-12T01:00:13.279Z] ====== als (apache-spark) [default], iteration 17 completed (15303.468 ms) ====== [2026-02-12T01:00:13.279Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-12T01:00:13.279Z] GC before operation: completed in 87.920 ms, heap usage 374.973 MB -> 69.659 MB. [2026-02-12T01:00:29.231Z] ====== als (apache-spark) [default], iteration 18 completed (16198.285 ms) ====== [2026-02-12T01:00:29.231Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-12T01:00:29.231Z] GC before operation: completed in 90.012 ms, heap usage 240.868 MB -> 69.767 MB. [2026-02-12T01:00:45.029Z] ====== als (apache-spark) [default], iteration 19 completed (15522.266 ms) ====== [2026-02-12T01:00:45.030Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-12T01:00:45.030Z] GC before operation: completed in 93.987 ms, heap usage 729.742 MB -> 70.791 MB. [2026-02-12T01:01:01.072Z] ====== als (apache-spark) [default], iteration 20 completed (15840.420 ms) ====== [2026-02-12T01:01:01.072Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-12T01:01:01.072Z] GC before operation: completed in 96.404 ms, heap usage 861.817 MB -> 71.119 MB. [2026-02-12T01:01:17.023Z] ====== als (apache-spark) [default], iteration 21 completed (15195.730 ms) ====== [2026-02-12T01:01:17.023Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-12T01:01:17.023Z] GC before operation: completed in 91.285 ms, heap usage 521.983 MB -> 71.007 MB. [2026-02-12T01:01:32.878Z] ====== als (apache-spark) [default], iteration 22 completed (15471.741 ms) ====== [2026-02-12T01:01:32.879Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-12T01:01:32.879Z] GC before operation: completed in 91.594 ms, heap usage 750.151 MB -> 71.640 MB. [2026-02-12T01:01:48.811Z] ====== als (apache-spark) [default], iteration 23 completed (16047.836 ms) ====== [2026-02-12T01:01:48.811Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-12T01:01:48.811Z] GC before operation: completed in 98.479 ms, heap usage 231.630 MB -> 71.105 MB. [2026-02-12T01:02:04.713Z] ====== als (apache-spark) [default], iteration 24 completed (15780.180 ms) ====== [2026-02-12T01:02:04.713Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-12T01:02:04.713Z] GC before operation: completed in 97.054 ms, heap usage 396.964 MB -> 71.590 MB. [2026-02-12T01:02:20.563Z] ====== als (apache-spark) [default], iteration 25 completed (15939.468 ms) ====== [2026-02-12T01:02:20.563Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-12T01:02:20.563Z] GC before operation: completed in 92.556 ms, heap usage 212.825 MB -> 71.576 MB. [2026-02-12T01:02:36.469Z] ====== als (apache-spark) [default], iteration 26 completed (15088.490 ms) ====== [2026-02-12T01:02:36.469Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-12T01:02:36.469Z] GC before operation: completed in 96.242 ms, heap usage 464.945 MB -> 72.322 MB. [2026-02-12T01:02:51.776Z] ====== als (apache-spark) [default], iteration 27 completed (16286.973 ms) ====== [2026-02-12T01:02:51.776Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-12T01:02:51.776Z] GC before operation: completed in 92.070 ms, heap usage 167.978 MB -> 72.188 MB. [2026-02-12T01:03:07.745Z] ====== als (apache-spark) [default], iteration 28 completed (15359.502 ms) ====== [2026-02-12T01:03:07.745Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-12T01:03:07.745Z] GC before operation: completed in 94.068 ms, heap usage 362.106 MB -> 72.226 MB. [2026-02-12T01:03:23.565Z] ====== als (apache-spark) [default], iteration 29 completed (15558.681 ms) ====== [2026-02-12T01:03:23.565Z] ----------------------------------- [2026-02-12T01:03:23.565Z] renaissance-als_0_PASSED [2026-02-12T01:03:23.565Z] ----------------------------------- [2026-02-12T01:03:23.565Z] [2026-02-12T01:03:23.565Z] TEST TEARDOWN: [2026-02-12T01:03:23.565Z] Nothing to be done for teardown. [2026-02-12T01:03:23.565Z] renaissance-als_0 Finish Time: Thu Feb 12 01:03:23 2026 Epoch Time (ms): 1770858203175