[2025-11-29T13:06:35.085Z] Running test renaissance-log-regression_0 ... [2025-11-29T13:06:35.085Z] =============================================== [2025-11-29T13:06:35.085Z] renaissance-log-regression_0 Start Time: Sat Nov 29 08:06:34 2025 Epoch Time (ms): 1764421594823 [2025-11-29T13:06:35.085Z] variation: NoOptions [2025-11-29T13:06:35.085Z] JVM_OPTIONS: [2025-11-29T13:06:35.085Z] { \ [2025-11-29T13:06:35.085Z] echo ""; echo "TEST SETUP:"; \ [2025-11-29T13:06:35.085Z] echo "Nothing to be done for setup."; \ [2025-11-29T13:06:35.085Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17644211171833/renaissance-log-regression_0"; \ [2025-11-29T13:06:35.085Z] cd "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17644211171833/renaissance-log-regression_0"; \ [2025-11-29T13:06:35.085Z] echo ""; echo "TESTING:"; \ [2025-11-29T13:06:35.085Z] "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17644211171833/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-11-29T13:06:35.085Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17644211171833/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-29T13:06:35.085Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-29T13:06:35.085Z] echo "Nothing to be done for teardown."; \ [2025-11-29T13:06:35.085Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17644211171833/TestTargetResult"; [2025-11-29T13:06:35.085Z] [2025-11-29T13:06:35.085Z] TEST SETUP: [2025-11-29T13:06:35.085Z] Nothing to be done for setup. [2025-11-29T13:06:35.085Z] [2025-11-29T13:06:35.085Z] TESTING: [2025-11-29T13:06:35.085Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-11-29T13:06:35.085Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_aarch64_mac/aqa-tests/TKG/output_17644211171833/renaissance-log-regression_0/launcher-080634-12635890089452068923/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-11-29T13:06:35.085Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-11-29T13:06:35.085Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-11-29T13:06:38.186Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-29T13:06:38.955Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-11-29T13:06:38.955Z] GC before operation: completed in 21.288 ms, heap usage 61.295 MB -> 35.313 MB. [2025-11-29T13:06:43.101Z] ====== log-regression (apache-spark) [default], iteration 0 completed (3857.462 ms) ====== [2025-11-29T13:06:43.101Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-11-29T13:06:43.101Z] GC before operation: completed in 32.199 ms, heap usage 497.622 MB -> 120.251 MB. [2025-11-29T13:06:43.452Z] ====== log-regression (apache-spark) [default], iteration 1 completed (762.299 ms) ====== [2025-11-29T13:06:43.452Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-11-29T13:06:43.452Z] GC before operation: completed in 29.723 ms, heap usage 459.285 MB -> 120.683 MB. [2025-11-29T13:06:44.221Z] ====== log-regression (apache-spark) [default], iteration 2 completed (630.566 ms) ====== [2025-11-29T13:06:44.222Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-11-29T13:06:44.222Z] GC before operation: completed in 28.918 ms, heap usage 532.449 MB -> 121.362 MB. [2025-11-29T13:06:44.577Z] ====== log-regression (apache-spark) [default], iteration 3 completed (653.991 ms) ====== [2025-11-29T13:06:44.577Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-11-29T13:06:44.936Z] GC before operation: completed in 31.922 ms, heap usage 533.001 MB -> 121.619 MB. [2025-11-29T13:06:45.306Z] ====== log-regression (apache-spark) [default], iteration 4 completed (584.512 ms) ====== [2025-11-29T13:06:45.306Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-11-29T13:06:45.306Z] GC before operation: completed in 29.735 ms, heap usage 380.354 MB -> 121.507 MB. [2025-11-29T13:06:46.077Z] ====== log-regression (apache-spark) [default], iteration 5 completed (501.477 ms) ====== [2025-11-29T13:06:46.077Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-11-29T13:06:46.077Z] GC before operation: completed in 30.337 ms, heap usage 390.077 MB -> 121.765 MB. [2025-11-29T13:06:46.451Z] ====== log-regression (apache-spark) [default], iteration 6 completed (463.121 ms) ====== [2025-11-29T13:06:46.451Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-11-29T13:06:46.451Z] GC before operation: completed in 29.590 ms, heap usage 420.647 MB -> 122.028 MB. [2025-11-29T13:06:46.805Z] ====== log-regression (apache-spark) [default], iteration 7 completed (445.330 ms) ====== [2025-11-29T13:06:46.805Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-11-29T13:06:46.805Z] GC before operation: completed in 29.786 ms, heap usage 284.862 MB -> 121.836 MB. [2025-11-29T13:06:47.559Z] ====== log-regression (apache-spark) [default], iteration 8 completed (446.168 ms) ====== [2025-11-29T13:06:47.559Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-11-29T13:06:47.559Z] GC before operation: completed in 31.334 ms, heap usage 745.987 MB -> 123.465 MB. [2025-11-29T13:06:47.912Z] ====== log-regression (apache-spark) [default], iteration 9 completed (435.642 ms) ====== [2025-11-29T13:06:47.912Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-11-29T13:06:47.912Z] GC before operation: completed in 30.555 ms, heap usage 609.071 MB -> 123.222 MB. [2025-11-29T13:06:48.277Z] ====== log-regression (apache-spark) [default], iteration 10 completed (453.667 ms) ====== [2025-11-29T13:06:48.277Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-11-29T13:06:48.277Z] GC before operation: completed in 31.833 ms, heap usage 374.325 MB -> 122.868 MB. [2025-11-29T13:06:48.637Z] ====== log-regression (apache-spark) [default], iteration 11 completed (429.596 ms) ====== [2025-11-29T13:06:48.637Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-11-29T13:06:48.637Z] GC before operation: completed in 31.810 ms, heap usage 758.015 MB -> 124.170 MB. [2025-11-29T13:06:49.412Z] ====== log-regression (apache-spark) [default], iteration 12 completed (426.804 ms) ====== [2025-11-29T13:06:49.412Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-11-29T13:06:49.412Z] GC before operation: completed in 30.251 ms, heap usage 695.068 MB -> 124.269 MB. [2025-11-29T13:06:49.773Z] ====== log-regression (apache-spark) [default], iteration 13 completed (406.003 ms) ====== [2025-11-29T13:06:49.773Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-11-29T13:06:49.773Z] GC before operation: completed in 30.363 ms, heap usage 590.044 MB -> 124.163 MB. [2025-11-29T13:06:50.128Z] ====== log-regression (apache-spark) [default], iteration 14 completed (404.782 ms) ====== [2025-11-29T13:06:50.128Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-11-29T13:06:50.128Z] GC before operation: completed in 31.033 ms, heap usage 718.158 MB -> 124.742 MB. [2025-11-29T13:06:50.492Z] ====== log-regression (apache-spark) [default], iteration 15 completed (414.128 ms) ====== [2025-11-29T13:06:50.492Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-11-29T13:06:50.492Z] GC before operation: completed in 30.915 ms, heap usage 776.851 MB -> 125.134 MB. [2025-11-29T13:06:50.848Z] ====== log-regression (apache-spark) [default], iteration 16 completed (406.269 ms) ====== [2025-11-29T13:06:50.848Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-11-29T13:06:50.848Z] GC before operation: completed in 31.821 ms, heap usage 569.295 MB -> 124.722 MB. [2025-11-29T13:06:51.628Z] ====== log-regression (apache-spark) [default], iteration 17 completed (403.193 ms) ====== [2025-11-29T13:06:51.628Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-11-29T13:06:51.628Z] GC before operation: completed in 33.526 ms, heap usage 595.563 MB -> 125.025 MB. [2025-11-29T13:06:51.980Z] ====== log-regression (apache-spark) [default], iteration 18 completed (401.324 ms) ====== [2025-11-29T13:06:51.980Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-11-29T13:06:51.980Z] GC before operation: completed in 32.997 ms, heap usage 451.940 MB -> 124.787 MB. [2025-11-29T13:06:52.335Z] ====== log-regression (apache-spark) [default], iteration 19 completed (465.759 ms) ====== [2025-11-29T13:06:52.335Z] ----------------------------------- [2025-11-29T13:06:52.335Z] renaissance-log-regression_0_PASSED [2025-11-29T13:06:52.335Z] ----------------------------------- [2025-11-29T13:06:52.335Z] [2025-11-29T13:06:52.335Z] TEST TEARDOWN: [2025-11-29T13:06:52.335Z] Nothing to be done for teardown. [2025-11-29T13:06:52.335Z] renaissance-log-regression_0 Finish Time: Sat Nov 29 08:06:52 2025 Epoch Time (ms): 1764421612234