[2025-11-20T00:49:28.761Z] Running test renaissance-log-regression_0 ... [2025-11-20T00:49:28.761Z] =============================================== [2025-11-20T00:49:28.761Z] renaissance-log-regression_0 Start Time: Thu Nov 20 00:49:28 2025 Epoch Time (ms): 1763599768176 [2025-11-20T00:49:28.761Z] variation: NoOptions [2025-11-20T00:49:28.761Z] JVM_OPTIONS: [2025-11-20T00:49:28.761Z] { \ [2025-11-20T00:49:28.761Z] echo ""; echo "TEST SETUP:"; \ [2025-11-20T00:49:28.761Z] echo "Nothing to be done for setup."; \ [2025-11-20T00:49:28.761Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_1763598609916/renaissance-log-regression_0"; \ [2025-11-20T00:49:28.761Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_1763598609916/renaissance-log-regression_0"; \ [2025-11-20T00:49:28.761Z] echo ""; echo "TESTING:"; \ [2025-11-20T00:49:28.761Z] "/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_1763598609916/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-11-20T00:49:28.761Z] 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_1763598609916/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-20T00:49:28.761Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-20T00:49:28.761Z] echo "Nothing to be done for teardown."; \ [2025-11-20T00:49:28.761Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_1763598609916/TestTargetResult"; [2025-11-20T00:49:28.761Z] [2025-11-20T00:49:28.761Z] TEST SETUP: [2025-11-20T00:49:28.761Z] Nothing to be done for setup. [2025-11-20T00:49:28.761Z] [2025-11-20T00:49:28.761Z] TESTING: [2025-11-20T00:49:36.013Z] NOTE: 'log-regression' benchmark uses Spark local executor with 12 (out of 24) threads. [2025-11-20T00:49:39.504Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-11-20T00:49:39.504Z] GC before operation: completed in 67.057 ms, heap usage 38.303 MB -> 34.698 MB. [2025-11-20T00:49:51.216Z] ====== log-regression (apache-spark) [default], iteration 0 completed (11308.905 ms) ====== [2025-11-20T00:49:51.216Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-11-20T00:49:51.216Z] GC before operation: completed in 107.206 ms, heap usage 763.449 MB -> 132.745 MB. [2025-11-20T00:49:52.815Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2160.643 ms) ====== [2025-11-20T00:49:52.815Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-11-20T00:49:52.815Z] GC before operation: completed in 103.177 ms, heap usage 504.878 MB -> 132.767 MB. [2025-11-20T00:49:55.274Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1906.038 ms) ====== [2025-11-20T00:49:55.274Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-11-20T00:49:55.274Z] GC before operation: completed in 106.276 ms, heap usage 597.970 MB -> 133.447 MB. [2025-11-20T00:49:56.861Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1795.510 ms) ====== [2025-11-20T00:49:56.861Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-11-20T00:49:56.861Z] GC before operation: completed in 107.673 ms, heap usage 945.176 MB -> 134.821 MB. [2025-11-20T00:49:58.468Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1783.316 ms) ====== [2025-11-20T00:49:58.468Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-11-20T00:49:58.468Z] GC before operation: completed in 111.893 ms, heap usage 413.043 MB -> 133.835 MB. [2025-11-20T00:50:01.019Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1751.883 ms) ====== [2025-11-20T00:50:01.019Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-11-20T00:50:01.019Z] GC before operation: completed in 114.938 ms, heap usage 498.735 MB -> 134.580 MB. [2025-11-20T00:50:02.639Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1648.505 ms) ====== [2025-11-20T00:50:02.639Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-11-20T00:50:02.639Z] GC before operation: completed in 122.856 ms, heap usage 667.053 MB -> 135.310 MB. [2025-11-20T00:50:04.232Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1658.420 ms) ====== [2025-11-20T00:50:04.232Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-11-20T00:50:04.232Z] GC before operation: completed in 120.712 ms, heap usage 432.233 MB -> 135.179 MB. [2025-11-20T00:50:05.828Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1701.372 ms) ====== [2025-11-20T00:50:05.828Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-11-20T00:50:05.828Z] GC before operation: completed in 129.184 ms, heap usage 985.157 MB -> 137.003 MB. [2025-11-20T00:50:07.418Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1672.739 ms) ====== [2025-11-20T00:50:07.418Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-11-20T00:50:07.418Z] GC before operation: completed in 124.835 ms, heap usage 997.273 MB -> 137.375 MB. [2025-11-20T00:50:09.017Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1594.922 ms) ====== [2025-11-20T00:50:09.017Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-11-20T00:50:09.793Z] GC before operation: completed in 119.943 ms, heap usage 1011.846 MB -> 137.853 MB. [2025-11-20T00:50:11.547Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1655.937 ms) ====== [2025-11-20T00:50:11.547Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-11-20T00:50:11.547Z] GC before operation: completed in 120.724 ms, heap usage 432.254 MB -> 136.684 MB. [2025-11-20T00:50:13.139Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1605.316 ms) ====== [2025-11-20T00:50:13.139Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-11-20T00:50:13.139Z] GC before operation: completed in 125.735 ms, heap usage 925.650 MB -> 138.372 MB. [2025-11-20T00:50:14.729Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1587.094 ms) ====== [2025-11-20T00:50:14.729Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-11-20T00:50:14.729Z] GC before operation: completed in 135.573 ms, heap usage 933.916 MB -> 138.843 MB. [2025-11-20T00:50:16.321Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1583.030 ms) ====== [2025-11-20T00:50:16.321Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-11-20T00:50:16.321Z] GC before operation: completed in 127.178 ms, heap usage 355.361 MB -> 137.414 MB. [2025-11-20T00:50:17.908Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1560.834 ms) ====== [2025-11-20T00:50:17.908Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-11-20T00:50:17.908Z] GC before operation: completed in 120.912 ms, heap usage 929.884 MB -> 139.495 MB. [2025-11-20T00:50:19.508Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1547.178 ms) ====== [2025-11-20T00:50:19.508Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-11-20T00:50:19.508Z] GC before operation: completed in 127.815 ms, heap usage 537.099 MB -> 138.785 MB. [2025-11-20T00:50:21.091Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1575.747 ms) ====== [2025-11-20T00:50:21.091Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-11-20T00:50:21.863Z] GC before operation: completed in 120.463 ms, heap usage 893.295 MB -> 140.219 MB. [2025-11-20T00:50:23.473Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1609.942 ms) ====== [2025-11-20T00:50:23.473Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-11-20T00:50:23.473Z] GC before operation: completed in 126.359 ms, heap usage 993.896 MB -> 140.947 MB. [2025-11-20T00:50:25.060Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1609.921 ms) ====== [2025-11-20T00:50:25.060Z] ----------------------------------- [2025-11-20T00:50:25.060Z] renaissance-log-regression_0_PASSED [2025-11-20T00:50:25.060Z] ----------------------------------- [2025-11-20T00:50:25.060Z] [2025-11-20T00:50:25.060Z] TEST TEARDOWN: [2025-11-20T00:50:25.060Z] Nothing to be done for teardown. [2025-11-20T00:50:25.060Z] renaissance-log-regression_0 Finish Time: Thu Nov 20 00:50:24 2025 Epoch Time (ms): 1763599824924