[2026-02-11T22:58:13.864Z] Running test renaissance-als_0 ... [2026-02-11T22:58:13.864Z] =============================================== [2026-02-11T22:58:14.450Z] renaissance-als_0 Start Time: Wed Feb 11 17:58:13 2026 Epoch Time (ms): 1770850693880 [2026-02-11T22:58:14.450Z] variation: NoOptions [2026-02-11T22:58:14.450Z] JVM_OPTIONS: [2026-02-11T22:58:14.450Z] { \ [2026-02-11T22:58:14.450Z] echo ""; echo "TEST SETUP:"; \ [2026-02-11T22:58:14.450Z] echo "Nothing to be done for setup."; \ [2026-02-11T22:58:14.450Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17708506878587/renaissance-als_0"; \ [2026-02-11T22:58:14.450Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17708506878587/renaissance-als_0"; \ [2026-02-11T22:58:14.450Z] echo ""; echo "TESTING:"; \ [2026-02-11T22:58:14.450Z] "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/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_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17708506878587/renaissance-als_0"/als.json" als; \ [2026-02-11T22:58:14.450Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17708506878587/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-11T22:58:14.450Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-11T22:58:14.450Z] echo "Nothing to be done for teardown."; \ [2026-02-11T22:58:14.450Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17708506878587/TestTargetResult"; [2026-02-11T22:58:14.450Z] [2026-02-11T22:58:14.450Z] TEST SETUP: [2026-02-11T22:58:14.450Z] Nothing to be done for setup. [2026-02-11T22:58:14.450Z] [2026-02-11T22:58:14.450Z] TESTING: [2026-02-11T22:58:46.488Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-11T22:59:05.822Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-11T22:59:05.822Z] GC before operation: completed in 217.898 ms, heap usage 332.057 MB -> 34.695 MB. [2026-02-11T23:00:21.055Z] ====== als (apache-spark) [default], iteration 0 completed (67144.999 ms) ====== [2026-02-11T23:00:21.055Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-11T23:00:21.055Z] GC before operation: completed in 486.680 ms, heap usage 135.518 MB -> 61.951 MB. [2026-02-11T23:01:00.226Z] ====== als (apache-spark) [default], iteration 1 completed (40513.840 ms) ====== [2026-02-11T23:01:00.226Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-11T23:01:00.226Z] GC before operation: completed in 167.382 ms, heap usage 145.052 MB -> 62.048 MB. [2026-02-11T23:01:38.154Z] ====== als (apache-spark) [default], iteration 2 completed (34724.166 ms) ====== [2026-02-11T23:01:38.154Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-11T23:01:38.154Z] GC before operation: completed in 255.849 ms, heap usage 150.112 MB -> 62.696 MB. [2026-02-11T23:02:16.196Z] ====== als (apache-spark) [default], iteration 3 completed (37513.329 ms) ====== [2026-02-11T23:02:16.196Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-11T23:02:16.196Z] GC before operation: completed in 368.721 ms, heap usage 253.459 MB -> 63.466 MB. [2026-02-11T23:02:54.668Z] ====== als (apache-spark) [default], iteration 4 completed (38520.048 ms) ====== [2026-02-11T23:02:54.668Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-11T23:02:54.668Z] GC before operation: completed in 505.227 ms, heap usage 1.433 GB -> 65.634 MB. [2026-02-11T23:03:49.735Z] ====== als (apache-spark) [default], iteration 5 completed (54354.833 ms) ====== [2026-02-11T23:03:49.735Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-11T23:03:49.735Z] GC before operation: completed in 716.864 ms, heap usage 476.546 MB -> 65.131 MB. [2026-02-11T23:04:44.147Z] ====== als (apache-spark) [default], iteration 6 completed (47979.408 ms) ====== [2026-02-11T23:04:44.147Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-11T23:04:44.147Z] GC before operation: completed in 650.511 ms, heap usage 460.719 MB -> 65.599 MB. [2026-02-11T23:05:38.681Z] ====== als (apache-spark) [default], iteration 7 completed (56738.964 ms) ====== [2026-02-11T23:05:38.681Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-11T23:05:38.681Z] GC before operation: completed in 1799.727 ms, heap usage 590.525 MB -> 66.243 MB. [2026-02-11T23:06:34.593Z] ====== als (apache-spark) [default], iteration 8 completed (47859.368 ms) ====== [2026-02-11T23:06:34.593Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-11T23:06:34.593Z] GC before operation: completed in 408.388 ms, heap usage 483.097 MB -> 66.670 MB. [2026-02-11T23:07:01.689Z] ====== als (apache-spark) [default], iteration 9 completed (31761.611 ms) ====== [2026-02-11T23:07:01.689Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-11T23:07:01.689Z] GC before operation: completed in 677.436 ms, heap usage 366.392 MB -> 66.559 MB. [2026-02-11T23:07:40.599Z] ====== als (apache-spark) [default], iteration 10 completed (35825.796 ms) ====== [2026-02-11T23:07:40.599Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-11T23:07:40.599Z] GC before operation: completed in 428.892 ms, heap usage 153.316 MB -> 66.731 MB. [2026-02-11T23:08:18.953Z] ====== als (apache-spark) [default], iteration 11 completed (37521.647 ms) ====== [2026-02-11T23:08:18.953Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-11T23:08:18.953Z] GC before operation: completed in 289.427 ms, heap usage 446.609 MB -> 67.255 MB. [2026-02-11T23:09:15.675Z] ====== als (apache-spark) [default], iteration 12 completed (54012.926 ms) ====== [2026-02-11T23:09:15.675Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-11T23:09:15.675Z] GC before operation: completed in 1173.202 ms, heap usage 290.819 MB -> 67.340 MB. [2026-02-11T23:10:10.782Z] ====== als (apache-spark) [default], iteration 13 completed (50240.357 ms) ====== [2026-02-11T23:10:10.782Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-11T23:10:10.782Z] GC before operation: completed in 486.363 ms, heap usage 189.346 MB -> 67.989 MB. [2026-02-11T23:10:56.219Z] ====== als (apache-spark) [default], iteration 14 completed (44003.591 ms) ====== [2026-02-11T23:10:56.219Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-11T23:10:56.219Z] GC before operation: completed in 951.571 ms, heap usage 241.844 MB -> 68.019 MB. [2026-02-11T23:11:42.405Z] ====== als (apache-spark) [default], iteration 15 completed (49812.662 ms) ====== [2026-02-11T23:11:42.405Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-11T23:11:43.101Z] GC before operation: completed in 494.155 ms, heap usage 213.673 MB -> 67.898 MB. [2026-02-11T23:12:48.054Z] ====== als (apache-spark) [default], iteration 16 completed (54355.312 ms) ====== [2026-02-11T23:12:48.054Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-11T23:12:48.054Z] GC before operation: completed in 778.154 ms, heap usage 877.181 MB -> 69.191 MB. [2026-02-11T23:13:27.234Z] ====== als (apache-spark) [default], iteration 17 completed (46407.922 ms) ====== [2026-02-11T23:13:27.234Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-11T23:13:27.786Z] GC before operation: completed in 199.279 ms, heap usage 374.951 MB -> 68.650 MB. [2026-02-11T23:14:13.843Z] ====== als (apache-spark) [default], iteration 18 completed (38927.693 ms) ====== [2026-02-11T23:14:13.843Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-11T23:14:13.843Z] GC before operation: completed in 272.917 ms, heap usage 244.855 MB -> 68.968 MB. [2026-02-11T23:14:40.479Z] ====== als (apache-spark) [default], iteration 19 completed (31648.200 ms) ====== [2026-02-11T23:14:40.479Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-11T23:14:41.892Z] GC before operation: completed in 293.801 ms, heap usage 749.111 MB -> 69.818 MB. [2026-02-11T23:15:18.738Z] ====== als (apache-spark) [default], iteration 20 completed (36394.114 ms) ====== [2026-02-11T23:15:18.738Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-11T23:15:18.738Z] GC before operation: completed in 247.856 ms, heap usage 287.162 MB -> 69.509 MB. [2026-02-11T23:15:56.059Z] ====== als (apache-spark) [default], iteration 21 completed (32904.057 ms) ====== [2026-02-11T23:15:56.060Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-11T23:15:56.060Z] GC before operation: completed in 330.512 ms, heap usage 458.680 MB -> 70.417 MB. [2026-02-11T23:16:28.545Z] ====== als (apache-spark) [default], iteration 22 completed (34068.865 ms) ====== [2026-02-11T23:16:28.545Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-11T23:16:28.545Z] GC before operation: completed in 955.731 ms, heap usage 465.070 MB -> 70.119 MB. [2026-02-11T23:17:12.398Z] ====== als (apache-spark) [default], iteration 23 completed (38226.630 ms) ====== [2026-02-11T23:17:12.398Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-11T23:17:12.398Z] GC before operation: completed in 239.413 ms, heap usage 285.105 MB -> 70.460 MB. [2026-02-11T23:17:50.253Z] ====== als (apache-spark) [default], iteration 24 completed (36095.662 ms) ====== [2026-02-11T23:17:50.253Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-11T23:17:50.253Z] GC before operation: completed in 323.148 ms, heap usage 1.072 GB -> 71.736 MB. [2026-02-11T23:18:21.612Z] ====== als (apache-spark) [default], iteration 25 completed (34812.592 ms) ====== [2026-02-11T23:18:21.612Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-11T23:18:22.079Z] GC before operation: completed in 399.491 ms, heap usage 245.381 MB -> 70.699 MB. [2026-02-11T23:18:59.755Z] ====== als (apache-spark) [default], iteration 26 completed (31943.785 ms) ====== [2026-02-11T23:18:59.755Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-11T23:18:59.755Z] GC before operation: completed in 333.135 ms, heap usage 1.168 GB -> 72.263 MB. [2026-02-11T23:19:27.002Z] ====== als (apache-spark) [default], iteration 27 completed (29961.317 ms) ====== [2026-02-11T23:19:27.002Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-11T23:19:27.002Z] GC before operation: completed in 708.129 ms, heap usage 713.814 MB -> 71.456 MB. [2026-02-11T23:20:05.150Z] ====== als (apache-spark) [default], iteration 28 completed (35621.226 ms) ====== [2026-02-11T23:20:05.150Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-11T23:20:05.150Z] GC before operation: completed in 344.832 ms, heap usage 280.091 MB -> 71.274 MB. [2026-02-11T23:20:42.418Z] ====== als (apache-spark) [default], iteration 29 completed (34655.840 ms) ====== [2026-02-11T23:20:42.418Z] ----------------------------------- [2026-02-11T23:20:42.418Z] renaissance-als_0_PASSED [2026-02-11T23:20:42.418Z] ----------------------------------- [2026-02-11T23:20:42.959Z] [2026-02-11T23:20:42.959Z] TEST TEARDOWN: [2026-02-11T23:20:42.959Z] Nothing to be done for teardown. [2026-02-11T23:20:43.433Z] renaissance-als_0 Finish Time: Wed Feb 11 18:20:42 2026 Epoch Time (ms): 1770852042981