[2025-12-25T00:09:50.645Z] Running test renaissance-log-regression_0 ... [2025-12-25T00:09:50.645Z] =============================================== [2025-12-25T00:09:50.645Z] renaissance-log-regression_0 Start Time: Thu Dec 25 00:09:49 2025 Epoch Time (ms): 1766621389401 [2025-12-25T00:09:50.645Z] variation: NoOptions [2025-12-25T00:09:50.645Z] JVM_OPTIONS: [2025-12-25T00:09:50.645Z] { \ [2025-12-25T00:09:50.645Z] echo ""; echo "TEST SETUP:"; \ [2025-12-25T00:09:50.645Z] echo "Nothing to be done for setup."; \ [2025-12-25T00:09:50.645Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17666196986535/renaissance-log-regression_0"; \ [2025-12-25T00:09:50.645Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17666196986535/renaissance-log-regression_0"; \ [2025-12-25T00:09:50.645Z] echo ""; echo "TESTING:"; \ [2025-12-25T00:09:50.645Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17666196986535/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-12-25T00:09:50.645Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17666196986535/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-25T00:09:50.645Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-25T00:09:50.645Z] echo "Nothing to be done for teardown."; \ [2025-12-25T00:09:50.645Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17666196986535/TestTargetResult"; [2025-12-25T00:09:50.645Z] [2025-12-25T00:09:50.645Z] TEST SETUP: [2025-12-25T00:09:50.645Z] Nothing to be done for setup. [2025-12-25T00:09:50.645Z] [2025-12-25T00:09:50.645Z] TESTING: [2025-12-25T00:09:58.796Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-25T00:10:04.192Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-25T00:10:04.192Z] GC before operation: completed in 67.380 ms, heap usage 55.015 MB -> 35.060 MB. [2025-12-25T00:10:28.921Z] ====== log-regression (apache-spark) [default], iteration 0 completed (23679.135 ms) ====== [2025-12-25T00:10:28.921Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-25T00:10:28.921Z] GC before operation: completed in 120.915 ms, heap usage 376.731 MB -> 119.926 MB. [2025-12-25T00:10:30.884Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3243.608 ms) ====== [2025-12-25T00:10:30.885Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-25T00:10:30.885Z] GC before operation: completed in 102.827 ms, heap usage 252.772 MB -> 120.110 MB. [2025-12-25T00:10:32.847Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2354.545 ms) ====== [2025-12-25T00:10:32.847Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-25T00:10:33.803Z] GC before operation: completed in 103.158 ms, heap usage 338.051 MB -> 120.798 MB. [2025-12-25T00:10:35.787Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2314.225 ms) ====== [2025-12-25T00:10:35.787Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-25T00:10:35.787Z] GC before operation: completed in 109.753 ms, heap usage 385.002 MB -> 121.249 MB. [2025-12-25T00:10:37.752Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2019.305 ms) ====== [2025-12-25T00:10:37.752Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-25T00:10:37.752Z] GC before operation: completed in 110.393 ms, heap usage 431.694 MB -> 121.583 MB. [2025-12-25T00:10:39.726Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1853.789 ms) ====== [2025-12-25T00:10:39.726Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-25T00:10:39.726Z] GC before operation: completed in 121.893 ms, heap usage 235.413 MB -> 121.334 MB. [2025-12-25T00:10:41.694Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1829.511 ms) ====== [2025-12-25T00:10:41.695Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-25T00:10:41.695Z] GC before operation: completed in 120.787 ms, heap usage 375.424 MB -> 121.965 MB. [2025-12-25T00:10:43.662Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1782.936 ms) ====== [2025-12-25T00:10:43.662Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-25T00:10:43.662Z] GC before operation: completed in 124.768 ms, heap usage 318.051 MB -> 122.022 MB. [2025-12-25T00:10:45.633Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1793.825 ms) ====== [2025-12-25T00:10:45.633Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-25T00:10:45.633Z] GC before operation: completed in 122.711 ms, heap usage 341.265 MB -> 122.143 MB. [2025-12-25T00:10:47.608Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2011.187 ms) ====== [2025-12-25T00:10:47.608Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-25T00:10:47.608Z] GC before operation: completed in 133.222 ms, heap usage 335.523 MB -> 122.415 MB. [2025-12-25T00:10:49.575Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1877.493 ms) ====== [2025-12-25T00:10:49.575Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-25T00:10:49.575Z] GC before operation: completed in 138.107 ms, heap usage 288.246 MB -> 122.430 MB. [2025-12-25T00:10:51.596Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1815.482 ms) ====== [2025-12-25T00:10:51.596Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-25T00:10:51.596Z] GC before operation: completed in 142.248 ms, heap usage 292.259 MB -> 122.658 MB. [2025-12-25T00:10:53.563Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1736.380 ms) ====== [2025-12-25T00:10:53.563Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-25T00:10:53.563Z] GC before operation: completed in 131.399 ms, heap usage 274.980 MB -> 122.772 MB. [2025-12-25T00:10:55.526Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1799.176 ms) ====== [2025-12-25T00:10:55.526Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-25T00:10:55.526Z] GC before operation: completed in 129.116 ms, heap usage 400.519 MB -> 123.390 MB. [2025-12-25T00:10:57.498Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1656.952 ms) ====== [2025-12-25T00:10:57.498Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-25T00:10:57.498Z] GC before operation: completed in 133.339 ms, heap usage 301.721 MB -> 123.280 MB. [2025-12-25T00:10:59.481Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1616.478 ms) ====== [2025-12-25T00:10:59.481Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-25T00:10:59.481Z] GC before operation: completed in 132.545 ms, heap usage 376.093 MB -> 123.803 MB. [2025-12-25T00:11:01.456Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1769.789 ms) ====== [2025-12-25T00:11:01.456Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-25T00:11:01.456Z] GC before operation: completed in 140.824 ms, heap usage 261.469 MB -> 123.608 MB. [2025-12-25T00:11:02.410Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1538.477 ms) ====== [2025-12-25T00:11:02.410Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-25T00:11:02.410Z] GC before operation: completed in 136.791 ms, heap usage 342.099 MB -> 124.091 MB. [2025-12-25T00:11:04.377Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1610.382 ms) ====== [2025-12-25T00:11:04.377Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-25T00:11:04.377Z] GC before operation: completed in 134.895 ms, heap usage 372.498 MB -> 124.418 MB. [2025-12-25T00:11:06.469Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1662.139 ms) ====== [2025-12-25T00:11:07.422Z] ----------------------------------- [2025-12-25T00:11:07.422Z] renaissance-log-regression_0_PASSED [2025-12-25T00:11:07.422Z] ----------------------------------- [2025-12-25T00:11:07.422Z] [2025-12-25T00:11:07.422Z] TEST TEARDOWN: [2025-12-25T00:11:07.422Z] Nothing to be done for teardown. [2025-12-25T00:11:07.422Z] renaissance-log-regression_0 Finish Time: Thu Dec 25 00:11:07 2025 Epoch Time (ms): 1766621467056