[2026-01-21T11:05:05.289Z] Running test renaissance-dec-tree_0 ... [2026-01-21T11:05:05.289Z] =============================================== [2026-01-21T11:05:05.289Z] renaissance-dec-tree_0 Start Time: Wed Jan 21 11:05:04 2026 Epoch Time (ms): 1768993504960 [2026-01-21T11:05:05.289Z] variation: NoOptions [2026-01-21T11:05:05.289Z] JVM_OPTIONS: [2026-01-21T11:05:05.289Z] { \ [2026-01-21T11:05:05.289Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T11:05:05.289Z] echo "Nothing to be done for setup."; \ [2026-01-21T11:05:05.289Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689926116690/renaissance-dec-tree_0"; \ [2026-01-21T11:05:05.289Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689926116690/renaissance-dec-tree_0"; \ [2026-01-21T11:05:05.289Z] echo ""; echo "TESTING:"; \ [2026-01-21T11:05:05.289Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_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_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689926116690/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-21T11:05:05.289Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689926116690/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T11:05:05.289Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T11:05:05.289Z] echo "Nothing to be done for teardown."; \ [2026-01-21T11:05:05.289Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17689926116690/TestTargetResult"; [2026-01-21T11:05:05.289Z] [2026-01-21T11:05:05.289Z] TEST SETUP: [2026-01-21T11:05:05.289Z] Nothing to be done for setup. [2026-01-21T11:05:05.289Z] [2026-01-21T11:05:05.289Z] TESTING: [2026-01-21T11:05:05.627Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-21T11:05:05.627Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_17689926116690/renaissance-dec-tree_0/launcher-110505-16029456914686502751/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-21T11:05:05.627Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-21T11:05:05.627Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-21T11:05:11.636Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-01-21T11:05:13.966Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-21T11:05:13.966Z] GC before operation: completed in 50.649 ms, heap usage 45.632 MB -> 34.868 MB. [2026-01-21T11:05:27.245Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11993.335 ms) ====== [2026-01-21T11:05:27.245Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-21T11:05:27.245Z] GC before operation: completed in 115.783 ms, heap usage 397.054 MB -> 67.665 MB. [2026-01-21T11:05:29.560Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3100.162 ms) ====== [2026-01-21T11:05:29.560Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-21T11:05:29.560Z] GC before operation: completed in 99.702 ms, heap usage 137.870 MB -> 67.703 MB. [2026-01-21T11:05:31.898Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2531.311 ms) ====== [2026-01-21T11:05:31.898Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-21T11:05:31.898Z] GC before operation: completed in 91.657 ms, heap usage 257.041 MB -> 68.237 MB. [2026-01-21T11:05:34.217Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2154.722 ms) ====== [2026-01-21T11:05:34.217Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-21T11:05:34.217Z] GC before operation: completed in 118.204 ms, heap usage 224.781 MB -> 68.617 MB. [2026-01-21T11:05:36.596Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2154.248 ms) ====== [2026-01-21T11:05:36.596Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-21T11:05:36.596Z] GC before operation: completed in 94.290 ms, heap usage 110.477 MB -> 68.019 MB. [2026-01-21T11:05:38.923Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2054.158 ms) ====== [2026-01-21T11:05:38.923Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-21T11:05:38.923Z] GC before operation: completed in 103.999 ms, heap usage 316.864 MB -> 68.841 MB. [2026-01-21T11:05:40.631Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1933.481 ms) ====== [2026-01-21T11:05:40.631Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-21T11:05:40.631Z] GC before operation: completed in 111.281 ms, heap usage 322.994 MB -> 68.919 MB. [2026-01-21T11:05:42.936Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1967.916 ms) ====== [2026-01-21T11:05:42.936Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-21T11:05:42.936Z] GC before operation: completed in 109.550 ms, heap usage 291.752 MB -> 69.253 MB. [2026-01-21T11:05:44.643Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1887.784 ms) ====== [2026-01-21T11:05:44.643Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-21T11:05:44.643Z] GC before operation: completed in 106.390 ms, heap usage 277.936 MB -> 69.249 MB. [2026-01-21T11:05:46.959Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1832.201 ms) ====== [2026-01-21T11:05:46.959Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-21T11:05:46.959Z] GC before operation: completed in 106.241 ms, heap usage 294.011 MB -> 69.407 MB. [2026-01-21T11:05:48.692Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1921.088 ms) ====== [2026-01-21T11:05:48.692Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-21T11:05:48.692Z] GC before operation: completed in 160.434 ms, heap usage 255.370 MB -> 78.220 MB. [2026-01-21T11:05:50.466Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1718.340 ms) ====== [2026-01-21T11:05:50.466Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-21T11:05:50.466Z] GC before operation: completed in 107.106 ms, heap usage 111.087 MB -> 69.134 MB. [2026-01-21T11:05:52.782Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1861.699 ms) ====== [2026-01-21T11:05:52.782Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-21T11:05:52.782Z] GC before operation: completed in 111.570 ms, heap usage 298.221 MB -> 78.119 MB. [2026-01-21T11:05:54.480Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1690.692 ms) ====== [2026-01-21T11:05:54.480Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-21T11:05:54.480Z] GC before operation: completed in 112.416 ms, heap usage 200.180 MB -> 70.266 MB. [2026-01-21T11:05:56.181Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1644.915 ms) ====== [2026-01-21T11:05:56.181Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-21T11:05:56.181Z] GC before operation: completed in 108.574 ms, heap usage 240.103 MB -> 70.009 MB. [2026-01-21T11:05:57.885Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1601.865 ms) ====== [2026-01-21T11:05:57.885Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-21T11:05:57.885Z] GC before operation: completed in 112.115 ms, heap usage 252.695 MB -> 70.250 MB. [2026-01-21T11:05:59.687Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1615.782 ms) ====== [2026-01-21T11:05:59.687Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-21T11:05:59.687Z] GC before operation: completed in 116.364 ms, heap usage 251.588 MB -> 70.398 MB. [2026-01-21T11:06:01.383Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1741.987 ms) ====== [2026-01-21T11:06:01.383Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-21T11:06:01.383Z] GC before operation: completed in 120.084 ms, heap usage 252.164 MB -> 70.538 MB. [2026-01-21T11:06:03.081Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1600.736 ms) ====== [2026-01-21T11:06:03.081Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-21T11:06:03.081Z] GC before operation: completed in 115.852 ms, heap usage 237.468 MB -> 70.384 MB. [2026-01-21T11:06:04.781Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1652.929 ms) ====== [2026-01-21T11:06:04.781Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-21T11:06:05.121Z] GC before operation: completed in 115.054 ms, heap usage 382.069 MB -> 70.596 MB. [2026-01-21T11:06:06.823Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1586.643 ms) ====== [2026-01-21T11:06:06.823Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-21T11:06:06.823Z] GC before operation: completed in 117.617 ms, heap usage 282.498 MB -> 70.697 MB. [2026-01-21T11:06:08.528Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1634.159 ms) ====== [2026-01-21T11:06:08.528Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-21T11:06:08.528Z] GC before operation: completed in 116.937 ms, heap usage 237.408 MB -> 70.907 MB. [2026-01-21T11:06:10.225Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1533.345 ms) ====== [2026-01-21T11:06:10.225Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-21T11:06:10.225Z] GC before operation: completed in 126.612 ms, heap usage 238.254 MB -> 98.473 MB. [2026-01-21T11:06:10.225Z] 11:06:09.898 WARN [block-manager-storage-async-thread-pool-9] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_317_piece0, which does not exist [2026-01-21T11:06:11.929Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1610.930 ms) ====== [2026-01-21T11:06:11.929Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-21T11:06:11.929Z] GC before operation: completed in 121.156 ms, heap usage 474.552 MB -> 71.285 MB. [2026-01-21T11:06:13.625Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1544.984 ms) ====== [2026-01-21T11:06:13.625Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-21T11:06:13.625Z] GC before operation: completed in 113.627 ms, heap usage 173.321 MB -> 70.762 MB. [2026-01-21T11:06:15.339Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1656.330 ms) ====== [2026-01-21T11:06:15.339Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-21T11:06:15.339Z] GC before operation: completed in 120.546 ms, heap usage 112.887 MB -> 70.960 MB. [2026-01-21T11:06:17.036Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1594.526 ms) ====== [2026-01-21T11:06:17.036Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-21T11:06:17.036Z] GC before operation: completed in 122.153 ms, heap usage 426.458 MB -> 71.787 MB. [2026-01-21T11:06:18.754Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1556.736 ms) ====== [2026-01-21T11:06:18.755Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-21T11:06:18.755Z] GC before operation: completed in 117.027 ms, heap usage 122.820 MB -> 70.906 MB. [2026-01-21T11:06:20.558Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1582.011 ms) ====== [2026-01-21T11:06:20.558Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-21T11:06:20.558Z] GC before operation: completed in 124.557 ms, heap usage 426.916 MB -> 71.857 MB. [2026-01-21T11:06:21.739Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1500.850 ms) ====== [2026-01-21T11:06:21.739Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-21T11:06:22.077Z] GC before operation: completed in 121.746 ms, heap usage 252.701 MB -> 71.619 MB. [2026-01-21T11:06:23.773Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1500.844 ms) ====== [2026-01-21T11:06:23.773Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-21T11:06:23.773Z] GC before operation: completed in 119.636 ms, heap usage 223.457 MB -> 71.692 MB. [2026-01-21T11:06:25.478Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1541.156 ms) ====== [2026-01-21T11:06:25.478Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-21T11:06:25.478Z] GC before operation: completed in 124.434 ms, heap usage 218.940 MB -> 71.966 MB. [2026-01-21T11:06:26.656Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1497.601 ms) ====== [2026-01-21T11:06:26.656Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-21T11:06:26.999Z] GC before operation: completed in 124.792 ms, heap usage 211.097 MB -> 72.070 MB. [2026-01-21T11:06:28.711Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1537.577 ms) ====== [2026-01-21T11:06:28.711Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-21T11:06:28.711Z] GC before operation: completed in 120.559 ms, heap usage 198.148 MB -> 72.065 MB. [2026-01-21T11:06:30.448Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1580.108 ms) ====== [2026-01-21T11:06:30.448Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-21T11:06:30.448Z] GC before operation: completed in 122.608 ms, heap usage 179.024 MB -> 71.873 MB. [2026-01-21T11:06:31.650Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1480.613 ms) ====== [2026-01-21T11:06:31.650Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-21T11:06:31.997Z] GC before operation: completed in 126.358 ms, heap usage 471.953 MB -> 72.632 MB. [2026-01-21T11:06:33.219Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1529.241 ms) ====== [2026-01-21T11:06:33.219Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-21T11:06:33.565Z] GC before operation: completed in 127.083 ms, heap usage 257.394 MB -> 72.343 MB. [2026-01-21T11:06:35.174Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1499.675 ms) ====== [2026-01-21T11:06:35.174Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-21T11:06:35.174Z] GC before operation: completed in 126.571 ms, heap usage 213.642 MB -> 72.555 MB. [2026-01-21T11:06:36.878Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1540.374 ms) ====== [2026-01-21T11:06:36.878Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-21T11:06:36.878Z] GC before operation: completed in 128.854 ms, heap usage 175.601 MB -> 91.718 MB. [2026-01-21T11:06:38.659Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1660.826 ms) ====== [2026-01-21T11:06:38.659Z] ----------------------------------- [2026-01-21T11:06:38.659Z] renaissance-dec-tree_0_PASSED [2026-01-21T11:06:38.659Z] ----------------------------------- [2026-01-21T11:06:38.659Z] [2026-01-21T11:06:38.659Z] TEST TEARDOWN: [2026-01-21T11:06:38.659Z] Nothing to be done for teardown. [2026-01-21T11:06:38.659Z] renaissance-dec-tree_0 Finish Time: Wed Jan 21 11:06:38 2026 Epoch Time (ms): 1768993598517