[2026-01-20T22:34:28.055Z] Running test renaissance-log-regression_0 ... [2026-01-20T22:34:28.055Z] =============================================== [2026-01-20T22:34:28.055Z] renaissance-log-regression_0 Start Time: Tue Jan 20 17:34:27 2026 Epoch Time (ms): 1768948467744 [2026-01-20T22:34:28.055Z] variation: NoOptions [2026-01-20T22:34:28.055Z] JVM_OPTIONS: [2026-01-20T22:34:28.055Z] { \ [2026-01-20T22:34:28.055Z] echo ""; echo "TEST SETUP:"; \ [2026-01-20T22:34:28.055Z] echo "Nothing to be done for setup."; \ [2026-01-20T22:34:28.055Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17689481079719/renaissance-log-regression_0"; \ [2026-01-20T22:34:28.055Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17689481079719/renaissance-log-regression_0"; \ [2026-01-20T22:34:28.055Z] echo ""; echo "TESTING:"; \ [2026-01-20T22:34:28.055Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17689481079719/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-01-20T22:34:28.055Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17689481079719/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-20T22:34:28.055Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-20T22:34:28.055Z] echo "Nothing to be done for teardown."; \ [2026-01-20T22:34:28.055Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17689481079719/TestTargetResult"; [2026-01-20T22:34:28.055Z] [2026-01-20T22:34:28.055Z] TEST SETUP: [2026-01-20T22:34:28.055Z] Nothing to be done for setup. [2026-01-20T22:34:28.055Z] [2026-01-20T22:34:28.055Z] TESTING: [2026-01-20T22:34:32.026Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-20T22:34:33.792Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-20T22:34:34.148Z] GC before operation: completed in 39.961 ms, heap usage 59.310 MB -> 35.069 MB. [2026-01-20T22:34:40.401Z] ====== log-regression (apache-spark) [default], iteration 0 completed (5968.438 ms) ====== [2026-01-20T22:34:40.401Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-20T22:34:40.401Z] GC before operation: completed in 71.358 ms, heap usage 392.187 MB -> 119.867 MB. [2026-01-20T22:34:41.219Z] ====== log-regression (apache-spark) [default], iteration 1 completed (1144.517 ms) ====== [2026-01-20T22:34:41.220Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-20T22:34:41.220Z] GC before operation: completed in 43.377 ms, heap usage 239.373 MB -> 120.024 MB. [2026-01-20T22:34:42.480Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1110.880 ms) ====== [2026-01-20T22:34:42.480Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-20T22:34:42.480Z] GC before operation: completed in 49.554 ms, heap usage 363.689 MB -> 120.688 MB. [2026-01-20T22:34:43.716Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1106.862 ms) ====== [2026-01-20T22:34:43.716Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-20T22:34:43.716Z] GC before operation: completed in 47.927 ms, heap usage 331.690 MB -> 120.878 MB. [2026-01-20T22:34:44.512Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1003.145 ms) ====== [2026-01-20T22:34:44.512Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-20T22:34:44.512Z] GC before operation: completed in 52.632 ms, heap usage 292.063 MB -> 121.081 MB. [2026-01-20T22:34:45.279Z] ====== log-regression (apache-spark) [default], iteration 5 completed (814.983 ms) ====== [2026-01-20T22:34:45.279Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-20T22:34:45.279Z] GC before operation: completed in 40.578 ms, heap usage 391.906 MB -> 121.551 MB. [2026-01-20T22:34:46.552Z] ====== log-regression (apache-spark) [default], iteration 6 completed (946.358 ms) ====== [2026-01-20T22:34:46.552Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-20T22:34:46.552Z] GC before operation: completed in 52.437 ms, heap usage 332.308 MB -> 121.585 MB. [2026-01-20T22:34:47.403Z] ====== log-regression (apache-spark) [default], iteration 7 completed (737.340 ms) ====== [2026-01-20T22:34:47.403Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-20T22:34:47.403Z] GC before operation: completed in 47.762 ms, heap usage 402.887 MB -> 122.031 MB. [2026-01-20T22:34:47.760Z] ====== log-regression (apache-spark) [default], iteration 8 completed (672.349 ms) ====== [2026-01-20T22:34:47.760Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-20T22:34:48.120Z] GC before operation: completed in 41.379 ms, heap usage 313.701 MB -> 121.899 MB. [2026-01-20T22:34:48.888Z] ====== log-regression (apache-spark) [default], iteration 9 completed (778.562 ms) ====== [2026-01-20T22:34:48.888Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-20T22:34:48.888Z] GC before operation: completed in 43.452 ms, heap usage 331.075 MB -> 122.162 MB. [2026-01-20T22:34:49.246Z] ====== log-regression (apache-spark) [default], iteration 10 completed (621.579 ms) ====== [2026-01-20T22:34:49.246Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-20T22:34:49.642Z] GC before operation: completed in 38.351 ms, heap usage 261.578 MB -> 122.241 MB. [2026-01-20T22:34:50.002Z] ====== log-regression (apache-spark) [default], iteration 11 completed (715.614 ms) ====== [2026-01-20T22:34:50.002Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-20T22:34:50.362Z] GC before operation: completed in 34.374 ms, heap usage 313.572 MB -> 122.565 MB. [2026-01-20T22:34:50.721Z] ====== log-regression (apache-spark) [default], iteration 12 completed (697.578 ms) ====== [2026-01-20T22:34:50.721Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-20T22:34:51.077Z] GC before operation: completed in 54.246 ms, heap usage 394.897 MB -> 123.045 MB. [2026-01-20T22:34:51.437Z] ====== log-regression (apache-spark) [default], iteration 13 completed (674.377 ms) ====== [2026-01-20T22:34:51.437Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-20T22:34:51.801Z] GC before operation: completed in 44.963 ms, heap usage 288.215 MB -> 122.967 MB. [2026-01-20T22:34:52.164Z] ====== log-regression (apache-spark) [default], iteration 14 completed (593.508 ms) ====== [2026-01-20T22:34:52.164Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-20T22:34:52.164Z] GC before operation: completed in 33.729 ms, heap usage 330.300 MB -> 123.272 MB. [2026-01-20T22:34:52.934Z] ====== log-regression (apache-spark) [default], iteration 15 completed (555.845 ms) ====== [2026-01-20T22:34:52.934Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-20T22:34:52.934Z] GC before operation: completed in 38.869 ms, heap usage 330.603 MB -> 123.667 MB. [2026-01-20T22:34:53.293Z] ====== log-regression (apache-spark) [default], iteration 16 completed (552.569 ms) ====== [2026-01-20T22:34:53.293Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-20T22:34:53.647Z] GC before operation: completed in 42.868 ms, heap usage 263.485 MB -> 123.507 MB. [2026-01-20T22:34:54.019Z] ====== log-regression (apache-spark) [default], iteration 17 completed (523.898 ms) ====== [2026-01-20T22:34:54.019Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-20T22:34:54.019Z] GC before operation: completed in 57.353 ms, heap usage 248.170 MB -> 123.654 MB. [2026-01-20T22:34:54.818Z] ====== log-regression (apache-spark) [default], iteration 18 completed (834.194 ms) ====== [2026-01-20T22:34:54.818Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-20T22:34:54.818Z] GC before operation: completed in 39.180 ms, heap usage 303.914 MB -> 123.941 MB. [2026-01-20T22:34:55.581Z] ====== log-regression (apache-spark) [default], iteration 19 completed (637.378 ms) ====== [2026-01-20T22:34:55.581Z] ----------------------------------- [2026-01-20T22:34:55.581Z] renaissance-log-regression_0_PASSED [2026-01-20T22:34:55.581Z] ----------------------------------- [2026-01-20T22:34:55.581Z] [2026-01-20T22:34:55.581Z] TEST TEARDOWN: [2026-01-20T22:34:55.581Z] Nothing to be done for teardown. [2026-01-20T22:34:55.581Z] renaissance-log-regression_0 Finish Time: Tue Jan 20 17:34:55 2026 Epoch Time (ms): 1768948495517