[2025-12-16T09:21:46.895Z] Running test renaissance-log-regression_0 ... [2025-12-16T09:21:47.213Z] =============================================== [2025-12-16T09:21:47.213Z] renaissance-log-regression_0 Start Time: Tue Dec 16 09:21:47 2025 Epoch Time (ms): 1765876907004 [2025-12-16T09:21:47.213Z] variation: NoOptions [2025-12-16T09:21:47.558Z] JVM_OPTIONS: [2025-12-16T09:21:47.558Z] { \ [2025-12-16T09:21:47.558Z] echo ""; echo "TEST SETUP:"; \ [2025-12-16T09:21:47.558Z] echo "Nothing to be done for setup."; \ [2025-12-16T09:21:47.558Z] mkdir -p "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17658743907010\\renaissance-log-regression_0"; \ [2025-12-16T09:21:47.558Z] cd "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17658743907010\\renaissance-log-regression_0"; \ [2025-12-16T09:21:47.558Z] echo ""; echo "TESTING:"; \ [2025-12-16T09:21:47.558Z] "c:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17658743907010\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2025-12-16T09:21:47.558Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17658743907010\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-16T09:21:47.558Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-16T09:21:47.558Z] echo "Nothing to be done for teardown."; \ [2025-12-16T09:21:47.558Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17658743907010\\TestTargetResult"; [2025-12-16T09:21:47.558Z] [2025-12-16T09:21:47.558Z] TEST SETUP: [2025-12-16T09:21:47.558Z] Nothing to be done for setup. [2025-12-16T09:21:47.559Z] [2025-12-16T09:21:47.559Z] TESTING: [2025-12-16T09:21:48.291Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-12-16T09:21:48.291Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/C:/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17658743907010/renaissance-log-regression_0/launcher-092147-4333849538860312948/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-12-16T09:21:48.291Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-12-16T09:21:48.291Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-12-16T09:22:04.154Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-12-16T09:22:07.480Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-16T09:22:07.480Z] GC before operation: completed in 62.269 ms, heap usage 47.500 MB -> 35.359 MB. [2025-12-16T09:22:28.000Z] ====== log-regression (apache-spark) [default], iteration 0 completed (20658.401 ms) ====== [2025-12-16T09:22:28.000Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-16T09:22:28.742Z] GC before operation: completed in 322.817 ms, heap usage 420.544 MB -> 118.302 MB. [2025-12-16T09:22:32.352Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3668.743 ms) ====== [2025-12-16T09:22:32.352Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-16T09:22:32.352Z] GC before operation: completed in 114.697 ms, heap usage 474.568 MB -> 118.172 MB. [2025-12-16T09:22:34.935Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3022.024 ms) ====== [2025-12-16T09:22:34.935Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-16T09:22:35.390Z] GC before operation: completed in 130.343 ms, heap usage 400.039 MB -> 118.179 MB. [2025-12-16T09:22:38.050Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2502.390 ms) ====== [2025-12-16T09:22:38.050Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-16T09:22:38.050Z] GC before operation: completed in 168.611 ms, heap usage 432.354 MB -> 118.759 MB. [2025-12-16T09:22:40.695Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2420.520 ms) ====== [2025-12-16T09:22:40.695Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-16T09:22:40.695Z] GC before operation: completed in 126.342 ms, heap usage 413.085 MB -> 118.920 MB. [2025-12-16T09:22:42.580Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2293.501 ms) ====== [2025-12-16T09:22:42.580Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-16T09:22:43.075Z] GC before operation: completed in 127.412 ms, heap usage 410.035 MB -> 119.138 MB. [2025-12-16T09:22:44.982Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2166.044 ms) ====== [2025-12-16T09:22:44.982Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-16T09:22:45.455Z] GC before operation: completed in 214.661 ms, heap usage 391.293 MB -> 119.239 MB. [2025-12-16T09:22:47.512Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2149.312 ms) ====== [2025-12-16T09:22:47.512Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-16T09:22:47.512Z] GC before operation: completed in 129.216 ms, heap usage 289.836 MB -> 119.031 MB. [2025-12-16T09:22:50.101Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2244.950 ms) ====== [2025-12-16T09:22:50.101Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-16T09:22:50.101Z] GC before operation: completed in 123.209 ms, heap usage 350.193 MB -> 119.396 MB. [2025-12-16T09:22:51.925Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2148.148 ms) ====== [2025-12-16T09:22:51.925Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-16T09:22:52.366Z] GC before operation: completed in 139.360 ms, heap usage 319.860 MB -> 119.455 MB. [2025-12-16T09:22:54.169Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2134.294 ms) ====== [2025-12-16T09:22:54.169Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-16T09:22:54.632Z] GC before operation: completed in 134.877 ms, heap usage 316.659 MB -> 119.604 MB. [2025-12-16T09:22:56.440Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2139.471 ms) ====== [2025-12-16T09:22:56.440Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-16T09:22:56.905Z] GC before operation: completed in 132.549 ms, heap usage 353.788 MB -> 120.011 MB. [2025-12-16T09:22:58.690Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2117.931 ms) ====== [2025-12-16T09:22:58.690Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-16T09:22:59.141Z] GC before operation: completed in 130.363 ms, heap usage 275.789 MB -> 119.910 MB. [2025-12-16T09:23:01.649Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2257.958 ms) ====== [2025-12-16T09:23:01.649Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-16T09:23:01.649Z] GC before operation: completed in 151.678 ms, heap usage 204.807 MB -> 119.872 MB. [2025-12-16T09:23:04.640Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2917.955 ms) ====== [2025-12-16T09:23:04.640Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-16T09:23:04.640Z] GC before operation: completed in 137.184 ms, heap usage 479.450 MB -> 120.954 MB. [2025-12-16T09:23:07.563Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2661.882 ms) ====== [2025-12-16T09:23:07.563Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-16T09:23:07.563Z] GC before operation: completed in 156.450 ms, heap usage 136.732 MB -> 120.105 MB. [2025-12-16T09:23:09.805Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2225.110 ms) ====== [2025-12-16T09:23:09.805Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-16T09:23:09.805Z] GC before operation: completed in 129.102 ms, heap usage 349.258 MB -> 120.953 MB. [2025-12-16T09:23:11.965Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1997.915 ms) ====== [2025-12-16T09:23:11.965Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-16T09:23:11.965Z] GC before operation: completed in 141.875 ms, heap usage 301.584 MB -> 120.879 MB. [2025-12-16T09:23:13.793Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2180.508 ms) ====== [2025-12-16T09:23:13.793Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-16T09:23:14.286Z] GC before operation: completed in 140.068 ms, heap usage 264.508 MB -> 120.997 MB. [2025-12-16T09:23:16.973Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2585.332 ms) ====== [2025-12-16T09:23:16.973Z] ----------------------------------- [2025-12-16T09:23:16.973Z] renaissance-log-regression_0_PASSED [2025-12-16T09:23:16.973Z] ----------------------------------- [2025-12-16T09:23:16.973Z] [2025-12-16T09:23:16.973Z] TEST TEARDOWN: [2025-12-16T09:23:16.973Z] Nothing to be done for teardown. [2025-12-16T09:23:17.291Z] renaissance-log-regression_0 Finish Time: Tue Dec 16 09:23:17 2025 Epoch Time (ms): 1765876997005