[2026-04-06T21:27:13.801Z] Running test renaissance-log-regression_0 ... [2026-04-06T21:27:13.801Z] =============================================== [2026-04-06T21:27:13.801Z] renaissance-log-regression_0 Start Time: Mon Apr 6 21:27:13 2026 Epoch Time (ms): 1775510833587 [2026-04-06T21:27:13.801Z] variation: NoOptions [2026-04-06T21:27:13.801Z] JVM_OPTIONS: [2026-04-06T21:27:13.801Z] { \ [2026-04-06T21:27:13.801Z] echo ""; echo "TEST SETUP:"; \ [2026-04-06T21:27:13.801Z] echo "Nothing to be done for setup."; \ [2026-04-06T21:27:13.801Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17755099715063/renaissance-log-regression_0"; \ [2026-04-06T21:27:13.801Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17755099715063/renaissance-log-regression_0"; \ [2026-04-06T21:27:13.801Z] echo ""; echo "TESTING:"; \ [2026-04-06T21:27:13.801Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/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 "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17755099715063/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-04-06T21:27:13.801Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17755099715063/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-06T21:27:13.801Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-06T21:27:13.801Z] echo "Nothing to be done for teardown."; \ [2026-04-06T21:27:13.801Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17755099715063/TestTargetResult"; [2026-04-06T21:27:13.801Z] [2026-04-06T21:27:13.801Z] TEST SETUP: [2026-04-06T21:27:13.801Z] Nothing to be done for setup. [2026-04-06T21:27:13.801Z] [2026-04-06T21:27:13.801Z] TESTING: [2026-04-06T21:27:19.682Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-06T21:27:20.003Z] WARNING: An illegal reflective access operation has occurred [2026-04-06T21:27:20.003Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_17755099715063/renaissance-log-regression_0/harness-212714-2298213355635737031/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-04-06T21:27:20.003Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-04-06T21:27:20.003Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-04-06T21:27:20.003Z] WARNING: All illegal access operations will be denied in a future release [2026-04-06T21:27:21.618Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-04-06T21:27:21.618Z] GC before operation: completed in 76.298 ms, heap usage 124.012 MB -> 34.439 MB. [2026-04-06T21:27:34.654Z] ====== log-regression (apache-spark) [default], iteration 0 completed (12149.241 ms) ====== [2026-04-06T21:27:34.654Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-04-06T21:27:34.654Z] GC before operation: completed in 166.942 ms, heap usage 345.261 MB -> 118.541 MB. [2026-04-06T21:27:36.870Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2881.141 ms) ====== [2026-04-06T21:27:36.870Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-04-06T21:27:36.870Z] GC before operation: completed in 139.558 ms, heap usage 322.782 MB -> 119.019 MB. [2026-04-06T21:27:39.793Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2558.329 ms) ====== [2026-04-06T21:27:39.793Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-04-06T21:27:39.793Z] GC before operation: completed in 139.954 ms, heap usage 408.449 MB -> 119.668 MB. [2026-04-06T21:27:41.432Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2119.904 ms) ====== [2026-04-06T21:27:41.432Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-04-06T21:27:41.754Z] GC before operation: completed in 198.018 ms, heap usage 239.725 MB -> 119.410 MB. [2026-04-06T21:27:43.979Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1990.989 ms) ====== [2026-04-06T21:27:43.979Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-04-06T21:27:43.979Z] GC before operation: completed in 140.851 ms, heap usage 406.956 MB -> 120.127 MB. [2026-04-06T21:27:46.207Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2055.132 ms) ====== [2026-04-06T21:27:46.207Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-04-06T21:27:46.207Z] GC before operation: completed in 129.679 ms, heap usage 310.520 MB -> 119.997 MB. [2026-04-06T21:27:49.542Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1700.090 ms) ====== [2026-04-06T21:27:49.542Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-04-06T21:27:49.542Z] GC before operation: completed in 130.057 ms, heap usage 295.396 MB -> 120.196 MB. [2026-04-06T21:27:49.862Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1789.258 ms) ====== [2026-04-06T21:27:49.862Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-04-06T21:27:49.862Z] GC before operation: completed in 158.433 ms, heap usage 384.050 MB -> 120.637 MB. [2026-04-06T21:27:51.505Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1767.752 ms) ====== [2026-04-06T21:27:51.505Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-04-06T21:27:51.823Z] GC before operation: completed in 132.900 ms, heap usage 298.977 MB -> 120.621 MB. [2026-04-06T21:27:53.445Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1557.507 ms) ====== [2026-04-06T21:27:53.445Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-04-06T21:27:53.445Z] GC before operation: completed in 153.350 ms, heap usage 397.428 MB -> 121.163 MB. [2026-04-06T21:27:55.087Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1754.637 ms) ====== [2026-04-06T21:27:55.087Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-04-06T21:27:55.405Z] GC before operation: completed in 144.769 ms, heap usage 265.475 MB -> 120.943 MB. [2026-04-06T21:27:57.065Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1772.905 ms) ====== [2026-04-06T21:27:57.065Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-04-06T21:27:57.384Z] GC before operation: completed in 135.141 ms, heap usage 287.715 MB -> 121.222 MB. [2026-04-06T21:27:59.002Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1590.416 ms) ====== [2026-04-06T21:27:59.002Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-04-06T21:27:59.002Z] GC before operation: completed in 152.965 ms, heap usage 411.818 MB -> 121.764 MB. [2026-04-06T21:28:01.225Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1778.446 ms) ====== [2026-04-06T21:28:01.225Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-04-06T21:28:01.225Z] GC before operation: completed in 149.589 ms, heap usage 310.550 MB -> 121.632 MB. [2026-04-06T21:28:02.846Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1624.777 ms) ====== [2026-04-06T21:28:02.846Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-04-06T21:28:02.846Z] GC before operation: completed in 162.096 ms, heap usage 282.919 MB -> 121.748 MB. [2026-04-06T21:28:04.492Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1680.240 ms) ====== [2026-04-06T21:28:04.492Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-04-06T21:28:04.492Z] GC before operation: completed in 142.306 ms, heap usage 396.410 MB -> 122.365 MB. [2026-04-06T21:28:06.119Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1688.848 ms) ====== [2026-04-06T21:28:06.119Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-04-06T21:28:06.467Z] GC before operation: completed in 133.036 ms, heap usage 428.669 MB -> 122.661 MB. [2026-04-06T21:28:08.088Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1796.117 ms) ====== [2026-04-06T21:28:08.088Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-04-06T21:28:08.412Z] GC before operation: completed in 144.878 ms, heap usage 264.090 MB -> 122.365 MB. [2026-04-06T21:28:10.045Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1529.832 ms) ====== [2026-04-06T21:28:10.045Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-04-06T21:28:10.045Z] GC before operation: completed in 162.946 ms, heap usage 287.909 MB -> 122.643 MB. [2026-04-06T21:28:11.663Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1754.420 ms) ====== [2026-04-06T21:28:12.478Z] ----------------------------------- [2026-04-06T21:28:12.478Z] renaissance-log-regression_0_PASSED [2026-04-06T21:28:12.478Z] ----------------------------------- [2026-04-06T21:28:12.478Z] [2026-04-06T21:28:12.478Z] TEST TEARDOWN: [2026-04-06T21:28:12.478Z] Nothing to be done for teardown. [2026-04-06T21:28:12.478Z] renaissance-log-regression_0 Finish Time: Mon Apr 6 21:28:12 2026 Epoch Time (ms): 1775510892107