[2025-12-27T18:57:24.196Z] Running test renaissance-log-regression_0 ... [2025-12-27T18:57:24.196Z] =============================================== [2025-12-27T18:57:24.196Z] renaissance-log-regression_0 Start Time: Sat Dec 27 18:57:23 2025 Epoch Time (ms): 1766861843998 [2025-12-27T18:57:24.196Z] variation: NoOptions [2025-12-27T18:57:24.196Z] JVM_OPTIONS: [2025-12-27T18:57:24.196Z] { \ [2025-12-27T18:57:24.196Z] echo ""; echo "TEST SETUP:"; \ [2025-12-27T18:57:24.196Z] echo "Nothing to be done for setup."; \ [2025-12-27T18:57:24.196Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17668591666400/renaissance-log-regression_0"; \ [2025-12-27T18:57:24.196Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17668591666400/renaissance-log-regression_0"; \ [2025-12-27T18:57:24.196Z] echo ""; echo "TESTING:"; \ [2025-12-27T18:57:24.196Z] "/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_17668591666400/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-12-27T18:57:24.196Z] 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_17668591666400/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-27T18:57:24.196Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-27T18:57:24.196Z] echo "Nothing to be done for teardown."; \ [2025-12-27T18:57:24.196Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17668591666400/TestTargetResult"; [2025-12-27T18:57:24.196Z] [2025-12-27T18:57:24.196Z] TEST SETUP: [2025-12-27T18:57:24.196Z] Nothing to be done for setup. [2025-12-27T18:57:24.196Z] [2025-12-27T18:57:24.196Z] TESTING: [2025-12-27T18:57:26.474Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-27T18:57:26.474Z] 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_17668591666400/renaissance-log-regression_0/launcher-185724-53843061385912465/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-27T18:57:26.474Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-27T18:57:26.474Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-27T18:57:49.604Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-27T18:57:58.757Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-27T18:57:58.757Z] GC before operation: completed in 258.107 ms, heap usage 49.775 MB -> 35.318 MB. [2025-12-27T18:58:46.954Z] ====== log-regression (apache-spark) [default], iteration 0 completed (48137.347 ms) ====== [2025-12-27T18:58:46.954Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-27T18:58:46.954Z] GC before operation: completed in 494.603 ms, heap usage 273.860 MB -> 122.668 MB. [2025-12-27T18:58:55.945Z] ====== log-regression (apache-spark) [default], iteration 1 completed (8984.876 ms) ====== [2025-12-27T18:58:55.946Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-27T18:58:56.284Z] GC before operation: completed in 522.429 ms, heap usage 245.655 MB -> 123.089 MB. [2025-12-27T18:59:05.257Z] ====== log-regression (apache-spark) [default], iteration 2 completed (7743.971 ms) ====== [2025-12-27T18:59:05.257Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-27T18:59:05.257Z] GC before operation: completed in 567.644 ms, heap usage 294.503 MB -> 123.715 MB. [2025-12-27T18:59:12.594Z] ====== log-regression (apache-spark) [default], iteration 3 completed (6903.522 ms) ====== [2025-12-27T18:59:12.594Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-27T18:59:12.594Z] GC before operation: completed in 609.870 ms, heap usage 623.616 MB -> 124.952 MB. [2025-12-27T18:59:18.568Z] ====== log-regression (apache-spark) [default], iteration 4 completed (6603.253 ms) ====== [2025-12-27T18:59:18.568Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-27T18:59:19.302Z] GC before operation: completed in 683.692 ms, heap usage 498.548 MB -> 124.721 MB. [2025-12-27T18:59:26.651Z] ====== log-regression (apache-spark) [default], iteration 5 completed (6530.111 ms) ====== [2025-12-27T18:59:26.651Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-27T18:59:26.651Z] GC before operation: completed in 674.875 ms, heap usage 461.374 MB -> 124.903 MB. [2025-12-27T18:59:32.600Z] ====== log-regression (apache-spark) [default], iteration 6 completed (6181.875 ms) ====== [2025-12-27T18:59:32.600Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-27T18:59:33.336Z] GC before operation: completed in 705.649 ms, heap usage 447.615 MB -> 125.048 MB. [2025-12-27T18:59:39.306Z] ====== log-regression (apache-spark) [default], iteration 7 completed (5973.455 ms) ====== [2025-12-27T18:59:39.306Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-27T18:59:40.038Z] GC before operation: completed in 724.165 ms, heap usage 460.392 MB -> 125.338 MB. [2025-12-27T18:59:46.024Z] ====== log-regression (apache-spark) [default], iteration 8 completed (5955.502 ms) ====== [2025-12-27T18:59:46.024Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-27T18:59:46.758Z] GC before operation: completed in 737.794 ms, heap usage 404.222 MB -> 125.402 MB. [2025-12-27T18:59:54.095Z] ====== log-regression (apache-spark) [default], iteration 9 completed (6269.430 ms) ====== [2025-12-27T18:59:54.095Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-27T18:59:54.095Z] GC before operation: completed in 740.713 ms, heap usage 372.347 MB -> 125.664 MB. [2025-12-27T19:00:00.078Z] ====== log-regression (apache-spark) [default], iteration 10 completed (5917.450 ms) ====== [2025-12-27T19:00:00.079Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-27T19:00:00.422Z] GC before operation: completed in 760.250 ms, heap usage 389.911 MB -> 125.834 MB. [2025-12-27T19:00:06.385Z] ====== log-regression (apache-spark) [default], iteration 11 completed (5950.813 ms) ====== [2025-12-27T19:00:06.385Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-27T19:00:07.575Z] GC before operation: completed in 806.813 ms, heap usage 370.209 MB -> 125.960 MB. [2025-12-27T19:00:13.544Z] ====== log-regression (apache-spark) [default], iteration 12 completed (5857.572 ms) ====== [2025-12-27T19:00:13.544Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-27T19:00:13.894Z] GC before operation: completed in 786.681 ms, heap usage 337.974 MB -> 126.078 MB. [2025-12-27T19:00:19.954Z] ====== log-regression (apache-spark) [default], iteration 13 completed (5674.739 ms) ====== [2025-12-27T19:00:19.954Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-27T19:00:20.297Z] GC before operation: completed in 804.872 ms, heap usage 775.321 MB -> 127.587 MB. [2025-12-27T19:00:26.276Z] ====== log-regression (apache-spark) [default], iteration 14 completed (5676.023 ms) ====== [2025-12-27T19:00:26.276Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-27T19:00:27.015Z] GC before operation: completed in 797.112 ms, heap usage 352.238 MB -> 126.475 MB. [2025-12-27T19:00:32.988Z] ====== log-regression (apache-spark) [default], iteration 15 completed (6060.165 ms) ====== [2025-12-27T19:00:32.989Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-27T19:00:33.724Z] GC before operation: completed in 799.892 ms, heap usage 259.186 MB -> 126.525 MB. [2025-12-27T19:00:41.042Z] ====== log-regression (apache-spark) [default], iteration 16 completed (6071.213 ms) ====== [2025-12-27T19:00:41.042Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-27T19:00:41.042Z] GC before operation: completed in 818.074 ms, heap usage 216.261 MB -> 126.559 MB. [2025-12-27T19:00:47.007Z] ====== log-regression (apache-spark) [default], iteration 17 completed (5597.544 ms) ====== [2025-12-27T19:00:47.007Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-27T19:00:47.007Z] GC before operation: completed in 865.536 ms, heap usage 1.198 GB -> 128.515 MB. [2025-12-27T19:00:52.986Z] ====== log-regression (apache-spark) [default], iteration 18 completed (5236.299 ms) ====== [2025-12-27T19:00:52.986Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-27T19:00:53.320Z] GC before operation: completed in 830.579 ms, heap usage 274.239 MB -> 127.152 MB. [2025-12-27T19:00:59.269Z] ====== log-regression (apache-spark) [default], iteration 19 completed (5301.985 ms) ====== [2025-12-27T19:01:00.424Z] ----------------------------------- [2025-12-27T19:01:00.424Z] renaissance-log-regression_0_PASSED [2025-12-27T19:01:00.424Z] ----------------------------------- [2025-12-27T19:01:00.424Z] [2025-12-27T19:01:00.424Z] TEST TEARDOWN: [2025-12-27T19:01:00.424Z] Nothing to be done for teardown. [2025-12-27T19:01:00.424Z] renaissance-log-regression_0 Finish Time: Sat Dec 27 19:01:00 2025 Epoch Time (ms): 1766862060081