[2026-01-10T13:43:04.504Z] Running test renaissance-log-regression_0 ... [2026-01-10T13:43:04.504Z] =============================================== [2026-01-10T13:43:04.504Z] renaissance-log-regression_0 Start Time: Sat Jan 10 08:43:04 2026 Epoch Time (ms): 1768052584103 [2026-01-10T13:43:04.504Z] variation: NoOptions [2026-01-10T13:43:04.504Z] JVM_OPTIONS: [2026-01-10T13:43:04.504Z] { \ [2026-01-10T13:43:04.504Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T13:43:04.504Z] echo "Nothing to be done for setup."; \ [2026-01-10T13:43:04.504Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_1768050119684/renaissance-log-regression_0"; \ [2026-01-10T13:43:04.504Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_1768050119684/renaissance-log-regression_0"; \ [2026-01-10T13:43:04.504Z] echo ""; echo "TESTING:"; \ [2026-01-10T13:43:04.504Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/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_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_1768050119684/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-01-10T13:43:04.504Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_1768050119684/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T13:43:04.504Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T13:43:04.504Z] echo "Nothing to be done for teardown."; \ [2026-01-10T13:43:04.504Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_1768050119684/TestTargetResult"; [2026-01-10T13:43:04.504Z] [2026-01-10T13:43:04.504Z] TEST SETUP: [2026-01-10T13:43:04.504Z] Nothing to be done for setup. [2026-01-10T13:43:04.504Z] [2026-01-10T13:43:04.504Z] TESTING: [2026-01-10T13:43:26.647Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T13:43:41.776Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-10T13:43:41.776Z] GC before operation: completed in 96.184 ms, heap usage 64.582 MB -> 34.038 MB. [2026-01-10T13:44:25.934Z] ====== log-regression (apache-spark) [default], iteration 0 completed (41104.957 ms) ====== [2026-01-10T13:44:25.934Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-10T13:44:25.934Z] GC before operation: completed in 320.314 ms, heap usage 461.240 MB -> 121.962 MB. [2026-01-10T13:44:32.225Z] ====== log-regression (apache-spark) [default], iteration 1 completed (10229.340 ms) ====== [2026-01-10T13:44:32.225Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-10T13:44:32.877Z] GC before operation: completed in 463.917 ms, heap usage 386.259 MB -> 122.379 MB. [2026-01-10T13:44:44.524Z] ====== log-regression (apache-spark) [default], iteration 2 completed (10199.331 ms) ====== [2026-01-10T13:44:44.524Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-10T13:44:44.524Z] GC before operation: completed in 230.537 ms, heap usage 300.712 MB -> 122.615 MB. [2026-01-10T13:44:50.909Z] ====== log-regression (apache-spark) [default], iteration 3 completed (7041.019 ms) ====== [2026-01-10T13:44:50.909Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-10T13:44:50.909Z] GC before operation: completed in 202.815 ms, heap usage 415.531 MB -> 123.294 MB. [2026-01-10T13:44:57.216Z] ====== log-regression (apache-spark) [default], iteration 4 completed (6226.361 ms) ====== [2026-01-10T13:44:57.216Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-10T13:44:57.216Z] GC before operation: completed in 311.117 ms, heap usage 344.619 MB -> 123.351 MB. [2026-01-10T13:45:03.831Z] ====== log-regression (apache-spark) [default], iteration 5 completed (6412.283 ms) ====== [2026-01-10T13:45:03.831Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-10T13:45:03.831Z] GC before operation: completed in 145.064 ms, heap usage 553.516 MB -> 124.050 MB. [2026-01-10T13:45:10.123Z] ====== log-regression (apache-spark) [default], iteration 6 completed (5705.671 ms) ====== [2026-01-10T13:45:10.123Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-10T13:45:10.123Z] GC before operation: completed in 295.820 ms, heap usage 422.472 MB -> 123.931 MB. [2026-01-10T13:45:16.515Z] ====== log-regression (apache-spark) [default], iteration 7 completed (6273.820 ms) ====== [2026-01-10T13:45:16.516Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-10T13:45:16.516Z] GC before operation: completed in 295.235 ms, heap usage 387.876 MB -> 123.978 MB. [2026-01-10T13:45:24.369Z] ====== log-regression (apache-spark) [default], iteration 8 completed (7146.487 ms) ====== [2026-01-10T13:45:24.369Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-10T13:45:24.369Z] GC before operation: completed in 379.333 ms, heap usage 1.000 GB -> 125.451 MB. [2026-01-10T13:45:30.634Z] ====== log-regression (apache-spark) [default], iteration 9 completed (6453.098 ms) ====== [2026-01-10T13:45:30.635Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-10T13:45:30.635Z] GC before operation: completed in 260.800 ms, heap usage 357.551 MB -> 124.346 MB. [2026-01-10T13:45:36.696Z] ====== log-regression (apache-spark) [default], iteration 10 completed (5779.292 ms) ====== [2026-01-10T13:45:36.696Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-10T13:45:36.696Z] GC before operation: completed in 714.706 ms, heap usage 229.887 MB -> 124.230 MB. [2026-01-10T13:45:44.641Z] ====== log-regression (apache-spark) [default], iteration 11 completed (7010.476 ms) ====== [2026-01-10T13:45:44.641Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-10T13:45:44.641Z] GC before operation: completed in 288.530 ms, heap usage 882.853 MB -> 126.071 MB. [2026-01-10T13:45:50.021Z] ====== log-regression (apache-spark) [default], iteration 12 completed (5884.457 ms) ====== [2026-01-10T13:45:50.021Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-10T13:45:50.578Z] GC before operation: completed in 307.249 ms, heap usage 255.848 MB -> 124.727 MB. [2026-01-10T13:45:56.906Z] ====== log-regression (apache-spark) [default], iteration 13 completed (6344.290 ms) ====== [2026-01-10T13:45:56.906Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-10T13:45:56.906Z] GC before operation: completed in 207.925 ms, heap usage 433.777 MB -> 125.407 MB. [2026-01-10T13:46:01.782Z] ====== log-regression (apache-spark) [default], iteration 14 completed (4587.908 ms) ====== [2026-01-10T13:46:01.783Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-10T13:46:01.783Z] GC before operation: completed in 135.570 ms, heap usage 738.051 MB -> 126.505 MB. [2026-01-10T13:46:06.908Z] ====== log-regression (apache-spark) [default], iteration 15 completed (5317.497 ms) ====== [2026-01-10T13:46:06.908Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-10T13:46:07.523Z] GC before operation: completed in 566.463 ms, heap usage 443.165 MB -> 125.840 MB. [2026-01-10T13:46:13.928Z] ====== log-regression (apache-spark) [default], iteration 16 completed (5454.533 ms) ====== [2026-01-10T13:46:13.928Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-10T13:46:13.928Z] GC before operation: completed in 249.119 ms, heap usage 767.082 MB -> 127.162 MB. [2026-01-10T13:46:20.535Z] ====== log-regression (apache-spark) [default], iteration 17 completed (6381.630 ms) ====== [2026-01-10T13:46:20.535Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-10T13:46:20.535Z] GC before operation: completed in 225.519 ms, heap usage 414.768 MB -> 126.167 MB. [2026-01-10T13:46:25.470Z] ====== log-regression (apache-spark) [default], iteration 18 completed (5672.112 ms) ====== [2026-01-10T13:46:25.470Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-10T13:46:25.918Z] GC before operation: completed in 362.232 ms, heap usage 655.251 MB -> 127.129 MB. [2026-01-10T13:46:32.117Z] ====== log-regression (apache-spark) [default], iteration 19 completed (5749.464 ms) ====== [2026-01-10T13:46:33.701Z] ----------------------------------- [2026-01-10T13:46:33.701Z] renaissance-log-regression_0_PASSED [2026-01-10T13:46:33.701Z] ----------------------------------- [2026-01-10T13:46:33.701Z] [2026-01-10T13:46:33.701Z] TEST TEARDOWN: [2026-01-10T13:46:33.701Z] Nothing to be done for teardown. [2026-01-10T13:46:33.701Z] renaissance-log-regression_0 Finish Time: Sat Jan 10 08:46:33 2026 Epoch Time (ms): 1768052793620