[2026-02-11T20:51:06.275Z] Running test renaissance-log-regression_0 ... [2026-02-11T20:51:06.275Z] =============================================== [2026-02-11T20:51:06.275Z] renaissance-log-regression_0 Start Time: Wed Feb 11 20:51:05 2026 Epoch Time (ms): 1770843065989 [2026-02-11T20:51:06.275Z] variation: NoOptions [2026-02-11T20:51:06.662Z] JVM_OPTIONS: [2026-02-11T20:51:06.662Z] { \ [2026-02-11T20:51:06.662Z] echo ""; echo "TEST SETUP:"; \ [2026-02-11T20:51:06.662Z] echo "Nothing to be done for setup."; \ [2026-02-11T20:51:06.662Z] mkdir -p "C:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1770841312372\\renaissance-log-regression_0"; \ [2026-02-11T20:51:06.662Z] cd "C:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1770841312372\\renaissance-log-regression_0"; \ [2026-02-11T20:51:06.662Z] echo ""; echo "TESTING:"; \ [2026-02-11T20:51:06.662Z] "c:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/jdkbinary/j2sdk-image\\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 "C:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1770841312372\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2026-02-11T20:51:06.662Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd C:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1770841312372\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-11T20:51:06.662Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-11T20:51:06.662Z] echo "Nothing to be done for teardown."; \ [2026-02-11T20:51:06.662Z] } 2>&1 | tee -a "C:/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1770841312372\\TestTargetResult"; [2026-02-11T20:51:06.662Z] [2026-02-11T20:51:06.662Z] TEST SETUP: [2026-02-11T20:51:06.662Z] Nothing to be done for setup. [2026-02-11T20:51:06.662Z] [2026-02-11T20:51:06.662Z] TESTING: [2026-02-11T20:51:29.834Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-11T20:51:34.723Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-02-11T20:51:34.723Z] GC before operation: completed in 59.527 ms, heap usage 77.993 MB -> 35.570 MB. [2026-02-11T20:51:50.849Z] ====== log-regression (apache-spark) [default], iteration 0 completed (16282.889 ms) ====== [2026-02-11T20:51:50.849Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-02-11T20:51:50.849Z] GC before operation: completed in 119.002 ms, heap usage 489.145 MB -> 123.689 MB. [2026-02-11T20:51:54.815Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3305.808 ms) ====== [2026-02-11T20:51:54.815Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-02-11T20:51:54.815Z] GC before operation: completed in 95.358 ms, heap usage 349.749 MB -> 124.064 MB. [2026-02-11T20:51:56.703Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2447.095 ms) ====== [2026-02-11T20:51:56.703Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-02-11T20:51:57.097Z] GC before operation: completed in 116.301 ms, heap usage 534.428 MB -> 125.018 MB. [2026-02-11T20:51:58.920Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2126.004 ms) ====== [2026-02-11T20:51:58.920Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-02-11T20:51:59.312Z] GC before operation: completed in 112.619 ms, heap usage 319.582 MB -> 126.397 MB. [2026-02-11T20:52:01.107Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2073.213 ms) ====== [2026-02-11T20:52:01.107Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-02-11T20:52:01.489Z] GC before operation: completed in 112.881 ms, heap usage 495.113 MB -> 125.450 MB. [2026-02-11T20:52:03.315Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1887.906 ms) ====== [2026-02-11T20:52:03.315Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-02-11T20:52:03.315Z] GC before operation: completed in 106.405 ms, heap usage 519.913 MB -> 125.644 MB. [2026-02-11T20:52:05.125Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1867.103 ms) ====== [2026-02-11T20:52:05.125Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-02-11T20:52:05.542Z] GC before operation: completed in 114.313 ms, heap usage 515.966 MB -> 125.902 MB. [2026-02-11T20:52:07.282Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1725.632 ms) ====== [2026-02-11T20:52:07.282Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-02-11T20:52:07.282Z] GC before operation: completed in 104.378 ms, heap usage 498.965 MB -> 126.125 MB. [2026-02-11T20:52:09.139Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1819.632 ms) ====== [2026-02-11T20:52:09.139Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-02-11T20:52:09.139Z] GC before operation: completed in 110.469 ms, heap usage 488.942 MB -> 126.889 MB. [2026-02-11T20:52:10.885Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1807.780 ms) ====== [2026-02-11T20:52:10.885Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-02-11T20:52:10.885Z] GC before operation: completed in 108.374 ms, heap usage 466.969 MB -> 127.482 MB. [2026-02-11T20:52:12.685Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1775.607 ms) ====== [2026-02-11T20:52:12.685Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-02-11T20:52:13.063Z] GC before operation: completed in 120.887 ms, heap usage 485.278 MB -> 126.738 MB. [2026-02-11T20:52:14.809Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1735.369 ms) ====== [2026-02-11T20:52:14.809Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-02-11T20:52:14.809Z] GC before operation: completed in 112.872 ms, heap usage 518.577 MB -> 127.023 MB. [2026-02-11T20:52:16.594Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1734.214 ms) ====== [2026-02-11T20:52:16.594Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-02-11T20:52:16.594Z] GC before operation: completed in 112.464 ms, heap usage 483.010 MB -> 127.054 MB. [2026-02-11T20:52:18.414Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1656.174 ms) ====== [2026-02-11T20:52:18.414Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-02-11T20:52:18.414Z] GC before operation: completed in 125.530 ms, heap usage 475.814 MB -> 127.174 MB. [2026-02-11T20:52:20.201Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1732.353 ms) ====== [2026-02-11T20:52:20.201Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-02-11T20:52:20.201Z] GC before operation: completed in 124.964 ms, heap usage 467.089 MB -> 127.289 MB. [2026-02-11T20:52:22.018Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1623.909 ms) ====== [2026-02-11T20:52:22.018Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-02-11T20:52:22.018Z] GC before operation: completed in 117.262 ms, heap usage 467.405 MB -> 127.493 MB. [2026-02-11T20:52:23.771Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1895.041 ms) ====== [2026-02-11T20:52:23.772Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-02-11T20:52:24.145Z] GC before operation: completed in 113.334 ms, heap usage 448.338 MB -> 127.651 MB. [2026-02-11T20:52:25.844Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1650.336 ms) ====== [2026-02-11T20:52:25.844Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-02-11T20:52:25.844Z] GC before operation: completed in 116.031 ms, heap usage 467.265 MB -> 127.947 MB. [2026-02-11T20:52:27.642Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1662.400 ms) ====== [2026-02-11T20:52:27.642Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-02-11T20:52:27.642Z] GC before operation: completed in 113.629 ms, heap usage 467.323 MB -> 128.110 MB. [2026-02-11T20:52:29.381Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1825.498 ms) ====== [2026-02-11T20:52:29.761Z] ----------------------------------- [2026-02-11T20:52:29.761Z] renaissance-log-regression_0_PASSED [2026-02-11T20:52:29.761Z] ----------------------------------- [2026-02-11T20:52:30.136Z] [2026-02-11T20:52:30.136Z] TEST TEARDOWN: [2026-02-11T20:52:30.136Z] Nothing to be done for teardown. [2026-02-11T20:52:30.136Z] renaissance-log-regression_0 Finish Time: Wed Feb 11 20:52:30 2026 Epoch Time (ms): 1770843150070