[2025-12-16T09:18:39.332Z] Running test renaissance-log-regression_0 ... [2025-12-16T09:18:39.332Z] =============================================== [2025-12-16T09:18:39.332Z] renaissance-log-regression_0 Start Time: Tue Dec 16 09:18:39 2025 Epoch Time (ms): 1765876719214 [2025-12-16T09:18:39.332Z] variation: NoOptions [2025-12-16T09:18:39.332Z] JVM_OPTIONS: [2025-12-16T09:18:39.332Z] { \ [2025-12-16T09:18:39.332Z] echo ""; echo "TEST SETUP:"; \ [2025-12-16T09:18:39.332Z] echo "Nothing to be done for setup."; \ [2025-12-16T09:18:39.332Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17658751645866/renaissance-log-regression_0"; \ [2025-12-16T09:18:39.332Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17658751645866/renaissance-log-regression_0"; \ [2025-12-16T09:18:39.332Z] echo ""; echo "TESTING:"; \ [2025-12-16T09:18:39.332Z] "/home/jenkins/workspace/Test_openjdk25_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_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17658751645866/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-12-16T09:18:39.332Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17658751645866/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-16T09:18:39.332Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-16T09:18:39.332Z] echo "Nothing to be done for teardown."; \ [2025-12-16T09:18:39.332Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17658751645866/TestTargetResult"; [2025-12-16T09:18:39.332Z] [2025-12-16T09:18:39.332Z] TEST SETUP: [2025-12-16T09:18:39.332Z] Nothing to be done for setup. [2025-12-16T09:18:39.332Z] [2025-12-16T09:18:39.332Z] TESTING: [2025-12-16T09:18:40.364Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-16T09:18:40.364Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/output_17658751645866/renaissance-log-regression_0/launcher-091839-5054373257474449350/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-16T09:18:40.364Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-16T09:18:40.364Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-16T09:18:57.366Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-16T09:19:08.289Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-16T09:19:08.289Z] GC before operation: completed in 100.716 ms, heap usage 55.348 MB -> 35.079 MB. [2025-12-16T09:19:34.460Z] ====== log-regression (apache-spark) [default], iteration 0 completed (23874.766 ms) ====== [2025-12-16T09:19:34.460Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-16T09:19:34.460Z] GC before operation: completed in 414.426 ms, heap usage 469.369 MB -> 120.050 MB. [2025-12-16T09:19:36.803Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3714.434 ms) ====== [2025-12-16T09:19:36.803Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-16T09:19:36.803Z] GC before operation: completed in 137.525 ms, heap usage 629.544 MB -> 120.961 MB. [2025-12-16T09:19:40.220Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3889.388 ms) ====== [2025-12-16T09:19:40.220Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-16T09:19:40.220Z] GC before operation: completed in 128.185 ms, heap usage 325.187 MB -> 120.572 MB. [2025-12-16T09:19:43.582Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2741.090 ms) ====== [2025-12-16T09:19:43.582Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-16T09:19:43.582Z] GC before operation: completed in 169.655 ms, heap usage 392.495 MB -> 121.147 MB. [2025-12-16T09:19:45.696Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2557.095 ms) ====== [2025-12-16T09:19:45.696Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-16T09:19:45.696Z] GC before operation: completed in 145.711 ms, heap usage 255.982 MB -> 120.928 MB. [2025-12-16T09:19:49.286Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2952.692 ms) ====== [2025-12-16T09:19:49.286Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-16T09:19:49.286Z] GC before operation: completed in 138.666 ms, heap usage 232.453 MB -> 121.035 MB. [2025-12-16T09:19:52.070Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2366.652 ms) ====== [2025-12-16T09:19:52.070Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-16T09:19:52.070Z] GC before operation: completed in 144.415 ms, heap usage 306.926 MB -> 121.515 MB. [2025-12-16T09:19:54.233Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2815.325 ms) ====== [2025-12-16T09:19:54.233Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-16T09:19:55.270Z] GC before operation: completed in 177.684 ms, heap usage 256.105 MB -> 121.564 MB. [2025-12-16T09:19:57.603Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2735.132 ms) ====== [2025-12-16T09:19:57.603Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-16T09:19:57.603Z] GC before operation: completed in 172.865 ms, heap usage 273.111 MB -> 121.903 MB. [2025-12-16T09:20:01.027Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2885.754 ms) ====== [2025-12-16T09:20:01.027Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-16T09:20:01.027Z] GC before operation: completed in 154.482 ms, heap usage 255.050 MB -> 122.030 MB. [2025-12-16T09:20:03.147Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2354.435 ms) ====== [2025-12-16T09:20:03.147Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-16T09:20:03.147Z] GC before operation: completed in 169.830 ms, heap usage 282.274 MB -> 122.299 MB. [2025-12-16T09:20:05.424Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2495.865 ms) ====== [2025-12-16T09:20:05.424Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-16T09:20:06.507Z] GC before operation: completed in 182.250 ms, heap usage 597.598 MB -> 123.535 MB. [2025-12-16T09:20:08.818Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2530.011 ms) ====== [2025-12-16T09:20:08.818Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-16T09:20:08.818Z] GC before operation: completed in 153.244 ms, heap usage 269.382 MB -> 122.714 MB. [2025-12-16T09:20:10.981Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2232.038 ms) ====== [2025-12-16T09:20:10.981Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-16T09:20:10.981Z] GC before operation: completed in 380.427 ms, heap usage 272.032 MB -> 122.904 MB. [2025-12-16T09:20:13.110Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2139.096 ms) ====== [2025-12-16T09:20:13.110Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-16T09:20:14.146Z] GC before operation: completed in 360.945 ms, heap usage 228.775 MB -> 122.949 MB. [2025-12-16T09:20:16.365Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2370.660 ms) ====== [2025-12-16T09:20:16.365Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-16T09:20:16.365Z] GC before operation: completed in 227.208 ms, heap usage 257.121 MB -> 123.177 MB. [2025-12-16T09:20:19.943Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2968.507 ms) ====== [2025-12-16T09:20:19.943Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-16T09:20:19.943Z] GC before operation: completed in 202.390 ms, heap usage 271.285 MB -> 123.469 MB. [2025-12-16T09:20:22.233Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2345.379 ms) ====== [2025-12-16T09:20:22.233Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-16T09:20:22.233Z] GC before operation: completed in 169.515 ms, heap usage 236.761 MB -> 123.618 MB. [2025-12-16T09:20:24.390Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2658.468 ms) ====== [2025-12-16T09:20:24.390Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-16T09:20:25.429Z] GC before operation: completed in 211.074 ms, heap usage 221.345 MB -> 124.749 MB. [2025-12-16T09:20:27.549Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2093.261 ms) ====== [2025-12-16T09:20:27.549Z] ----------------------------------- [2025-12-16T09:20:27.549Z] renaissance-log-regression_0_PASSED [2025-12-16T09:20:27.549Z] ----------------------------------- [2025-12-16T09:20:27.549Z] [2025-12-16T09:20:27.549Z] TEST TEARDOWN: [2025-12-16T09:20:27.549Z] Nothing to be done for teardown. [2025-12-16T09:20:27.549Z] renaissance-log-regression_0 Finish Time: Tue Dec 16 09:20:27 2025 Epoch Time (ms): 1765876827229