[2026-03-05T18:02:17.896Z] Running test renaissance-als_0 ... [2026-03-05T18:02:17.896Z] =============================================== [2026-03-05T18:02:17.896Z] renaissance-als_0 Start Time: Thu Mar 5 13:02:17 2026 Epoch Time (ms): 1772733737532 [2026-03-05T18:02:17.896Z] variation: NoOptions [2026-03-05T18:02:17.896Z] JVM_OPTIONS: [2026-03-05T18:02:17.896Z] { \ [2026-03-05T18:02:17.896Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T18:02:17.896Z] echo "Nothing to be done for setup."; \ [2026-03-05T18:02:17.896Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17727337348423/renaissance-als_0"; \ [2026-03-05T18:02:17.896Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17727337348423/renaissance-als_0"; \ [2026-03-05T18:02:17.896Z] echo ""; echo "TESTING:"; \ [2026-03-05T18:02:17.896Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17727337348423/renaissance-als_0"/als.json" als; \ [2026-03-05T18:02:17.896Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17727337348423/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T18:02:17.896Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T18:02:17.896Z] echo "Nothing to be done for teardown."; \ [2026-03-05T18:02:17.896Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17727337348423/TestTargetResult"; [2026-03-05T18:02:17.896Z] [2026-03-05T18:02:17.896Z] TEST SETUP: [2026-03-05T18:02:17.896Z] Nothing to be done for setup. [2026-03-05T18:02:17.896Z] [2026-03-05T18:02:17.896Z] TESTING: [2026-03-05T18:02:54.411Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-03-05T18:03:07.487Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-03-05T18:03:07.487Z] GC before operation: completed in 274.333 ms, heap usage 332.469 MB -> 34.115 MB. [2026-03-05T18:04:50.612Z] ====== als (apache-spark) [default], iteration 0 completed (88581.574 ms) ====== [2026-03-05T18:04:50.612Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-03-05T18:04:50.612Z] GC before operation: completed in 308.009 ms, heap usage 234.397 MB -> 60.699 MB. [2026-03-05T18:05:34.528Z] ====== als (apache-spark) [default], iteration 1 completed (46710.409 ms) ====== [2026-03-05T18:05:34.528Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-03-05T18:05:34.528Z] GC before operation: completed in 389.478 ms, heap usage 863.613 MB -> 62.560 MB. [2026-03-05T18:06:18.788Z] ====== als (apache-spark) [default], iteration 2 completed (44960.036 ms) ====== [2026-03-05T18:06:18.788Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-03-05T18:06:18.788Z] GC before operation: completed in 347.448 ms, heap usage 359.062 MB -> 62.359 MB. [2026-03-05T18:07:03.559Z] ====== als (apache-spark) [default], iteration 3 completed (43070.865 ms) ====== [2026-03-05T18:07:03.559Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-03-05T18:07:03.559Z] GC before operation: completed in 1250.150 ms, heap usage 354.957 MB -> 63.186 MB. [2026-03-05T18:07:49.044Z] ====== als (apache-spark) [default], iteration 4 completed (40744.391 ms) ====== [2026-03-05T18:07:49.044Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-03-05T18:07:49.044Z] GC before operation: completed in 397.025 ms, heap usage 493.573 MB -> 63.794 MB. [2026-03-05T18:08:41.444Z] ====== als (apache-spark) [default], iteration 5 completed (48679.375 ms) ====== [2026-03-05T18:08:41.444Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-03-05T18:08:41.444Z] GC before operation: completed in 392.991 ms, heap usage 799.202 MB -> 64.671 MB. [2026-03-05T18:09:13.286Z] ====== als (apache-spark) [default], iteration 6 completed (35822.822 ms) ====== [2026-03-05T18:09:13.286Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-03-05T18:09:13.286Z] GC before operation: completed in 251.454 ms, heap usage 705.650 MB -> 65.287 MB. [2026-03-05T18:09:57.756Z] ====== als (apache-spark) [default], iteration 7 completed (37949.299 ms) ====== [2026-03-05T18:09:57.756Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-03-05T18:09:57.756Z] GC before operation: completed in 579.621 ms, heap usage 210.519 MB -> 64.981 MB. [2026-03-05T18:10:43.492Z] ====== als (apache-spark) [default], iteration 8 completed (47578.515 ms) ====== [2026-03-05T18:10:43.492Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-03-05T18:10:43.492Z] GC before operation: completed in 1160.695 ms, heap usage 674.477 MB -> 66.244 MB. [2026-03-05T18:11:20.683Z] ====== als (apache-spark) [default], iteration 9 completed (36510.209 ms) ====== [2026-03-05T18:11:20.683Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-03-05T18:11:20.683Z] GC before operation: completed in 561.062 ms, heap usage 587.416 MB -> 66.428 MB. [2026-03-05T18:12:05.755Z] ====== als (apache-spark) [default], iteration 10 completed (40032.719 ms) ====== [2026-03-05T18:12:05.755Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-03-05T18:12:05.755Z] GC before operation: completed in 496.544 ms, heap usage 696.285 MB -> 66.733 MB. [2026-03-05T18:12:37.452Z] ====== als (apache-spark) [default], iteration 11 completed (34353.272 ms) ====== [2026-03-05T18:12:37.452Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-03-05T18:12:37.452Z] GC before operation: completed in 262.167 ms, heap usage 690.570 MB -> 67.095 MB. [2026-03-05T18:13:30.685Z] ====== als (apache-spark) [default], iteration 12 completed (48373.018 ms) ====== [2026-03-05T18:13:30.685Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-03-05T18:13:30.685Z] GC before operation: completed in 406.317 ms, heap usage 128.720 MB -> 68.022 MB. [2026-03-05T18:14:08.080Z] ====== als (apache-spark) [default], iteration 13 completed (37377.497 ms) ====== [2026-03-05T18:14:08.080Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-03-05T18:14:08.080Z] GC before operation: completed in 414.495 ms, heap usage 706.605 MB -> 67.669 MB. [2026-03-05T18:14:52.406Z] ====== als (apache-spark) [default], iteration 14 completed (39727.526 ms) ====== [2026-03-05T18:14:52.406Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-03-05T18:14:52.406Z] GC before operation: completed in 342.969 ms, heap usage 510.860 MB -> 67.586 MB. [2026-03-05T18:15:25.406Z] ====== als (apache-spark) [default], iteration 15 completed (34041.033 ms) ====== [2026-03-05T18:15:25.406Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-03-05T18:15:25.406Z] GC before operation: completed in 383.920 ms, heap usage 435.033 MB -> 67.926 MB. [2026-03-05T18:16:03.701Z] ====== als (apache-spark) [default], iteration 16 completed (40505.694 ms) ====== [2026-03-05T18:16:03.701Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-03-05T18:16:03.701Z] GC before operation: completed in 338.811 ms, heap usage 555.306 MB -> 68.287 MB. [2026-03-05T18:16:48.116Z] ====== als (apache-spark) [default], iteration 17 completed (38451.533 ms) ====== [2026-03-05T18:16:48.116Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-03-05T18:16:48.116Z] GC before operation: completed in 361.959 ms, heap usage 398.447 MB -> 68.275 MB. [2026-03-05T18:17:26.326Z] ====== als (apache-spark) [default], iteration 18 completed (37965.151 ms) ====== [2026-03-05T18:17:26.326Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-03-05T18:17:26.326Z] GC before operation: completed in 246.597 ms, heap usage 417.481 MB -> 68.733 MB. [2026-03-05T18:18:04.005Z] ====== als (apache-spark) [default], iteration 19 completed (41261.584 ms) ====== [2026-03-05T18:18:04.005Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-03-05T18:18:04.005Z] GC before operation: completed in 263.330 ms, heap usage 562.260 MB -> 68.997 MB. [2026-03-05T18:18:48.358Z] ====== als (apache-spark) [default], iteration 20 completed (37943.944 ms) ====== [2026-03-05T18:18:48.358Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-03-05T18:18:48.358Z] GC before operation: completed in 910.403 ms, heap usage 251.496 MB -> 68.826 MB. [2026-03-05T18:19:19.914Z] ====== als (apache-spark) [default], iteration 21 completed (32129.680 ms) ====== [2026-03-05T18:19:19.914Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-03-05T18:19:19.914Z] GC before operation: completed in 453.875 ms, heap usage 803.780 MB -> 69.790 MB. [2026-03-05T18:19:57.869Z] ====== als (apache-spark) [default], iteration 22 completed (40497.781 ms) ====== [2026-03-05T18:19:57.869Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-03-05T18:19:59.197Z] GC before operation: completed in 989.292 ms, heap usage 193.996 MB -> 69.563 MB. [2026-03-05T18:20:36.067Z] ====== als (apache-spark) [default], iteration 23 completed (34631.274 ms) ====== [2026-03-05T18:20:36.067Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-03-05T18:20:36.067Z] GC before operation: completed in 319.901 ms, heap usage 1.077 GB -> 70.844 MB. [2026-03-05T18:21:13.346Z] ====== als (apache-spark) [default], iteration 24 completed (35745.200 ms) ====== [2026-03-05T18:21:13.346Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-03-05T18:21:13.346Z] GC before operation: completed in 174.468 ms, heap usage 832.896 MB -> 70.765 MB. [2026-03-05T18:21:50.516Z] ====== als (apache-spark) [default], iteration 25 completed (34245.584 ms) ====== [2026-03-05T18:21:50.516Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-03-05T18:21:50.516Z] GC before operation: completed in 295.207 ms, heap usage 569.759 MB -> 70.658 MB. [2026-03-05T18:22:27.976Z] ====== als (apache-spark) [default], iteration 26 completed (39296.763 ms) ====== [2026-03-05T18:22:27.976Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-03-05T18:22:27.976Z] GC before operation: completed in 1009.565 ms, heap usage 795.143 MB -> 71.273 MB. [2026-03-05T18:23:05.289Z] ====== als (apache-spark) [default], iteration 27 completed (32244.250 ms) ====== [2026-03-05T18:23:05.289Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-03-05T18:23:05.289Z] GC before operation: completed in 295.228 ms, heap usage 375.435 MB -> 70.894 MB. [2026-03-05T18:23:43.553Z] ====== als (apache-spark) [default], iteration 28 completed (40128.166 ms) ====== [2026-03-05T18:23:43.553Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-03-05T18:23:43.553Z] GC before operation: completed in 418.700 ms, heap usage 540.063 MB -> 71.400 MB. [2026-03-05T18:24:20.917Z] ====== als (apache-spark) [default], iteration 29 completed (33386.185 ms) ====== [2026-03-05T18:24:24.902Z] ----------------------------------- [2026-03-05T18:24:24.902Z] renaissance-als_0_PASSED [2026-03-05T18:24:24.902Z] ----------------------------------- [2026-03-05T18:24:24.902Z] [2026-03-05T18:24:24.902Z] TEST TEARDOWN: [2026-03-05T18:24:24.902Z] Nothing to be done for teardown. [2026-03-05T18:24:25.971Z] renaissance-als_0 Finish Time: Thu Mar 5 13:24:25 2026 Epoch Time (ms): 1772735065583