[2026-01-15T02:26:25.748Z] Running test renaissance-log-regression_0 ... [2026-01-15T02:26:26.090Z] =============================================== [2026-01-15T02:26:26.439Z] renaissance-log-regression_0 Start Time: Thu Jan 15 02:26:26 2026 Epoch Time (ms): 1768443986212 [2026-01-15T02:26:26.439Z] variation: NoOptions [2026-01-15T02:26:26.439Z] JVM_OPTIONS: [2026-01-15T02:26:26.439Z] { \ [2026-01-15T02:26:26.439Z] echo ""; echo "TEST SETUP:"; \ [2026-01-15T02:26:26.439Z] echo "Nothing to be done for setup."; \ [2026-01-15T02:26:26.439Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17684418026734\\renaissance-log-regression_0"; \ [2026-01-15T02:26:26.439Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17684418026734\\renaissance-log-regression_0"; \ [2026-01-15T02:26:26.439Z] echo ""; echo "TESTING:"; \ [2026-01-15T02:26:26.439Z] "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_17684418026734\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2026-01-15T02:26:26.439Z] 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_17684418026734\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-15T02:26:26.439Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-15T02:26:26.439Z] echo "Nothing to be done for teardown."; \ [2026-01-15T02:26:26.439Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17684418026734\\TestTargetResult"; [2026-01-15T02:26:26.807Z] [2026-01-15T02:26:26.807Z] TEST SETUP: [2026-01-15T02:26:26.807Z] Nothing to be done for setup. [2026-01-15T02:26:26.807Z] [2026-01-15T02:26:26.807Z] TESTING: [2026-01-15T02:26:42.861Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-15T02:26:42.861Z] WARNING: An illegal reflective access operation has occurred [2026-01-15T02:26:42.861Z] 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_17684418026734/renaissance-log-regression_0/harness-022627-2836698955457962854/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-01-15T02:26:42.861Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-01-15T02:26:42.861Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-01-15T02:26:42.861Z] WARNING: All illegal access operations will be denied in a future release [2026-01-15T02:26:44.596Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-15T02:26:44.596Z] GC before operation: completed in 59.456 ms, heap usage 79.619 MB -> 34.912 MB. [2026-01-15T02:26:58.387Z] ====== log-regression (apache-spark) [default], iteration 0 completed (12336.642 ms) ====== [2026-01-15T02:26:58.387Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-15T02:26:58.387Z] GC before operation: completed in 137.212 ms, heap usage 413.050 MB -> 119.210 MB. [2026-01-15T02:27:01.003Z] ====== log-regression (apache-spark) [default], iteration 1 completed (4231.822 ms) ====== [2026-01-15T02:27:01.003Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-15T02:27:01.469Z] GC before operation: completed in 149.484 ms, heap usage 259.364 MB -> 119.412 MB. [2026-01-15T02:27:04.846Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3079.039 ms) ====== [2026-01-15T02:27:04.846Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-15T02:27:04.846Z] GC before operation: completed in 121.058 ms, heap usage 238.105 MB -> 119.710 MB. [2026-01-15T02:27:06.644Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1966.799 ms) ====== [2026-01-15T02:27:06.644Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-15T02:27:06.644Z] GC before operation: completed in 125.929 ms, heap usage 236.234 MB -> 119.962 MB. [2026-01-15T02:27:08.486Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1931.283 ms) ====== [2026-01-15T02:27:08.486Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-15T02:27:08.486Z] GC before operation: completed in 110.102 ms, heap usage 256.472 MB -> 120.183 MB. [2026-01-15T02:27:10.351Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1822.187 ms) ====== [2026-01-15T02:27:10.351Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-15T02:27:10.351Z] GC before operation: completed in 134.272 ms, heap usage 348.473 MB -> 120.684 MB. [2026-01-15T02:27:12.262Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1803.114 ms) ====== [2026-01-15T02:27:12.262Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-15T02:27:12.684Z] GC before operation: completed in 129.478 ms, heap usage 400.129 MB -> 121.064 MB. [2026-01-15T02:27:14.015Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1666.071 ms) ====== [2026-01-15T02:27:14.015Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-15T02:27:14.419Z] GC before operation: completed in 138.292 ms, heap usage 425.742 MB -> 121.264 MB. [2026-01-15T02:27:15.813Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1667.607 ms) ====== [2026-01-15T02:27:15.813Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-15T02:27:16.202Z] GC before operation: completed in 131.235 ms, heap usage 285.203 MB -> 121.071 MB. [2026-01-15T02:27:18.018Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1732.556 ms) ====== [2026-01-15T02:27:18.018Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-15T02:27:18.018Z] GC before operation: completed in 133.705 ms, heap usage 421.990 MB -> 121.693 MB. [2026-01-15T02:27:19.905Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1584.762 ms) ====== [2026-01-15T02:27:19.905Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-15T02:27:19.905Z] GC before operation: completed in 126.827 ms, heap usage 346.108 MB -> 121.723 MB. [2026-01-15T02:27:21.792Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1760.601 ms) ====== [2026-01-15T02:27:21.792Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-15T02:27:21.792Z] GC before operation: completed in 120.862 ms, heap usage 237.457 MB -> 121.589 MB. [2026-01-15T02:27:23.693Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1723.903 ms) ====== [2026-01-15T02:27:23.693Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-15T02:27:23.693Z] GC before operation: completed in 135.496 ms, heap usage 288.589 MB -> 121.954 MB. [2026-01-15T02:27:24.989Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1716.847 ms) ====== [2026-01-15T02:27:24.989Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-15T02:27:25.416Z] GC before operation: completed in 131.418 ms, heap usage 301.880 MB -> 122.147 MB. [2026-01-15T02:27:27.260Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1764.450 ms) ====== [2026-01-15T02:27:27.260Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-15T02:27:27.260Z] GC before operation: completed in 123.694 ms, heap usage 239.285 MB -> 122.185 MB. [2026-01-15T02:27:29.028Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1668.543 ms) ====== [2026-01-15T02:27:29.028Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-15T02:27:29.028Z] GC before operation: completed in 128.111 ms, heap usage 255.630 MB -> 122.424 MB. [2026-01-15T02:27:30.814Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1636.220 ms) ====== [2026-01-15T02:27:30.814Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-15T02:27:30.814Z] GC before operation: completed in 124.701 ms, heap usage 246.794 MB -> 122.606 MB. [2026-01-15T02:27:32.576Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1622.502 ms) ====== [2026-01-15T02:27:32.576Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-15T02:27:32.576Z] GC before operation: completed in 124.391 ms, heap usage 339.815 MB -> 123.138 MB. [2026-01-15T02:27:33.869Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1408.518 ms) ====== [2026-01-15T02:27:33.869Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-15T02:27:33.869Z] GC before operation: completed in 146.002 ms, heap usage 418.723 MB -> 123.503 MB. [2026-01-15T02:27:35.800Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1620.397 ms) ====== [2026-01-15T02:27:36.151Z] ----------------------------------- [2026-01-15T02:27:36.151Z] renaissance-log-regression_0_PASSED [2026-01-15T02:27:36.151Z] ----------------------------------- [2026-01-15T02:27:36.151Z] [2026-01-15T02:27:36.151Z] TEST TEARDOWN: [2026-01-15T02:27:36.151Z] Nothing to be done for teardown. [2026-01-15T02:27:36.492Z] renaissance-log-regression_0 Finish Time: Thu Jan 15 02:27:36 2026 Epoch Time (ms): 1768444056187