[2026-01-21T03:25:13.365Z] Running test renaissance-log-regression_0 ... [2026-01-21T03:25:13.365Z] =============================================== [2026-01-21T03:25:13.365Z] renaissance-log-regression_0 Start Time: Wed Jan 21 03:25:12 2026 Epoch Time (ms): 1768965912550 [2026-01-21T03:25:13.365Z] variation: NoOptions [2026-01-21T03:25:13.365Z] JVM_OPTIONS: [2026-01-21T03:25:13.365Z] { \ [2026-01-21T03:25:13.365Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T03:25:13.365Z] echo "Nothing to be done for setup."; \ [2026-01-21T03:25:13.365Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17689652806165/renaissance-log-regression_0"; \ [2026-01-21T03:25:13.365Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17689652806165/renaissance-log-regression_0"; \ [2026-01-21T03:25:13.365Z] echo ""; echo "TESTING:"; \ [2026-01-21T03:25:13.365Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17689652806165/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-01-21T03:25:13.365Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17689652806165/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T03:25:13.365Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T03:25:13.365Z] echo "Nothing to be done for teardown."; \ [2026-01-21T03:25:13.365Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17689652806165/TestTargetResult"; [2026-01-21T03:25:13.365Z] [2026-01-21T03:25:13.365Z] TEST SETUP: [2026-01-21T03:25:13.365Z] Nothing to be done for setup. [2026-01-21T03:25:13.365Z] [2026-01-21T03:25:13.365Z] TESTING: [2026-01-21T03:25:20.726Z] NOTE: 'log-regression' benchmark uses Spark local executor with 12 (out of 24) threads. [2026-01-21T03:25:23.236Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-01-21T03:25:23.236Z] GC before operation: completed in 70.580 ms, heap usage 56.742 MB -> 34.780 MB. [2026-01-21T03:25:35.045Z] ====== log-regression (apache-spark) [default], iteration 0 completed (11057.186 ms) ====== [2026-01-21T03:25:35.045Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-01-21T03:25:35.045Z] GC before operation: completed in 115.819 ms, heap usage 445.131 MB -> 132.382 MB. [2026-01-21T03:25:36.676Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2002.246 ms) ====== [2026-01-21T03:25:36.676Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-01-21T03:25:36.676Z] GC before operation: completed in 118.320 ms, heap usage 337.336 MB -> 132.774 MB. [2026-01-21T03:25:38.295Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1821.824 ms) ====== [2026-01-21T03:25:38.295Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-01-21T03:25:38.295Z] GC before operation: completed in 114.895 ms, heap usage 354.117 MB -> 133.120 MB. [2026-01-21T03:25:39.910Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1704.475 ms) ====== [2026-01-21T03:25:39.910Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-01-21T03:25:39.910Z] GC before operation: completed in 110.415 ms, heap usage 268.675 MB -> 133.343 MB. [2026-01-21T03:25:42.423Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1666.664 ms) ====== [2026-01-21T03:25:42.423Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-01-21T03:25:42.423Z] GC before operation: completed in 112.839 ms, heap usage 705.916 MB -> 135.160 MB. [2026-01-21T03:25:44.044Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1644.773 ms) ====== [2026-01-21T03:25:44.044Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-01-21T03:25:44.044Z] GC before operation: completed in 123.261 ms, heap usage 475.039 MB -> 134.855 MB. [2026-01-21T03:25:45.663Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1558.580 ms) ====== [2026-01-21T03:25:45.663Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-01-21T03:25:45.663Z] GC before operation: completed in 119.081 ms, heap usage 297.833 MB -> 134.720 MB. [2026-01-21T03:25:47.283Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1561.284 ms) ====== [2026-01-21T03:25:47.283Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-01-21T03:25:47.283Z] GC before operation: completed in 110.666 ms, heap usage 1.130 GB -> 137.548 MB. [2026-01-21T03:25:48.902Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1581.865 ms) ====== [2026-01-21T03:25:48.902Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-01-21T03:25:48.902Z] GC before operation: completed in 133.988 ms, heap usage 525.848 MB -> 136.048 MB. [2026-01-21T03:25:50.523Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1515.729 ms) ====== [2026-01-21T03:25:50.523Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-01-21T03:25:50.523Z] GC before operation: completed in 121.318 ms, heap usage 732.081 MB -> 137.125 MB. [2026-01-21T03:25:52.141Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1490.137 ms) ====== [2026-01-21T03:25:52.142Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-01-21T03:25:52.142Z] GC before operation: completed in 114.234 ms, heap usage 926.214 MB -> 138.104 MB. [2026-01-21T03:25:53.761Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1547.516 ms) ====== [2026-01-21T03:25:53.761Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-01-21T03:25:53.761Z] GC before operation: completed in 132.670 ms, heap usage 564.091 MB -> 137.373 MB. [2026-01-21T03:25:55.381Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1483.137 ms) ====== [2026-01-21T03:25:55.381Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-01-21T03:25:55.381Z] GC before operation: completed in 121.821 ms, heap usage 657.198 MB -> 138.194 MB. [2026-01-21T03:25:57.005Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1480.783 ms) ====== [2026-01-21T03:25:57.005Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-01-21T03:25:57.005Z] GC before operation: completed in 131.172 ms, heap usage 724.971 MB -> 138.750 MB. [2026-01-21T03:25:58.634Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1478.534 ms) ====== [2026-01-21T03:25:58.634Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-01-21T03:25:58.634Z] GC before operation: completed in 135.850 ms, heap usage 360.772 MB -> 138.010 MB. [2026-01-21T03:26:00.252Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1450.779 ms) ====== [2026-01-21T03:26:00.252Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-01-21T03:26:00.252Z] GC before operation: completed in 123.193 ms, heap usage 1.109 GB -> 140.570 MB. [2026-01-21T03:26:01.875Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1468.907 ms) ====== [2026-01-21T03:26:01.875Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-01-21T03:26:01.875Z] GC before operation: completed in 126.486 ms, heap usage 859.434 MB -> 140.107 MB. [2026-01-21T03:26:03.499Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1472.010 ms) ====== [2026-01-21T03:26:03.499Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-01-21T03:26:03.499Z] GC before operation: completed in 125.411 ms, heap usage 834.757 MB -> 140.487 MB. [2026-01-21T03:26:05.122Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1455.010 ms) ====== [2026-01-21T03:26:05.122Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-01-21T03:26:05.122Z] GC before operation: completed in 125.637 ms, heap usage 926.231 MB -> 141.039 MB. [2026-01-21T03:26:06.749Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1455.905 ms) ====== [2026-01-21T03:26:06.749Z] ----------------------------------- [2026-01-21T03:26:06.749Z] renaissance-log-regression_0_PASSED [2026-01-21T03:26:06.749Z] ----------------------------------- [2026-01-21T03:26:06.749Z] [2026-01-21T03:26:06.749Z] TEST TEARDOWN: [2026-01-21T03:26:06.749Z] Nothing to be done for teardown. [2026-01-21T03:26:06.749Z] renaissance-log-regression_0 Finish Time: Wed Jan 21 03:26:06 2026 Epoch Time (ms): 1768965966444