[2026-01-18T21:58:00.111Z] Running test renaissance-log-regression_0 ... [2026-01-18T21:58:00.111Z] =============================================== [2026-01-18T21:58:00.111Z] renaissance-log-regression_0 Start Time: Sun Jan 18 21:57:59 2026 Epoch Time (ms): 1768773479474 [2026-01-18T21:58:00.111Z] variation: NoOptions [2026-01-18T21:58:00.111Z] JVM_OPTIONS: [2026-01-18T21:58:00.111Z] { \ [2026-01-18T21:58:00.111Z] echo ""; echo "TEST SETUP:"; \ [2026-01-18T21:58:00.111Z] echo "Nothing to be done for setup."; \ [2026-01-18T21:58:00.111Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17687716655643/renaissance-log-regression_0"; \ [2026-01-18T21:58:00.111Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17687716655643/renaissance-log-regression_0"; \ [2026-01-18T21:58:00.111Z] echo ""; echo "TESTING:"; \ [2026-01-18T21:58:00.111Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17687716655643/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-01-18T21:58:00.111Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17687716655643/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-18T21:58:00.111Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-18T21:58:00.111Z] echo "Nothing to be done for teardown."; \ [2026-01-18T21:58:00.111Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17687716655643/TestTargetResult"; [2026-01-18T21:58:00.111Z] [2026-01-18T21:58:00.111Z] TEST SETUP: [2026-01-18T21:58:00.111Z] Nothing to be done for setup. [2026-01-18T21:58:00.111Z] [2026-01-18T21:58:00.111Z] TESTING: [2026-01-18T21:58:04.967Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-01-18T21:58:07.063Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-18T21:58:07.063Z] GC before operation: completed in 44.559 ms, heap usage 37.974 MB -> 34.887 MB. [2026-01-18T21:58:19.509Z] ====== log-regression (apache-spark) [default], iteration 0 completed (12268.610 ms) ====== [2026-01-18T21:58:19.509Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-18T21:58:19.509Z] GC before operation: completed in 125.363 ms, heap usage 523.065 MB -> 117.347 MB. [2026-01-18T21:58:22.455Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3312.381 ms) ====== [2026-01-18T21:58:22.455Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-18T21:58:23.253Z] GC before operation: completed in 88.141 ms, heap usage 175.628 MB -> 116.811 MB. [2026-01-18T21:58:27.166Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3842.000 ms) ====== [2026-01-18T21:58:27.166Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-18T21:58:27.166Z] GC before operation: completed in 90.244 ms, heap usage 258.234 MB -> 117.365 MB. [2026-01-18T21:58:29.269Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2742.761 ms) ====== [2026-01-18T21:58:29.270Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-18T21:58:29.270Z] GC before operation: completed in 89.345 ms, heap usage 281.934 MB -> 117.737 MB. [2026-01-18T21:58:32.200Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2394.198 ms) ====== [2026-01-18T21:58:32.200Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-18T21:58:32.200Z] GC before operation: completed in 97.724 ms, heap usage 305.645 MB -> 118.059 MB. [2026-01-18T21:58:35.128Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2571.844 ms) ====== [2026-01-18T21:58:35.128Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-18T21:58:35.128Z] GC before operation: completed in 93.506 ms, heap usage 285.163 MB -> 118.176 MB. [2026-01-18T21:58:37.228Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2066.016 ms) ====== [2026-01-18T21:58:37.228Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-18T21:58:37.228Z] GC before operation: completed in 97.419 ms, heap usage 572.350 MB -> 119.647 MB. [2026-01-18T21:58:39.343Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2228.554 ms) ====== [2026-01-18T21:58:39.343Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-18T21:58:39.343Z] GC before operation: completed in 98.676 ms, heap usage 330.985 MB -> 118.769 MB. [2026-01-18T21:58:41.445Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2046.369 ms) ====== [2026-01-18T21:58:41.445Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-18T21:58:41.445Z] GC before operation: completed in 98.061 ms, heap usage 615.968 MB -> 120.065 MB. [2026-01-18T21:58:43.552Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2092.492 ms) ====== [2026-01-18T21:58:43.552Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-18T21:58:43.552Z] GC before operation: completed in 98.073 ms, heap usage 289.612 MB -> 118.974 MB. [2026-01-18T21:58:45.649Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2158.365 ms) ====== [2026-01-18T21:58:45.649Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-18T21:58:45.649Z] GC before operation: completed in 99.905 ms, heap usage 291.986 MB -> 119.159 MB. [2026-01-18T21:58:47.745Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2043.236 ms) ====== [2026-01-18T21:58:47.745Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-18T21:58:47.745Z] GC before operation: completed in 97.337 ms, heap usage 146.108 MB -> 119.091 MB. [2026-01-18T21:58:50.682Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2768.322 ms) ====== [2026-01-18T21:58:50.682Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-18T21:58:50.682Z] GC before operation: completed in 101.907 ms, heap usage 230.855 MB -> 119.433 MB. [2026-01-18T21:58:52.784Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2187.458 ms) ====== [2026-01-18T21:58:52.784Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-18T21:58:53.432Z] GC before operation: completed in 103.319 ms, heap usage 238.031 MB -> 119.514 MB. [2026-01-18T21:58:54.772Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1850.851 ms) ====== [2026-01-18T21:58:54.772Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-18T21:58:54.772Z] GC before operation: completed in 102.538 ms, heap usage 629.772 MB -> 121.163 MB. [2026-01-18T21:58:57.703Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2191.140 ms) ====== [2026-01-18T21:58:57.703Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-18T21:58:57.703Z] GC before operation: completed in 103.968 ms, heap usage 516.879 MB -> 120.970 MB. [2026-01-18T21:58:59.063Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1967.040 ms) ====== [2026-01-18T21:58:59.063Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-18T21:58:59.710Z] GC before operation: completed in 119.647 ms, heap usage 560.573 MB -> 121.320 MB. [2026-01-18T21:59:01.812Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1949.113 ms) ====== [2026-01-18T21:59:01.812Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-18T21:59:01.812Z] GC before operation: completed in 113.548 ms, heap usage 539.320 MB -> 121.457 MB. [2026-01-18T21:59:03.914Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2020.470 ms) ====== [2026-01-18T21:59:03.914Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-18T21:59:03.914Z] GC before operation: completed in 114.179 ms, heap usage 140.537 MB -> 120.343 MB. [2026-01-18T21:59:06.018Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2589.976 ms) ====== [2026-01-18T21:59:06.668Z] ----------------------------------- [2026-01-18T21:59:06.668Z] renaissance-log-regression_0_PASSED [2026-01-18T21:59:06.668Z] ----------------------------------- [2026-01-18T21:59:06.668Z] [2026-01-18T21:59:06.668Z] TEST TEARDOWN: [2026-01-18T21:59:06.668Z] Nothing to be done for teardown. [2026-01-18T21:59:06.668Z] renaissance-log-regression_0 Finish Time: Sun Jan 18 21:59:06 2026 Epoch Time (ms): 1768773546222