[2025-11-06T13:48:30.523Z] Running test renaissance-log-regression_0 ... [2025-11-06T13:48:30.523Z] =============================================== [2025-11-06T13:48:30.523Z] renaissance-log-regression_0 Start Time: Thu Nov 6 13:48:30 2025 Epoch Time (ms): 1762436910417 [2025-11-06T13:48:30.523Z] variation: NoOptions [2025-11-06T13:48:30.523Z] JVM_OPTIONS: [2025-11-06T13:48:30.523Z] { \ [2025-11-06T13:48:30.523Z] echo ""; echo "TEST SETUP:"; \ [2025-11-06T13:48:30.523Z] echo "Nothing to be done for setup."; \ [2025-11-06T13:48:30.523Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624366956502/renaissance-log-regression_0"; \ [2025-11-06T13:48:30.523Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624366956502/renaissance-log-regression_0"; \ [2025-11-06T13:48:30.523Z] echo ""; echo "TESTING:"; \ [2025-11-06T13:48:30.523Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_1/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_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624366956502/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-11-06T13:48:30.523Z] 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_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624366956502/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-06T13:48:30.523Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-06T13:48:30.523Z] echo "Nothing to be done for teardown."; \ [2025-11-06T13:48:30.523Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17624366956502/TestTargetResult"; [2025-11-06T13:48:30.523Z] [2025-11-06T13:48:30.523Z] TEST SETUP: [2025-11-06T13:48:30.523Z] Nothing to be done for setup. [2025-11-06T13:48:30.523Z] [2025-11-06T13:48:30.523Z] TESTING: [2025-11-06T13:48:35.855Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-06T13:48:38.172Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-11-06T13:48:38.172Z] GC before operation: completed in 65.133 ms, heap usage 54.347 MB -> 35.051 MB. [2025-11-06T13:48:49.376Z] ====== log-regression (apache-spark) [default], iteration 0 completed (10217.947 ms) ====== [2025-11-06T13:48:49.376Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-11-06T13:48:49.376Z] GC before operation: completed in 83.250 ms, heap usage 310.455 MB -> 119.732 MB. [2025-11-06T13:48:50.873Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2210.399 ms) ====== [2025-11-06T13:48:50.873Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-11-06T13:48:50.873Z] GC before operation: completed in 69.218 ms, heap usage 281.219 MB -> 120.287 MB. [2025-11-06T13:48:53.199Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1857.069 ms) ====== [2025-11-06T13:48:53.199Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-11-06T13:48:53.199Z] GC before operation: completed in 67.047 ms, heap usage 393.957 MB -> 120.971 MB. [2025-11-06T13:48:54.692Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1527.665 ms) ====== [2025-11-06T13:48:54.692Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-11-06T13:48:54.692Z] GC before operation: completed in 70.226 ms, heap usage 289.667 MB -> 120.956 MB. [2025-11-06T13:48:56.191Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1648.085 ms) ====== [2025-11-06T13:48:56.191Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-11-06T13:48:56.191Z] GC before operation: completed in 77.766 ms, heap usage 265.624 MB -> 121.120 MB. [2025-11-06T13:48:57.691Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1441.711 ms) ====== [2025-11-06T13:48:57.691Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-11-06T13:48:57.691Z] GC before operation: completed in 76.101 ms, heap usage 243.943 MB -> 121.251 MB. [2025-11-06T13:48:59.186Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1331.142 ms) ====== [2025-11-06T13:48:59.186Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-11-06T13:48:59.186Z] GC before operation: completed in 74.005 ms, heap usage 335.580 MB -> 121.656 MB. [2025-11-06T13:49:00.682Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1358.278 ms) ====== [2025-11-06T13:49:00.682Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-11-06T13:49:00.682Z] GC before operation: completed in 74.534 ms, heap usage 238.310 MB -> 121.621 MB. [2025-11-06T13:49:02.178Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1345.346 ms) ====== [2025-11-06T13:49:02.178Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-11-06T13:49:02.178Z] GC before operation: completed in 77.090 ms, heap usage 276.662 MB -> 121.981 MB. [2025-11-06T13:49:02.899Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1267.829 ms) ====== [2025-11-06T13:49:02.899Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-11-06T13:49:03.618Z] GC before operation: completed in 81.235 ms, heap usage 293.081 MB -> 122.238 MB. [2025-11-06T13:49:04.336Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1285.106 ms) ====== [2025-11-06T13:49:04.336Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-11-06T13:49:04.336Z] GC before operation: completed in 80.116 ms, heap usage 237.115 MB -> 122.322 MB. [2025-11-06T13:49:06.669Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1808.861 ms) ====== [2025-11-06T13:49:06.669Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-11-06T13:49:06.669Z] GC before operation: completed in 78.209 ms, heap usage 343.494 MB -> 122.807 MB. [2025-11-06T13:49:08.159Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1302.776 ms) ====== [2025-11-06T13:49:08.159Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-11-06T13:49:08.159Z] GC before operation: completed in 78.190 ms, heap usage 360.004 MB -> 122.979 MB. [2025-11-06T13:49:09.649Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1345.938 ms) ====== [2025-11-06T13:49:09.649Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-11-06T13:49:09.649Z] GC before operation: completed in 82.141 ms, heap usage 292.628 MB -> 123.040 MB. [2025-11-06T13:49:10.379Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1247.245 ms) ====== [2025-11-06T13:49:10.379Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-11-06T13:49:10.379Z] GC before operation: completed in 76.971 ms, heap usage 394.942 MB -> 123.518 MB. [2025-11-06T13:49:11.867Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1222.750 ms) ====== [2025-11-06T13:49:11.867Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-11-06T13:49:11.867Z] GC before operation: completed in 79.821 ms, heap usage 275.858 MB -> 123.355 MB. [2025-11-06T13:49:13.366Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1195.937 ms) ====== [2025-11-06T13:49:13.366Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-11-06T13:49:13.366Z] GC before operation: completed in 74.470 ms, heap usage 283.814 MB -> 123.730 MB. [2025-11-06T13:49:14.326Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1248.416 ms) ====== [2025-11-06T13:49:14.326Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-11-06T13:49:14.326Z] GC before operation: completed in 76.129 ms, heap usage 343.610 MB -> 124.135 MB. [2025-11-06T13:49:15.823Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1193.944 ms) ====== [2025-11-06T13:49:15.823Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-11-06T13:49:15.823Z] GC before operation: completed in 82.993 ms, heap usage 275.295 MB -> 124.022 MB. [2025-11-06T13:49:17.310Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1318.542 ms) ====== [2025-11-06T13:49:17.310Z] ----------------------------------- [2025-11-06T13:49:17.310Z] renaissance-log-regression_0_PASSED [2025-11-06T13:49:17.310Z] ----------------------------------- [2025-11-06T13:49:17.310Z] [2025-11-06T13:49:17.310Z] TEST TEARDOWN: [2025-11-06T13:49:17.310Z] Nothing to be done for teardown. [2025-11-06T13:49:17.310Z] renaissance-log-regression_0 Finish Time: Thu Nov 6 13:49:17 2025 Epoch Time (ms): 1762436957091