[2026-04-14T10:25:38.010Z] Running test renaissance-als_0 ... [2026-04-14T10:25:38.010Z] =============================================== [2026-04-14T10:25:38.010Z] renaissance-als_0 Start Time: Tue Apr 14 06:25:37 2026 Epoch Time (ms): 1776162337670 [2026-04-14T10:25:38.010Z] variation: NoOptions [2026-04-14T10:25:38.526Z] JVM_OPTIONS: [2026-04-14T10:25:38.526Z] { \ [2026-04-14T10:25:38.526Z] echo ""; echo "TEST SETUP:"; \ [2026-04-14T10:25:38.526Z] echo "Nothing to be done for setup."; \ [2026-04-14T10:25:38.526Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1776162334592/renaissance-als_0"; \ [2026-04-14T10:25:38.526Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1776162334592/renaissance-als_0"; \ [2026-04-14T10:25:38.526Z] echo ""; echo "TESTING:"; \ [2026-04-14T10:25:38.526Z] "/Users/admin/workspace/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1776162334592/renaissance-als_0"/als.json" als; \ [2026-04-14T10:25:38.526Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1776162334592/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-14T10:25:38.526Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-14T10:25:38.526Z] echo "Nothing to be done for teardown."; \ [2026-04-14T10:25:38.526Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1776162334592/TestTargetResult"; [2026-04-14T10:25:39.126Z] [2026-04-14T10:25:39.126Z] TEST SETUP: [2026-04-14T10:25:39.126Z] Nothing to be done for setup. [2026-04-14T10:25:39.126Z] [2026-04-14T10:25:39.126Z] TESTING: [2026-04-14T10:26:17.251Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-14T10:26:30.458Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-04-14T10:26:30.458Z] GC before operation: completed in 268.811 ms, heap usage 320.396 MB -> 34.023 MB. [2026-04-14T10:27:59.223Z] ====== als (apache-spark) [default], iteration 0 completed (83118.988 ms) ====== [2026-04-14T10:27:59.223Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-04-14T10:27:59.223Z] GC before operation: completed in 408.316 ms, heap usage 144.164 MB -> 61.624 MB. [2026-04-14T10:28:43.595Z] ====== als (apache-spark) [default], iteration 1 completed (46416.579 ms) ====== [2026-04-14T10:28:43.595Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-04-14T10:28:43.595Z] GC before operation: completed in 413.306 ms, heap usage 813.537 MB -> 62.331 MB. [2026-04-14T10:29:27.587Z] ====== als (apache-spark) [default], iteration 2 completed (38768.376 ms) ====== [2026-04-14T10:29:27.587Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-04-14T10:29:27.587Z] GC before operation: completed in 1003.433 ms, heap usage 456.126 MB -> 62.625 MB. [2026-04-14T10:30:05.646Z] ====== als (apache-spark) [default], iteration 3 completed (36801.908 ms) ====== [2026-04-14T10:30:05.646Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-04-14T10:30:05.646Z] GC before operation: completed in 658.382 ms, heap usage 971.406 MB -> 63.667 MB. [2026-04-14T10:30:43.497Z] ====== als (apache-spark) [default], iteration 4 completed (36041.280 ms) ====== [2026-04-14T10:30:43.497Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-04-14T10:30:43.497Z] GC before operation: completed in 329.015 ms, heap usage 223.100 MB -> 63.165 MB. [2026-04-14T10:31:22.711Z] ====== als (apache-spark) [default], iteration 5 completed (40700.722 ms) ====== [2026-04-14T10:31:22.711Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-04-14T10:31:22.711Z] GC before operation: completed in 411.826 ms, heap usage 729.466 MB -> 64.603 MB. [2026-04-14T10:31:53.838Z] ====== als (apache-spark) [default], iteration 6 completed (31044.594 ms) ====== [2026-04-14T10:31:53.838Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-04-14T10:31:55.164Z] GC before operation: completed in 1255.320 ms, heap usage 792.375 MB -> 65.113 MB. [2026-04-14T10:32:40.597Z] ====== als (apache-spark) [default], iteration 7 completed (42073.357 ms) ====== [2026-04-14T10:32:40.597Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-04-14T10:32:40.597Z] GC before operation: completed in 255.769 ms, heap usage 352.556 MB -> 64.984 MB. [2026-04-14T10:33:06.854Z] ====== als (apache-spark) [default], iteration 8 completed (28386.227 ms) ====== [2026-04-14T10:33:06.854Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-04-14T10:33:06.854Z] GC before operation: completed in 276.201 ms, heap usage 434.084 MB -> 65.965 MB. [2026-04-14T10:33:54.009Z] ====== als (apache-spark) [default], iteration 9 completed (44570.529 ms) ====== [2026-04-14T10:33:54.009Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-04-14T10:33:54.009Z] GC before operation: completed in 291.758 ms, heap usage 670.106 MB -> 66.120 MB. [2026-04-14T10:34:31.846Z] ====== als (apache-spark) [default], iteration 10 completed (35585.950 ms) ====== [2026-04-14T10:34:31.846Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-04-14T10:34:31.846Z] GC before operation: completed in 317.221 ms, heap usage 1.096 GB -> 67.010 MB. [2026-04-14T10:35:10.329Z] ====== als (apache-spark) [default], iteration 11 completed (35171.276 ms) ====== [2026-04-14T10:35:10.329Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-04-14T10:35:10.329Z] GC before operation: completed in 1534.173 ms, heap usage 790.567 MB -> 66.913 MB. [2026-04-14T10:35:41.741Z] ====== als (apache-spark) [default], iteration 12 completed (32070.224 ms) ====== [2026-04-14T10:35:41.741Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-04-14T10:35:41.741Z] GC before operation: completed in 284.204 ms, heap usage 150.687 MB -> 67.438 MB. [2026-04-14T10:36:19.558Z] ====== als (apache-spark) [default], iteration 13 completed (36088.225 ms) ====== [2026-04-14T10:36:19.558Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-04-14T10:36:19.558Z] GC before operation: completed in 259.024 ms, heap usage 643.565 MB -> 67.304 MB. [2026-04-14T10:36:45.399Z] ====== als (apache-spark) [default], iteration 14 completed (26218.211 ms) ====== [2026-04-14T10:36:45.399Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-04-14T10:36:46.024Z] GC before operation: completed in 775.510 ms, heap usage 453.102 MB -> 67.401 MB. [2026-04-14T10:37:39.608Z] ====== als (apache-spark) [default], iteration 15 completed (48345.212 ms) ====== [2026-04-14T10:37:39.608Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-04-14T10:37:39.608Z] GC before operation: completed in 337.840 ms, heap usage 405.082 MB -> 67.594 MB. [2026-04-14T10:38:11.163Z] ====== als (apache-spark) [default], iteration 16 completed (32666.861 ms) ====== [2026-04-14T10:38:11.163Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-04-14T10:38:11.163Z] GC before operation: completed in 832.788 ms, heap usage 980.683 MB -> 68.480 MB. [2026-04-14T10:38:48.039Z] ====== als (apache-spark) [default], iteration 17 completed (34561.273 ms) ====== [2026-04-14T10:38:48.039Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-04-14T10:38:48.039Z] GC before operation: completed in 331.256 ms, heap usage 307.357 MB -> 67.956 MB. [2026-04-14T10:39:25.923Z] ====== als (apache-spark) [default], iteration 18 completed (36575.068 ms) ====== [2026-04-14T10:39:25.923Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-04-14T10:39:25.923Z] GC before operation: completed in 320.936 ms, heap usage 525.486 MB -> 68.735 MB. [2026-04-14T10:39:57.561Z] ====== als (apache-spark) [default], iteration 19 completed (30483.867 ms) ====== [2026-04-14T10:39:57.561Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-04-14T10:39:57.561Z] GC before operation: completed in 337.252 ms, heap usage 919.178 MB -> 69.536 MB. [2026-04-14T10:40:34.946Z] ====== als (apache-spark) [default], iteration 20 completed (35658.512 ms) ====== [2026-04-14T10:40:34.946Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-04-14T10:40:34.946Z] GC before operation: completed in 776.582 ms, heap usage 355.399 MB -> 69.054 MB. [2026-04-14T10:41:01.934Z] ====== als (apache-spark) [default], iteration 21 completed (27259.132 ms) ====== [2026-04-14T10:41:01.934Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-04-14T10:41:01.934Z] GC before operation: completed in 247.757 ms, heap usage 585.197 MB -> 69.497 MB. [2026-04-14T10:41:34.221Z] ====== als (apache-spark) [default], iteration 22 completed (34016.780 ms) ====== [2026-04-14T10:41:34.221Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-04-14T10:41:34.221Z] GC before operation: completed in 257.176 ms, heap usage 201.130 MB -> 69.146 MB. [2026-04-14T10:42:18.195Z] ====== als (apache-spark) [default], iteration 23 completed (37874.902 ms) ====== [2026-04-14T10:42:18.195Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-04-14T10:42:18.195Z] GC before operation: completed in 354.033 ms, heap usage 945.448 MB -> 70.390 MB. [2026-04-14T10:42:56.774Z] ====== als (apache-spark) [default], iteration 24 completed (42250.701 ms) ====== [2026-04-14T10:42:56.774Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-04-14T10:42:56.774Z] GC before operation: completed in 501.986 ms, heap usage 177.409 MB -> 69.576 MB. [2026-04-14T10:43:33.952Z] ====== als (apache-spark) [default], iteration 25 completed (33912.660 ms) ====== [2026-04-14T10:43:33.952Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-04-14T10:43:33.952Z] GC before operation: completed in 283.786 ms, heap usage 1.183 GB -> 71.170 MB. [2026-04-14T10:44:05.342Z] ====== als (apache-spark) [default], iteration 26 completed (31977.419 ms) ====== [2026-04-14T10:44:05.342Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-04-14T10:44:05.342Z] GC before operation: completed in 288.967 ms, heap usage 1.548 GB -> 71.819 MB. [2026-04-14T10:44:37.530Z] ====== als (apache-spark) [default], iteration 27 completed (31534.977 ms) ====== [2026-04-14T10:44:37.530Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-04-14T10:44:37.530Z] GC before operation: completed in 602.406 ms, heap usage 153.275 MB -> 70.539 MB. [2026-04-14T10:45:09.267Z] ====== als (apache-spark) [default], iteration 28 completed (29806.782 ms) ====== [2026-04-14T10:45:09.267Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-04-14T10:45:09.267Z] GC before operation: completed in 1557.404 ms, heap usage 1.007 GB -> 71.815 MB. [2026-04-14T10:45:54.115Z] ====== als (apache-spark) [default], iteration 29 completed (37541.194 ms) ====== [2026-04-14T10:45:54.115Z] ----------------------------------- [2026-04-14T10:45:54.115Z] renaissance-als_0_PASSED [2026-04-14T10:45:54.115Z] ----------------------------------- [2026-04-14T10:45:54.115Z] [2026-04-14T10:45:54.115Z] TEST TEARDOWN: [2026-04-14T10:45:54.115Z] Nothing to be done for teardown. [2026-04-14T10:45:54.115Z] renaissance-als_0 Finish Time: Tue Apr 14 06:45:52 2026 Epoch Time (ms): 1776163552274