[2026-03-05T05:28:12.414Z] Running test renaissance-log-regression_0 ... [2026-03-05T05:28:12.414Z] =============================================== [2026-03-05T05:28:12.414Z] renaissance-log-regression_0 Start Time: Thu Mar 5 05:28:12 2026 Epoch Time (ms): 1772688492353 [2026-03-05T05:28:12.769Z] variation: NoOptions [2026-03-05T05:28:12.769Z] JVM_OPTIONS: [2026-03-05T05:28:12.769Z] { \ [2026-03-05T05:28:12.769Z] echo ""; echo "TEST SETUP:"; \ [2026-03-05T05:28:12.769Z] echo "Nothing to be done for setup."; \ [2026-03-05T05:28:12.769Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\renaissance-log-regression_0"; \ [2026-03-05T05:28:12.769Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\renaissance-log-regression_0"; \ [2026-03-05T05:28:12.769Z] echo ""; echo "TESTING:"; \ [2026-03-05T05:28:12.769Z] "c:/jenkins/workspace/Test_openjdk17_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:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2026-03-05T05:28:12.770Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-05T05:28:12.770Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-05T05:28:12.770Z] echo "Nothing to be done for teardown."; \ [2026-03-05T05:28:12.770Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17726871194443\\TestTargetResult"; [2026-03-05T05:28:12.770Z] [2026-03-05T05:28:12.770Z] TEST SETUP: [2026-03-05T05:28:12.770Z] Nothing to be done for setup. [2026-03-05T05:28:12.770Z] [2026-03-05T05:28:12.770Z] TESTING: [2026-03-05T05:28:26.182Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-03-05T05:28:27.047Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-03-05T05:28:27.047Z] GC before operation: completed in 75.832 ms, heap usage 46.514 MB -> 35.013 MB. [2026-03-05T05:28:41.378Z] ====== log-regression (apache-spark) [default], iteration 0 completed (12471.743 ms) ====== [2026-03-05T05:28:41.378Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-03-05T05:28:41.378Z] GC before operation: completed in 80.856 ms, heap usage 343.802 MB -> 118.249 MB. [2026-03-05T05:28:42.766Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3168.312 ms) ====== [2026-03-05T05:28:42.766Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-03-05T05:28:43.218Z] GC before operation: completed in 87.525 ms, heap usage 322.920 MB -> 117.221 MB. [2026-03-05T05:28:45.235Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2279.851 ms) ====== [2026-03-05T05:28:45.235Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-03-05T05:28:45.235Z] GC before operation: completed in 79.546 ms, heap usage 233.747 MB -> 117.534 MB. [2026-03-05T05:28:47.401Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1887.683 ms) ====== [2026-03-05T05:28:47.401Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-03-05T05:28:47.401Z] GC before operation: completed in 74.972 ms, heap usage 293.961 MB -> 118.075 MB. [2026-03-05T05:28:49.253Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1755.239 ms) ====== [2026-03-05T05:28:49.253Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-03-05T05:28:49.253Z] GC before operation: completed in 78.279 ms, heap usage 317.275 MB -> 118.236 MB. [2026-03-05T05:28:51.202Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1815.544 ms) ====== [2026-03-05T05:28:51.202Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-03-05T05:28:51.202Z] GC before operation: completed in 96.629 ms, heap usage 488.581 MB -> 119.043 MB. [2026-03-05T05:28:53.064Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1782.106 ms) ====== [2026-03-05T05:28:53.064Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-03-05T05:28:53.064Z] GC before operation: completed in 90.976 ms, heap usage 271.795 MB -> 118.542 MB. [2026-03-05T05:28:54.454Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1637.763 ms) ====== [2026-03-05T05:28:54.454Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-03-05T05:28:54.454Z] GC before operation: completed in 81.073 ms, heap usage 261.992 MB -> 118.742 MB. [2026-03-05T05:28:56.426Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1609.526 ms) ====== [2026-03-05T05:28:56.426Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-03-05T05:28:56.426Z] GC before operation: completed in 82.894 ms, heap usage 258.832 MB -> 118.846 MB. [2026-03-05T05:28:57.828Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1576.833 ms) ====== [2026-03-05T05:28:57.828Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-03-05T05:28:58.264Z] GC before operation: completed in 88.528 ms, heap usage 408.641 MB -> 119.660 MB. [2026-03-05T05:28:59.754Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1620.254 ms) ====== [2026-03-05T05:28:59.754Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-03-05T05:28:59.754Z] GC before operation: completed in 88.929 ms, heap usage 573.515 MB -> 120.423 MB. [2026-03-05T05:29:01.631Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1565.679 ms) ====== [2026-03-05T05:29:01.631Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-03-05T05:29:01.631Z] GC before operation: completed in 99.536 ms, heap usage 261.121 MB -> 119.487 MB. [2026-03-05T05:29:03.092Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1501.082 ms) ====== [2026-03-05T05:29:03.092Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-03-05T05:29:03.092Z] GC before operation: completed in 91.360 ms, heap usage 384.840 MB -> 120.123 MB. [2026-03-05T05:29:04.369Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1488.199 ms) ====== [2026-03-05T05:29:04.369Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-03-05T05:29:04.811Z] GC before operation: completed in 102.612 ms, heap usage 453.032 MB -> 120.573 MB. [2026-03-05T05:29:06.310Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1518.858 ms) ====== [2026-03-05T05:29:06.310Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-03-05T05:29:06.310Z] GC before operation: completed in 89.771 ms, heap usage 255.256 MB -> 120.003 MB. [2026-03-05T05:29:08.154Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1571.136 ms) ====== [2026-03-05T05:29:08.154Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-03-05T05:29:08.154Z] GC before operation: completed in 88.715 ms, heap usage 393.195 MB -> 120.756 MB. [2026-03-05T05:29:09.482Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1492.193 ms) ====== [2026-03-05T05:29:09.482Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-03-05T05:29:09.482Z] GC before operation: completed in 87.096 ms, heap usage 244.825 MB -> 120.330 MB. [2026-03-05T05:29:10.834Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1428.037 ms) ====== [2026-03-05T05:29:10.834Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-03-05T05:29:11.274Z] GC before operation: completed in 87.528 ms, heap usage 449.416 MB -> 121.305 MB. [2026-03-05T05:29:12.685Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1612.250 ms) ====== [2026-03-05T05:29:12.685Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-03-05T05:29:12.685Z] GC before operation: completed in 85.707 ms, heap usage 252.857 MB -> 120.776 MB. [2026-03-05T05:29:14.007Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1475.236 ms) ====== [2026-03-05T05:29:14.357Z] [2026-03-05T05:29:14.134+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2026-03-05T05:29:14.357Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk17_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17726871194443\renaissance-log-regression_0\harness-052813-7592425929845455297: harness-052813-7592425929845455297\apache-spark\lib\activation-1.1.1.jar: The process cannot access the file because it is being used by another process [2026-03-05T05:29:14.706Z] ----------------------------------- [2026-03-05T05:29:14.706Z] renaissance-log-regression_0_PASSED [2026-03-05T05:29:14.706Z] ----------------------------------- [2026-03-05T05:29:14.706Z] [2026-03-05T05:29:14.706Z] TEST TEARDOWN: [2026-03-05T05:29:14.706Z] Nothing to be done for teardown. [2026-03-05T05:29:14.706Z] renaissance-log-regression_0 Finish Time: Thu Mar 5 05:29:14 2026 Epoch Time (ms): 1772688554676