[2025-12-24T23:53:15.531Z] Running test renaissance-log-regression_0 ... [2025-12-24T23:53:15.531Z] =============================================== [2025-12-24T23:53:15.531Z] renaissance-log-regression_0 Start Time: Wed Dec 24 23:53:15 2025 Epoch Time (ms): 1766620395456 [2025-12-24T23:53:15.950Z] variation: NoOptions [2025-12-24T23:53:15.950Z] JVM_OPTIONS: [2025-12-24T23:53:15.950Z] { \ [2025-12-24T23:53:15.950Z] echo ""; echo "TEST SETUP:"; \ [2025-12-24T23:53:15.950Z] echo "Nothing to be done for setup."; \ [2025-12-24T23:53:15.950Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17666184974796\\renaissance-log-regression_0"; \ [2025-12-24T23:53:15.950Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17666184974796\\renaissance-log-regression_0"; \ [2025-12-24T23:53:15.950Z] echo ""; echo "TESTING:"; \ [2025-12-24T23:53:15.950Z] "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_17666184974796\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2025-12-24T23:53:15.950Z] 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_17666184974796\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-24T23:53:15.950Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-24T23:53:15.950Z] echo "Nothing to be done for teardown."; \ [2025-12-24T23:53:15.950Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17666184974796\\TestTargetResult"; [2025-12-24T23:53:15.950Z] [2025-12-24T23:53:15.950Z] TEST SETUP: [2025-12-24T23:53:15.950Z] Nothing to be done for setup. [2025-12-24T23:53:15.950Z] [2025-12-24T23:53:15.950Z] TESTING: [2025-12-24T23:53:29.415Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-12-24T23:53:30.649Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-24T23:53:30.649Z] GC before operation: completed in 39.676 ms, heap usage 42.390 MB -> 35.214 MB. [2025-12-24T23:53:45.389Z] ====== log-regression (apache-spark) [default], iteration 0 completed (13158.330 ms) ====== [2025-12-24T23:53:45.389Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-24T23:53:45.389Z] GC before operation: completed in 511.854 ms, heap usage 384.658 MB -> 118.505 MB. [2025-12-24T23:53:47.255Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3015.643 ms) ====== [2025-12-24T23:53:47.255Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-24T23:53:47.255Z] GC before operation: completed in 105.773 ms, heap usage 302.671 MB -> 117.588 MB. [2025-12-24T23:53:50.185Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2674.278 ms) ====== [2025-12-24T23:53:50.185Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-24T23:53:50.185Z] GC before operation: completed in 117.721 ms, heap usage 236.515 MB -> 117.781 MB. [2025-12-24T23:53:52.548Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2175.201 ms) ====== [2025-12-24T23:53:52.548Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-24T23:53:52.548Z] GC before operation: completed in 86.078 ms, heap usage 280.824 MB -> 118.231 MB. [2025-12-24T23:53:54.605Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1907.336 ms) ====== [2025-12-24T23:53:54.605Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-24T23:53:54.605Z] GC before operation: completed in 87.304 ms, heap usage 593.069 MB -> 119.726 MB. [2025-12-24T23:53:56.613Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1874.156 ms) ====== [2025-12-24T23:53:56.613Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-24T23:53:56.613Z] GC before operation: completed in 180.488 ms, heap usage 393.417 MB -> 119.012 MB. [2025-12-24T23:53:58.642Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1901.558 ms) ====== [2025-12-24T23:53:58.642Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-24T23:53:58.642Z] GC before operation: completed in 91.669 ms, heap usage 442.459 MB -> 119.521 MB. [2025-12-24T23:54:00.802Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1980.554 ms) ====== [2025-12-24T23:54:00.803Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-24T23:54:00.803Z] GC before operation: completed in 88.322 ms, heap usage 545.156 MB -> 120.117 MB. [2025-12-24T23:54:02.373Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1854.884 ms) ====== [2025-12-24T23:54:02.373Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-24T23:54:02.866Z] GC before operation: completed in 101.485 ms, heap usage 503.900 MB -> 120.168 MB. [2025-12-24T23:54:04.308Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1873.131 ms) ====== [2025-12-24T23:54:04.308Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-24T23:54:04.790Z] GC before operation: completed in 109.266 ms, heap usage 438.844 MB -> 120.162 MB. [2025-12-24T23:54:06.236Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1877.139 ms) ====== [2025-12-24T23:54:06.236Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-24T23:54:06.676Z] GC before operation: completed in 97.426 ms, heap usage 561.653 MB -> 120.726 MB. [2025-12-24T23:54:08.668Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1956.278 ms) ====== [2025-12-24T23:54:08.668Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-24T23:54:08.668Z] GC before operation: completed in 93.006 ms, heap usage 603.165 MB -> 121.044 MB. [2025-12-24T23:54:10.690Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1897.481 ms) ====== [2025-12-24T23:54:10.690Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-24T23:54:10.690Z] GC before operation: completed in 93.442 ms, heap usage 538.132 MB -> 121.006 MB. [2025-12-24T23:54:11.969Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1565.812 ms) ====== [2025-12-24T23:54:11.969Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-24T23:54:12.385Z] GC before operation: completed in 107.281 ms, heap usage 267.404 MB -> 120.138 MB. [2025-12-24T23:54:13.723Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1671.235 ms) ====== [2025-12-24T23:54:13.723Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-24T23:54:14.171Z] GC before operation: completed in 101.162 ms, heap usage 254.424 MB -> 120.288 MB. [2025-12-24T23:54:16.013Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1808.305 ms) ====== [2025-12-24T23:54:16.013Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-24T23:54:16.380Z] GC before operation: completed in 470.043 ms, heap usage 352.144 MB -> 120.998 MB. [2025-12-24T23:54:17.687Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1548.816 ms) ====== [2025-12-24T23:54:17.687Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-24T23:54:18.129Z] GC before operation: completed in 99.125 ms, heap usage 337.029 MB -> 120.985 MB. [2025-12-24T23:54:19.398Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1618.907 ms) ====== [2025-12-24T23:54:19.398Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-24T23:54:19.904Z] GC before operation: completed in 98.701 ms, heap usage 300.576 MB -> 121.057 MB. [2025-12-24T23:54:21.971Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2161.998 ms) ====== [2025-12-24T23:54:21.971Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-24T23:54:21.971Z] GC before operation: completed in 104.116 ms, heap usage 331.943 MB -> 121.440 MB. [2025-12-24T23:54:23.271Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1342.109 ms) ====== [2025-12-24T23:54:23.622Z] ----------------------------------- [2025-12-24T23:54:23.623Z] renaissance-log-regression_0_PASSED [2025-12-24T23:54:23.623Z] ----------------------------------- [2025-12-24T23:54:23.623Z] [2025-12-24T23:54:23.623Z] TEST TEARDOWN: [2025-12-24T23:54:23.623Z] Nothing to be done for teardown. [2025-12-24T23:54:23.623Z] renaissance-log-regression_0 Finish Time: Wed Dec 24 23:54:23 2025 Epoch Time (ms): 1766620463581