[2026-02-04T23:26:40.142Z] Running test renaissance-als_0 ... [2026-02-04T23:26:40.142Z] =============================================== [2026-02-04T23:26:40.142Z] renaissance-als_0 Start Time: Wed Feb 4 23:26:40 2026 Epoch Time (ms): 1770247600112 [2026-02-04T23:26:40.521Z] variation: NoOptions [2026-02-04T23:26:40.521Z] JVM_OPTIONS: [2026-02-04T23:26:40.521Z] { \ [2026-02-04T23:26:40.521Z] echo ""; echo "TEST SETUP:"; \ [2026-02-04T23:26:40.521Z] echo "Nothing to be done for setup."; \ [2026-02-04T23:26:40.521Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-als_0"; \ [2026-02-04T23:26:40.521Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-als_0"; \ [2026-02-04T23:26:40.521Z] echo ""; echo "TESTING:"; \ [2026-02-04T23:26:40.521Z] "c:/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-als_0"\\als.json" als; \ [2026-02-04T23:26:40.521Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-04T23:26:40.521Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-04T23:26:40.521Z] echo "Nothing to be done for teardown."; \ [2026-02-04T23:26:40.521Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\TestTargetResult"; [2026-02-04T23:26:40.521Z] [2026-02-04T23:26:40.521Z] TEST SETUP: [2026-02-04T23:26:40.521Z] Nothing to be done for setup. [2026-02-04T23:26:40.521Z] [2026-02-04T23:26:40.521Z] TESTING: [2026-02-04T23:26:54.449Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-02-04T23:26:57.817Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-04T23:26:57.817Z] GC before operation: completed in 97.014 ms, heap usage 51.854 MB -> 35.196 MB. [2026-02-04T23:27:41.442Z] ====== als (apache-spark) [default], iteration 0 completed (41469.068 ms) ====== [2026-02-04T23:27:41.442Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-04T23:27:41.442Z] GC before operation: completed in 317.463 ms, heap usage 210.675 MB -> 62.237 MB. [2026-02-04T23:28:05.415Z] ====== als (apache-spark) [default], iteration 1 completed (22569.943 ms) ====== [2026-02-04T23:28:05.415Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-04T23:28:05.415Z] GC before operation: completed in 112.745 ms, heap usage 318.656 MB -> 62.921 MB. [2026-02-04T23:28:29.286Z] ====== als (apache-spark) [default], iteration 2 completed (22027.148 ms) ====== [2026-02-04T23:28:29.286Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-04T23:28:29.286Z] GC before operation: completed in 85.825 ms, heap usage 245.391 MB -> 63.415 MB. [2026-02-04T23:28:49.393Z] ====== als (apache-spark) [default], iteration 3 completed (21679.828 ms) ====== [2026-02-04T23:28:49.393Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-04T23:28:49.393Z] GC before operation: completed in 144.916 ms, heap usage 235.188 MB -> 63.604 MB. [2026-02-04T23:29:13.069Z] ====== als (apache-spark) [default], iteration 4 completed (21339.105 ms) ====== [2026-02-04T23:29:13.069Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-04T23:29:13.069Z] GC before operation: completed in 203.792 ms, heap usage 173.747 MB -> 63.915 MB. [2026-02-04T23:29:32.908Z] ====== als (apache-spark) [default], iteration 5 completed (21235.497 ms) ====== [2026-02-04T23:29:32.908Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-04T23:29:32.908Z] GC before operation: completed in 177.314 ms, heap usage 463.665 MB -> 65.371 MB. [2026-02-04T23:29:52.955Z] ====== als (apache-spark) [default], iteration 6 completed (21026.259 ms) ====== [2026-02-04T23:29:52.956Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-04T23:29:52.956Z] GC before operation: completed in 400.054 ms, heap usage 452.277 MB -> 66.008 MB. [2026-02-04T23:30:16.968Z] ====== als (apache-spark) [default], iteration 7 completed (21024.093 ms) ====== [2026-02-04T23:30:16.968Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-04T23:30:16.968Z] GC before operation: completed in 131.682 ms, heap usage 138.098 MB -> 66.110 MB. [2026-02-04T23:30:36.578Z] ====== als (apache-spark) [default], iteration 8 completed (20845.100 ms) ====== [2026-02-04T23:30:36.578Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-04T23:30:36.578Z] GC before operation: completed in 139.226 ms, heap usage 354.937 MB -> 66.884 MB. [2026-02-04T23:31:00.371Z] ====== als (apache-spark) [default], iteration 9 completed (20927.333 ms) ====== [2026-02-04T23:31:00.371Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-04T23:31:00.371Z] GC before operation: completed in 219.706 ms, heap usage 356.901 MB -> 67.111 MB. [2026-02-04T23:31:19.926Z] ====== als (apache-spark) [default], iteration 10 completed (20897.723 ms) ====== [2026-02-04T23:31:19.926Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-04T23:31:19.926Z] GC before operation: completed in 99.472 ms, heap usage 111.924 MB -> 66.599 MB. [2026-02-04T23:31:45.035Z] ====== als (apache-spark) [default], iteration 11 completed (25939.091 ms) ====== [2026-02-04T23:31:45.035Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-04T23:31:45.035Z] GC before operation: completed in 96.212 ms, heap usage 454.281 MB -> 67.818 MB. [2026-02-04T23:32:08.827Z] ====== als (apache-spark) [default], iteration 12 completed (20995.882 ms) ====== [2026-02-04T23:32:08.827Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-04T23:32:08.827Z] GC before operation: completed in 95.097 ms, heap usage 112.463 MB -> 67.137 MB. [2026-02-04T23:32:28.641Z] ====== als (apache-spark) [default], iteration 13 completed (20857.427 ms) ====== [2026-02-04T23:32:28.641Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-04T23:32:28.641Z] GC before operation: completed in 91.899 ms, heap usage 343.283 MB -> 68.130 MB. [2026-02-04T23:32:48.693Z] ====== als (apache-spark) [default], iteration 14 completed (20773.003 ms) ====== [2026-02-04T23:32:48.693Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-04T23:32:48.693Z] GC before operation: completed in 95.935 ms, heap usage 433.201 MB -> 68.596 MB. [2026-02-04T23:33:12.486Z] ====== als (apache-spark) [default], iteration 15 completed (20650.791 ms) ====== [2026-02-04T23:33:12.486Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-04T23:33:12.486Z] GC before operation: completed in 188.806 ms, heap usage 318.652 MB -> 68.679 MB. [2026-02-04T23:33:32.258Z] ====== als (apache-spark) [default], iteration 16 completed (20719.632 ms) ====== [2026-02-04T23:33:32.258Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-04T23:33:32.258Z] GC before operation: completed in 92.770 ms, heap usage 479.037 MB -> 69.073 MB. [2026-02-04T23:33:52.051Z] ====== als (apache-spark) [default], iteration 17 completed (21398.882 ms) ====== [2026-02-04T23:33:52.051Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-04T23:33:52.534Z] GC before operation: completed in 89.671 ms, heap usage 91.088 MB -> 68.465 MB. [2026-02-04T23:34:16.297Z] ====== als (apache-spark) [default], iteration 18 completed (20808.214 ms) ====== [2026-02-04T23:34:16.297Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-04T23:34:16.297Z] GC before operation: completed in 89.010 ms, heap usage 122.225 MB -> 69.170 MB. [2026-02-04T23:34:36.134Z] ====== als (apache-spark) [default], iteration 19 completed (20816.526 ms) ====== [2026-02-04T23:34:36.134Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-04T23:34:36.134Z] GC before operation: completed in 107.370 ms, heap usage 102.478 MB -> 69.007 MB. [2026-02-04T23:34:57.111Z] ====== als (apache-spark) [default], iteration 20 completed (22118.535 ms) ====== [2026-02-04T23:34:57.111Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-04T23:34:57.111Z] GC before operation: completed in 115.845 ms, heap usage 101.272 MB -> 69.218 MB. [2026-02-04T23:35:20.828Z] ====== als (apache-spark) [default], iteration 21 completed (20620.434 ms) ====== [2026-02-04T23:35:20.828Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-04T23:35:20.828Z] GC before operation: completed in 89.983 ms, heap usage 435.993 MB -> 70.425 MB. [2026-02-04T23:35:40.658Z] ====== als (apache-spark) [default], iteration 22 completed (20625.620 ms) ====== [2026-02-04T23:35:40.658Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-04T23:35:40.658Z] GC before operation: completed in 104.327 ms, heap usage 442.832 MB -> 70.702 MB. [2026-02-04T23:36:00.612Z] ====== als (apache-spark) [default], iteration 23 completed (20750.526 ms) ====== [2026-02-04T23:36:00.612Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-04T23:36:00.612Z] GC before operation: completed in 97.150 ms, heap usage 263.483 MB -> 70.107 MB. [2026-02-04T23:36:24.305Z] ====== als (apache-spark) [default], iteration 24 completed (20916.604 ms) ====== [2026-02-04T23:36:24.305Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-04T23:36:24.305Z] GC before operation: completed in 109.821 ms, heap usage 240.393 MB -> 70.836 MB. [2026-02-04T23:36:44.054Z] ====== als (apache-spark) [default], iteration 25 completed (20412.539 ms) ====== [2026-02-04T23:36:44.054Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-04T23:36:44.054Z] GC before operation: completed in 98.174 ms, heap usage 254.126 MB -> 71.145 MB. [2026-02-04T23:37:03.756Z] ====== als (apache-spark) [default], iteration 26 completed (20487.801 ms) ====== [2026-02-04T23:37:03.756Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-04T23:37:03.756Z] GC before operation: completed in 104.557 ms, heap usage 187.984 MB -> 71.350 MB. [2026-02-04T23:37:23.550Z] ====== als (apache-spark) [default], iteration 27 completed (21143.247 ms) ====== [2026-02-04T23:37:23.550Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-04T23:37:23.550Z] GC before operation: completed in 92.855 ms, heap usage 103.382 MB -> 70.969 MB. [2026-02-04T23:37:47.762Z] ====== als (apache-spark) [default], iteration 28 completed (20443.116 ms) ====== [2026-02-04T23:37:47.762Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-04T23:37:47.762Z] GC before operation: completed in 93.958 ms, heap usage 438.567 MB -> 71.677 MB. [2026-02-04T23:38:07.500Z] ====== als (apache-spark) [default], iteration 29 completed (20527.765 ms) ====== [2026-02-04T23:38:07.500Z] ----------------------------------- [2026-02-04T23:38:07.500Z] renaissance-als_0_PASSED [2026-02-04T23:38:07.500Z] ----------------------------------- [2026-02-04T23:38:07.500Z] [2026-02-04T23:38:07.500Z] TEST TEARDOWN: [2026-02-04T23:38:07.500Z] Nothing to be done for teardown. [2026-02-04T23:38:07.500Z] renaissance-als_0 Finish Time: Wed Feb 4 23:38:05 2026 Epoch Time (ms): 1770248285688