[2026-02-25T22:25:25.135Z] Running test renaissance-log-regression_0 ... [2026-02-25T22:25:25.135Z] =============================================== [2026-02-25T22:25:25.135Z] renaissance-log-regression_0 Start Time: Wed Feb 25 22:25:24 2026 Epoch Time (ms): 1772058324263 [2026-02-25T22:25:25.135Z] variation: NoOptions [2026-02-25T22:25:25.135Z] JVM_OPTIONS: [2026-02-25T22:25:25.135Z] { \ [2026-02-25T22:25:25.135Z] echo ""; echo "TEST SETUP:"; \ [2026-02-25T22:25:25.135Z] echo "Nothing to be done for setup."; \ [2026-02-25T22:25:25.135Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772057657945/renaissance-log-regression_0"; \ [2026-02-25T22:25:25.135Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772057657945/renaissance-log-regression_0"; \ [2026-02-25T22:25:25.135Z] echo ""; echo "TESTING:"; \ [2026-02-25T22:25:25.135Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772057657945/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-02-25T22:25:25.135Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772057657945/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-25T22:25:25.135Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-25T22:25:25.135Z] echo "Nothing to be done for teardown."; \ [2026-02-25T22:25:25.135Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772057657945/TestTargetResult"; [2026-02-25T22:25:25.135Z] [2026-02-25T22:25:25.135Z] TEST SETUP: [2026-02-25T22:25:25.135Z] Nothing to be done for setup. [2026-02-25T22:25:25.135Z] [2026-02-25T22:25:25.135Z] TESTING: [2026-02-25T22:25:30.438Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-25T22:25:32.368Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-02-25T22:25:32.368Z] GC before operation: completed in 56.739 ms, heap usage 49.434 MB -> 34.862 MB. [2026-02-25T22:25:42.011Z] ====== log-regression (apache-spark) [default], iteration 0 completed (9428.699 ms) ====== [2026-02-25T22:25:42.011Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-02-25T22:25:42.011Z] GC before operation: completed in 96.599 ms, heap usage 353.777 MB -> 119.605 MB. [2026-02-25T22:25:43.940Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2009.806 ms) ====== [2026-02-25T22:25:43.940Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-02-25T22:25:43.940Z] GC before operation: completed in 63.062 ms, heap usage 233.930 MB -> 119.977 MB. [2026-02-25T22:25:45.871Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1788.898 ms) ====== [2026-02-25T22:25:45.871Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-02-25T22:25:45.871Z] GC before operation: completed in 67.002 ms, heap usage 265.971 MB -> 120.496 MB. [2026-02-25T22:25:47.801Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1648.777 ms) ====== [2026-02-25T22:25:47.801Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-02-25T22:25:47.801Z] GC before operation: completed in 69.556 ms, heap usage 271.997 MB -> 120.681 MB. [2026-02-25T22:25:48.740Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1571.879 ms) ====== [2026-02-25T22:25:48.740Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-02-25T22:25:48.740Z] GC before operation: completed in 70.651 ms, heap usage 305.911 MB -> 121.035 MB. [2026-02-25T22:25:50.669Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1472.277 ms) ====== [2026-02-25T22:25:50.669Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-02-25T22:25:50.669Z] GC before operation: completed in 75.518 ms, heap usage 297.262 MB -> 121.268 MB. [2026-02-25T22:25:52.604Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1512.533 ms) ====== [2026-02-25T22:25:52.604Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-02-25T22:25:52.604Z] GC before operation: completed in 73.131 ms, heap usage 252.159 MB -> 121.442 MB. [2026-02-25T22:25:53.545Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1415.728 ms) ====== [2026-02-25T22:25:53.545Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-02-25T22:25:53.545Z] GC before operation: completed in 86.930 ms, heap usage 261.400 MB -> 121.470 MB. [2026-02-25T22:25:56.401Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1491.072 ms) ====== [2026-02-25T22:25:56.401Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-02-25T22:25:56.401Z] GC before operation: completed in 73.434 ms, heap usage 348.213 MB -> 121.984 MB. [2026-02-25T22:25:56.401Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1425.830 ms) ====== [2026-02-25T22:25:56.401Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-02-25T22:25:57.474Z] GC before operation: completed in 74.636 ms, heap usage 443.816 MB -> 122.454 MB. [2026-02-25T22:25:58.413Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1343.247 ms) ====== [2026-02-25T22:25:58.413Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-02-25T22:25:58.413Z] GC before operation: completed in 82.723 ms, heap usage 235.285 MB -> 122.092 MB. [2026-02-25T22:25:59.363Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1401.625 ms) ====== [2026-02-25T22:25:59.363Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-02-25T22:25:59.363Z] GC before operation: completed in 86.153 ms, heap usage 274.900 MB -> 122.335 MB. [2026-02-25T22:26:01.293Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1358.764 ms) ====== [2026-02-25T22:26:01.293Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-02-25T22:26:01.293Z] GC before operation: completed in 87.135 ms, heap usage 321.325 MB -> 122.734 MB. [2026-02-25T22:26:02.232Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1342.363 ms) ====== [2026-02-25T22:26:02.232Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-02-25T22:26:02.232Z] GC before operation: completed in 79.497 ms, heap usage 392.984 MB -> 123.098 MB. [2026-02-25T22:26:04.180Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1382.287 ms) ====== [2026-02-25T22:26:04.180Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-02-25T22:26:04.180Z] GC before operation: completed in 84.389 ms, heap usage 331.929 MB -> 123.183 MB. [2026-02-25T22:26:05.120Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1404.715 ms) ====== [2026-02-25T22:26:05.120Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-02-25T22:26:05.120Z] GC before operation: completed in 86.220 ms, heap usage 288.853 MB -> 123.271 MB. [2026-02-25T22:26:07.049Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1456.372 ms) ====== [2026-02-25T22:26:07.049Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-02-25T22:26:07.049Z] GC before operation: completed in 88.289 ms, heap usage 433.500 MB -> 123.924 MB. [2026-02-25T22:26:08.983Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1358.896 ms) ====== [2026-02-25T22:26:08.983Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-02-25T22:26:08.983Z] GC before operation: completed in 94.905 ms, heap usage 286.195 MB -> 123.657 MB. [2026-02-25T22:26:09.924Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1331.902 ms) ====== [2026-02-25T22:26:09.924Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-02-25T22:26:09.924Z] GC before operation: completed in 93.984 ms, heap usage 336.984 MB -> 124.054 MB. [2026-02-25T22:26:11.854Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1363.105 ms) ====== [2026-02-25T22:26:11.855Z] ----------------------------------- [2026-02-25T22:26:11.855Z] renaissance-log-regression_0_PASSED [2026-02-25T22:26:11.855Z] ----------------------------------- [2026-02-25T22:26:11.855Z] [2026-02-25T22:26:11.855Z] TEST TEARDOWN: [2026-02-25T22:26:11.855Z] Nothing to be done for teardown. [2026-02-25T22:26:11.855Z] renaissance-log-regression_0 Finish Time: Wed Feb 25 22:26:11 2026 Epoch Time (ms): 1772058371063