[2026-04-02T01:51:08.738Z] Running test renaissance-log-regression_0 ... [2026-04-02T01:51:08.738Z] =============================================== [2026-04-02T01:51:08.738Z] renaissance-log-regression_0 Start Time: Thu Apr 2 01:51:06 2026 Epoch Time (ms): 1775094666593 [2026-04-02T01:51:08.738Z] variation: NoOptions [2026-04-02T01:51:08.738Z] JVM_OPTIONS: [2026-04-02T01:51:08.738Z] { \ [2026-04-02T01:51:08.738Z] echo ""; echo "TEST SETUP:"; \ [2026-04-02T01:51:08.738Z] echo "Nothing to be done for setup."; \ [2026-04-02T01:51:08.738Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-log-regression_0"; \ [2026-04-02T01:51:08.738Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-log-regression_0"; \ [2026-04-02T01:51:08.738Z] echo ""; echo "TESTING:"; \ [2026-04-02T01:51:08.738Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-04-02T01:51:08.738Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-02T01:51:08.738Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-02T01:51:08.738Z] echo "Nothing to be done for teardown."; \ [2026-04-02T01:51:08.738Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1775092997766/TestTargetResult"; [2026-04-02T01:51:08.738Z] [2026-04-02T01:51:08.738Z] TEST SETUP: [2026-04-02T01:51:08.738Z] Nothing to be done for setup. [2026-04-02T01:51:08.738Z] [2026-04-02T01:51:08.738Z] TESTING: [2026-04-02T01:51:21.182Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-02T01:51:29.495Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-04-02T01:51:29.495Z] GC before operation: completed in 94.737 ms, heap usage 79.499 MB -> 35.340 MB. [2026-04-02T01:51:58.323Z] ====== log-regression (apache-spark) [default], iteration 0 completed (28942.092 ms) ====== [2026-04-02T01:51:58.323Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-04-02T01:51:58.323Z] GC before operation: completed in 150.976 ms, heap usage 293.967 MB -> 119.662 MB. [2026-04-02T01:52:05.198Z] ====== log-regression (apache-spark) [default], iteration 1 completed (7143.296 ms) ====== [2026-04-02T01:52:05.198Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-04-02T01:52:05.198Z] GC before operation: completed in 158.798 ms, heap usage 323.973 MB -> 120.331 MB. [2026-04-02T01:52:10.684Z] ====== log-regression (apache-spark) [default], iteration 2 completed (4778.889 ms) ====== [2026-04-02T01:52:10.684Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-04-02T01:52:10.684Z] GC before operation: completed in 172.104 ms, heap usage 244.088 MB -> 120.480 MB. [2026-04-02T01:52:14.913Z] ====== log-regression (apache-spark) [default], iteration 3 completed (4054.031 ms) ====== [2026-04-02T01:52:14.913Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-04-02T01:52:14.913Z] GC before operation: completed in 181.655 ms, heap usage 383.462 MB -> 121.152 MB. [2026-04-02T01:52:19.153Z] ====== log-regression (apache-spark) [default], iteration 4 completed (4533.604 ms) ====== [2026-04-02T01:52:19.153Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-04-02T01:52:19.153Z] GC before operation: completed in 139.869 ms, heap usage 263.581 MB -> 121.024 MB. [2026-04-02T01:52:23.425Z] ====== log-regression (apache-spark) [default], iteration 5 completed (4772.560 ms) ====== [2026-04-02T01:52:23.425Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-04-02T01:52:24.402Z] GC before operation: completed in 237.780 ms, heap usage 251.195 MB -> 121.152 MB. [2026-04-02T01:52:29.031Z] ====== log-regression (apache-spark) [default], iteration 6 completed (4133.453 ms) ====== [2026-04-02T01:52:29.031Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-04-02T01:52:29.031Z] GC before operation: completed in 153.601 ms, heap usage 277.724 MB -> 121.460 MB. [2026-04-02T01:52:31.365Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3261.354 ms) ====== [2026-04-02T01:52:31.365Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-04-02T01:52:31.365Z] GC before operation: completed in 157.056 ms, heap usage 234.822 MB -> 121.576 MB. [2026-04-02T01:52:34.421Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2991.449 ms) ====== [2026-04-02T01:52:34.421Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-04-02T01:52:35.386Z] GC before operation: completed in 160.147 ms, heap usage 273.244 MB -> 121.897 MB. [2026-04-02T01:52:38.455Z] ====== log-regression (apache-spark) [default], iteration 9 completed (3152.856 ms) ====== [2026-04-02T01:52:38.455Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-04-02T01:52:38.455Z] GC before operation: completed in 171.719 ms, heap usage 236.808 MB -> 122.027 MB. [2026-04-02T01:52:41.522Z] ====== log-regression (apache-spark) [default], iteration 10 completed (3263.350 ms) ====== [2026-04-02T01:52:41.522Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-04-02T01:52:41.522Z] GC before operation: completed in 165.175 ms, heap usage 303.194 MB -> 122.389 MB. [2026-04-02T01:52:44.597Z] ====== log-regression (apache-spark) [default], iteration 11 completed (3133.635 ms) ====== [2026-04-02T01:52:44.597Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-04-02T01:52:44.597Z] GC before operation: completed in 159.704 ms, heap usage 251.800 MB -> 122.395 MB. [2026-04-02T01:52:48.808Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3488.324 ms) ====== [2026-04-02T01:52:48.808Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-04-02T01:52:48.808Z] GC before operation: completed in 210.325 ms, heap usage 267.726 MB -> 122.708 MB. [2026-04-02T01:52:53.047Z] ====== log-regression (apache-spark) [default], iteration 13 completed (3834.958 ms) ====== [2026-04-02T01:52:53.047Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-04-02T01:52:53.047Z] GC before operation: completed in 218.986 ms, heap usage 265.280 MB -> 122.904 MB. [2026-04-02T01:52:56.106Z] ====== log-regression (apache-spark) [default], iteration 14 completed (3238.997 ms) ====== [2026-04-02T01:52:56.106Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-04-02T01:52:56.106Z] GC before operation: completed in 194.822 ms, heap usage 288.619 MB -> 123.154 MB. [2026-04-02T01:53:00.320Z] ====== log-regression (apache-spark) [default], iteration 15 completed (3848.353 ms) ====== [2026-04-02T01:53:00.320Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-04-02T01:53:00.320Z] GC before operation: completed in 250.640 ms, heap usage 289.441 MB -> 123.403 MB. [2026-04-02T01:53:04.570Z] ====== log-regression (apache-spark) [default], iteration 16 completed (3847.502 ms) ====== [2026-04-02T01:53:04.570Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-04-02T01:53:04.570Z] GC before operation: completed in 190.715 ms, heap usage 278.436 MB -> 123.541 MB. [2026-04-02T01:53:07.652Z] ====== log-regression (apache-spark) [default], iteration 17 completed (3342.420 ms) ====== [2026-04-02T01:53:07.652Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-04-02T01:53:07.652Z] GC before operation: completed in 164.627 ms, heap usage 315.873 MB -> 123.917 MB. [2026-04-02T01:53:11.908Z] ====== log-regression (apache-spark) [default], iteration 18 completed (4005.789 ms) ====== [2026-04-02T01:53:11.908Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-04-02T01:53:11.908Z] GC before operation: completed in 281.820 ms, heap usage 272.927 MB -> 123.876 MB. [2026-04-02T01:53:16.164Z] ====== log-regression (apache-spark) [default], iteration 19 completed (4111.243 ms) ====== [2026-04-02T01:53:17.133Z] ----------------------------------- [2026-04-02T01:53:17.133Z] renaissance-log-regression_0_PASSED [2026-04-02T01:53:17.133Z] ----------------------------------- [2026-04-02T01:53:17.133Z] [2026-04-02T01:53:17.133Z] TEST TEARDOWN: [2026-04-02T01:53:17.133Z] Nothing to be done for teardown. [2026-04-02T01:53:17.133Z] renaissance-log-regression_0 Finish Time: Thu Apr 2 01:53:16 2026 Epoch Time (ms): 1775094796750