[2026-04-01T21:16:53.579Z] Running test renaissance-als_0 ... [2026-04-01T21:16:53.579Z] =============================================== [2026-04-01T21:16:53.948Z] renaissance-als_0 Start Time: Wed Apr 1 21:16:53 2026 Epoch Time (ms): 1775078213551 [2026-04-01T21:16:53.948Z] variation: NoOptions [2026-04-01T21:16:53.948Z] JVM_OPTIONS: [2026-04-01T21:16:53.948Z] { \ [2026-04-01T21:16:53.948Z] echo ""; echo "TEST SETUP:"; \ [2026-04-01T21:16:53.948Z] echo "Nothing to be done for setup."; \ [2026-04-01T21:16:53.948Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-als_0"; \ [2026-04-01T21:16:53.948Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-als_0"; \ [2026-04-01T21:16:53.948Z] echo ""; echo "TESTING:"; \ [2026-04-01T21:16:53.948Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_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_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-als_0"/als.json" als; \ [2026-04-01T21:16:53.948Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-01T21:16:53.948Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-01T21:16:53.948Z] echo "Nothing to be done for teardown."; \ [2026-04-01T21:16:53.948Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17750780587161/TestTargetResult"; [2026-04-01T21:16:53.948Z] [2026-04-01T21:16:53.948Z] TEST SETUP: [2026-04-01T21:16:53.948Z] Nothing to be done for setup. [2026-04-01T21:16:53.948Z] [2026-04-01T21:16:53.948Z] TESTING: [2026-04-01T21:16:58.570Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-01T21:17:01.415Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-01T21:17:01.415Z] GC before operation: completed in 55.819 ms, heap usage 288.912 MB -> 36.175 MB. [2026-04-01T21:17:22.020Z] ====== als (apache-spark) [default], iteration 0 completed (18634.393 ms) ====== [2026-04-01T21:17:22.020Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-01T21:17:22.020Z] GC before operation: completed in 163.980 ms, heap usage 1.520 GB -> 64.405 MB. [2026-04-01T21:17:28.847Z] ====== als (apache-spark) [default], iteration 1 completed (7731.210 ms) ====== [2026-04-01T21:17:28.847Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-01T21:17:28.847Z] GC before operation: completed in 104.059 ms, heap usage 863.727 MB -> 64.629 MB. [2026-04-01T21:17:36.700Z] ====== als (apache-spark) [default], iteration 2 completed (6924.577 ms) ====== [2026-04-01T21:17:36.700Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-01T21:17:36.700Z] GC before operation: completed in 141.571 ms, heap usage 437.130 MB -> 64.624 MB. [2026-04-01T21:17:44.107Z] ====== als (apache-spark) [default], iteration 3 completed (6487.490 ms) ====== [2026-04-01T21:17:44.107Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-01T21:17:44.108Z] GC before operation: completed in 140.077 ms, heap usage 518.168 MB -> 65.531 MB. [2026-04-01T21:17:50.319Z] ====== als (apache-spark) [default], iteration 4 completed (6316.039 ms) ====== [2026-04-01T21:17:50.319Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-01T21:17:50.319Z] GC before operation: completed in 125.137 ms, heap usage 646.471 MB -> 66.069 MB. [2026-04-01T21:17:56.545Z] ====== als (apache-spark) [default], iteration 5 completed (6052.798 ms) ====== [2026-04-01T21:17:56.545Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-01T21:17:56.545Z] GC before operation: completed in 120.802 ms, heap usage 247.832 MB -> 66.271 MB. [2026-04-01T21:18:02.939Z] ====== als (apache-spark) [default], iteration 6 completed (6254.863 ms) ====== [2026-04-01T21:18:02.939Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-01T21:18:02.939Z] GC before operation: completed in 123.558 ms, heap usage 217.932 MB -> 66.823 MB. [2026-04-01T21:18:09.157Z] ====== als (apache-spark) [default], iteration 7 completed (5889.373 ms) ====== [2026-04-01T21:18:09.157Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-01T21:18:09.157Z] GC before operation: completed in 118.213 ms, heap usage 933.464 MB -> 68.153 MB. [2026-04-01T21:18:18.799Z] ====== als (apache-spark) [default], iteration 8 completed (6223.297 ms) ====== [2026-04-01T21:18:18.799Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-01T21:18:18.799Z] GC before operation: completed in 115.911 ms, heap usage 1.226 GB -> 69.040 MB. [2026-04-01T21:18:22.147Z] ====== als (apache-spark) [default], iteration 9 completed (6394.188 ms) ====== [2026-04-01T21:18:22.147Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-01T21:18:22.147Z] GC before operation: completed in 114.143 ms, heap usage 1.210 GB -> 69.803 MB. [2026-04-01T21:18:28.362Z] ====== als (apache-spark) [default], iteration 10 completed (6132.330 ms) ====== [2026-04-01T21:18:28.362Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-01T21:18:28.362Z] GC before operation: completed in 123.440 ms, heap usage 679.236 MB -> 68.834 MB. [2026-04-01T21:18:34.428Z] ====== als (apache-spark) [default], iteration 11 completed (5979.530 ms) ====== [2026-04-01T21:18:34.429Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-01T21:18:34.785Z] GC before operation: completed in 122.163 ms, heap usage 827.640 MB -> 69.275 MB. [2026-04-01T21:18:40.924Z] ====== als (apache-spark) [default], iteration 12 completed (5802.790 ms) ====== [2026-04-01T21:18:40.924Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-01T21:18:40.924Z] GC before operation: completed in 136.979 ms, heap usage 804.221 MB -> 69.659 MB. [2026-04-01T21:18:48.503Z] ====== als (apache-spark) [default], iteration 13 completed (6396.809 ms) ====== [2026-04-01T21:18:48.503Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-01T21:18:48.503Z] GC before operation: completed in 113.546 ms, heap usage 188.372 MB -> 69.163 MB. [2026-04-01T21:18:53.498Z] ====== als (apache-spark) [default], iteration 14 completed (6039.220 ms) ====== [2026-04-01T21:18:53.498Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-01T21:18:53.858Z] GC before operation: completed in 113.915 ms, heap usage 764.554 MB -> 69.979 MB. [2026-04-01T21:19:02.299Z] ====== als (apache-spark) [default], iteration 15 completed (6153.237 ms) ====== [2026-04-01T21:19:02.299Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-01T21:19:02.299Z] GC before operation: completed in 126.996 ms, heap usage 602.823 MB -> 70.326 MB. [2026-04-01T21:19:09.155Z] ====== als (apache-spark) [default], iteration 16 completed (6129.716 ms) ====== [2026-04-01T21:19:09.155Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-01T21:19:09.155Z] GC before operation: completed in 139.072 ms, heap usage 1.277 GB -> 71.217 MB. [2026-04-01T21:19:13.338Z] ====== als (apache-spark) [default], iteration 17 completed (6234.246 ms) ====== [2026-04-01T21:19:13.338Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-01T21:19:13.338Z] GC before operation: completed in 131.194 ms, heap usage 1.440 GB -> 71.677 MB. [2026-04-01T21:19:22.436Z] ====== als (apache-spark) [default], iteration 18 completed (5946.952 ms) ====== [2026-04-01T21:19:22.436Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-01T21:19:22.436Z] GC before operation: completed in 135.371 ms, heap usage 252.726 MB -> 70.443 MB. [2026-04-01T21:19:28.163Z] ====== als (apache-spark) [default], iteration 19 completed (6303.333 ms) ====== [2026-04-01T21:19:28.163Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-01T21:19:28.163Z] GC before operation: completed in 166.644 ms, heap usage 677.657 MB -> 71.362 MB. [2026-04-01T21:19:33.232Z] ====== als (apache-spark) [default], iteration 20 completed (6303.071 ms) ====== [2026-04-01T21:19:33.232Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-01T21:19:33.232Z] GC before operation: completed in 132.864 ms, heap usage 303.018 MB -> 71.141 MB. [2026-04-01T21:19:39.696Z] ====== als (apache-spark) [default], iteration 21 completed (5841.389 ms) ====== [2026-04-01T21:19:39.696Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-01T21:19:39.696Z] GC before operation: completed in 139.140 ms, heap usage 1.003 GB -> 72.257 MB. [2026-04-01T21:19:47.919Z] ====== als (apache-spark) [default], iteration 22 completed (6216.178 ms) ====== [2026-04-01T21:19:47.919Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-01T21:19:47.919Z] GC before operation: completed in 171.532 ms, heap usage 973.150 MB -> 72.461 MB. [2026-04-01T21:19:52.016Z] ====== als (apache-spark) [default], iteration 23 completed (6092.036 ms) ====== [2026-04-01T21:19:52.016Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-01T21:19:52.016Z] GC before operation: completed in 147.577 ms, heap usage 766.718 MB -> 72.668 MB. [2026-04-01T21:19:58.122Z] ====== als (apache-spark) [default], iteration 24 completed (5973.910 ms) ====== [2026-04-01T21:19:58.122Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-01T21:19:58.122Z] GC before operation: completed in 136.325 ms, heap usage 955.063 MB -> 72.975 MB. [2026-04-01T21:20:04.184Z] ====== als (apache-spark) [default], iteration 25 completed (5845.291 ms) ====== [2026-04-01T21:20:04.184Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-01T21:20:04.184Z] GC before operation: completed in 146.075 ms, heap usage 219.428 MB -> 72.279 MB. [2026-04-01T21:20:10.344Z] ====== als (apache-spark) [default], iteration 26 completed (6123.916 ms) ====== [2026-04-01T21:20:10.344Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-01T21:20:10.344Z] GC before operation: completed in 120.409 ms, heap usage 538.106 MB -> 73.241 MB. [2026-04-01T21:20:16.456Z] ====== als (apache-spark) [default], iteration 27 completed (6028.578 ms) ====== [2026-04-01T21:20:16.456Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-01T21:20:16.822Z] GC before operation: completed in 130.920 ms, heap usage 599.691 MB -> 73.360 MB. [2026-04-01T21:20:23.297Z] ====== als (apache-spark) [default], iteration 28 completed (5833.207 ms) ====== [2026-04-01T21:20:23.297Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-01T21:20:23.297Z] GC before operation: completed in 149.186 ms, heap usage 206.439 MB -> 72.678 MB. [2026-04-01T21:20:29.408Z] ====== als (apache-spark) [default], iteration 29 completed (5948.906 ms) ====== [2026-04-01T21:20:29.408Z] ----------------------------------- [2026-04-01T21:20:29.408Z] renaissance-als_0_PASSED [2026-04-01T21:20:29.408Z] ----------------------------------- [2026-04-01T21:20:29.408Z] [2026-04-01T21:20:29.408Z] TEST TEARDOWN: [2026-04-01T21:20:29.408Z] Nothing to be done for teardown. [2026-04-01T21:20:29.408Z] renaissance-als_0 Finish Time: Wed Apr 1 21:20:29 2026 Epoch Time (ms): 1775078429360