[2026-02-26T15:32:03.477Z] Running test renaissance-log-regression_0 ... [2026-02-26T15:32:03.477Z] =============================================== [2026-02-26T15:32:03.477Z] renaissance-log-regression_0 Start Time: Thu Feb 26 15:32:03 2026 Epoch Time (ms): 1772119923349 [2026-02-26T15:32:03.477Z] variation: NoOptions [2026-02-26T15:32:03.477Z] JVM_OPTIONS: [2026-02-26T15:32:03.477Z] { \ [2026-02-26T15:32:03.477Z] echo ""; echo "TEST SETUP:"; \ [2026-02-26T15:32:03.477Z] echo "Nothing to be done for setup."; \ [2026-02-26T15:32:03.477Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772119227840/renaissance-log-regression_0"; \ [2026-02-26T15:32:03.477Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772119227840/renaissance-log-regression_0"; \ [2026-02-26T15:32:03.477Z] echo ""; echo "TESTING:"; \ [2026-02-26T15:32:03.477Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772119227840/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-02-26T15:32:03.477Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772119227840/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-26T15:32:03.477Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-26T15:32:03.477Z] echo "Nothing to be done for teardown."; \ [2026-02-26T15:32:03.477Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772119227840/TestTargetResult"; [2026-02-26T15:32:03.477Z] [2026-02-26T15:32:03.477Z] TEST SETUP: [2026-02-26T15:32:03.477Z] Nothing to be done for setup. [2026-02-26T15:32:03.477Z] [2026-02-26T15:32:03.477Z] TESTING: [2026-02-26T15:32:08.818Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-26T15:32:10.757Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-02-26T15:32:10.757Z] GC before operation: completed in 56.378 ms, heap usage 56.323 MB -> 35.085 MB. [2026-02-26T15:32:20.434Z] ====== log-regression (apache-spark) [default], iteration 0 completed (9562.652 ms) ====== [2026-02-26T15:32:20.434Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-02-26T15:32:20.434Z] GC before operation: completed in 73.707 ms, heap usage 514.547 MB -> 120.176 MB. [2026-02-26T15:32:23.429Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2083.930 ms) ====== [2026-02-26T15:32:23.429Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-02-26T15:32:23.429Z] GC before operation: completed in 70.309 ms, heap usage 712.302 MB -> 121.302 MB. [2026-02-26T15:32:24.416Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1822.181 ms) ====== [2026-02-26T15:32:24.416Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-02-26T15:32:25.363Z] GC before operation: completed in 80.607 ms, heap usage 725.618 MB -> 121.843 MB. [2026-02-26T15:32:26.312Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1799.188 ms) ====== [2026-02-26T15:32:26.312Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-02-26T15:32:26.312Z] GC before operation: completed in 76.704 ms, heap usage 455.064 MB -> 121.208 MB. [2026-02-26T15:32:28.255Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1655.704 ms) ====== [2026-02-26T15:32:28.255Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-02-26T15:32:28.255Z] GC before operation: completed in 87.382 ms, heap usage 391.274 MB -> 121.304 MB. [2026-02-26T15:32:30.200Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1590.200 ms) ====== [2026-02-26T15:32:30.201Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-02-26T15:32:30.201Z] GC before operation: completed in 92.250 ms, heap usage 738.805 MB -> 122.702 MB. [2026-02-26T15:32:32.144Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1564.751 ms) ====== [2026-02-26T15:32:32.144Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-02-26T15:32:32.144Z] GC before operation: completed in 89.900 ms, heap usage 356.885 MB -> 121.715 MB. [2026-02-26T15:32:33.092Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1479.685 ms) ====== [2026-02-26T15:32:33.092Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-02-26T15:32:33.092Z] GC before operation: completed in 95.177 ms, heap usage 601.029 MB -> 122.777 MB. [2026-02-26T15:32:35.055Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1563.489 ms) ====== [2026-02-26T15:32:35.055Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-02-26T15:32:35.055Z] GC before operation: completed in 89.034 ms, heap usage 522.760 MB -> 122.707 MB. [2026-02-26T15:32:37.042Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1478.234 ms) ====== [2026-02-26T15:32:37.042Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-02-26T15:32:37.042Z] GC before operation: completed in 90.659 ms, heap usage 860.076 MB -> 123.795 MB. [2026-02-26T15:32:37.987Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1498.343 ms) ====== [2026-02-26T15:32:37.987Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-02-26T15:32:37.987Z] GC before operation: completed in 91.159 ms, heap usage 573.474 MB -> 123.303 MB. [2026-02-26T15:32:39.928Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1439.660 ms) ====== [2026-02-26T15:32:39.928Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-02-26T15:32:39.928Z] GC before operation: completed in 91.968 ms, heap usage 292.470 MB -> 122.593 MB. [2026-02-26T15:32:40.874Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1455.788 ms) ====== [2026-02-26T15:32:40.874Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-02-26T15:32:40.874Z] GC before operation: completed in 97.595 ms, heap usage 440.184 MB -> 123.275 MB. [2026-02-26T15:32:42.537Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1466.952 ms) ====== [2026-02-26T15:32:42.537Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-02-26T15:32:42.537Z] GC before operation: completed in 101.163 ms, heap usage 842.390 MB -> 124.650 MB. [2026-02-26T15:32:44.479Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1469.688 ms) ====== [2026-02-26T15:32:44.479Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-02-26T15:32:44.479Z] GC before operation: completed in 82.692 ms, heap usage 340.241 MB -> 123.353 MB. [2026-02-26T15:32:46.421Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1499.555 ms) ====== [2026-02-26T15:32:46.421Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-02-26T15:32:46.421Z] GC before operation: completed in 88.891 ms, heap usage 638.475 MB -> 124.478 MB. [2026-02-26T15:32:47.366Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1509.343 ms) ====== [2026-02-26T15:32:47.366Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-02-26T15:32:47.366Z] GC before operation: completed in 89.772 ms, heap usage 483.693 MB -> 124.151 MB. [2026-02-26T15:32:49.308Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1460.866 ms) ====== [2026-02-26T15:32:49.308Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-02-26T15:32:49.308Z] GC before operation: completed in 91.807 ms, heap usage 253.373 MB -> 123.708 MB. [2026-02-26T15:32:50.304Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1433.792 ms) ====== [2026-02-26T15:32:50.304Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-02-26T15:32:51.250Z] GC before operation: completed in 101.580 ms, heap usage 683.376 MB -> 125.255 MB. [2026-02-26T15:32:52.196Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1527.481 ms) ====== [2026-02-26T15:32:52.196Z] ----------------------------------- [2026-02-26T15:32:52.196Z] renaissance-log-regression_0_PASSED [2026-02-26T15:32:52.196Z] ----------------------------------- [2026-02-26T15:32:52.196Z] [2026-02-26T15:32:52.196Z] TEST TEARDOWN: [2026-02-26T15:32:52.197Z] Nothing to be done for teardown. [2026-02-26T15:32:52.197Z] renaissance-log-regression_0 Finish Time: Thu Feb 26 15:32:51 2026 Epoch Time (ms): 1772119971947