[2026-04-14T12:07:37.102Z] Running test renaissance-als_0 ... [2026-04-14T12:07:37.102Z] =============================================== [2026-04-14T12:07:37.102Z] renaissance-als_0 Start Time: Tue Apr 14 12:07:36 2026 Epoch Time (ms): 1776168456137 [2026-04-14T12:07:37.102Z] variation: NoOptions [2026-04-14T12:07:37.102Z] JVM_OPTIONS: [2026-04-14T12:07:37.102Z] { \ [2026-04-14T12:07:37.102Z] echo ""; echo "TEST SETUP:"; \ [2026-04-14T12:07:37.102Z] echo "Nothing to be done for setup."; \ [2026-04-14T12:07:37.102Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17761684555319/renaissance-als_0"; \ [2026-04-14T12:07:37.102Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17761684555319/renaissance-als_0"; \ [2026-04-14T12:07:37.102Z] echo ""; echo "TESTING:"; \ [2026-04-14T12:07:37.102Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17761684555319/renaissance-als_0"/als.json" als; \ [2026-04-14T12:07:37.102Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17761684555319/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-14T12:07:37.102Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-14T12:07:37.102Z] echo "Nothing to be done for teardown."; \ [2026-04-14T12:07:37.102Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17761684555319/TestTargetResult"; [2026-04-14T12:07:37.102Z] [2026-04-14T12:07:37.102Z] TEST SETUP: [2026-04-14T12:07:37.102Z] Nothing to be done for setup. [2026-04-14T12:07:37.102Z] [2026-04-14T12:07:37.102Z] TESTING: [2026-04-14T12:07:45.316Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-14T12:07:52.033Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-14T12:07:55.297Z] GC before operation: completed in 922.154 ms, heap usage 79.236 MB -> 35.161 MB. [2026-04-14T12:08:24.057Z] ====== als (apache-spark) [default], iteration 0 completed (30584.388 ms) ====== [2026-04-14T12:08:24.057Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-14T12:08:24.057Z] GC before operation: completed in 173.847 ms, heap usage 565.780 MB -> 62.375 MB. [2026-04-14T12:08:37.656Z] ====== als (apache-spark) [default], iteration 1 completed (12566.615 ms) ====== [2026-04-14T12:08:37.656Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-14T12:08:37.656Z] GC before operation: completed in 139.468 ms, heap usage 378.264 MB -> 63.040 MB. [2026-04-14T12:08:49.355Z] ====== als (apache-spark) [default], iteration 2 completed (10548.997 ms) ====== [2026-04-14T12:08:49.355Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-14T12:08:49.355Z] GC before operation: completed in 167.114 ms, heap usage 486.718 MB -> 63.871 MB. [2026-04-14T12:08:58.574Z] ====== als (apache-spark) [default], iteration 3 completed (10069.491 ms) ====== [2026-04-14T12:08:58.574Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-14T12:08:58.574Z] GC before operation: completed in 198.437 ms, heap usage 645.480 MB -> 64.617 MB. [2026-04-14T12:09:12.332Z] ====== als (apache-spark) [default], iteration 4 completed (12515.745 ms) ====== [2026-04-14T12:09:12.332Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-14T12:09:12.332Z] GC before operation: completed in 356.067 ms, heap usage 615.687 MB -> 65.130 MB. [2026-04-14T12:09:26.091Z] ====== als (apache-spark) [default], iteration 5 completed (12276.359 ms) ====== [2026-04-14T12:09:26.091Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-14T12:09:26.091Z] GC before operation: completed in 242.886 ms, heap usage 595.947 MB -> 65.681 MB. [2026-04-14T12:09:37.974Z] ====== als (apache-spark) [default], iteration 6 completed (11133.507 ms) ====== [2026-04-14T12:09:37.974Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-14T12:09:37.974Z] GC before operation: completed in 232.733 ms, heap usage 877.548 MB -> 66.523 MB. [2026-04-14T12:09:49.580Z] ====== als (apache-spark) [default], iteration 7 completed (11129.885 ms) ====== [2026-04-14T12:09:49.580Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-14T12:09:49.580Z] GC before operation: completed in 175.036 ms, heap usage 673.198 MB -> 66.907 MB. [2026-04-14T12:09:59.505Z] ====== als (apache-spark) [default], iteration 8 completed (10166.189 ms) ====== [2026-04-14T12:09:59.505Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-14T12:09:59.505Z] GC before operation: completed in 190.704 ms, heap usage 287.971 MB -> 66.926 MB. [2026-04-14T12:10:11.126Z] ====== als (apache-spark) [default], iteration 9 completed (10827.367 ms) ====== [2026-04-14T12:10:11.126Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-14T12:10:11.126Z] GC before operation: completed in 207.508 ms, heap usage 756.320 MB -> 67.673 MB. [2026-04-14T12:10:24.715Z] ====== als (apache-spark) [default], iteration 10 completed (13233.251 ms) ====== [2026-04-14T12:10:24.715Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-14T12:10:25.684Z] GC before operation: completed in 387.014 ms, heap usage 732.402 MB -> 67.943 MB. [2026-04-14T12:10:39.361Z] ====== als (apache-spark) [default], iteration 11 completed (13640.010 ms) ====== [2026-04-14T12:10:39.361Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-14T12:10:39.361Z] GC before operation: completed in 327.118 ms, heap usage 122.128 MB -> 67.172 MB. [2026-04-14T12:10:51.022Z] ====== als (apache-spark) [default], iteration 12 completed (10897.890 ms) ====== [2026-04-14T12:10:51.022Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-14T12:10:51.022Z] GC before operation: completed in 216.261 ms, heap usage 167.326 MB -> 67.403 MB. [2026-04-14T12:11:02.674Z] ====== als (apache-spark) [default], iteration 13 completed (10590.292 ms) ====== [2026-04-14T12:11:02.674Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-14T12:11:02.674Z] GC before operation: completed in 194.611 ms, heap usage 139.276 MB -> 67.990 MB. [2026-04-14T12:11:16.915Z] ====== als (apache-spark) [default], iteration 14 completed (12485.929 ms) ====== [2026-04-14T12:11:16.915Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-14T12:11:16.915Z] GC before operation: completed in 345.133 ms, heap usage 249.055 MB -> 68.438 MB. [2026-04-14T12:11:28.558Z] ====== als (apache-spark) [default], iteration 15 completed (10959.567 ms) ====== [2026-04-14T12:11:28.558Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-14T12:11:28.558Z] GC before operation: completed in 199.668 ms, heap usage 567.619 MB -> 69.057 MB. [2026-04-14T12:11:38.411Z] ====== als (apache-spark) [default], iteration 16 completed (9960.534 ms) ====== [2026-04-14T12:11:38.411Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-14T12:11:38.411Z] GC before operation: completed in 223.724 ms, heap usage 247.714 MB -> 68.961 MB. [2026-04-14T12:11:50.043Z] ====== als (apache-spark) [default], iteration 17 completed (11043.713 ms) ====== [2026-04-14T12:11:50.043Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-14T12:11:50.043Z] GC before operation: completed in 168.524 ms, heap usage 274.728 MB -> 69.126 MB. [2026-04-14T12:11:59.859Z] ====== als (apache-spark) [default], iteration 18 completed (9998.726 ms) ====== [2026-04-14T12:11:59.860Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-14T12:11:59.860Z] GC before operation: completed in 193.358 ms, heap usage 402.937 MB -> 69.548 MB. [2026-04-14T12:12:11.578Z] ====== als (apache-spark) [default], iteration 19 completed (11624.740 ms) ====== [2026-04-14T12:12:11.578Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-14T12:12:12.537Z] GC before operation: completed in 345.728 ms, heap usage 667.087 MB -> 70.123 MB. [2026-04-14T12:12:26.482Z] ====== als (apache-spark) [default], iteration 20 completed (14022.905 ms) ====== [2026-04-14T12:12:26.482Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-14T12:12:27.637Z] GC before operation: completed in 560.232 ms, heap usage 255.099 MB -> 69.895 MB. [2026-04-14T12:12:39.743Z] ====== als (apache-spark) [default], iteration 21 completed (11413.016 ms) ====== [2026-04-14T12:12:39.743Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-14T12:12:39.743Z] GC before operation: completed in 206.104 ms, heap usage 255.176 MB -> 70.295 MB. [2026-04-14T12:12:51.392Z] ====== als (apache-spark) [default], iteration 22 completed (11284.431 ms) ====== [2026-04-14T12:12:51.392Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-14T12:12:51.392Z] GC before operation: completed in 316.010 ms, heap usage 694.516 MB -> 71.057 MB. [2026-04-14T12:13:03.811Z] ====== als (apache-spark) [default], iteration 23 completed (11837.154 ms) ====== [2026-04-14T12:13:03.811Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-14T12:13:03.811Z] GC before operation: completed in 262.476 ms, heap usage 142.178 MB -> 70.602 MB. [2026-04-14T12:13:15.465Z] ====== als (apache-spark) [default], iteration 24 completed (10998.008 ms) ====== [2026-04-14T12:13:15.465Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-14T12:13:15.465Z] GC before operation: completed in 281.071 ms, heap usage 352.741 MB -> 71.043 MB. [2026-04-14T12:13:29.089Z] ====== als (apache-spark) [default], iteration 25 completed (13651.802 ms) ====== [2026-04-14T12:13:29.089Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-14T12:13:29.089Z] GC before operation: completed in 236.545 ms, heap usage 894.922 MB -> 72.101 MB. [2026-04-14T12:13:42.875Z] ====== als (apache-spark) [default], iteration 26 completed (12306.197 ms) ====== [2026-04-14T12:13:42.875Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-14T12:13:42.875Z] GC before operation: completed in 447.345 ms, heap usage 632.639 MB -> 72.059 MB. [2026-04-14T12:13:56.723Z] ====== als (apache-spark) [default], iteration 27 completed (12483.693 ms) ====== [2026-04-14T12:13:56.723Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-14T12:13:56.723Z] GC before operation: completed in 241.774 ms, heap usage 170.549 MB -> 71.787 MB. [2026-04-14T12:14:08.595Z] ====== als (apache-spark) [default], iteration 28 completed (11402.291 ms) ====== [2026-04-14T12:14:08.595Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-14T12:14:08.595Z] GC before operation: completed in 245.535 ms, heap usage 655.137 MB -> 72.199 MB. [2026-04-14T12:14:20.733Z] ====== als (apache-spark) [default], iteration 29 completed (12950.127 ms) ====== [2026-04-14T12:14:22.694Z] ----------------------------------- [2026-04-14T12:14:22.694Z] renaissance-als_0_PASSED [2026-04-14T12:14:22.694Z] ----------------------------------- [2026-04-14T12:14:22.694Z] [2026-04-14T12:14:22.694Z] TEST TEARDOWN: [2026-04-14T12:14:22.694Z] Nothing to be done for teardown. [2026-04-14T12:14:22.694Z] renaissance-als_0 Finish Time: Tue Apr 14 12:14:22 2026 Epoch Time (ms): 1776168862092