[2026-01-24T12:59:59.605Z] Running test renaissance-dec-tree_0 ... [2026-01-24T12:59:59.605Z] =============================================== [2026-01-24T12:59:59.605Z] renaissance-dec-tree_0 Start Time: Sat Jan 24 12:59:59 2026 Epoch Time (ms): 1769259599147 [2026-01-24T12:59:59.605Z] variation: NoOptions [2026-01-24T12:59:59.605Z] JVM_OPTIONS: [2026-01-24T12:59:59.605Z] { \ [2026-01-24T12:59:59.605Z] echo ""; echo "TEST SETUP:"; \ [2026-01-24T12:59:59.605Z] echo "Nothing to be done for setup."; \ [2026-01-24T12:59:59.605Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17692586428216/renaissance-dec-tree_0"; \ [2026-01-24T12:59:59.605Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17692586428216/renaissance-dec-tree_0"; \ [2026-01-24T12:59:59.605Z] echo ""; echo "TESTING:"; \ [2026-01-24T12:59:59.605Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17692586428216/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-24T12:59:59.605Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17692586428216/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-24T12:59:59.605Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-24T12:59:59.605Z] echo "Nothing to be done for teardown."; \ [2026-01-24T12:59:59.605Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17692586428216/TestTargetResult"; [2026-01-24T12:59:59.605Z] [2026-01-24T12:59:59.605Z] TEST SETUP: [2026-01-24T12:59:59.605Z] Nothing to be done for setup. [2026-01-24T12:59:59.605Z] [2026-01-24T12:59:59.605Z] TESTING: [2026-01-24T13:00:00.979Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-24T13:00:00.979Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17692586428216/renaissance-dec-tree_0/launcher-125959-9806487786795816150/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-24T13:00:00.979Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-24T13:00:00.979Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-24T13:00:08.917Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-01-24T13:00:11.029Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-24T13:00:11.029Z] GC before operation: completed in 131.853 ms, heap usage 50.347 MB -> 35.008 MB. [2026-01-24T13:00:23.530Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11071.151 ms) ====== [2026-01-24T13:00:23.530Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-24T13:00:23.530Z] GC before operation: completed in 138.962 ms, heap usage 132.232 MB -> 67.583 MB. [2026-01-24T13:00:24.898Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2938.356 ms) ====== [2026-01-24T13:00:24.898Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-24T13:00:25.577Z] GC before operation: completed in 120.194 ms, heap usage 282.083 MB -> 67.927 MB. [2026-01-24T13:00:28.550Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2984.434 ms) ====== [2026-01-24T13:00:28.550Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-24T13:00:28.550Z] GC before operation: completed in 102.699 ms, heap usage 207.209 MB -> 68.276 MB. [2026-01-24T13:00:30.741Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2419.986 ms) ====== [2026-01-24T13:00:30.741Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-24T13:00:30.741Z] GC before operation: completed in 146.351 ms, heap usage 216.199 MB -> 68.356 MB. [2026-01-24T13:00:33.729Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2480.298 ms) ====== [2026-01-24T13:00:33.729Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-24T13:00:33.729Z] GC before operation: completed in 128.066 ms, heap usage 104.713 MB -> 67.931 MB. [2026-01-24T13:00:35.893Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2474.437 ms) ====== [2026-01-24T13:00:35.893Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-24T13:00:35.893Z] GC before operation: completed in 118.810 ms, heap usage 345.334 MB -> 68.797 MB. [2026-01-24T13:00:38.843Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2341.553 ms) ====== [2026-01-24T13:00:38.843Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-24T13:00:38.843Z] GC before operation: completed in 87.561 ms, heap usage 150.473 MB -> 68.803 MB. [2026-01-24T13:00:40.928Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2212.146 ms) ====== [2026-01-24T13:00:40.928Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-24T13:00:40.928Z] GC before operation: completed in 107.655 ms, heap usage 259.684 MB -> 69.197 MB. [2026-01-24T13:00:43.804Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2468.527 ms) ====== [2026-01-24T13:00:43.805Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-24T13:00:43.805Z] GC before operation: completed in 116.018 ms, heap usage 128.799 MB -> 69.291 MB. [2026-01-24T13:00:45.886Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2137.973 ms) ====== [2026-01-24T13:00:45.886Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-24T13:00:45.886Z] GC before operation: completed in 139.976 ms, heap usage 322.523 MB -> 88.834 MB. [2026-01-24T13:00:47.979Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2181.256 ms) ====== [2026-01-24T13:00:47.979Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-24T13:00:47.979Z] GC before operation: completed in 103.985 ms, heap usage 153.115 MB -> 77.644 MB. [2026-01-24T13:00:50.081Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2018.607 ms) ====== [2026-01-24T13:00:50.081Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-24T13:00:50.081Z] GC before operation: completed in 101.026 ms, heap usage 260.773 MB -> 69.773 MB. [2026-01-24T13:00:52.170Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2235.760 ms) ====== [2026-01-24T13:00:52.170Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-24T13:00:52.170Z] GC before operation: completed in 109.544 ms, heap usage 250.321 MB -> 69.793 MB. [2026-01-24T13:00:54.273Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2016.846 ms) ====== [2026-01-24T13:00:54.273Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-24T13:00:54.919Z] GC before operation: completed in 131.627 ms, heap usage 146.447 MB -> 69.593 MB. [2026-01-24T13:00:56.960Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1957.337 ms) ====== [2026-01-24T13:00:56.960Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-24T13:00:56.960Z] GC before operation: completed in 112.579 ms, heap usage 198.357 MB -> 70.215 MB. [2026-01-24T13:00:59.020Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2032.856 ms) ====== [2026-01-24T13:00:59.020Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-24T13:00:59.020Z] GC before operation: completed in 131.109 ms, heap usage 344.205 MB -> 70.145 MB. [2026-01-24T13:01:01.085Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1939.170 ms) ====== [2026-01-24T13:01:01.085Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-24T13:01:01.085Z] GC before operation: completed in 119.034 ms, heap usage 199.767 MB -> 98.068 MB. [2026-01-24T13:01:03.160Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1882.522 ms) ====== [2026-01-24T13:01:03.160Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-24T13:01:03.160Z] GC before operation: completed in 146.171 ms, heap usage 134.538 MB -> 89.514 MB. [2026-01-24T13:01:05.228Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1872.745 ms) ====== [2026-01-24T13:01:05.228Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-24T13:01:05.228Z] GC before operation: completed in 136.675 ms, heap usage 174.323 MB -> 70.291 MB. [2026-01-24T13:01:07.254Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2117.010 ms) ====== [2026-01-24T13:01:07.254Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-24T13:01:07.254Z] GC before operation: completed in 124.480 ms, heap usage 346.521 MB -> 79.179 MB. [2026-01-24T13:01:09.277Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2232.329 ms) ====== [2026-01-24T13:01:09.277Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-24T13:01:09.899Z] GC before operation: completed in 160.684 ms, heap usage 162.820 MB -> 70.730 MB. [2026-01-24T13:01:11.929Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1956.814 ms) ====== [2026-01-24T13:01:11.929Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-24T13:01:11.929Z] GC before operation: completed in 117.198 ms, heap usage 209.907 MB -> 71.007 MB. [2026-01-24T13:01:13.233Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1780.732 ms) ====== [2026-01-24T13:01:13.233Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-24T13:01:13.898Z] GC before operation: completed in 108.760 ms, heap usage 160.792 MB -> 70.747 MB. [2026-01-24T13:01:15.228Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1958.497 ms) ====== [2026-01-24T13:01:15.228Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-24T13:01:15.874Z] GC before operation: completed in 134.393 ms, heap usage 276.951 MB -> 71.149 MB. [2026-01-24T13:01:17.922Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2032.122 ms) ====== [2026-01-24T13:01:17.922Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-24T13:01:17.922Z] GC before operation: completed in 127.872 ms, heap usage 163.042 MB -> 71.279 MB. [2026-01-24T13:01:19.963Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1878.844 ms) ====== [2026-01-24T13:01:19.963Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-24T13:01:19.963Z] GC before operation: completed in 142.158 ms, heap usage 257.905 MB -> 98.971 MB. [2026-01-24T13:01:22.030Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2058.782 ms) ====== [2026-01-24T13:01:22.030Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-24T13:01:22.030Z] GC before operation: completed in 147.283 ms, heap usage 153.654 MB -> 71.237 MB. [2026-01-24T13:01:23.799Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1644.104 ms) ====== [2026-01-24T13:01:23.799Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-24T13:01:23.799Z] GC before operation: completed in 142.915 ms, heap usage 426.854 MB -> 99.266 MB. [2026-01-24T13:01:25.223Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1700.685 ms) ====== [2026-01-24T13:01:25.223Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-24T13:01:25.874Z] GC before operation: completed in 124.279 ms, heap usage 136.745 MB -> 71.260 MB. [2026-01-24T13:01:27.899Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1903.181 ms) ====== [2026-01-24T13:01:27.899Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-24T13:01:27.899Z] GC before operation: completed in 117.926 ms, heap usage 110.872 MB -> 71.405 MB. [2026-01-24T13:01:29.222Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1787.955 ms) ====== [2026-01-24T13:01:29.222Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-24T13:01:29.865Z] GC before operation: completed in 134.557 ms, heap usage 425.351 MB -> 91.489 MB. [2026-01-24T13:01:31.180Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1804.594 ms) ====== [2026-01-24T13:01:31.180Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-24T13:01:31.801Z] GC before operation: completed in 111.617 ms, heap usage 153.988 MB -> 71.736 MB. [2026-01-24T13:01:33.135Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1706.378 ms) ====== [2026-01-24T13:01:33.135Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-24T13:01:33.135Z] GC before operation: completed in 188.060 ms, heap usage 308.135 MB -> 91.341 MB. [2026-01-24T13:01:33.135Z] 13:01:33.053 WARN [block-manager-storage-async-thread-pool-44] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_457_piece0, which does not exist [2026-01-24T13:01:36.059Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2184.638 ms) ====== [2026-01-24T13:01:36.059Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-24T13:01:36.059Z] GC before operation: completed in 113.959 ms, heap usage 152.448 MB -> 71.990 MB. [2026-01-24T13:01:37.385Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1547.978 ms) ====== [2026-01-24T13:01:37.385Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-24T13:01:37.385Z] GC before operation: completed in 155.088 ms, heap usage 268.996 MB -> 72.376 MB. [2026-01-24T13:01:39.442Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2074.597 ms) ====== [2026-01-24T13:01:39.442Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-24T13:01:39.442Z] GC before operation: completed in 121.422 ms, heap usage 232.641 MB -> 72.474 MB. [2026-01-24T13:01:41.506Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1849.222 ms) ====== [2026-01-24T13:01:41.506Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-24T13:01:41.506Z] GC before operation: completed in 161.212 ms, heap usage 155.190 MB -> 72.144 MB. [2026-01-24T13:01:43.549Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1811.456 ms) ====== [2026-01-24T13:01:43.549Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-24T13:01:43.549Z] GC before operation: completed in 156.777 ms, heap usage 324.958 MB -> 81.105 MB. [2026-01-24T13:01:43.549Z] 13:01:43.228 WARN [block-manager-storage-async-thread-pool-94] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_527, which does not exist [2026-01-24T13:01:45.698Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2000.182 ms) ====== [2026-01-24T13:01:45.698Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-24T13:01:45.698Z] GC before operation: completed in 128.146 ms, heap usage 151.844 MB -> 72.720 MB. [2026-01-24T13:01:47.747Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1894.725 ms) ====== [2026-01-24T13:01:47.747Z] ----------------------------------- [2026-01-24T13:01:47.747Z] renaissance-dec-tree_0_PASSED [2026-01-24T13:01:47.747Z] ----------------------------------- [2026-01-24T13:01:47.747Z] [2026-01-24T13:01:47.747Z] TEST TEARDOWN: [2026-01-24T13:01:47.747Z] Nothing to be done for teardown. [2026-01-24T13:01:47.747Z] renaissance-dec-tree_0 Finish Time: Sat Jan 24 13:01:47 2026 Epoch Time (ms): 1769259707540