[2026-04-21T22:40:45.996Z] Running test renaissance-log-regression_0 ... [2026-04-21T22:40:45.996Z] =============================================== [2026-04-21T22:40:45.996Z] renaissance-log-regression_0 Start Time: Tue Apr 21 22:40:45 2026 Epoch Time (ms): 1776811245306 [2026-04-21T22:40:45.996Z] variation: NoOptions [2026-04-21T22:40:45.996Z] JVM_OPTIONS: [2026-04-21T22:40:45.996Z] { \ [2026-04-21T22:40:45.996Z] echo ""; echo "TEST SETUP:"; \ [2026-04-21T22:40:45.996Z] echo "Nothing to be done for setup."; \ [2026-04-21T22:40:45.996Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17768106137468/renaissance-log-regression_0"; \ [2026-04-21T22:40:45.996Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17768106137468/renaissance-log-regression_0"; \ [2026-04-21T22:40:45.997Z] echo ""; echo "TESTING:"; \ [2026-04-21T22:40:45.997Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/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_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17768106137468/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-04-21T22:40:45.997Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17768106137468/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-21T22:40:45.997Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-21T22:40:45.997Z] echo "Nothing to be done for teardown."; \ [2026-04-21T22:40:45.997Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17768106137468/TestTargetResult"; [2026-04-21T22:40:45.997Z] [2026-04-21T22:40:45.997Z] TEST SETUP: [2026-04-21T22:40:45.997Z] Nothing to be done for setup. [2026-04-21T22:40:45.997Z] [2026-04-21T22:40:45.997Z] TESTING: [2026-04-21T22:40:53.191Z] NOTE: 'log-regression' benchmark uses Spark local executor with 12 (out of 24) threads. [2026-04-21T22:40:56.230Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-04-21T22:40:56.230Z] GC before operation: completed in 79.585 ms, heap usage 38.644 MB -> 34.659 MB. [2026-04-21T22:41:07.987Z] ====== log-regression (apache-spark) [default], iteration 0 completed (11059.735 ms) ====== [2026-04-21T22:41:07.987Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-04-21T22:41:07.987Z] GC before operation: completed in 106.342 ms, heap usage 386.774 MB -> 132.081 MB. [2026-04-21T22:41:09.964Z] ====== log-regression (apache-spark) [default], iteration 1 completed (1993.316 ms) ====== [2026-04-21T22:41:09.964Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-04-21T22:41:09.964Z] GC before operation: completed in 99.715 ms, heap usage 541.871 MB -> 133.164 MB. [2026-04-21T22:41:11.937Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1762.974 ms) ====== [2026-04-21T22:41:11.937Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-04-21T22:41:11.937Z] GC before operation: completed in 110.978 ms, heap usage 688.065 MB -> 133.964 MB. [2026-04-21T22:41:12.897Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1703.542 ms) ====== [2026-04-21T22:41:12.897Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-04-21T22:41:13.855Z] GC before operation: completed in 110.941 ms, heap usage 802.893 MB -> 134.713 MB. [2026-04-21T22:41:14.833Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1639.458 ms) ====== [2026-04-21T22:41:14.833Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-04-21T22:41:14.833Z] GC before operation: completed in 112.294 ms, heap usage 472.446 MB -> 134.246 MB. [2026-04-21T22:41:16.799Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1661.017 ms) ====== [2026-04-21T22:41:16.799Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-04-21T22:41:16.799Z] GC before operation: completed in 117.279 ms, heap usage 643.982 MB -> 135.007 MB. [2026-04-21T22:41:18.764Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1605.863 ms) ====== [2026-04-21T22:41:18.764Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-04-21T22:41:18.764Z] GC before operation: completed in 115.471 ms, heap usage 620.678 MB -> 135.391 MB. [2026-04-21T22:41:20.731Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1571.616 ms) ====== [2026-04-21T22:41:20.731Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-04-21T22:41:20.731Z] GC before operation: completed in 116.220 ms, heap usage 268.059 MB -> 134.653 MB. [2026-04-21T22:41:21.689Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1560.989 ms) ====== [2026-04-21T22:41:21.689Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-04-21T22:41:21.689Z] GC before operation: completed in 121.885 ms, heap usage 860.636 MB -> 136.801 MB. [2026-04-21T22:41:23.652Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1563.266 ms) ====== [2026-04-21T22:41:23.652Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-04-21T22:41:23.652Z] GC before operation: completed in 117.482 ms, heap usage 805.134 MB -> 137.006 MB. [2026-04-21T22:41:25.626Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1525.184 ms) ====== [2026-04-21T22:41:25.626Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-04-21T22:41:25.626Z] GC before operation: completed in 119.709 ms, heap usage 285.508 MB -> 135.819 MB. [2026-04-21T22:41:26.582Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1524.421 ms) ====== [2026-04-21T22:41:26.582Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-04-21T22:41:26.582Z] GC before operation: completed in 127.697 ms, heap usage 908.851 MB -> 138.144 MB. [2026-04-21T22:41:28.548Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1544.161 ms) ====== [2026-04-21T22:41:28.548Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-04-21T22:41:28.548Z] GC before operation: completed in 126.791 ms, heap usage 866.172 MB -> 138.355 MB. [2026-04-21T22:41:30.515Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1475.617 ms) ====== [2026-04-21T22:41:30.515Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-04-21T22:41:30.515Z] GC before operation: completed in 120.058 ms, heap usage 764.745 MB -> 138.309 MB. [2026-04-21T22:41:31.478Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1463.830 ms) ====== [2026-04-21T22:41:31.478Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-04-21T22:41:31.478Z] GC before operation: completed in 130.037 ms, heap usage 570.988 MB -> 138.165 MB. [2026-04-21T22:41:33.801Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1485.067 ms) ====== [2026-04-21T22:41:33.801Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-04-21T22:41:33.801Z] GC before operation: completed in 123.024 ms, heap usage 569.495 MB -> 138.588 MB. [2026-04-21T22:41:34.762Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1462.819 ms) ====== [2026-04-21T22:41:34.762Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-04-21T22:41:34.762Z] GC before operation: completed in 121.471 ms, heap usage 649.135 MB -> 139.160 MB. [2026-04-21T22:41:36.730Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1494.479 ms) ====== [2026-04-21T22:41:36.730Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-04-21T22:41:36.730Z] GC before operation: completed in 123.990 ms, heap usage 299.996 MB -> 138.664 MB. [2026-04-21T22:41:38.795Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1463.304 ms) ====== [2026-04-21T22:41:38.795Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-04-21T22:41:38.795Z] GC before operation: completed in 124.962 ms, heap usage 825.084 MB -> 140.538 MB. [2026-04-21T22:41:39.751Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1501.152 ms) ====== [2026-04-21T22:41:39.751Z] ----------------------------------- [2026-04-21T22:41:39.751Z] renaissance-log-regression_0_PASSED [2026-04-21T22:41:39.751Z] ----------------------------------- [2026-04-21T22:41:39.751Z] [2026-04-21T22:41:39.751Z] TEST TEARDOWN: [2026-04-21T22:41:39.751Z] Nothing to be done for teardown. [2026-04-21T22:41:39.751Z] renaissance-log-regression_0 Finish Time: Tue Apr 21 22:41:39 2026 Epoch Time (ms): 1776811299623