[2025-11-28T04:57:23.082Z] Running test renaissance-log-regression_0 ... [2025-11-28T04:57:23.082Z] =============================================== [2025-11-28T04:57:23.082Z] renaissance-log-regression_0 Start Time: Fri Nov 28 04:57:22 2025 Epoch Time (ms): 1764305842854 [2025-11-28T04:57:23.082Z] variation: NoOptions [2025-11-28T04:57:23.082Z] JVM_OPTIONS: [2025-11-28T04:57:23.082Z] { \ [2025-11-28T04:57:23.082Z] echo ""; echo "TEST SETUP:"; \ [2025-11-28T04:57:23.082Z] echo "Nothing to be done for setup."; \ [2025-11-28T04:57:23.082Z] mkdir -p "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-log-regression_0"; \ [2025-11-28T04:57:23.082Z] cd "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-log-regression_0"; \ [2025-11-28T04:57:23.082Z] echo ""; echo "TESTING:"; \ [2025-11-28T04:57:23.082Z] "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-11-28T04:57:23.082Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/..; rm -f -r "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-28T04:57:23.082Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-28T04:57:23.082Z] echo "Nothing to be done for teardown."; \ [2025-11-28T04:57:23.082Z] } 2>&1 | tee -a "/Users/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1_rerun/aqa-tests/TKG/../TKG/output_17643048823248/TestTargetResult"; [2025-11-28T04:57:23.082Z] [2025-11-28T04:57:23.082Z] TEST SETUP: [2025-11-28T04:57:23.082Z] Nothing to be done for setup. [2025-11-28T04:57:23.082Z] [2025-11-28T04:57:23.082Z] TESTING: [2025-11-28T04:57:29.204Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2025-11-28T04:57:32.303Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-11-28T04:57:32.303Z] GC before operation: completed in 48.296 ms, heap usage 50.474 MB -> 35.417 MB. [2025-11-28T04:57:48.550Z] ====== log-regression (apache-spark) [default], iteration 0 completed (14216.985 ms) ====== [2025-11-28T04:57:48.550Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-11-28T04:57:48.550Z] GC before operation: completed in 78.966 ms, heap usage 245.502 MB -> 126.137 MB. [2025-11-28T04:57:50.301Z] ====== log-regression (apache-spark) [default], iteration 1 completed (4141.974 ms) ====== [2025-11-28T04:57:50.301Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-11-28T04:57:50.301Z] GC before operation: completed in 79.331 ms, heap usage 629.380 MB -> 126.995 MB. [2025-11-28T04:57:54.290Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3667.013 ms) ====== [2025-11-28T04:57:54.290Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-11-28T04:57:54.290Z] GC before operation: completed in 86.042 ms, heap usage 549.883 MB -> 127.221 MB. [2025-11-28T04:57:58.255Z] ====== log-regression (apache-spark) [default], iteration 3 completed (3470.751 ms) ====== [2025-11-28T04:57:58.255Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-11-28T04:57:58.255Z] GC before operation: completed in 80.834 ms, heap usage 607.793 MB -> 127.784 MB. [2025-11-28T04:58:01.440Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3466.430 ms) ====== [2025-11-28T04:58:01.440Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-11-28T04:58:01.440Z] GC before operation: completed in 84.321 ms, heap usage 510.203 MB -> 128.001 MB. [2025-11-28T04:58:04.542Z] ====== log-regression (apache-spark) [default], iteration 5 completed (3415.036 ms) ====== [2025-11-28T04:58:04.542Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-11-28T04:58:04.935Z] GC before operation: completed in 82.385 ms, heap usage 465.323 MB -> 128.386 MB. [2025-11-28T04:58:08.056Z] ====== log-regression (apache-spark) [default], iteration 6 completed (3228.519 ms) ====== [2025-11-28T04:58:08.056Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-11-28T04:58:08.056Z] GC before operation: completed in 87.048 ms, heap usage 369.524 MB -> 128.767 MB. [2025-11-28T04:58:11.236Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3253.751 ms) ====== [2025-11-28T04:58:11.236Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-11-28T04:58:11.236Z] GC before operation: completed in 94.848 ms, heap usage 306.794 MB -> 129.145 MB. [2025-11-28T04:58:15.211Z] ====== log-regression (apache-spark) [default], iteration 8 completed (3350.236 ms) ====== [2025-11-28T04:58:15.211Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-11-28T04:58:15.211Z] GC before operation: completed in 88.423 ms, heap usage 673.085 MB -> 129.659 MB. [2025-11-28T04:58:18.323Z] ====== log-regression (apache-spark) [default], iteration 9 completed (3382.441 ms) ====== [2025-11-28T04:58:18.323Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-11-28T04:58:18.323Z] GC before operation: completed in 89.052 ms, heap usage 417.950 MB -> 129.927 MB. [2025-11-28T04:58:22.291Z] ====== log-regression (apache-spark) [default], iteration 10 completed (3301.615 ms) ====== [2025-11-28T04:58:22.291Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-11-28T04:58:22.292Z] GC before operation: completed in 87.289 ms, heap usage 639.080 MB -> 130.518 MB. [2025-11-28T04:58:25.446Z] ====== log-regression (apache-spark) [default], iteration 11 completed (3316.526 ms) ====== [2025-11-28T04:58:25.446Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-11-28T04:58:25.446Z] GC before operation: completed in 91.049 ms, heap usage 338.418 MB -> 130.625 MB. [2025-11-28T04:58:28.545Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3208.163 ms) ====== [2025-11-28T04:58:28.545Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-11-28T04:58:28.545Z] GC before operation: completed in 94.277 ms, heap usage 393.860 MB -> 130.902 MB. [2025-11-28T04:58:31.667Z] ====== log-regression (apache-spark) [default], iteration 13 completed (3149.511 ms) ====== [2025-11-28T04:58:31.667Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-11-28T04:58:31.667Z] GC before operation: completed in 95.155 ms, heap usage 348.941 MB -> 131.299 MB. [2025-11-28T04:58:35.627Z] ====== log-regression (apache-spark) [default], iteration 14 completed (3392.934 ms) ====== [2025-11-28T04:58:35.627Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-11-28T04:58:35.627Z] GC before operation: completed in 89.058 ms, heap usage 323.952 MB -> 131.578 MB. [2025-11-28T04:58:38.729Z] ====== log-regression (apache-spark) [default], iteration 15 completed (3283.227 ms) ====== [2025-11-28T04:58:38.729Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-11-28T04:58:38.729Z] GC before operation: completed in 91.658 ms, heap usage 381.750 MB -> 132.027 MB. [2025-11-28T04:58:41.843Z] ====== log-regression (apache-spark) [default], iteration 16 completed (3335.913 ms) ====== [2025-11-28T04:58:41.843Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-11-28T04:58:41.843Z] GC before operation: completed in 89.606 ms, heap usage 273.439 MB -> 132.452 MB. [2025-11-28T04:58:45.815Z] ====== log-regression (apache-spark) [default], iteration 17 completed (3307.002 ms) ====== [2025-11-28T04:58:45.815Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-11-28T04:58:45.815Z] GC before operation: completed in 97.099 ms, heap usage 778.606 MB -> 132.984 MB. [2025-11-28T04:58:48.920Z] ====== log-regression (apache-spark) [default], iteration 18 completed (3088.296 ms) ====== [2025-11-28T04:58:48.920Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-11-28T04:58:48.920Z] GC before operation: completed in 92.813 ms, heap usage 752.311 MB -> 133.369 MB. [2025-11-28T04:58:52.045Z] ====== log-regression (apache-spark) [default], iteration 19 completed (3100.117 ms) ====== [2025-11-28T04:58:52.045Z] ----------------------------------- [2025-11-28T04:58:52.045Z] renaissance-log-regression_0_PASSED [2025-11-28T04:58:52.045Z] ----------------------------------- [2025-11-28T04:58:52.045Z] [2025-11-28T04:58:52.045Z] TEST TEARDOWN: [2025-11-28T04:58:52.045Z] Nothing to be done for teardown. [2025-11-28T04:58:52.045Z] renaissance-log-regression_0 Finish Time: Fri Nov 28 04:58:51 2025 Epoch Time (ms): 1764305931863