[2026-01-21T01:48:52.949Z] Running test renaissance-log-regression_0 ... [2026-01-21T01:48:52.949Z] =============================================== [2026-01-21T01:48:52.949Z] renaissance-log-regression_0 Start Time: Wed Jan 21 01:48:52 2026 Epoch Time (ms): 1768960132399 [2026-01-21T01:48:52.949Z] variation: NoOptions [2026-01-21T01:48:52.949Z] JVM_OPTIONS: [2026-01-21T01:48:52.949Z] { \ [2026-01-21T01:48:52.949Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T01:48:52.949Z] echo "Nothing to be done for setup."; \ [2026-01-21T01:48:52.949Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17689589059458/renaissance-log-regression_0"; \ [2026-01-21T01:48:52.949Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17689589059458/renaissance-log-regression_0"; \ [2026-01-21T01:48:52.949Z] echo ""; echo "TESTING:"; \ [2026-01-21T01:48:52.950Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17689589059458/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-01-21T01:48:52.950Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17689589059458/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T01:48:52.950Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T01:48:52.950Z] echo "Nothing to be done for teardown."; \ [2026-01-21T01:48:52.950Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17689589059458/TestTargetResult"; [2026-01-21T01:48:52.950Z] [2026-01-21T01:48:52.950Z] TEST SETUP: [2026-01-21T01:48:52.950Z] Nothing to be done for setup. [2026-01-21T01:48:52.950Z] [2026-01-21T01:48:52.950Z] TESTING: [2026-01-21T01:48:57.877Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-01-21T01:48:59.244Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-21T01:48:59.881Z] GC before operation: completed in 88.755 ms, heap usage 50.249 MB -> 35.024 MB. [2026-01-21T01:49:14.892Z] ====== log-regression (apache-spark) [default], iteration 0 completed (14806.195 ms) ====== [2026-01-21T01:49:14.892Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-21T01:49:14.892Z] GC before operation: completed in 162.722 ms, heap usage 466.382 MB -> 117.478 MB. [2026-01-21T01:49:18.879Z] ====== log-regression (apache-spark) [default], iteration 1 completed (4020.391 ms) ====== [2026-01-21T01:49:18.879Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-21T01:49:18.879Z] GC before operation: completed in 157.242 ms, heap usage 352.763 MB -> 117.444 MB. [2026-01-21T01:49:22.845Z] ====== log-regression (apache-spark) [default], iteration 2 completed (4306.745 ms) ====== [2026-01-21T01:49:22.845Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-21T01:49:23.560Z] GC before operation: completed in 175.273 ms, heap usage 231.207 MB -> 117.531 MB. [2026-01-21T01:49:27.546Z] ====== log-regression (apache-spark) [default], iteration 3 completed (4048.507 ms) ====== [2026-01-21T01:49:27.546Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-21T01:49:27.546Z] GC before operation: completed in 147.702 ms, heap usage 319.161 MB -> 118.175 MB. [2026-01-21T01:49:30.571Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3337.366 ms) ====== [2026-01-21T01:49:30.571Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-21T01:49:30.571Z] GC before operation: completed in 109.230 ms, heap usage 576.926 MB -> 119.300 MB. [2026-01-21T01:49:34.489Z] ====== log-regression (apache-spark) [default], iteration 5 completed (3597.089 ms) ====== [2026-01-21T01:49:34.489Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-21T01:49:34.489Z] GC before operation: completed in 148.165 ms, heap usage 266.983 MB -> 118.367 MB. [2026-01-21T01:49:38.510Z] ====== log-regression (apache-spark) [default], iteration 6 completed (3323.407 ms) ====== [2026-01-21T01:49:38.510Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-21T01:49:38.510Z] GC before operation: completed in 114.696 ms, heap usage 202.104 MB -> 118.535 MB. [2026-01-21T01:49:40.821Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2953.378 ms) ====== [2026-01-21T01:49:40.821Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-21T01:49:40.821Z] GC before operation: completed in 109.582 ms, heap usage 177.471 MB -> 118.611 MB. [2026-01-21T01:49:44.675Z] ====== log-regression (apache-spark) [default], iteration 8 completed (3166.966 ms) ====== [2026-01-21T01:49:44.675Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-21T01:49:44.675Z] GC before operation: completed in 123.815 ms, heap usage 560.148 MB -> 120.166 MB. [2026-01-21T01:49:46.831Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2698.349 ms) ====== [2026-01-21T01:49:46.831Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-21T01:49:47.474Z] GC before operation: completed in 101.921 ms, heap usage 363.425 MB -> 119.429 MB. [2026-01-21T01:49:50.449Z] ====== log-regression (apache-spark) [default], iteration 10 completed (3063.460 ms) ====== [2026-01-21T01:49:50.449Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-21T01:49:50.449Z] GC before operation: completed in 152.739 ms, heap usage 289.335 MB -> 119.396 MB. [2026-01-21T01:49:53.492Z] ====== log-regression (apache-spark) [default], iteration 11 completed (3348.175 ms) ====== [2026-01-21T01:49:53.493Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-21T01:49:54.139Z] GC before operation: completed in 177.232 ms, heap usage 272.098 MB -> 119.563 MB. [2026-01-21T01:49:57.207Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3338.367 ms) ====== [2026-01-21T01:49:57.207Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-21T01:49:57.207Z] GC before operation: completed in 130.317 ms, heap usage 273.286 MB -> 119.662 MB. [2026-01-21T01:50:01.179Z] ====== log-regression (apache-spark) [default], iteration 13 completed (3410.363 ms) ====== [2026-01-21T01:50:01.179Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-21T01:50:01.179Z] GC before operation: completed in 148.305 ms, heap usage 295.807 MB -> 119.908 MB. [2026-01-21T01:50:04.179Z] ====== log-regression (apache-spark) [default], iteration 14 completed (3106.763 ms) ====== [2026-01-21T01:50:04.179Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-21T01:50:04.179Z] GC before operation: completed in 194.159 ms, heap usage 242.669 MB -> 119.948 MB. [2026-01-21T01:50:08.187Z] ====== log-regression (apache-spark) [default], iteration 15 completed (3472.001 ms) ====== [2026-01-21T01:50:08.187Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-21T01:50:08.187Z] GC before operation: completed in 170.177 ms, heap usage 513.257 MB -> 121.191 MB. [2026-01-21T01:50:11.165Z] ====== log-regression (apache-spark) [default], iteration 16 completed (3073.296 ms) ====== [2026-01-21T01:50:11.165Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-21T01:50:11.165Z] GC before operation: completed in 115.427 ms, heap usage 250.307 MB -> 120.312 MB. [2026-01-21T01:50:14.253Z] ====== log-regression (apache-spark) [default], iteration 17 completed (3265.277 ms) ====== [2026-01-21T01:50:14.253Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-21T01:50:14.253Z] GC before operation: completed in 126.509 ms, heap usage 230.583 MB -> 120.570 MB. [2026-01-21T01:50:18.139Z] ====== log-regression (apache-spark) [default], iteration 18 completed (3399.882 ms) ====== [2026-01-21T01:50:18.139Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-21T01:50:18.139Z] GC before operation: completed in 117.102 ms, heap usage 155.721 MB -> 121.977 MB. [2026-01-21T01:50:20.961Z] ====== log-regression (apache-spark) [default], iteration 19 completed (3198.059 ms) ====== [2026-01-21T01:50:21.628Z] ----------------------------------- [2026-01-21T01:50:21.628Z] renaissance-log-regression_0_PASSED [2026-01-21T01:50:21.628Z] ----------------------------------- [2026-01-21T01:50:21.628Z] [2026-01-21T01:50:21.628Z] TEST TEARDOWN: [2026-01-21T01:50:21.628Z] Nothing to be done for teardown. [2026-01-21T01:50:21.628Z] renaissance-log-regression_0 Finish Time: Wed Jan 21 01:50:21 2026 Epoch Time (ms): 1768960221232