[2026-04-22T15:50:44.690Z] Running test renaissance-log-regression_0 ... [2026-04-22T15:50:44.690Z] =============================================== [2026-04-22T15:50:44.690Z] renaissance-log-regression_0 Start Time: Wed Apr 22 15:50:43 2026 Epoch Time (ms): 1776873043867 [2026-04-22T15:50:44.690Z] variation: NoOptions [2026-04-22T15:50:44.690Z] JVM_OPTIONS: [2026-04-22T15:50:44.690Z] { \ [2026-04-22T15:50:44.690Z] echo ""; echo "TEST SETUP:"; \ [2026-04-22T15:50:44.690Z] echo "Nothing to be done for setup."; \ [2026-04-22T15:50:44.690Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768718878509/renaissance-log-regression_0"; \ [2026-04-22T15:50:44.690Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768718878509/renaissance-log-regression_0"; \ [2026-04-22T15:50:44.690Z] echo ""; echo "TESTING:"; \ [2026-04-22T15:50:44.690Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-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_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768718878509/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-04-22T15:50:44.691Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768718878509/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-22T15:50:44.691Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-22T15:50:44.691Z] echo "Nothing to be done for teardown."; \ [2026-04-22T15:50:44.691Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17768718878509/TestTargetResult"; [2026-04-22T15:50:44.691Z] [2026-04-22T15:50:44.691Z] TEST SETUP: [2026-04-22T15:50:44.691Z] Nothing to be done for setup. [2026-04-22T15:50:44.691Z] [2026-04-22T15:50:44.691Z] TESTING: [2026-04-22T15:50:54.259Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-22T15:50:58.530Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-04-22T15:50:58.530Z] GC before operation: completed in 152.439 ms, heap usage 67.000 MB -> 35.061 MB. [2026-04-22T15:51:24.764Z] ====== log-regression (apache-spark) [default], iteration 0 completed (25488.757 ms) ====== [2026-04-22T15:51:24.764Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-04-22T15:51:24.764Z] GC before operation: completed in 146.494 ms, heap usage 493.302 MB -> 120.168 MB. [2026-04-22T15:51:30.378Z] ====== log-regression (apache-spark) [default], iteration 1 completed (5983.132 ms) ====== [2026-04-22T15:51:30.378Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-04-22T15:51:30.378Z] GC before operation: completed in 189.225 ms, heap usage 562.348 MB -> 120.916 MB. [2026-04-22T15:51:34.710Z] ====== log-regression (apache-spark) [default], iteration 2 completed (4651.978 ms) ====== [2026-04-22T15:51:34.710Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-04-22T15:51:35.452Z] GC before operation: completed in 193.405 ms, heap usage 235.967 MB -> 120.421 MB. [2026-04-22T15:51:39.751Z] ====== log-regression (apache-spark) [default], iteration 3 completed (4105.361 ms) ====== [2026-04-22T15:51:39.751Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-04-22T15:51:39.751Z] GC before operation: completed in 160.151 ms, heap usage 399.752 MB -> 121.068 MB. [2026-04-22T15:51:43.029Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3678.765 ms) ====== [2026-04-22T15:51:43.029Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-04-22T15:51:43.029Z] GC before operation: completed in 179.591 ms, heap usage 361.674 MB -> 121.256 MB. [2026-04-22T15:51:47.327Z] ====== log-regression (apache-spark) [default], iteration 5 completed (3443.347 ms) ====== [2026-04-22T15:51:47.327Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-04-22T15:51:47.327Z] GC before operation: completed in 187.779 ms, heap usage 585.870 MB -> 122.079 MB. [2026-04-22T15:51:50.600Z] ====== log-regression (apache-spark) [default], iteration 6 completed (3299.091 ms) ====== [2026-04-22T15:51:50.600Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-04-22T15:51:50.600Z] GC before operation: completed in 228.340 ms, heap usage 561.442 MB -> 122.231 MB. [2026-04-22T15:51:53.891Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3372.935 ms) ====== [2026-04-22T15:51:53.891Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-04-22T15:51:53.891Z] GC before operation: completed in 189.074 ms, heap usage 706.456 MB -> 122.932 MB. [2026-04-22T15:51:58.179Z] ====== log-regression (apache-spark) [default], iteration 8 completed (3451.925 ms) ====== [2026-04-22T15:51:58.179Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-04-22T15:51:58.179Z] GC before operation: completed in 209.208 ms, heap usage 640.186 MB -> 123.894 MB. [2026-04-22T15:52:01.476Z] ====== log-regression (apache-spark) [default], iteration 9 completed (3323.140 ms) ====== [2026-04-22T15:52:01.476Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-04-22T15:52:01.476Z] GC before operation: completed in 194.902 ms, heap usage 250.055 MB -> 121.945 MB. [2026-04-22T15:52:04.757Z] ====== log-regression (apache-spark) [default], iteration 10 completed (3659.563 ms) ====== [2026-04-22T15:52:04.757Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-04-22T15:52:04.757Z] GC before operation: completed in 178.687 ms, heap usage 738.221 MB -> 123.687 MB. [2026-04-22T15:52:08.068Z] ====== log-regression (apache-spark) [default], iteration 11 completed (3105.995 ms) ====== [2026-04-22T15:52:08.068Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-04-22T15:52:08.068Z] GC before operation: completed in 186.095 ms, heap usage 632.503 MB -> 123.569 MB. [2026-04-22T15:52:11.459Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3177.318 ms) ====== [2026-04-22T15:52:11.459Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-04-22T15:52:11.459Z] GC before operation: completed in 162.115 ms, heap usage 577.315 MB -> 123.478 MB. [2026-04-22T15:52:14.825Z] ====== log-regression (apache-spark) [default], iteration 13 completed (3218.565 ms) ====== [2026-04-22T15:52:14.825Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-04-22T15:52:14.825Z] GC before operation: completed in 170.439 ms, heap usage 278.696 MB -> 122.823 MB. [2026-04-22T15:52:18.218Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2938.472 ms) ====== [2026-04-22T15:52:18.218Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-04-22T15:52:18.218Z] GC before operation: completed in 209.678 ms, heap usage 472.817 MB -> 123.640 MB. [2026-04-22T15:52:21.624Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2976.645 ms) ====== [2026-04-22T15:52:21.625Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-04-22T15:52:21.625Z] GC before operation: completed in 207.745 ms, heap usage 657.412 MB -> 124.397 MB. [2026-04-22T15:52:25.007Z] ====== log-regression (apache-spark) [default], iteration 16 completed (3206.497 ms) ====== [2026-04-22T15:52:25.007Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-04-22T15:52:25.007Z] GC before operation: completed in 221.066 ms, heap usage 433.602 MB -> 124.022 MB. [2026-04-22T15:52:28.381Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2919.719 ms) ====== [2026-04-22T15:52:28.381Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-04-22T15:52:28.381Z] GC before operation: completed in 221.007 ms, heap usage 352.404 MB -> 124.014 MB. [2026-04-22T15:52:30.817Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2861.275 ms) ====== [2026-04-22T15:52:30.817Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-04-22T15:52:30.817Z] GC before operation: completed in 193.047 ms, heap usage 735.821 MB -> 125.250 MB. [2026-04-22T15:52:34.184Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2869.362 ms) ====== [2026-04-22T15:52:34.942Z] ----------------------------------- [2026-04-22T15:52:34.942Z] renaissance-log-regression_0_PASSED [2026-04-22T15:52:34.942Z] ----------------------------------- [2026-04-22T15:52:34.942Z] [2026-04-22T15:52:34.942Z] TEST TEARDOWN: [2026-04-22T15:52:34.942Z] Nothing to be done for teardown. [2026-04-22T15:52:34.942Z] renaissance-log-regression_0 Finish Time: Wed Apr 22 15:52:34 2026 Epoch Time (ms): 1776873154187