[2025-10-23T00:21:45.129Z] Running test renaissance-log-regression_0 ... [2025-10-23T00:21:45.129Z] =============================================== [2025-10-23T00:21:45.129Z] renaissance-log-regression_0 Start Time: Thu Oct 23 00:21:44 2025 Epoch Time (ms): 1761178904754 [2025-10-23T00:21:45.129Z] variation: NoOptions [2025-10-23T00:21:45.129Z] JVM_OPTIONS: [2025-10-23T00:21:45.129Z] { \ [2025-10-23T00:21:45.129Z] echo ""; echo "TEST SETUP:"; \ [2025-10-23T00:21:45.129Z] echo "Nothing to be done for setup."; \ [2025-10-23T00:21:45.129Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17611745521285/renaissance-log-regression_0"; \ [2025-10-23T00:21:45.129Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17611745521285/renaissance-log-regression_0"; \ [2025-10-23T00:21:45.129Z] echo ""; echo "TESTING:"; \ [2025-10-23T00:21:45.129Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/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_riscv64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17611745521285/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-10-23T00:21:45.129Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17611745521285/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-23T00:21:45.129Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-23T00:21:45.129Z] echo "Nothing to be done for teardown."; \ [2025-10-23T00:21:45.129Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17611745521285/TestTargetResult"; [2025-10-23T00:21:45.129Z] [2025-10-23T00:21:45.129Z] TEST SETUP: [2025-10-23T00:21:45.129Z] Nothing to be done for setup. [2025-10-23T00:21:45.129Z] [2025-10-23T00:21:45.129Z] TESTING: [2025-10-23T00:21:47.707Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-10-23T00:21:47.707Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/output_17611745521285/renaissance-log-regression_0/launcher-002145-11449880061159003891/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-10-23T00:21:47.707Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-10-23T00:21:47.707Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-10-23T00:22:08.685Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-10-23T00:22:18.289Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-10-23T00:22:18.681Z] GC before operation: completed in 275.113 ms, heap usage 65.905 MB -> 35.536 MB. [2025-10-23T00:23:07.990Z] ====== log-regression (apache-spark) [default], iteration 0 completed (47435.387 ms) ====== [2025-10-23T00:23:07.990Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-10-23T00:23:07.990Z] GC before operation: completed in 490.141 ms, heap usage 267.859 MB -> 122.535 MB. [2025-10-23T00:23:15.916Z] ====== log-regression (apache-spark) [default], iteration 1 completed (9520.292 ms) ====== [2025-10-23T00:23:15.917Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-10-23T00:23:16.772Z] GC before operation: completed in 568.029 ms, heap usage 1.083 GB -> 124.827 MB. [2025-10-23T00:23:25.480Z] ====== log-regression (apache-spark) [default], iteration 2 completed (8240.136 ms) ====== [2025-10-23T00:23:25.480Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-10-23T00:23:25.480Z] GC before operation: completed in 619.909 ms, heap usage 638.691 MB -> 124.693 MB. [2025-10-23T00:23:31.974Z] ====== log-regression (apache-spark) [default], iteration 3 completed (6390.946 ms) ====== [2025-10-23T00:23:31.974Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-10-23T00:23:32.370Z] GC before operation: completed in 641.391 ms, heap usage 710.640 MB -> 125.119 MB. [2025-10-23T00:23:38.859Z] ====== log-regression (apache-spark) [default], iteration 4 completed (6340.600 ms) ====== [2025-10-23T00:23:38.859Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-10-23T00:23:39.708Z] GC before operation: completed in 685.706 ms, heap usage 705.253 MB -> 125.378 MB. [2025-10-23T00:23:46.185Z] ====== log-regression (apache-spark) [default], iteration 5 completed (6215.211 ms) ====== [2025-10-23T00:23:46.185Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-10-23T00:23:46.576Z] GC before operation: completed in 696.366 ms, heap usage 402.711 MB -> 124.702 MB. [2025-10-23T00:23:53.041Z] ====== log-regression (apache-spark) [default], iteration 6 completed (5990.236 ms) ====== [2025-10-23T00:23:53.041Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-10-23T00:23:53.041Z] GC before operation: completed in 722.460 ms, heap usage 307.092 MB -> 124.682 MB. [2025-10-23T00:23:59.150Z] ====== log-regression (apache-spark) [default], iteration 7 completed (6171.324 ms) ====== [2025-10-23T00:23:59.150Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-10-23T00:24:00.001Z] GC before operation: completed in 744.028 ms, heap usage 530.108 MB -> 125.457 MB. [2025-10-23T00:24:06.510Z] ====== log-regression (apache-spark) [default], iteration 8 completed (5595.585 ms) ====== [2025-10-23T00:24:06.510Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-10-23T00:24:06.510Z] GC before operation: completed in 762.386 ms, heap usage 745.633 MB -> 126.322 MB. [2025-10-23T00:24:12.972Z] ====== log-regression (apache-spark) [default], iteration 9 completed (5767.603 ms) ====== [2025-10-23T00:24:12.972Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-10-23T00:24:12.972Z] GC before operation: completed in 772.485 ms, heap usage 705.498 MB -> 126.458 MB. [2025-10-23T00:24:19.452Z] ====== log-regression (apache-spark) [default], iteration 10 completed (5848.500 ms) ====== [2025-10-23T00:24:19.452Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-10-23T00:24:19.452Z] GC before operation: completed in 799.503 ms, heap usage 377.893 MB -> 125.685 MB. [2025-10-23T00:24:25.982Z] ====== log-regression (apache-spark) [default], iteration 11 completed (5939.559 ms) ====== [2025-10-23T00:24:25.982Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-10-23T00:24:26.379Z] GC before operation: completed in 815.181 ms, heap usage 331.502 MB -> 125.801 MB. [2025-10-23T00:24:32.879Z] ====== log-regression (apache-spark) [default], iteration 12 completed (5704.733 ms) ====== [2025-10-23T00:24:32.879Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-10-23T00:24:32.879Z] GC before operation: completed in 856.195 ms, heap usage 401.679 MB -> 126.177 MB. [2025-10-23T00:24:38.655Z] ====== log-regression (apache-spark) [default], iteration 13 completed (5544.980 ms) ====== [2025-10-23T00:24:38.655Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-10-23T00:24:39.496Z] GC before operation: completed in 863.481 ms, heap usage 359.881 MB -> 126.295 MB. [2025-10-23T00:24:45.975Z] ====== log-regression (apache-spark) [default], iteration 14 completed (5745.910 ms) ====== [2025-10-23T00:24:45.975Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-10-23T00:24:45.975Z] GC before operation: completed in 850.296 ms, heap usage 311.734 MB -> 126.333 MB. [2025-10-23T00:24:52.448Z] ====== log-regression (apache-spark) [default], iteration 15 completed (5681.431 ms) ====== [2025-10-23T00:24:52.448Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-10-23T00:24:52.448Z] GC before operation: completed in 851.664 ms, heap usage 340.793 MB -> 126.532 MB. [2025-10-23T00:24:57.724Z] ====== log-regression (apache-spark) [default], iteration 16 completed (5267.048 ms) ====== [2025-10-23T00:24:57.724Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-10-23T00:24:58.582Z] GC before operation: completed in 882.307 ms, heap usage 723.321 MB -> 127.981 MB. [2025-10-23T00:25:05.053Z] ====== log-regression (apache-spark) [default], iteration 17 completed (5451.838 ms) ====== [2025-10-23T00:25:05.053Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-10-23T00:25:05.053Z] GC before operation: completed in 880.559 ms, heap usage 715.383 MB -> 128.116 MB. [2025-10-23T00:25:10.328Z] ====== log-regression (apache-spark) [default], iteration 18 completed (5234.258 ms) ====== [2025-10-23T00:25:10.328Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-10-23T00:25:11.182Z] GC before operation: completed in 881.510 ms, heap usage 656.810 MB -> 128.261 MB. [2025-10-23T00:25:16.602Z] ====== log-regression (apache-spark) [default], iteration 19 completed (5391.433 ms) ====== [2025-10-23T00:25:17.925Z] ----------------------------------- [2025-10-23T00:25:17.925Z] renaissance-log-regression_0_PASSED [2025-10-23T00:25:17.925Z] ----------------------------------- [2025-10-23T00:25:18.325Z] [2025-10-23T00:25:18.325Z] TEST TEARDOWN: [2025-10-23T00:25:18.325Z] Nothing to be done for teardown. [2025-10-23T00:25:18.325Z] renaissance-log-regression_0 Finish Time: Thu Oct 23 00:25:18 2025 Epoch Time (ms): 1761179118095