[2026-01-12T11:56:27.400Z] Running test renaissance-log-regression_0 ... [2026-01-12T11:56:27.400Z] =============================================== [2026-01-12T11:56:27.400Z] renaissance-log-regression_0 Start Time: Mon Jan 12 11:56:27 2026 Epoch Time (ms): 1768218987297 [2026-01-12T11:56:27.400Z] variation: NoOptions [2026-01-12T11:56:27.400Z] JVM_OPTIONS: [2026-01-12T11:56:27.400Z] { \ [2026-01-12T11:56:27.400Z] echo ""; echo "TEST SETUP:"; \ [2026-01-12T11:56:27.400Z] echo "Nothing to be done for setup."; \ [2026-01-12T11:56:27.400Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/aqa-tests/TKG/../TKG/output_17682147065077/renaissance-log-regression_0"; \ [2026-01-12T11:56:27.400Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/aqa-tests/TKG/../TKG/output_17682147065077/renaissance-log-regression_0"; \ [2026-01-12T11:56:27.400Z] echo ""; echo "TESTING:"; \ [2026-01-12T11:56:27.400Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/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_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/aqa-tests/TKG/../TKG/output_17682147065077/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-01-12T11:56:27.400Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/aqa-tests/TKG/../TKG/output_17682147065077/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-12T11:56:27.400Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-12T11:56:27.400Z] echo "Nothing to be done for teardown."; \ [2026-01-12T11:56:27.400Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1_rerun/aqa-tests/TKG/../TKG/output_17682147065077/TestTargetResult"; [2026-01-12T11:56:27.400Z] [2026-01-12T11:56:27.400Z] TEST SETUP: [2026-01-12T11:56:27.400Z] Nothing to be done for setup. [2026-01-12T11:56:27.400Z] [2026-01-12T11:56:27.400Z] TESTING: [2026-01-12T11:56:50.390Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-12T11:57:01.177Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-12T11:57:01.508Z] GC before operation: completed in 217.859 ms, heap usage 42.624 MB -> 36.567 MB. [2026-01-12T11:57:59.201Z] ====== log-regression (apache-spark) [default], iteration 0 completed (52327.631 ms) ====== [2026-01-12T11:57:59.201Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-12T11:57:59.201Z] GC before operation: completed in 503.339 ms, heap usage 262.831 MB -> 124.082 MB. [2026-01-12T11:58:06.608Z] ====== log-regression (apache-spark) [default], iteration 1 completed (11213.838 ms) ====== [2026-01-12T11:58:06.608Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-12T11:58:06.608Z] GC before operation: completed in 586.497 ms, heap usage 249.196 MB -> 124.492 MB. [2026-01-12T11:58:19.732Z] ====== log-regression (apache-spark) [default], iteration 2 completed (11948.980 ms) ====== [2026-01-12T11:58:19.732Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-12T11:58:19.732Z] GC before operation: completed in 583.972 ms, heap usage 263.813 MB -> 124.954 MB. [2026-01-12T11:58:26.972Z] ====== log-regression (apache-spark) [default], iteration 3 completed (7611.874 ms) ====== [2026-01-12T11:58:26.972Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-12T11:58:26.973Z] GC before operation: completed in 590.529 ms, heap usage 510.018 MB -> 126.018 MB. [2026-01-12T11:58:34.252Z] ====== log-regression (apache-spark) [default], iteration 4 completed (7063.942 ms) ====== [2026-01-12T11:58:34.253Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-12T11:58:34.583Z] GC before operation: completed in 690.982 ms, heap usage 283.386 MB -> 125.720 MB. [2026-01-12T11:58:41.834Z] ====== log-regression (apache-spark) [default], iteration 5 completed (7078.476 ms) ====== [2026-01-12T11:58:41.834Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-12T11:58:42.554Z] GC before operation: completed in 702.086 ms, heap usage 284.715 MB -> 125.877 MB. [2026-01-12T11:58:50.033Z] ====== log-regression (apache-spark) [default], iteration 6 completed (7148.442 ms) ====== [2026-01-12T11:58:50.033Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-12T11:58:50.359Z] GC before operation: completed in 706.172 ms, heap usage 407.434 MB -> 126.499 MB. [2026-01-12T11:58:57.607Z] ====== log-regression (apache-spark) [default], iteration 7 completed (6638.217 ms) ====== [2026-01-12T11:58:57.607Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-12T11:58:57.607Z] GC before operation: completed in 723.188 ms, heap usage 494.046 MB -> 126.881 MB. [2026-01-12T11:59:04.859Z] ====== log-regression (apache-spark) [default], iteration 8 completed (6642.925 ms) ====== [2026-01-12T11:59:04.859Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-12T11:59:04.859Z] GC before operation: completed in 743.850 ms, heap usage 318.509 MB -> 126.668 MB. [2026-01-12T11:59:12.124Z] ====== log-regression (apache-spark) [default], iteration 9 completed (6859.855 ms) ====== [2026-01-12T11:59:12.124Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-12T11:59:12.837Z] GC before operation: completed in 769.909 ms, heap usage 482.985 MB -> 127.379 MB. [2026-01-12T11:59:20.077Z] ====== log-regression (apache-spark) [default], iteration 10 completed (6459.271 ms) ====== [2026-01-12T11:59:20.077Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-12T11:59:20.077Z] GC before operation: completed in 774.984 ms, heap usage 303.701 MB -> 126.800 MB. [2026-01-12T11:59:27.362Z] ====== log-regression (apache-spark) [default], iteration 11 completed (6619.373 ms) ====== [2026-01-12T11:59:27.362Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-12T11:59:27.362Z] GC before operation: completed in 774.083 ms, heap usage 454.509 MB -> 127.569 MB. [2026-01-12T11:59:34.621Z] ====== log-regression (apache-spark) [default], iteration 12 completed (6425.340 ms) ====== [2026-01-12T11:59:34.621Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-12T11:59:34.621Z] GC before operation: completed in 787.188 ms, heap usage 277.558 MB -> 127.223 MB. [2026-01-12T11:59:41.879Z] ====== log-regression (apache-spark) [default], iteration 13 completed (6308.677 ms) ====== [2026-01-12T11:59:41.879Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-12T11:59:41.879Z] GC before operation: completed in 792.619 ms, heap usage 428.160 MB -> 127.916 MB. [2026-01-12T11:59:47.770Z] ====== log-regression (apache-spark) [default], iteration 14 completed (6088.852 ms) ====== [2026-01-12T11:59:47.770Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-12T11:59:48.493Z] GC before operation: completed in 811.434 ms, heap usage 279.902 MB -> 127.547 MB. [2026-01-12T11:59:55.757Z] ====== log-regression (apache-spark) [default], iteration 15 completed (6373.832 ms) ====== [2026-01-12T11:59:55.757Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-12T11:59:55.757Z] GC before operation: completed in 812.344 ms, heap usage 414.318 MB -> 128.240 MB. [2026-01-12T12:00:03.030Z] ====== log-regression (apache-spark) [default], iteration 16 completed (6176.638 ms) ====== [2026-01-12T12:00:03.030Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-12T12:00:03.030Z] GC before operation: completed in 835.217 ms, heap usage 470.495 MB -> 128.585 MB. [2026-01-12T12:00:09.078Z] ====== log-regression (apache-spark) [default], iteration 17 completed (6105.019 ms) ====== [2026-01-12T12:00:09.078Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-12T12:00:09.803Z] GC before operation: completed in 843.729 ms, heap usage 280.234 MB -> 128.379 MB. [2026-01-12T12:00:17.068Z] ====== log-regression (apache-spark) [default], iteration 18 completed (6259.264 ms) ====== [2026-01-12T12:00:17.068Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-12T12:00:17.068Z] GC before operation: completed in 854.202 ms, heap usage 381.706 MB -> 128.737 MB. [2026-01-12T12:00:24.319Z] ====== log-regression (apache-spark) [default], iteration 19 completed (6384.628 ms) ====== [2026-01-12T12:00:25.021Z] ----------------------------------- [2026-01-12T12:00:25.021Z] renaissance-log-regression_0_PASSED [2026-01-12T12:00:25.021Z] ----------------------------------- [2026-01-12T12:00:25.021Z] [2026-01-12T12:00:25.021Z] TEST TEARDOWN: [2026-01-12T12:00:25.021Z] Nothing to be done for teardown. [2026-01-12T12:00:25.021Z] renaissance-log-regression_0 Finish Time: Mon Jan 12 12:00:24 2026 Epoch Time (ms): 1768219224986