[2025-11-20T11:36:25.572Z] Running test renaissance-log-regression_0 ... [2025-11-20T11:36:25.572Z] =============================================== [2025-11-20T11:36:25.572Z] renaissance-log-regression_0 Start Time: Thu Nov 20 11:36:25 2025 Epoch Time (ms): 1763638585121 [2025-11-20T11:36:25.572Z] variation: NoOptions [2025-11-20T11:36:25.572Z] JVM_OPTIONS: [2025-11-20T11:36:25.572Z] { \ [2025-11-20T11:36:25.572Z] echo ""; echo "TEST SETUP:"; \ [2025-11-20T11:36:25.572Z] echo "Nothing to be done for setup."; \ [2025-11-20T11:36:25.572Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17636377121423/renaissance-log-regression_0"; \ [2025-11-20T11:36:25.572Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17636377121423/renaissance-log-regression_0"; \ [2025-11-20T11:36:25.572Z] echo ""; echo "TESTING:"; \ [2025-11-20T11:36:25.572Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/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_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17636377121423/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-11-20T11:36:25.572Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17636377121423/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-20T11:36:25.572Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-20T11:36:25.572Z] echo "Nothing to be done for teardown."; \ [2025-11-20T11:36:25.572Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17636377121423/TestTargetResult"; [2025-11-20T11:36:25.572Z] [2025-11-20T11:36:25.572Z] TEST SETUP: [2025-11-20T11:36:25.572Z] Nothing to be done for setup. [2025-11-20T11:36:25.572Z] [2025-11-20T11:36:25.572Z] TESTING: [2025-11-20T11:36:30.148Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-20T11:36:32.564Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-11-20T11:36:32.564Z] GC before operation: completed in 41.860 ms, heap usage 44.623 MB -> 35.069 MB. [2025-11-20T11:36:44.096Z] ====== log-regression (apache-spark) [default], iteration 0 completed (10428.860 ms) ====== [2025-11-20T11:36:44.096Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-11-20T11:36:44.096Z] GC before operation: completed in 112.215 ms, heap usage 283.968 MB -> 119.659 MB. [2025-11-20T11:36:45.662Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2341.818 ms) ====== [2025-11-20T11:36:45.662Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-11-20T11:36:45.662Z] GC before operation: completed in 63.244 ms, heap usage 267.760 MB -> 120.210 MB. [2025-11-20T11:36:47.229Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1842.076 ms) ====== [2025-11-20T11:36:47.229Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-11-20T11:36:47.229Z] GC before operation: completed in 78.589 ms, heap usage 283.234 MB -> 120.691 MB. [2025-11-20T11:36:49.661Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1660.858 ms) ====== [2025-11-20T11:36:49.661Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-11-20T11:36:49.661Z] GC before operation: completed in 66.487 ms, heap usage 267.743 MB -> 120.993 MB. [2025-11-20T11:36:51.223Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1606.007 ms) ====== [2025-11-20T11:36:51.223Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-11-20T11:36:51.223Z] GC before operation: completed in 90.182 ms, heap usage 281.546 MB -> 121.184 MB. [2025-11-20T11:36:52.784Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1515.599 ms) ====== [2025-11-20T11:36:52.784Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-11-20T11:36:52.784Z] GC before operation: completed in 68.411 ms, heap usage 279.337 MB -> 121.331 MB. [2025-11-20T11:36:54.471Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1436.176 ms) ====== [2025-11-20T11:36:54.471Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-11-20T11:36:54.471Z] GC before operation: completed in 75.130 ms, heap usage 238.464 MB -> 121.597 MB. [2025-11-20T11:36:55.225Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1369.327 ms) ====== [2025-11-20T11:36:55.225Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-11-20T11:36:55.225Z] GC before operation: completed in 71.436 ms, heap usage 382.926 MB -> 122.165 MB. [2025-11-20T11:36:56.786Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1350.455 ms) ====== [2025-11-20T11:36:56.786Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-11-20T11:36:56.786Z] GC before operation: completed in 72.347 ms, heap usage 276.000 MB -> 122.103 MB. [2025-11-20T11:36:58.344Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1349.233 ms) ====== [2025-11-20T11:36:58.344Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-11-20T11:36:58.344Z] GC before operation: completed in 72.176 ms, heap usage 268.393 MB -> 122.304 MB. [2025-11-20T11:36:59.901Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1334.482 ms) ====== [2025-11-20T11:36:59.902Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-11-20T11:36:59.902Z] GC before operation: completed in 77.234 ms, heap usage 380.262 MB -> 122.729 MB. [2025-11-20T11:37:01.469Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1334.005 ms) ====== [2025-11-20T11:37:01.469Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-11-20T11:37:01.469Z] GC before operation: completed in 79.613 ms, heap usage 268.889 MB -> 122.573 MB. [2025-11-20T11:37:03.030Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1388.984 ms) ====== [2025-11-20T11:37:03.030Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-11-20T11:37:03.030Z] GC before operation: completed in 80.771 ms, heap usage 394.736 MB -> 123.097 MB. [2025-11-20T11:37:03.786Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1269.138 ms) ====== [2025-11-20T11:37:03.786Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-11-20T11:37:03.786Z] GC before operation: completed in 78.425 ms, heap usage 264.060 MB -> 123.048 MB. [2025-11-20T11:37:05.347Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1320.705 ms) ====== [2025-11-20T11:37:05.347Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-11-20T11:37:05.347Z] GC before operation: completed in 81.978 ms, heap usage 302.716 MB -> 123.292 MB. [2025-11-20T11:37:06.905Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1347.769 ms) ====== [2025-11-20T11:37:06.905Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-11-20T11:37:06.905Z] GC before operation: completed in 89.255 ms, heap usage 340.530 MB -> 123.688 MB. [2025-11-20T11:37:08.472Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1279.807 ms) ====== [2025-11-20T11:37:08.472Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-11-20T11:37:08.472Z] GC before operation: completed in 80.299 ms, heap usage 371.855 MB -> 123.981 MB. [2025-11-20T11:37:10.037Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1383.584 ms) ====== [2025-11-20T11:37:10.037Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-11-20T11:37:10.037Z] GC before operation: completed in 80.227 ms, heap usage 275.309 MB -> 123.825 MB. [2025-11-20T11:37:10.800Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1254.859 ms) ====== [2025-11-20T11:37:10.800Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-11-20T11:37:10.800Z] GC before operation: completed in 78.925 ms, heap usage 377.494 MB -> 124.333 MB. [2025-11-20T11:37:12.598Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1273.346 ms) ====== [2025-11-20T11:37:12.598Z] ----------------------------------- [2025-11-20T11:37:12.598Z] renaissance-log-regression_0_PASSED [2025-11-20T11:37:12.598Z] ----------------------------------- [2025-11-20T11:37:12.598Z] [2025-11-20T11:37:12.598Z] TEST TEARDOWN: [2025-11-20T11:37:12.598Z] Nothing to be done for teardown. [2025-11-20T11:37:12.598Z] renaissance-log-regression_0 Finish Time: Thu Nov 20 11:37:12 2025 Epoch Time (ms): 1763638632176