[2026-04-22T14:54:32.144Z] Running test renaissance-log-regression_0 ... [2026-04-22T14:54:32.144Z] =============================================== [2026-04-22T14:54:32.144Z] renaissance-log-regression_0 Start Time: Wed Apr 22 14:54:31 2026 Epoch Time (ms): 1776869671529 [2026-04-22T14:54:32.144Z] variation: NoOptions [2026-04-22T14:54:32.144Z] JVM_OPTIONS: [2026-04-22T14:54:32.144Z] { \ [2026-04-22T14:54:32.144Z] echo ""; echo "TEST SETUP:"; \ [2026-04-22T14:54:32.144Z] echo "Nothing to be done for setup."; \ [2026-04-22T14:54:32.144Z] mkdir -p "/Users/runner/agent/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17768687131744/renaissance-log-regression_0"; \ [2026-04-22T14:54:32.144Z] cd "/Users/runner/agent/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17768687131744/renaissance-log-regression_0"; \ [2026-04-22T14:54:32.144Z] echo ""; echo "TESTING:"; \ [2026-04-22T14:54:32.145Z] "/Users/runner/agent/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/runner/agent/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/runner/agent/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17768687131744/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-04-22T14:54:32.145Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/runner/agent/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/runner/agent/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17768687131744/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-22T14:54:32.145Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-22T14:54:32.145Z] echo "Nothing to be done for teardown."; \ [2026-04-22T14:54:32.145Z] } 2>&1 | tee -a "/Users/runner/agent/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17768687131744/TestTargetResult"; [2026-04-22T14:54:32.145Z] [2026-04-22T14:54:32.145Z] TEST SETUP: [2026-04-22T14:54:32.145Z] Nothing to be done for setup. [2026-04-22T14:54:32.145Z] [2026-04-22T14:54:32.145Z] TESTING: [2026-04-22T14:54:44.498Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-22T14:54:46.594Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-04-22T14:54:46.594Z] GC before operation: completed in 38.869 ms, heap usage 42.531 MB -> 34.803 MB. [2026-04-22T14:54:58.975Z] ====== log-regression (apache-spark) [default], iteration 0 completed (11270.085 ms) ====== [2026-04-22T14:54:58.975Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-04-22T14:54:58.975Z] GC before operation: completed in 79.781 ms, heap usage 251.292 MB -> 122.478 MB. [2026-04-22T14:55:01.071Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3008.159 ms) ====== [2026-04-22T14:55:01.071Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-04-22T14:55:01.071Z] GC before operation: completed in 64.144 ms, heap usage 425.466 MB -> 123.371 MB. [2026-04-22T14:55:03.172Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1854.413 ms) ====== [2026-04-22T14:55:03.172Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-04-22T14:55:03.172Z] GC before operation: completed in 75.288 ms, heap usage 363.165 MB -> 123.699 MB. [2026-04-22T14:55:05.284Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1838.560 ms) ====== [2026-04-22T14:55:05.284Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-04-22T14:55:05.284Z] GC before operation: completed in 73.914 ms, heap usage 529.355 MB -> 124.479 MB. [2026-04-22T14:55:06.619Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1658.930 ms) ====== [2026-04-22T14:55:06.619Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-04-22T14:55:06.619Z] GC before operation: completed in 70.249 ms, heap usage 350.602 MB -> 124.225 MB. [2026-04-22T14:55:07.959Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1456.439 ms) ====== [2026-04-22T14:55:07.959Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-04-22T14:55:07.959Z] GC before operation: completed in 66.328 ms, heap usage 306.118 MB -> 124.332 MB. [2026-04-22T14:55:10.170Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1674.869 ms) ====== [2026-04-22T14:55:10.170Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-04-22T14:55:10.170Z] GC before operation: completed in 83.711 ms, heap usage 485.384 MB -> 125.070 MB. [2026-04-22T14:55:13.094Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3122.637 ms) ====== [2026-04-22T14:55:13.094Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-04-22T14:55:13.094Z] GC before operation: completed in 96.872 ms, heap usage 305.857 MB -> 125.901 MB. [2026-04-22T14:55:15.177Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2235.717 ms) ====== [2026-04-22T14:55:15.177Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-04-22T14:55:15.906Z] GC before operation: completed in 100.499 ms, heap usage 486.811 MB -> 125.633 MB. [2026-04-22T14:55:17.238Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1648.699 ms) ====== [2026-04-22T14:55:17.238Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-04-22T14:55:17.238Z] GC before operation: completed in 85.999 ms, heap usage 291.953 MB -> 125.182 MB. [2026-04-22T14:55:18.582Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1575.076 ms) ====== [2026-04-22T14:55:18.582Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-04-22T14:55:19.259Z] GC before operation: completed in 95.633 ms, heap usage 399.004 MB -> 125.731 MB. [2026-04-22T14:55:20.603Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1592.185 ms) ====== [2026-04-22T14:55:20.603Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-04-22T14:55:20.603Z] GC before operation: completed in 94.582 ms, heap usage 484.722 MB -> 126.190 MB. [2026-04-22T14:55:21.949Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1550.919 ms) ====== [2026-04-22T14:55:21.949Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-04-22T14:55:22.588Z] GC before operation: completed in 86.291 ms, heap usage 509.178 MB -> 126.405 MB. [2026-04-22T14:55:23.933Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1518.339 ms) ====== [2026-04-22T14:55:23.933Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-04-22T14:55:23.933Z] GC before operation: completed in 99.394 ms, heap usage 243.716 MB -> 125.869 MB. [2026-04-22T14:55:26.032Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1833.056 ms) ====== [2026-04-22T14:55:26.032Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-04-22T14:55:26.032Z] GC before operation: completed in 91.395 ms, heap usage 262.981 MB -> 126.154 MB. [2026-04-22T14:55:28.184Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1998.461 ms) ====== [2026-04-22T14:55:28.184Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-04-22T14:55:28.184Z] GC before operation: completed in 90.537 ms, heap usage 305.637 MB -> 126.533 MB. [2026-04-22T14:55:29.571Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1719.009 ms) ====== [2026-04-22T14:55:29.571Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-04-22T14:55:29.571Z] GC before operation: completed in 95.371 ms, heap usage 263.363 MB -> 126.731 MB. [2026-04-22T14:55:30.964Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1313.679 ms) ====== [2026-04-22T14:55:30.964Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-04-22T14:55:30.964Z] GC before operation: completed in 91.759 ms, heap usage 261.907 MB -> 126.796 MB. [2026-04-22T14:55:32.324Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1327.882 ms) ====== [2026-04-22T14:55:32.324Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-04-22T14:55:32.324Z] GC before operation: completed in 95.988 ms, heap usage 451.506 MB -> 127.486 MB. [2026-04-22T14:55:34.457Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1500.206 ms) ====== [2026-04-22T14:55:34.457Z] ----------------------------------- [2026-04-22T14:55:34.457Z] renaissance-log-regression_0_PASSED [2026-04-22T14:55:34.457Z] ----------------------------------- [2026-04-22T14:55:34.457Z] [2026-04-22T14:55:34.457Z] TEST TEARDOWN: [2026-04-22T14:55:34.457Z] Nothing to be done for teardown. [2026-04-22T14:55:34.457Z] renaissance-log-regression_0 Finish Time: Wed Apr 22 14:55:33 2026 Epoch Time (ms): 1776869733911