[2026-03-02T00:41:07.952Z] Running test renaissance-log-regression_0 ... [2026-03-02T00:41:07.952Z] =============================================== [2026-03-02T00:41:08.264Z] renaissance-log-regression_0 Start Time: Mon Mar 2 00:41:08 2026 Epoch Time (ms): 1772412068027 [2026-03-02T00:41:08.264Z] variation: NoOptions [2026-03-02T00:41:08.264Z] JVM_OPTIONS: [2026-03-02T00:41:08.264Z] { \ [2026-03-02T00:41:08.264Z] echo ""; echo "TEST SETUP:"; \ [2026-03-02T00:41:08.264Z] echo "Nothing to be done for setup."; \ [2026-03-02T00:41:08.264Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-log-regression_0"; \ [2026-03-02T00:41:08.264Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-log-regression_0"; \ [2026-03-02T00:41:08.264Z] echo ""; echo "TESTING:"; \ [2026-03-02T00:41:08.264Z] "c:/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2026-03-02T00:41:08.264Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-02T00:41:08.264Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-02T00:41:08.264Z] echo "Nothing to be done for teardown."; \ [2026-03-02T00:41:08.264Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17724102465297\\TestTargetResult"; [2026-03-02T00:41:08.603Z] [2026-03-02T00:41:08.603Z] TEST SETUP: [2026-03-02T00:41:08.603Z] Nothing to be done for setup. [2026-03-02T00:41:08.603Z] [2026-03-02T00:41:08.603Z] TESTING: [2026-03-02T00:41:24.395Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-03-02T00:41:25.553Z] WARNING: An illegal reflective access operation has occurred [2026-03-02T00:41:25.553Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17724102465297/renaissance-log-regression_0/harness-004109-10721659226217223812/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-03-02T00:41:25.553Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-03-02T00:41:25.553Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-03-02T00:41:25.553Z] WARNING: All illegal access operations will be denied in a future release [2026-03-02T00:41:27.298Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-03-02T00:41:27.298Z] GC before operation: completed in 78.467 ms, heap usage 43.004 MB -> 34.544 MB. [2026-03-02T00:41:44.774Z] ====== log-regression (apache-spark) [default], iteration 0 completed (16727.035 ms) ====== [2026-03-02T00:41:44.774Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-03-02T00:41:44.774Z] GC before operation: completed in 199.311 ms, heap usage 249.374 MB -> 115.691 MB. [2026-03-02T00:41:52.835Z] ====== log-regression (apache-spark) [default], iteration 1 completed (8056.522 ms) ====== [2026-03-02T00:41:52.835Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-03-02T00:41:52.835Z] GC before operation: completed in 147.853 ms, heap usage 225.804 MB -> 116.075 MB. [2026-03-02T00:41:57.017Z] ====== log-regression (apache-spark) [default], iteration 2 completed (4509.950 ms) ====== [2026-03-02T00:41:57.017Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-03-02T00:41:57.436Z] GC before operation: completed in 186.362 ms, heap usage 260.748 MB -> 116.562 MB. [2026-03-02T00:42:01.147Z] ====== log-regression (apache-spark) [default], iteration 3 completed (3860.022 ms) ====== [2026-03-02T00:42:01.147Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-03-02T00:42:01.147Z] GC before operation: completed in 160.539 ms, heap usage 237.853 MB -> 116.782 MB. [2026-03-02T00:42:05.219Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3137.838 ms) ====== [2026-03-02T00:42:05.219Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-03-02T00:42:05.219Z] GC before operation: completed in 171.333 ms, heap usage 249.509 MB -> 116.964 MB. [2026-03-02T00:42:08.306Z] ====== log-regression (apache-spark) [default], iteration 5 completed (3795.260 ms) ====== [2026-03-02T00:42:08.306Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-03-02T00:42:08.681Z] GC before operation: completed in 173.390 ms, heap usage 228.649 MB -> 117.155 MB. [2026-03-02T00:42:11.081Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2415.813 ms) ====== [2026-03-02T00:42:11.081Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-03-02T00:42:11.081Z] GC before operation: completed in 200.331 ms, heap usage 339.739 MB -> 117.674 MB. [2026-03-02T00:42:15.100Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3510.742 ms) ====== [2026-03-02T00:42:15.100Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-03-02T00:42:15.100Z] GC before operation: completed in 181.577 ms, heap usage 290.063 MB -> 117.716 MB. [2026-03-02T00:42:18.428Z] ====== log-regression (apache-spark) [default], iteration 8 completed (3249.583 ms) ====== [2026-03-02T00:42:18.428Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-03-02T00:42:18.428Z] GC before operation: completed in 179.614 ms, heap usage 258.232 MB -> 117.792 MB. [2026-03-02T00:42:21.586Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2799.363 ms) ====== [2026-03-02T00:42:21.586Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-03-02T00:42:21.586Z] GC before operation: completed in 163.817 ms, heap usage 291.667 MB -> 118.150 MB. [2026-03-02T00:42:24.332Z] ====== log-regression (apache-spark) [default], iteration 10 completed (3145.925 ms) ====== [2026-03-02T00:42:24.332Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-03-02T00:42:24.721Z] GC before operation: completed in 185.464 ms, heap usage 247.656 MB -> 118.148 MB. [2026-03-02T00:42:28.002Z] ====== log-regression (apache-spark) [default], iteration 11 completed (3032.369 ms) ====== [2026-03-02T00:42:28.002Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-03-02T00:42:28.002Z] GC before operation: completed in 195.167 ms, heap usage 246.720 MB -> 118.242 MB. [2026-03-02T00:42:31.248Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3075.911 ms) ====== [2026-03-02T00:42:31.248Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-03-02T00:42:31.248Z] GC before operation: completed in 179.674 ms, heap usage 226.966 MB -> 118.418 MB. [2026-03-02T00:42:34.505Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2781.954 ms) ====== [2026-03-02T00:42:34.505Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-03-02T00:42:34.505Z] GC before operation: completed in 184.186 ms, heap usage 246.838 MB -> 118.573 MB. [2026-03-02T00:42:37.132Z] ====== log-regression (apache-spark) [default], iteration 14 completed (3168.887 ms) ====== [2026-03-02T00:42:37.132Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-03-02T00:42:37.502Z] GC before operation: completed in 178.350 ms, heap usage 291.761 MB -> 119.003 MB. [2026-03-02T00:42:40.749Z] ====== log-regression (apache-spark) [default], iteration 15 completed (3093.556 ms) ====== [2026-03-02T00:42:40.749Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-03-02T00:42:40.749Z] GC before operation: completed in 198.448 ms, heap usage 282.169 MB -> 119.139 MB. [2026-03-02T00:42:43.777Z] ====== log-regression (apache-spark) [default], iteration 16 completed (3080.224 ms) ====== [2026-03-02T00:42:43.777Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-03-02T00:42:43.777Z] GC before operation: completed in 181.543 ms, heap usage 247.203 MB -> 119.158 MB. [2026-03-02T00:42:46.780Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2500.001 ms) ====== [2026-03-02T00:42:46.780Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-03-02T00:42:46.780Z] GC before operation: completed in 200.185 ms, heap usage 315.116 MB -> 119.585 MB. [2026-03-02T00:42:49.606Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2877.602 ms) ====== [2026-03-02T00:42:49.606Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-03-02T00:42:49.606Z] GC before operation: completed in 227.037 ms, heap usage 357.660 MB -> 119.929 MB. [2026-03-02T00:42:52.677Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2547.006 ms) ====== [2026-03-02T00:42:52.677Z] ----------------------------------- [2026-03-02T00:42:52.677Z] renaissance-log-regression_0_PASSED [2026-03-02T00:42:52.677Z] ----------------------------------- [2026-03-02T00:42:53.001Z] [2026-03-02T00:42:53.001Z] TEST TEARDOWN: [2026-03-02T00:42:53.001Z] Nothing to be done for teardown. [2026-03-02T00:42:53.001Z] renaissance-log-regression_0 Finish Time: Mon Mar 2 00:42:52 2026 Epoch Time (ms): 1772412172788