[2026-03-05T18:51:59.042Z] Running test renaissance-log-regression_0 ... [2026-03-05T18:51:59.485Z] =============================================== [2026-03-05T18:51:59.485Z] renaissance-log-regression_0 Start Time: Thu Mar 5 13:51:58 2026 Epoch Time (ms): 1772736718835 [2026-03-05T18:51:59.485Z] variation: NoOptions [2026-03-05T18:51:59.485Z] JVM_OPTIONS: [2026-03-05T18:51:59.485Z] { \ [2026-03-05T18:51:59.485Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T18:51:59.485Z] echo "Nothing to be done for setup."; \ [2026-03-05T18:51:59.485Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17727355298115/renaissance-log-regression_0"; \ [2026-03-05T18:51:59.485Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17727355298115/renaissance-log-regression_0"; \ [2026-03-05T18:51:59.485Z] echo ""; echo "TESTING:"; \ [2026-03-05T18:51:59.485Z] "/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_17727355298115/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-03-05T18:51:59.485Z] 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_17727355298115/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T18:51:59.485Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T18:51:59.485Z] echo "Nothing to be done for teardown."; \ [2026-03-05T18:51:59.485Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17727355298115/TestTargetResult"; [2026-03-05T18:51:59.485Z] [2026-03-05T18:51:59.485Z] TEST SETUP: [2026-03-05T18:51:59.486Z] Nothing to be done for setup. [2026-03-05T18:51:59.486Z] [2026-03-05T18:51:59.486Z] TESTING: [2026-03-05T18:52:21.575Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-03-05T18:52:36.774Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-03-05T18:52:36.774Z] GC before operation: completed in 126.136 ms, heap usage 64.440 MB -> 34.108 MB. [2026-03-05T18:53:19.985Z] ====== log-regression (apache-spark) [default], iteration 0 completed (42086.820 ms) ====== [2026-03-05T18:53:19.985Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-03-05T18:53:19.985Z] GC before operation: completed in 294.872 ms, heap usage 299.206 MB -> 123.846 MB. [2026-03-05T18:53:29.313Z] ====== log-regression (apache-spark) [default], iteration 1 completed (10369.885 ms) ====== [2026-03-05T18:53:29.313Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-03-05T18:53:29.313Z] GC before operation: completed in 271.444 ms, heap usage 742.904 MB -> 123.554 MB. [2026-03-05T18:53:40.474Z] ====== log-regression (apache-spark) [default], iteration 2 completed (10277.474 ms) ====== [2026-03-05T18:53:40.474Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-03-05T18:53:40.474Z] GC before operation: completed in 227.112 ms, heap usage 637.171 MB -> 123.750 MB. [2026-03-05T18:53:48.211Z] ====== log-regression (apache-spark) [default], iteration 3 completed (8286.453 ms) ====== [2026-03-05T18:53:48.211Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-03-05T18:53:48.841Z] GC before operation: completed in 250.169 ms, heap usage 980.707 MB -> 124.498 MB. [2026-03-05T18:53:56.213Z] ====== log-regression (apache-spark) [default], iteration 4 completed (6608.172 ms) ====== [2026-03-05T18:53:56.213Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-03-05T18:53:56.213Z] GC before operation: completed in 257.202 ms, heap usage 319.154 MB -> 123.410 MB. [2026-03-05T18:54:02.433Z] ====== log-regression (apache-spark) [default], iteration 5 completed (6202.175 ms) ====== [2026-03-05T18:54:02.433Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-03-05T18:54:02.433Z] GC before operation: completed in 157.584 ms, heap usage 375.375 MB -> 123.824 MB. [2026-03-05T18:54:07.580Z] ====== log-regression (apache-spark) [default], iteration 6 completed (5906.012 ms) ====== [2026-03-05T18:54:07.580Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-03-05T18:54:08.164Z] GC before operation: completed in 329.023 ms, heap usage 450.595 MB -> 124.294 MB. [2026-03-05T18:54:14.274Z] ====== log-regression (apache-spark) [default], iteration 7 completed (6191.622 ms) ====== [2026-03-05T18:54:14.274Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-03-05T18:54:14.274Z] GC before operation: completed in 196.322 ms, heap usage 564.672 MB -> 124.858 MB. [2026-03-05T18:54:20.718Z] ====== log-regression (apache-spark) [default], iteration 8 completed (6310.389 ms) ====== [2026-03-05T18:54:20.718Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-03-05T18:54:21.201Z] GC before operation: completed in 292.879 ms, heap usage 531.729 MB -> 124.914 MB. [2026-03-05T18:54:27.381Z] ====== log-regression (apache-spark) [default], iteration 9 completed (5752.114 ms) ====== [2026-03-05T18:54:27.381Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-03-05T18:54:27.381Z] GC before operation: completed in 249.654 ms, heap usage 230.079 MB -> 124.303 MB. [2026-03-05T18:54:33.553Z] ====== log-regression (apache-spark) [default], iteration 10 completed (6752.662 ms) ====== [2026-03-05T18:54:33.554Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-03-05T18:54:34.242Z] GC before operation: completed in 247.786 ms, heap usage 284.946 MB -> 124.852 MB. [2026-03-05T18:54:39.371Z] ====== log-regression (apache-spark) [default], iteration 11 completed (4878.409 ms) ====== [2026-03-05T18:54:39.371Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-03-05T18:54:39.371Z] GC before operation: completed in 443.164 ms, heap usage 372.696 MB -> 125.121 MB. [2026-03-05T18:54:45.468Z] ====== log-regression (apache-spark) [default], iteration 12 completed (5858.330 ms) ====== [2026-03-05T18:54:45.468Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-03-05T18:54:45.468Z] GC before operation: completed in 250.877 ms, heap usage 256.677 MB -> 125.057 MB. [2026-03-05T18:54:50.621Z] ====== log-regression (apache-spark) [default], iteration 13 completed (5293.405 ms) ====== [2026-03-05T18:54:50.621Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-03-05T18:54:51.250Z] GC before operation: completed in 499.201 ms, heap usage 618.024 MB -> 126.285 MB. [2026-03-05T18:54:57.438Z] ====== log-regression (apache-spark) [default], iteration 14 completed (5346.202 ms) ====== [2026-03-05T18:54:57.438Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-03-05T18:54:57.438Z] GC before operation: completed in 269.517 ms, heap usage 560.984 MB -> 126.469 MB. [2026-03-05T18:55:02.497Z] ====== log-regression (apache-spark) [default], iteration 15 completed (5635.659 ms) ====== [2026-03-05T18:55:02.497Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-03-05T18:55:03.069Z] GC before operation: completed in 221.335 ms, heap usage 239.239 MB -> 125.338 MB. [2026-03-05T18:55:08.281Z] ====== log-regression (apache-spark) [default], iteration 16 completed (5272.919 ms) ====== [2026-03-05T18:55:08.281Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-03-05T18:55:08.281Z] GC before operation: completed in 162.951 ms, heap usage 136.377 MB -> 126.919 MB. [2026-03-05T18:55:17.290Z] ====== log-regression (apache-spark) [default], iteration 17 completed (7714.730 ms) ====== [2026-03-05T18:55:17.290Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-03-05T18:55:17.290Z] GC before operation: completed in 449.871 ms, heap usage 820.652 MB -> 127.337 MB. [2026-03-05T18:55:21.217Z] ====== log-regression (apache-spark) [default], iteration 18 completed (4377.797 ms) ====== [2026-03-05T18:55:21.218Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-03-05T18:55:21.218Z] GC before operation: completed in 156.573 ms, heap usage 258.000 MB -> 126.107 MB. [2026-03-05T18:55:27.558Z] ====== log-regression (apache-spark) [default], iteration 19 completed (6022.139 ms) ====== [2026-03-05T18:55:28.500Z] ----------------------------------- [2026-03-05T18:55:28.500Z] renaissance-log-regression_0_PASSED [2026-03-05T18:55:28.500Z] ----------------------------------- [2026-03-05T18:55:28.500Z] [2026-03-05T18:55:28.500Z] TEST TEARDOWN: [2026-03-05T18:55:28.500Z] Nothing to be done for teardown. [2026-03-05T18:55:28.500Z] renaissance-log-regression_0 Finish Time: Thu Mar 5 13:55:28 2026 Epoch Time (ms): 1772736928122