[2025-10-31T17:47:23.928Z] Running test renaissance-log-regression_0 ... [2025-10-31T17:47:23.928Z] =============================================== [2025-10-31T17:47:23.928Z] renaissance-log-regression_0 Start Time: Fri Oct 31 17:47:23 2025 Epoch Time (ms): 1761932843082 [2025-10-31T17:47:23.928Z] variation: NoOptions [2025-10-31T17:47:23.928Z] JVM_OPTIONS: [2025-10-31T17:47:23.928Z] { \ [2025-10-31T17:47:23.928Z] echo ""; echo "TEST SETUP:"; \ [2025-10-31T17:47:23.928Z] echo "Nothing to be done for setup."; \ [2025-10-31T17:47:23.928Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17619306251678/renaissance-log-regression_0"; \ [2025-10-31T17:47:23.928Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17619306251678/renaissance-log-regression_0"; \ [2025-10-31T17:47:23.928Z] echo ""; echo "TESTING:"; \ [2025-10-31T17:47:23.928Z] "/home/jenkins/workspace/Test_openjdk25_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_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17619306251678/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-10-31T17:47:23.928Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17619306251678/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-31T17:47:23.928Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-31T17:47:23.928Z] echo "Nothing to be done for teardown."; \ [2025-10-31T17:47:23.928Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17619306251678/TestTargetResult"; [2025-10-31T17:47:23.928Z] [2025-10-31T17:47:23.928Z] TEST SETUP: [2025-10-31T17:47:23.928Z] Nothing to be done for setup. [2025-10-31T17:47:23.928Z] [2025-10-31T17:47:23.928Z] TESTING: [2025-10-31T17:47:24.898Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-10-31T17:47:24.898Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17619306251678/renaissance-log-regression_0/launcher-174723-3221461939157418298/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-10-31T17:47:24.898Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-10-31T17:47:24.898Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-10-31T17:47:33.094Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-10-31T17:47:37.274Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-10-31T17:47:37.274Z] GC before operation: completed in 89.599 ms, heap usage 57.295 MB -> 35.300 MB. [2025-10-31T17:47:58.639Z] ====== log-regression (apache-spark) [default], iteration 0 completed (19843.097 ms) ====== [2025-10-31T17:47:58.639Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-10-31T17:47:58.639Z] GC before operation: completed in 114.790 ms, heap usage 356.408 MB -> 119.879 MB. [2025-10-31T17:48:00.616Z] ====== log-regression (apache-spark) [default], iteration 1 completed (4125.751 ms) ====== [2025-10-31T17:48:00.616Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-10-31T17:48:01.582Z] GC before operation: completed in 122.159 ms, heap usage 487.188 MB -> 120.793 MB. [2025-10-31T17:48:05.381Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3416.081 ms) ====== [2025-10-31T17:48:05.381Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-10-31T17:48:05.381Z] GC before operation: completed in 130.160 ms, heap usage 473.889 MB -> 121.308 MB. [2025-10-31T17:48:07.360Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2846.297 ms) ====== [2025-10-31T17:48:07.360Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-10-31T17:48:07.360Z] GC before operation: completed in 124.959 ms, heap usage 136.225 MB -> 122.073 MB. [2025-10-31T17:48:11.583Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3191.703 ms) ====== [2025-10-31T17:48:11.583Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-10-31T17:48:11.583Z] GC before operation: completed in 148.181 ms, heap usage 234.437 MB -> 121.052 MB. [2025-10-31T17:48:13.566Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2794.052 ms) ====== [2025-10-31T17:48:13.566Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-10-31T17:48:13.566Z] GC before operation: completed in 123.686 ms, heap usage 758.321 MB -> 122.933 MB. [2025-10-31T17:48:16.617Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2557.320 ms) ====== [2025-10-31T17:48:16.617Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-10-31T17:48:16.617Z] GC before operation: completed in 129.944 ms, heap usage 290.759 MB -> 121.620 MB. [2025-10-31T17:48:19.677Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2657.777 ms) ====== [2025-10-31T17:48:19.677Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-10-31T17:48:19.677Z] GC before operation: completed in 129.394 ms, heap usage 665.838 MB -> 122.988 MB. [2025-10-31T17:48:21.715Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2628.599 ms) ====== [2025-10-31T17:48:21.715Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-10-31T17:48:22.682Z] GC before operation: completed in 141.191 ms, heap usage 393.692 MB -> 122.490 MB. [2025-10-31T17:48:24.657Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2611.179 ms) ====== [2025-10-31T17:48:24.657Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-10-31T17:48:24.657Z] GC before operation: completed in 137.827 ms, heap usage 265.354 MB -> 122.182 MB. [2025-10-31T17:48:27.716Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2334.885 ms) ====== [2025-10-31T17:48:27.716Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-10-31T17:48:27.716Z] GC before operation: completed in 140.166 ms, heap usage 732.767 MB -> 123.810 MB. [2025-10-31T17:48:29.704Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2661.888 ms) ====== [2025-10-31T17:48:29.705Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-10-31T17:48:30.668Z] GC before operation: completed in 146.325 ms, heap usage 437.674 MB -> 123.209 MB. [2025-10-31T17:48:32.651Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2439.489 ms) ====== [2025-10-31T17:48:32.651Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-10-31T17:48:32.651Z] GC before operation: completed in 135.447 ms, heap usage 395.932 MB -> 123.231 MB. [2025-10-31T17:48:34.628Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2244.406 ms) ====== [2025-10-31T17:48:34.628Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-10-31T17:48:35.586Z] GC before operation: completed in 145.222 ms, heap usage 744.962 MB -> 124.323 MB. [2025-10-31T17:48:37.570Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2290.535 ms) ====== [2025-10-31T17:48:37.570Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-10-31T17:48:37.570Z] GC before operation: completed in 142.024 ms, heap usage 350.182 MB -> 123.299 MB. [2025-10-31T17:48:40.611Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2511.300 ms) ====== [2025-10-31T17:48:40.611Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-10-31T17:48:40.611Z] GC before operation: completed in 158.452 ms, heap usage 296.077 MB -> 123.467 MB. [2025-10-31T17:48:42.579Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2440.971 ms) ====== [2025-10-31T17:48:42.579Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-10-31T17:48:42.579Z] GC before operation: completed in 154.068 ms, heap usage 743.722 MB -> 124.954 MB. [2025-10-31T17:48:45.632Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2366.038 ms) ====== [2025-10-31T17:48:45.632Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-10-31T17:48:45.632Z] GC before operation: completed in 152.819 ms, heap usage 251.629 MB -> 123.650 MB. [2025-10-31T17:48:47.615Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2324.421 ms) ====== [2025-10-31T17:48:47.615Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-10-31T17:48:47.615Z] GC before operation: completed in 155.569 ms, heap usage 407.987 MB -> 124.348 MB. [2025-10-31T17:48:50.678Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2493.786 ms) ====== [2025-10-31T17:48:50.678Z] ----------------------------------- [2025-10-31T17:48:50.678Z] renaissance-log-regression_0_PASSED [2025-10-31T17:48:50.678Z] ----------------------------------- [2025-10-31T17:48:50.678Z] [2025-10-31T17:48:50.678Z] TEST TEARDOWN: [2025-10-31T17:48:50.678Z] Nothing to be done for teardown. [2025-10-31T17:48:51.640Z] renaissance-log-regression_0 Finish Time: Fri Oct 31 17:48:50 2025 Epoch Time (ms): 1761932930600