[2026-02-04T23:45:38.983Z] Running test renaissance-log-regression_0 ... [2026-02-04T23:45:39.321Z] =============================================== [2026-02-04T23:45:39.321Z] renaissance-log-regression_0 Start Time: Wed Feb 4 23:45:39 2026 Epoch Time (ms): 1770248739122 [2026-02-04T23:45:39.321Z] variation: NoOptions [2026-02-04T23:45:39.321Z] JVM_OPTIONS: [2026-02-04T23:45:39.321Z] { \ [2026-02-04T23:45:39.321Z] echo ""; echo "TEST SETUP:"; \ [2026-02-04T23:45:39.321Z] echo "Nothing to be done for setup."; \ [2026-02-04T23:45:39.321Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-log-regression_0"; \ [2026-02-04T23:45:39.321Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-log-regression_0"; \ [2026-02-04T23:45:39.321Z] echo ""; echo "TESTING:"; \ [2026-02-04T23:45:39.321Z] "c:/jenkins/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:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2026-02-04T23:45:39.321Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-04T23:45:39.321Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-04T23:45:39.321Z] echo "Nothing to be done for teardown."; \ [2026-02-04T23:45:39.321Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17702473026037\\TestTargetResult"; [2026-02-04T23:45:39.679Z] [2026-02-04T23:45:39.679Z] TEST SETUP: [2026-02-04T23:45:39.679Z] Nothing to be done for setup. [2026-02-04T23:45:39.679Z] [2026-02-04T23:45:39.679Z] TESTING: [2026-02-04T23:45:53.255Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-02-04T23:45:54.575Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-02-04T23:45:54.575Z] GC before operation: completed in 41.384 ms, heap usage 40.086 MB -> 35.162 MB. [2026-02-04T23:46:08.643Z] ====== log-regression (apache-spark) [default], iteration 0 completed (12389.434 ms) ====== [2026-02-04T23:46:08.643Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-02-04T23:46:08.643Z] GC before operation: completed in 339.782 ms, heap usage 512.138 MB -> 118.505 MB. [2026-02-04T23:46:09.969Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2912.304 ms) ====== [2026-02-04T23:46:09.969Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-02-04T23:46:10.462Z] GC before operation: completed in 104.644 ms, heap usage 488.009 MB -> 118.083 MB. [2026-02-04T23:46:13.150Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2526.834 ms) ====== [2026-02-04T23:46:13.150Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-02-04T23:46:13.150Z] GC before operation: completed in 109.775 ms, heap usage 461.231 MB -> 118.487 MB. [2026-02-04T23:46:15.291Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2219.949 ms) ====== [2026-02-04T23:46:15.291Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-02-04T23:46:15.291Z] GC before operation: completed in 87.311 ms, heap usage 287.073 MB -> 118.097 MB. [2026-02-04T23:46:17.611Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2634.016 ms) ====== [2026-02-04T23:46:17.611Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-02-04T23:46:18.134Z] GC before operation: completed in 90.482 ms, heap usage 314.043 MB -> 118.409 MB. [2026-02-04T23:46:20.694Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2514.497 ms) ====== [2026-02-04T23:46:20.694Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-02-04T23:46:20.694Z] GC before operation: completed in 86.837 ms, heap usage 247.232 MB -> 118.402 MB. [2026-02-04T23:46:22.921Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2109.991 ms) ====== [2026-02-04T23:46:22.921Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-02-04T23:46:22.921Z] GC before operation: completed in 89.628 ms, heap usage 266.124 MB -> 118.746 MB. [2026-02-04T23:46:24.375Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1591.230 ms) ====== [2026-02-04T23:46:24.375Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-02-04T23:46:24.375Z] GC before operation: completed in 87.271 ms, heap usage 132.801 MB -> 119.480 MB. [2026-02-04T23:46:25.778Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1598.280 ms) ====== [2026-02-04T23:46:25.778Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-02-04T23:46:26.303Z] GC before operation: completed in 94.206 ms, heap usage 556.471 MB -> 120.174 MB. [2026-02-04T23:46:28.269Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1791.413 ms) ====== [2026-02-04T23:46:28.269Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-02-04T23:46:28.269Z] GC before operation: completed in 99.214 ms, heap usage 573.533 MB -> 120.454 MB. [2026-02-04T23:46:29.591Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1781.700 ms) ====== [2026-02-04T23:46:29.591Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-02-04T23:46:30.082Z] GC before operation: completed in 120.065 ms, heap usage 589.230 MB -> 120.720 MB. [2026-02-04T23:46:31.468Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1797.926 ms) ====== [2026-02-04T23:46:31.468Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-02-04T23:46:31.997Z] GC before operation: completed in 95.139 ms, heap usage 513.336 MB -> 120.638 MB. [2026-02-04T23:46:33.382Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1785.736 ms) ====== [2026-02-04T23:46:33.382Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-02-04T23:46:33.382Z] GC before operation: completed in 93.949 ms, heap usage 373.471 MB -> 120.221 MB. [2026-02-04T23:46:35.253Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1408.845 ms) ====== [2026-02-04T23:46:35.253Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-02-04T23:46:35.253Z] GC before operation: completed in 103.530 ms, heap usage 377.200 MB -> 120.427 MB. [2026-02-04T23:46:36.646Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1663.165 ms) ====== [2026-02-04T23:46:36.646Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-02-04T23:46:36.646Z] GC before operation: completed in 94.677 ms, heap usage 236.641 MB -> 120.111 MB. [2026-02-04T23:46:39.819Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2425.973 ms) ====== [2026-02-04T23:46:39.819Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-02-04T23:46:39.819Z] GC before operation: completed in 388.690 ms, heap usage 283.207 MB -> 120.484 MB. [2026-02-04T23:46:41.318Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1384.716 ms) ====== [2026-02-04T23:46:41.318Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-02-04T23:46:41.318Z] GC before operation: completed in 103.162 ms, heap usage 325.997 MB -> 120.742 MB. [2026-02-04T23:46:48.810Z] ====== log-regression (apache-spark) [default], iteration 17 completed (7455.247 ms) ====== [2026-02-04T23:46:48.810Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-02-04T23:46:48.810Z] GC before operation: completed in 97.547 ms, heap usage 248.851 MB -> 120.639 MB. [2026-02-04T23:46:51.151Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2310.858 ms) ====== [2026-02-04T23:46:51.151Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-02-04T23:46:51.151Z] GC before operation: completed in 137.063 ms, heap usage 651.809 MB -> 122.429 MB. [2026-02-04T23:46:53.227Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1772.039 ms) ====== [2026-02-04T23:46:53.227Z] [2026-02-04T23:46:52.913+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2026-02-04T23:46:53.227Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk21_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17702473026037\renaissance-log-regression_0\launcher-234539-16878170202622155612: launcher-234539-16878170202622155612\renaissance-harness_3\lib\renaissance-harness_3-0.16.0.jar: The process cannot access the file because it is being used by another process [2026-02-04T23:46:53.227Z] ----------------------------------- [2026-02-04T23:46:53.227Z] renaissance-log-regression_0_PASSED [2026-02-04T23:46:53.227Z] ----------------------------------- [2026-02-04T23:46:53.583Z] [2026-02-04T23:46:53.583Z] TEST TEARDOWN: [2026-02-04T23:46:53.583Z] Nothing to be done for teardown. [2026-02-04T23:46:53.583Z] renaissance-log-regression_0 Finish Time: Wed Feb 4 23:46:53 2026 Epoch Time (ms): 1770248813324