[2025-12-24T23:28:32.301Z] Running test renaissance-log-regression_0 ... [2025-12-24T23:28:32.301Z] =============================================== [2025-12-24T23:28:32.301Z] renaissance-log-regression_0 Start Time: Wed Dec 24 23:28:31 2025 Epoch Time (ms): 1766618911300 [2025-12-24T23:28:32.301Z] variation: NoOptions [2025-12-24T23:28:32.301Z] JVM_OPTIONS: [2025-12-24T23:28:32.301Z] { \ [2025-12-24T23:28:32.301Z] echo ""; echo "TEST SETUP:"; \ [2025-12-24T23:28:32.301Z] echo "Nothing to be done for setup."; \ [2025-12-24T23:28:32.301Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17666167571812/renaissance-log-regression_0"; \ [2025-12-24T23:28:32.301Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17666167571812/renaissance-log-regression_0"; \ [2025-12-24T23:28:32.301Z] echo ""; echo "TESTING:"; \ [2025-12-24T23:28:32.301Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-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_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17666167571812/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-12-24T23:28:32.301Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17666167571812/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-24T23:28:32.301Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-24T23:28:32.301Z] echo "Nothing to be done for teardown."; \ [2025-12-24T23:28:32.301Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17666167571812/TestTargetResult"; [2025-12-24T23:28:32.301Z] [2025-12-24T23:28:32.301Z] TEST SETUP: [2025-12-24T23:28:32.301Z] Nothing to be done for setup. [2025-12-24T23:28:32.301Z] [2025-12-24T23:28:32.301Z] TESTING: [2025-12-24T23:28:42.115Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-24T23:28:46.281Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-24T23:28:46.281Z] GC before operation: completed in 79.378 ms, heap usage 64.422 MB -> 35.053 MB. [2025-12-24T23:29:07.689Z] ====== log-regression (apache-spark) [default], iteration 0 completed (20833.122 ms) ====== [2025-12-24T23:29:07.689Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-24T23:29:07.689Z] GC before operation: completed in 168.425 ms, heap usage 482.856 MB -> 120.049 MB. [2025-12-24T23:29:10.927Z] ====== log-regression (apache-spark) [default], iteration 1 completed (4551.534 ms) ====== [2025-12-24T23:29:10.927Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-24T23:29:11.933Z] GC before operation: completed in 135.116 ms, heap usage 546.718 MB -> 120.787 MB. [2025-12-24T23:29:15.006Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3616.987 ms) ====== [2025-12-24T23:29:15.006Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-24T23:29:15.006Z] GC before operation: completed in 166.910 ms, heap usage 791.093 MB -> 121.952 MB. [2025-12-24T23:29:18.066Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2914.622 ms) ====== [2025-12-24T23:29:18.066Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-24T23:29:18.066Z] GC before operation: completed in 141.757 ms, heap usage 587.207 MB -> 121.676 MB. [2025-12-24T23:29:21.122Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3231.919 ms) ====== [2025-12-24T23:29:21.122Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-24T23:29:22.104Z] GC before operation: completed in 127.824 ms, heap usage 135.500 MB -> 121.998 MB. [2025-12-24T23:29:25.166Z] ====== log-regression (apache-spark) [default], iteration 5 completed (3215.120 ms) ====== [2025-12-24T23:29:25.167Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-24T23:29:25.167Z] GC before operation: completed in 213.126 ms, heap usage 275.263 MB -> 121.161 MB. [2025-12-24T23:29:28.226Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2655.375 ms) ====== [2025-12-24T23:29:28.226Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-24T23:29:28.226Z] GC before operation: completed in 180.246 ms, heap usage 749.161 MB -> 122.874 MB. [2025-12-24T23:29:31.277Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2903.971 ms) ====== [2025-12-24T23:29:31.277Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-24T23:29:31.277Z] GC before operation: completed in 210.680 ms, heap usage 366.480 MB -> 121.932 MB. [2025-12-24T23:29:34.324Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2664.877 ms) ====== [2025-12-24T23:29:34.324Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-24T23:29:34.324Z] GC before operation: completed in 193.826 ms, heap usage 607.948 MB -> 122.797 MB. [2025-12-24T23:29:36.307Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2571.014 ms) ====== [2025-12-24T23:29:36.307Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-24T23:29:36.307Z] GC before operation: completed in 213.611 ms, heap usage 519.466 MB -> 122.779 MB. [2025-12-24T23:29:39.360Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2385.698 ms) ====== [2025-12-24T23:29:39.360Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-24T23:29:39.360Z] GC before operation: completed in 196.748 ms, heap usage 398.387 MB -> 122.592 MB. [2025-12-24T23:29:41.329Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2266.199 ms) ====== [2025-12-24T23:29:41.329Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-24T23:29:41.329Z] GC before operation: completed in 208.548 ms, heap usage 728.706 MB -> 123.761 MB. [2025-12-24T23:29:44.381Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2339.540 ms) ====== [2025-12-24T23:29:44.381Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-24T23:29:44.381Z] GC before operation: completed in 225.139 ms, heap usage 543.735 MB -> 123.482 MB. [2025-12-24T23:29:46.364Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2350.072 ms) ====== [2025-12-24T23:29:46.364Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-24T23:29:47.334Z] GC before operation: completed in 166.500 ms, heap usage 624.145 MB -> 123.961 MB. [2025-12-24T23:29:49.330Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2548.336 ms) ====== [2025-12-24T23:29:49.330Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-24T23:29:49.330Z] GC before operation: completed in 196.959 ms, heap usage 574.798 MB -> 124.033 MB. [2025-12-24T23:29:52.380Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2730.720 ms) ====== [2025-12-24T23:29:52.380Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-24T23:29:52.380Z] GC before operation: completed in 223.294 ms, heap usage 675.220 MB -> 124.603 MB. [2025-12-24T23:29:55.441Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2363.157 ms) ====== [2025-12-24T23:29:55.441Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-24T23:29:55.441Z] GC before operation: completed in 193.407 ms, heap usage 147.302 MB -> 123.337 MB. [2025-12-24T23:29:58.169Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2323.084 ms) ====== [2025-12-24T23:29:58.169Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-24T23:29:58.169Z] GC before operation: completed in 190.754 ms, heap usage 137.563 MB -> 124.225 MB. [2025-12-24T23:30:00.164Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2310.546 ms) ====== [2025-12-24T23:30:00.164Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-24T23:30:00.164Z] GC before operation: completed in 214.906 ms, heap usage 539.591 MB -> 124.714 MB. [2025-12-24T23:30:03.311Z] ====== log-regression (apache-spark) [default], iteration 19 completed (3181.588 ms) ====== [2025-12-24T23:30:04.270Z] ----------------------------------- [2025-12-24T23:30:04.270Z] renaissance-log-regression_0_PASSED [2025-12-24T23:30:04.270Z] ----------------------------------- [2025-12-24T23:30:04.270Z] [2025-12-24T23:30:04.270Z] TEST TEARDOWN: [2025-12-24T23:30:04.270Z] Nothing to be done for teardown. [2025-12-24T23:30:04.270Z] renaissance-log-regression_0 Finish Time: Wed Dec 24 23:30:03 2025 Epoch Time (ms): 1766619003507