[2025-06-08T01:47:46.227Z] Running test renaissance-log-regression_0 ... [2025-06-08T01:47:46.227Z] =============================================== [2025-06-08T01:47:46.227Z] renaissance-log-regression_0 Start Time: Sun Jun 8 01:47:45 2025 Epoch Time (ms): 1749347265624 [2025-06-08T01:47:46.227Z] variation: NoOptions [2025-06-08T01:47:46.227Z] JVM_OPTIONS: [2025-06-08T01:47:46.227Z] { \ [2025-06-08T01:47:46.227Z] echo ""; echo "TEST SETUP:"; \ [2025-06-08T01:47:46.227Z] echo "Nothing to be done for setup."; \ [2025-06-08T01:47:46.227Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17493435959871/renaissance-log-regression_0"; \ [2025-06-08T01:47:46.227Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17493435959871/renaissance-log-regression_0"; \ [2025-06-08T01:47:46.227Z] echo ""; echo "TESTING:"; \ [2025-06-08T01:47:46.227Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_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_riscv64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17493435959871/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-06-08T01:47:46.228Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17493435959871/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-08T01:47:46.228Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-08T01:47:46.228Z] echo "Nothing to be done for teardown."; \ [2025-06-08T01:47:46.228Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17493435959871/TestTargetResult"; [2025-06-08T01:47:46.228Z] [2025-06-08T01:47:46.228Z] TEST SETUP: [2025-06-08T01:47:46.228Z] Nothing to be done for setup. [2025-06-08T01:47:46.228Z] [2025-06-08T01:47:46.228Z] TESTING: [2025-06-08T01:47:48.466Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-06-08T01:47:48.466Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/output_17493435959871/renaissance-log-regression_0/launcher-014746-1035471299001701469/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-06-08T01:47:48.466Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-06-08T01:47:48.466Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-06-08T01:48:11.469Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-06-08T01:48:20.333Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-06-08T01:48:20.333Z] GC before operation: completed in 273.879 ms, heap usage 73.721 MB -> 35.357 MB. [2025-06-08T01:49:08.355Z] ====== log-regression (apache-spark) [default], iteration 0 completed (48401.429 ms) ====== [2025-06-08T01:49:08.355Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-06-08T01:49:08.355Z] GC before operation: completed in 516.790 ms, heap usage 537.630 MB -> 123.314 MB. [2025-06-08T01:49:19.260Z] ====== log-regression (apache-spark) [default], iteration 1 completed (9757.030 ms) ====== [2025-06-08T01:49:19.260Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-06-08T01:49:19.260Z] GC before operation: completed in 558.616 ms, heap usage 301.930 MB -> 123.168 MB. [2025-06-08T01:49:26.519Z] ====== log-regression (apache-spark) [default], iteration 2 completed (7300.646 ms) ====== [2025-06-08T01:49:26.519Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-06-08T01:49:26.852Z] GC before operation: completed in 620.853 ms, heap usage 794.575 MB -> 125.033 MB. [2025-06-08T01:49:34.111Z] ====== log-regression (apache-spark) [default], iteration 3 completed (6829.909 ms) ====== [2025-06-08T01:49:34.111Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-06-08T01:49:34.111Z] GC before operation: completed in 657.857 ms, heap usage 314.948 MB -> 123.993 MB. [2025-06-08T01:49:41.384Z] ====== log-regression (apache-spark) [default], iteration 4 completed (6236.632 ms) ====== [2025-06-08T01:49:41.384Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-06-08T01:49:41.384Z] GC before operation: completed in 683.117 ms, heap usage 253.877 MB -> 123.952 MB. [2025-06-08T01:49:48.642Z] ====== log-regression (apache-spark) [default], iteration 5 completed (6320.123 ms) ====== [2025-06-08T01:49:48.642Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-06-08T01:49:48.642Z] GC before operation: completed in 714.801 ms, heap usage 708.487 MB -> 125.504 MB. [2025-06-08T01:49:54.633Z] ====== log-regression (apache-spark) [default], iteration 6 completed (6409.256 ms) ====== [2025-06-08T01:49:54.633Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-06-08T01:49:55.345Z] GC before operation: completed in 780.593 ms, heap usage 294.311 MB -> 124.488 MB. [2025-06-08T01:50:02.601Z] ====== log-regression (apache-spark) [default], iteration 7 completed (6093.103 ms) ====== [2025-06-08T01:50:02.601Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-06-08T01:50:02.601Z] GC before operation: completed in 746.482 ms, heap usage 393.448 MB -> 124.935 MB. [2025-06-08T01:50:08.560Z] ====== log-regression (apache-spark) [default], iteration 8 completed (5586.764 ms) ====== [2025-06-08T01:50:08.560Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-06-08T01:50:08.560Z] GC before operation: completed in 773.946 ms, heap usage 704.333 MB -> 126.112 MB. [2025-06-08T01:50:14.487Z] ====== log-regression (apache-spark) [default], iteration 9 completed (5710.703 ms) ====== [2025-06-08T01:50:14.487Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-06-08T01:50:15.215Z] GC before operation: completed in 780.954 ms, heap usage 664.949 MB -> 126.229 MB. [2025-06-08T01:50:21.151Z] ====== log-regression (apache-spark) [default], iteration 10 completed (5805.676 ms) ====== [2025-06-08T01:50:21.151Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-06-08T01:50:21.865Z] GC before operation: completed in 792.713 ms, heap usage 693.565 MB -> 126.436 MB. [2025-06-08T01:50:27.774Z] ====== log-regression (apache-spark) [default], iteration 11 completed (5744.085 ms) ====== [2025-06-08T01:50:27.774Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-06-08T01:50:28.106Z] GC before operation: completed in 824.507 ms, heap usage 708.161 MB -> 126.758 MB. [2025-06-08T01:50:34.017Z] ====== log-regression (apache-spark) [default], iteration 12 completed (5639.601 ms) ====== [2025-06-08T01:50:34.017Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-06-08T01:50:34.773Z] GC before operation: completed in 846.594 ms, heap usage 680.806 MB -> 126.888 MB. [2025-06-08T01:50:40.693Z] ====== log-regression (apache-spark) [default], iteration 13 completed (5426.243 ms) ====== [2025-06-08T01:50:40.693Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-06-08T01:50:41.025Z] GC before operation: completed in 838.333 ms, heap usage 746.868 MB -> 127.271 MB. [2025-06-08T01:50:46.963Z] ====== log-regression (apache-spark) [default], iteration 14 completed (5491.422 ms) ====== [2025-06-08T01:50:46.963Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-06-08T01:50:47.296Z] GC before operation: completed in 865.158 ms, heap usage 707.191 MB -> 127.314 MB. [2025-06-08T01:50:53.263Z] ====== log-regression (apache-spark) [default], iteration 15 completed (5481.530 ms) ====== [2025-06-08T01:50:53.263Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-06-08T01:50:53.597Z] GC before operation: completed in 863.746 ms, heap usage 695.122 MB -> 127.521 MB. [2025-06-08T01:50:59.496Z] ====== log-regression (apache-spark) [default], iteration 16 completed (5856.088 ms) ====== [2025-06-08T01:50:59.496Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-06-08T01:51:00.653Z] GC before operation: completed in 874.329 ms, heap usage 266.933 MB -> 126.459 MB. [2025-06-08T01:51:06.675Z] ====== log-regression (apache-spark) [default], iteration 17 completed (5443.434 ms) ====== [2025-06-08T01:51:06.675Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-06-08T01:51:06.675Z] GC before operation: completed in 871.437 ms, heap usage 674.233 MB -> 128.000 MB. [2025-06-08T01:51:12.579Z] ====== log-regression (apache-spark) [default], iteration 18 completed (5425.374 ms) ====== [2025-06-08T01:51:12.579Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-06-08T01:51:13.286Z] GC before operation: completed in 885.202 ms, heap usage 661.096 MB -> 128.106 MB. [2025-06-08T01:51:19.185Z] ====== log-regression (apache-spark) [default], iteration 19 completed (5475.407 ms) ====== [2025-06-08T01:51:19.881Z] ----------------------------------- [2025-06-08T01:51:19.881Z] renaissance-log-regression_0_PASSED [2025-06-08T01:51:19.881Z] ----------------------------------- [2025-06-08T01:51:20.205Z] [2025-06-08T01:51:20.205Z] TEST TEARDOWN: [2025-06-08T01:51:20.205Z] Nothing to be done for teardown. [2025-06-08T01:51:20.544Z] renaissance-log-regression_0 Finish Time: Sun Jun 8 01:51:20 2025 Epoch Time (ms): 1749347480204