[2025-12-16T09:22:55.972Z] Running test renaissance-log-regression_0 ... [2025-12-16T09:22:55.972Z] =============================================== [2025-12-16T09:22:55.972Z] renaissance-log-regression_0 Start Time: Tue Dec 16 09:22:55 2025 Epoch Time (ms): 1765876975706 [2025-12-16T09:22:55.972Z] variation: NoOptions [2025-12-16T09:22:55.972Z] JVM_OPTIONS: [2025-12-16T09:22:55.972Z] { \ [2025-12-16T09:22:55.972Z] echo ""; echo "TEST SETUP:"; \ [2025-12-16T09:22:55.972Z] echo "Nothing to be done for setup."; \ [2025-12-16T09:22:55.972Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17658756899982/renaissance-log-regression_0"; \ [2025-12-16T09:22:55.972Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17658756899982/renaissance-log-regression_0"; \ [2025-12-16T09:22:55.972Z] echo ""; echo "TESTING:"; \ [2025-12-16T09:22:55.972Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/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_2/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17658756899982/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-12-16T09:22:55.972Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17658756899982/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-16T09:22:55.972Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-16T09:22:55.972Z] echo "Nothing to be done for teardown."; \ [2025-12-16T09:22:55.972Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17658756899982/TestTargetResult"; [2025-12-16T09:22:55.972Z] [2025-12-16T09:22:55.972Z] TEST SETUP: [2025-12-16T09:22:55.972Z] Nothing to be done for setup. [2025-12-16T09:22:55.972Z] [2025-12-16T09:22:55.972Z] TESTING: [2025-12-16T09:22:58.189Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-16T09:22:58.189Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/output_17658756899982/renaissance-log-regression_0/launcher-092256-4466967856458722021/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-16T09:22:58.189Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-16T09:22:58.189Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-16T09:23:21.206Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-16T09:23:30.085Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-16T09:23:30.085Z] GC before operation: completed in 283.971 ms, heap usage 61.562 MB -> 35.363 MB. [2025-12-16T09:24:18.437Z] ====== log-regression (apache-spark) [default], iteration 0 completed (47813.432 ms) ====== [2025-12-16T09:24:18.437Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-16T09:24:18.437Z] GC before operation: completed in 491.129 ms, heap usage 437.282 MB -> 123.171 MB. [2025-12-16T09:24:29.203Z] ====== log-regression (apache-spark) [default], iteration 1 completed (9484.126 ms) ====== [2025-12-16T09:24:29.203Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-16T09:24:29.203Z] GC before operation: completed in 514.932 ms, heap usage 752.753 MB -> 124.569 MB. [2025-12-16T09:24:36.442Z] ====== log-regression (apache-spark) [default], iteration 2 completed (8144.575 ms) ====== [2025-12-16T09:24:36.442Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-16T09:24:36.766Z] GC before operation: completed in 573.197 ms, heap usage 359.501 MB -> 123.847 MB. [2025-12-16T09:24:44.057Z] ====== log-regression (apache-spark) [default], iteration 3 completed (7089.922 ms) ====== [2025-12-16T09:24:44.057Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-16T09:24:44.419Z] GC before operation: completed in 598.894 ms, heap usage 301.397 MB -> 123.993 MB. [2025-12-16T09:24:51.641Z] ====== log-regression (apache-spark) [default], iteration 4 completed (6507.859 ms) ====== [2025-12-16T09:24:51.641Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-16T09:24:51.641Z] GC before operation: completed in 627.256 ms, heap usage 335.240 MB -> 124.440 MB. [2025-12-16T09:24:57.573Z] ====== log-regression (apache-spark) [default], iteration 5 completed (5957.555 ms) ====== [2025-12-16T09:24:57.573Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-16T09:24:58.352Z] GC before operation: completed in 672.170 ms, heap usage 370.469 MB -> 124.690 MB. [2025-12-16T09:25:05.565Z] ====== log-regression (apache-spark) [default], iteration 6 completed (6227.220 ms) ====== [2025-12-16T09:25:05.565Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-16T09:25:05.565Z] GC before operation: completed in 685.695 ms, heap usage 736.293 MB -> 125.952 MB. [2025-12-16T09:25:11.442Z] ====== log-regression (apache-spark) [default], iteration 7 completed (5794.002 ms) ====== [2025-12-16T09:25:11.442Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-16T09:25:11.764Z] GC before operation: completed in 695.421 ms, heap usage 466.976 MB -> 125.408 MB. [2025-12-16T09:25:17.648Z] ====== log-regression (apache-spark) [default], iteration 8 completed (5774.855 ms) ====== [2025-12-16T09:25:17.648Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-16T09:25:18.350Z] GC before operation: completed in 705.016 ms, heap usage 782.449 MB -> 126.479 MB. [2025-12-16T09:25:24.234Z] ====== log-regression (apache-spark) [default], iteration 9 completed (6193.617 ms) ====== [2025-12-16T09:25:24.234Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-16T09:25:24.942Z] GC before operation: completed in 715.784 ms, heap usage 247.600 MB -> 125.137 MB. [2025-12-16T09:25:30.827Z] ====== log-regression (apache-spark) [default], iteration 10 completed (5523.874 ms) ====== [2025-12-16T09:25:30.827Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-16T09:25:31.160Z] GC before operation: completed in 735.440 ms, heap usage 944.460 MB -> 127.076 MB. [2025-12-16T09:25:38.378Z] ====== log-regression (apache-spark) [default], iteration 11 completed (6002.402 ms) ====== [2025-12-16T09:25:38.378Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-16T09:25:38.378Z] GC before operation: completed in 749.159 ms, heap usage 391.963 MB -> 125.977 MB. [2025-12-16T09:25:44.242Z] ====== log-regression (apache-spark) [default], iteration 12 completed (5927.982 ms) ====== [2025-12-16T09:25:44.242Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-16T09:25:44.946Z] GC before operation: completed in 764.450 ms, heap usage 379.894 MB -> 126.259 MB. [2025-12-16T09:25:50.825Z] ====== log-regression (apache-spark) [default], iteration 13 completed (5791.818 ms) ====== [2025-12-16T09:25:50.825Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-16T09:25:51.539Z] GC before operation: completed in 769.778 ms, heap usage 554.527 MB -> 126.764 MB. [2025-12-16T09:25:57.423Z] ====== log-regression (apache-spark) [default], iteration 14 completed (5636.664 ms) ====== [2025-12-16T09:25:57.423Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-16T09:25:57.749Z] GC before operation: completed in 783.664 ms, heap usage 405.563 MB -> 126.555 MB. [2025-12-16T09:26:03.641Z] ====== log-regression (apache-spark) [default], iteration 15 completed (5461.126 ms) ====== [2025-12-16T09:26:03.641Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-16T09:26:03.968Z] GC before operation: completed in 782.820 ms, heap usage 679.741 MB -> 127.566 MB. [2025-12-16T09:26:09.833Z] ====== log-regression (apache-spark) [default], iteration 16 completed (5599.081 ms) ====== [2025-12-16T09:26:09.833Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-16T09:26:10.546Z] GC before operation: completed in 821.297 ms, heap usage 658.994 MB -> 127.780 MB. [2025-12-16T09:26:16.836Z] ====== log-regression (apache-spark) [default], iteration 17 completed (5519.733 ms) ====== [2025-12-16T09:26:16.836Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-16T09:26:16.836Z] GC before operation: completed in 814.276 ms, heap usage 665.730 MB -> 127.983 MB. [2025-12-16T09:26:22.728Z] ====== log-regression (apache-spark) [default], iteration 18 completed (5616.197 ms) ====== [2025-12-16T09:26:22.728Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-16T09:26:23.431Z] GC before operation: completed in 881.507 ms, heap usage 267.579 MB -> 126.969 MB. [2025-12-16T09:26:29.276Z] ====== log-regression (apache-spark) [default], iteration 19 completed (5356.354 ms) ====== [2025-12-16T09:26:30.911Z] ----------------------------------- [2025-12-16T09:26:30.911Z] renaissance-log-regression_0_PASSED [2025-12-16T09:26:30.911Z] ----------------------------------- [2025-12-16T09:26:30.911Z] [2025-12-16T09:26:30.911Z] TEST TEARDOWN: [2025-12-16T09:26:30.911Z] Nothing to be done for teardown. [2025-12-16T09:26:30.911Z] renaissance-log-regression_0 Finish Time: Tue Dec 16 09:26:30 2025 Epoch Time (ms): 1765877190510