[2026-02-26T04:28:44.236Z] Running test renaissance-als_0 ... [2026-02-26T04:28:44.236Z] =============================================== [2026-02-26T04:28:44.236Z] renaissance-als_0 Start Time: Wed Feb 25 23:28:43 2026 Epoch Time (ms): 1772080123851 [2026-02-26T04:28:44.236Z] variation: NoOptions [2026-02-26T04:28:44.236Z] JVM_OPTIONS: [2026-02-26T04:28:44.236Z] { \ [2026-02-26T04:28:44.236Z] echo ""; echo "TEST SETUP:"; \ [2026-02-26T04:28:44.236Z] echo "Nothing to be done for setup."; \ [2026-02-26T04:28:44.236Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17720801213662/renaissance-als_0"; \ [2026-02-26T04:28:44.236Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17720801213662/renaissance-als_0"; \ [2026-02-26T04:28:44.236Z] echo ""; echo "TESTING:"; \ [2026-02-26T04:28:44.236Z] "/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_17720801213662/renaissance-als_0"/als.json" als; \ [2026-02-26T04:28:44.236Z] 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_17720801213662/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-26T04:28:44.236Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-26T04:28:44.236Z] echo "Nothing to be done for teardown."; \ [2026-02-26T04:28:44.236Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17720801213662/TestTargetResult"; [2026-02-26T04:28:44.642Z] [2026-02-26T04:28:44.642Z] TEST SETUP: [2026-02-26T04:28:44.642Z] Nothing to be done for setup. [2026-02-26T04:28:44.642Z] [2026-02-26T04:28:44.642Z] TESTING: [2026-02-26T04:29:05.860Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-26T04:29:25.623Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-26T04:29:25.623Z] GC before operation: completed in 356.253 ms, heap usage 237.902 MB -> 34.085 MB. [2026-02-26T04:30:54.340Z] ====== als (apache-spark) [default], iteration 0 completed (76548.140 ms) ====== [2026-02-26T04:30:54.341Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-26T04:30:54.341Z] GC before operation: completed in 309.620 ms, heap usage 735.739 MB -> 61.146 MB. [2026-02-26T04:31:31.820Z] ====== als (apache-spark) [default], iteration 1 completed (42635.773 ms) ====== [2026-02-26T04:31:31.820Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-26T04:31:31.820Z] GC before operation: completed in 613.509 ms, heap usage 356.728 MB -> 61.796 MB. [2026-02-26T04:32:09.953Z] ====== als (apache-spark) [default], iteration 2 completed (37568.408 ms) ====== [2026-02-26T04:32:09.953Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-26T04:32:09.953Z] GC before operation: completed in 269.963 ms, heap usage 241.047 MB -> 61.925 MB. [2026-02-26T04:32:41.610Z] ====== als (apache-spark) [default], iteration 3 completed (32654.524 ms) ====== [2026-02-26T04:32:41.611Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-26T04:32:41.611Z] GC before operation: completed in 201.028 ms, heap usage 278.094 MB -> 62.606 MB. [2026-02-26T04:33:18.730Z] ====== als (apache-spark) [default], iteration 4 completed (35315.240 ms) ====== [2026-02-26T04:33:18.730Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-26T04:33:18.730Z] GC before operation: completed in 566.340 ms, heap usage 995.217 MB -> 64.189 MB. [2026-02-26T04:33:55.634Z] ====== als (apache-spark) [default], iteration 5 completed (32628.647 ms) ====== [2026-02-26T04:33:55.635Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-26T04:33:55.635Z] GC before operation: completed in 324.583 ms, heap usage 431.705 MB -> 64.134 MB. [2026-02-26T04:34:28.847Z] ====== als (apache-spark) [default], iteration 6 completed (30654.583 ms) ====== [2026-02-26T04:34:28.848Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-26T04:34:28.848Z] GC before operation: completed in 384.833 ms, heap usage 721.421 MB -> 64.851 MB. [2026-02-26T04:35:00.007Z] ====== als (apache-spark) [default], iteration 7 completed (32794.135 ms) ====== [2026-02-26T04:35:00.007Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-26T04:35:00.007Z] GC before operation: completed in 258.767 ms, heap usage 206.235 MB -> 64.665 MB. [2026-02-26T04:35:30.757Z] ====== als (apache-spark) [default], iteration 8 completed (30676.636 ms) ====== [2026-02-26T04:35:30.757Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-26T04:35:30.757Z] GC before operation: completed in 1056.854 ms, heap usage 943.117 MB -> 66.287 MB. [2026-02-26T04:36:07.782Z] ====== als (apache-spark) [default], iteration 9 completed (31577.193 ms) ====== [2026-02-26T04:36:07.782Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-26T04:36:07.782Z] GC before operation: completed in 208.953 ms, heap usage 182.852 MB -> 65.710 MB. [2026-02-26T04:36:39.038Z] ====== als (apache-spark) [default], iteration 10 completed (33251.847 ms) ====== [2026-02-26T04:36:39.038Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-26T04:36:39.038Z] GC before operation: completed in 744.336 ms, heap usage 572.801 MB -> 66.332 MB. [2026-02-26T04:37:09.537Z] ====== als (apache-spark) [default], iteration 11 completed (28699.212 ms) ====== [2026-02-26T04:37:09.537Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-26T04:37:09.537Z] GC before operation: completed in 270.344 ms, heap usage 142.854 MB -> 67.238 MB. [2026-02-26T04:37:43.104Z] ====== als (apache-spark) [default], iteration 12 completed (31903.503 ms) ====== [2026-02-26T04:37:43.104Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-26T04:37:43.104Z] GC before operation: completed in 416.402 ms, heap usage 739.695 MB -> 67.020 MB. [2026-02-26T04:38:14.366Z] ====== als (apache-spark) [default], iteration 13 completed (30655.733 ms) ====== [2026-02-26T04:38:14.366Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-26T04:38:14.366Z] GC before operation: completed in 325.111 ms, heap usage 1.307 GB -> 67.908 MB. [2026-02-26T04:38:47.454Z] ====== als (apache-spark) [default], iteration 14 completed (30022.737 ms) ====== [2026-02-26T04:38:47.454Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-26T04:38:47.454Z] GC before operation: completed in 295.988 ms, heap usage 894.902 MB -> 67.720 MB. [2026-02-26T04:39:13.745Z] ====== als (apache-spark) [default], iteration 15 completed (26840.126 ms) ====== [2026-02-26T04:39:13.745Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-26T04:39:13.745Z] GC before operation: completed in 298.145 ms, heap usage 485.767 MB -> 67.627 MB. [2026-02-26T04:39:58.602Z] ====== als (apache-spark) [default], iteration 16 completed (34820.679 ms) ====== [2026-02-26T04:39:58.602Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-26T04:39:58.602Z] GC before operation: completed in 424.383 ms, heap usage 1.096 GB -> 68.649 MB. [2026-02-26T04:40:18.146Z] ====== als (apache-spark) [default], iteration 17 completed (31217.866 ms) ====== [2026-02-26T04:40:18.146Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-26T04:40:18.146Z] GC before operation: completed in 265.395 ms, heap usage 389.821 MB -> 67.787 MB. [2026-02-26T04:40:54.736Z] ====== als (apache-spark) [default], iteration 18 completed (32792.711 ms) ====== [2026-02-26T04:40:54.736Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-26T04:40:54.736Z] GC before operation: completed in 345.217 ms, heap usage 660.238 MB -> 68.656 MB. [2026-02-26T04:41:25.761Z] ====== als (apache-spark) [default], iteration 19 completed (31604.780 ms) ====== [2026-02-26T04:41:25.761Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-26T04:41:25.761Z] GC before operation: completed in 269.416 ms, heap usage 637.317 MB -> 68.939 MB. [2026-02-26T04:41:57.051Z] ====== als (apache-spark) [default], iteration 20 completed (30953.119 ms) ====== [2026-02-26T04:41:57.051Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-26T04:41:57.051Z] GC before operation: completed in 276.444 ms, heap usage 161.762 MB -> 68.713 MB. [2026-02-26T04:42:29.401Z] ====== als (apache-spark) [default], iteration 21 completed (29453.719 ms) ====== [2026-02-26T04:42:29.401Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-26T04:42:29.401Z] GC before operation: completed in 190.884 ms, heap usage 238.408 MB -> 68.935 MB. [2026-02-26T04:43:00.873Z] ====== als (apache-spark) [default], iteration 22 completed (34830.808 ms) ====== [2026-02-26T04:43:00.873Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-26T04:43:01.465Z] GC before operation: completed in 260.749 ms, heap usage 372.394 MB -> 69.205 MB. [2026-02-26T04:43:32.877Z] ====== als (apache-spark) [default], iteration 23 completed (29774.591 ms) ====== [2026-02-26T04:43:32.877Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-26T04:43:32.877Z] GC before operation: completed in 241.194 ms, heap usage 856.983 MB -> 70.220 MB. [2026-02-26T04:44:04.494Z] ====== als (apache-spark) [default], iteration 24 completed (27586.075 ms) ====== [2026-02-26T04:44:04.494Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-26T04:44:04.494Z] GC before operation: completed in 529.512 ms, heap usage 186.448 MB -> 69.694 MB. [2026-02-26T04:44:35.207Z] ====== als (apache-spark) [default], iteration 25 completed (30729.543 ms) ====== [2026-02-26T04:44:35.207Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-26T04:44:35.207Z] GC before operation: completed in 233.725 ms, heap usage 1.015 GB -> 71.078 MB. [2026-02-26T04:45:05.751Z] ====== als (apache-spark) [default], iteration 26 completed (30634.452 ms) ====== [2026-02-26T04:45:05.751Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-26T04:45:05.751Z] GC before operation: completed in 151.575 ms, heap usage 355.463 MB -> 70.344 MB. [2026-02-26T04:45:36.290Z] ====== als (apache-spark) [default], iteration 27 completed (27441.598 ms) ====== [2026-02-26T04:45:36.290Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-26T04:45:36.290Z] GC before operation: completed in 325.194 ms, heap usage 640.091 MB -> 71.152 MB. [2026-02-26T04:46:02.101Z] ====== als (apache-spark) [default], iteration 28 completed (28510.859 ms) ====== [2026-02-26T04:46:02.101Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-26T04:46:02.571Z] GC before operation: completed in 348.341 ms, heap usage 582.563 MB -> 71.288 MB. [2026-02-26T04:46:33.670Z] ====== als (apache-spark) [default], iteration 29 completed (27947.397 ms) ====== [2026-02-26T04:46:33.670Z] ----------------------------------- [2026-02-26T04:46:33.670Z] renaissance-als_0_PASSED [2026-02-26T04:46:33.670Z] ----------------------------------- [2026-02-26T04:46:33.670Z] [2026-02-26T04:46:33.670Z] TEST TEARDOWN: [2026-02-26T04:46:33.670Z] Nothing to be done for teardown. [2026-02-26T04:46:33.670Z] renaissance-als_0 Finish Time: Wed Feb 25 23:46:33 2026 Epoch Time (ms): 1772081193309