[2026-01-21T02:22:34.048Z] Running test renaissance-log-regression_0 ... [2026-01-21T02:22:34.048Z] =============================================== [2026-01-21T02:22:34.048Z] renaissance-log-regression_0 Start Time: Wed Jan 21 02:22:33 2026 Epoch Time (ms): 1768962153759 [2026-01-21T02:22:34.048Z] variation: NoOptions [2026-01-21T02:22:34.048Z] JVM_OPTIONS: [2026-01-21T02:22:34.048Z] { \ [2026-01-21T02:22:34.048Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T02:22:34.048Z] echo "Nothing to be done for setup."; \ [2026-01-21T02:22:34.048Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689614544809/renaissance-log-regression_0"; \ [2026-01-21T02:22:34.048Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689614544809/renaissance-log-regression_0"; \ [2026-01-21T02:22:34.048Z] echo ""; echo "TESTING:"; \ [2026-01-21T02:22:34.048Z] "/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_17689614544809/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-01-21T02:22:34.049Z] 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_17689614544809/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T02:22:34.049Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T02:22:34.049Z] echo "Nothing to be done for teardown."; \ [2026-01-21T02:22:34.049Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689614544809/TestTargetResult"; [2026-01-21T02:22:34.049Z] [2026-01-21T02:22:34.049Z] TEST SETUP: [2026-01-21T02:22:34.049Z] Nothing to be done for setup. [2026-01-21T02:22:34.049Z] [2026-01-21T02:22:34.049Z] TESTING: [2026-01-21T02:22:39.505Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-21T02:22:42.577Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-21T02:22:42.577Z] GC before operation: completed in 56.988 ms, heap usage 52.837 MB -> 35.012 MB. [2026-01-21T02:22:52.456Z] ====== log-regression (apache-spark) [default], iteration 0 completed (10070.369 ms) ====== [2026-01-21T02:22:52.456Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-21T02:22:52.456Z] GC before operation: completed in 73.141 ms, heap usage 339.065 MB -> 119.541 MB. [2026-01-21T02:22:54.449Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2084.789 ms) ====== [2026-01-21T02:22:54.449Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-21T02:22:54.449Z] GC before operation: completed in 72.706 ms, heap usage 241.895 MB -> 119.917 MB. [2026-01-21T02:22:56.440Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1927.443 ms) ====== [2026-01-21T02:22:56.440Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-21T02:22:56.440Z] GC before operation: completed in 79.827 ms, heap usage 277.356 MB -> 120.442 MB. [2026-01-21T02:22:57.410Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1641.002 ms) ====== [2026-01-21T02:22:57.410Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-21T02:22:58.381Z] GC before operation: completed in 78.454 ms, heap usage 328.396 MB -> 120.778 MB. [2026-01-21T02:22:59.349Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1606.959 ms) ====== [2026-01-21T02:22:59.349Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-21T02:22:59.349Z] GC before operation: completed in 81.619 ms, heap usage 272.034 MB -> 121.032 MB. [2026-01-21T02:23:01.339Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1623.856 ms) ====== [2026-01-21T02:23:01.339Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-21T02:23:01.339Z] GC before operation: completed in 90.151 ms, heap usage 525.432 MB -> 121.857 MB. [2026-01-21T02:23:03.332Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1573.444 ms) ====== [2026-01-21T02:23:03.332Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-21T02:23:03.332Z] GC before operation: completed in 81.289 ms, heap usage 168.109 MB -> 121.215 MB. [2026-01-21T02:23:04.306Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1428.738 ms) ====== [2026-01-21T02:23:04.306Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-21T02:23:04.306Z] GC before operation: completed in 89.922 ms, heap usage 732.382 MB -> 122.974 MB. [2026-01-21T02:23:06.298Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1465.847 ms) ====== [2026-01-21T02:23:06.298Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-21T02:23:06.298Z] GC before operation: completed in 73.696 ms, heap usage 365.644 MB -> 122.084 MB. [2026-01-21T02:23:07.281Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1426.045 ms) ====== [2026-01-21T02:23:07.281Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-21T02:23:07.281Z] GC before operation: completed in 73.086 ms, heap usage 697.294 MB -> 123.251 MB. [2026-01-21T02:23:09.271Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1426.855 ms) ====== [2026-01-21T02:23:09.271Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-21T02:23:09.271Z] GC before operation: completed in 80.130 ms, heap usage 287.194 MB -> 122.247 MB. [2026-01-21T02:23:10.242Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1469.658 ms) ====== [2026-01-21T02:23:10.242Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-21T02:23:10.242Z] GC before operation: completed in 105.082 ms, heap usage 661.581 MB -> 123.619 MB. [2026-01-21T02:23:12.232Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1414.844 ms) ====== [2026-01-21T02:23:12.232Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-21T02:23:12.232Z] GC before operation: completed in 94.607 ms, heap usage 584.964 MB -> 123.542 MB. [2026-01-21T02:23:13.202Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1431.214 ms) ====== [2026-01-21T02:23:13.202Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-21T02:23:13.202Z] GC before operation: completed in 77.694 ms, heap usage 657.873 MB -> 123.993 MB. [2026-01-21T02:23:15.193Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1384.977 ms) ====== [2026-01-21T02:23:15.193Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-21T02:23:15.193Z] GC before operation: completed in 79.698 ms, heap usage 460.326 MB -> 123.649 MB. [2026-01-21T02:23:16.163Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1322.066 ms) ====== [2026-01-21T02:23:16.163Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-21T02:23:16.163Z] GC before operation: completed in 84.511 ms, heap usage 692.590 MB -> 124.470 MB. [2026-01-21T02:23:18.156Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1376.024 ms) ====== [2026-01-21T02:23:18.156Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-21T02:23:18.156Z] GC before operation: completed in 87.780 ms, heap usage 580.052 MB -> 124.373 MB. [2026-01-21T02:23:19.127Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1296.371 ms) ====== [2026-01-21T02:23:19.127Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-21T02:23:19.127Z] GC before operation: completed in 91.775 ms, heap usage 531.247 MB -> 124.435 MB. [2026-01-21T02:23:21.119Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1358.968 ms) ====== [2026-01-21T02:23:21.119Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-21T02:23:21.119Z] GC before operation: completed in 82.775 ms, heap usage 416.857 MB -> 124.320 MB. [2026-01-21T02:23:22.090Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1316.005 ms) ====== [2026-01-21T02:23:22.090Z] ----------------------------------- [2026-01-21T02:23:22.090Z] renaissance-log-regression_0_PASSED [2026-01-21T02:23:22.090Z] ----------------------------------- [2026-01-21T02:23:22.090Z] [2026-01-21T02:23:22.090Z] TEST TEARDOWN: [2026-01-21T02:23:22.090Z] Nothing to be done for teardown. [2026-01-21T02:23:22.090Z] renaissance-log-regression_0 Finish Time: Wed Jan 21 02:23:21 2026 Epoch Time (ms): 1768962201818