[2026-03-17T22:12:36.207Z] Running test renaissance-dec-tree_0 ... [2026-03-17T22:12:36.207Z] =============================================== [2026-03-17T22:12:36.207Z] renaissance-dec-tree_0 Start Time: Tue Mar 17 22:12:35 2026 Epoch Time (ms): 1773785555948 [2026-03-17T22:12:36.207Z] variation: NoOptions [2026-03-17T22:12:36.207Z] JVM_OPTIONS: [2026-03-17T22:12:36.207Z] { \ [2026-03-17T22:12:36.207Z] echo ""; echo "TEST SETUP:"; \ [2026-03-17T22:12:36.207Z] echo "Nothing to be done for setup."; \ [2026-03-17T22:12:36.207Z] mkdir -p "/home/jenkins/workspace/Test_openjdk26_hs_extended.perf_s390x_linux_rerun/aqa-tests/TKG/../TKG/output_17737847804490/renaissance-dec-tree_0"; \ [2026-03-17T22:12:36.207Z] cd "/home/jenkins/workspace/Test_openjdk26_hs_extended.perf_s390x_linux_rerun/aqa-tests/TKG/../TKG/output_17737847804490/renaissance-dec-tree_0"; \ [2026-03-17T22:12:36.207Z] echo ""; echo "TESTING:"; \ [2026-03-17T22:12:36.207Z] "/home/jenkins/workspace/Test_openjdk26_hs_extended.perf_s390x_linux_rerun/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_openjdk26_hs_extended.perf_s390x_linux_rerun/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk26_hs_extended.perf_s390x_linux_rerun/aqa-tests/TKG/../TKG/output_17737847804490/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-03-17T22:12:36.207Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk26_hs_extended.perf_s390x_linux_rerun/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk26_hs_extended.perf_s390x_linux_rerun/aqa-tests/TKG/../TKG/output_17737847804490/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-17T22:12:36.207Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-17T22:12:36.207Z] echo "Nothing to be done for teardown."; \ [2026-03-17T22:12:36.207Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk26_hs_extended.perf_s390x_linux_rerun/aqa-tests/TKG/../TKG/output_17737847804490/TestTargetResult"; [2026-03-17T22:12:36.207Z] [2026-03-17T22:12:36.207Z] TEST SETUP: [2026-03-17T22:12:36.207Z] Nothing to be done for setup. [2026-03-17T22:12:36.207Z] [2026-03-17T22:12:36.207Z] TESTING: [2026-03-17T22:12:39.319Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-03-17T22:12:39.320Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (resource:/shared/scala3-library_3-3.3.4.jar) [2026-03-17T22:12:39.320Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-03-17T22:12:39.320Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-03-17T22:13:08.649Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-03-17T22:13:11.782Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-03-17T22:13:11.782Z] GC before operation: completed in 159.109 ms, heap usage 39.662 MB -> 35.915 MB. [2026-03-17T22:13:27.142Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (14901.859 ms) ====== [2026-03-17T22:13:27.142Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-03-17T22:13:27.142Z] GC before operation: completed in 169.942 ms, heap usage 183.675 MB -> 69.326 MB. [2026-03-17T22:13:30.398Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3411.613 ms) ====== [2026-03-17T22:13:30.398Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-03-17T22:13:30.398Z] GC before operation: completed in 122.336 ms, heap usage 411.405 MB -> 69.906 MB. [2026-03-17T22:13:33.714Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2871.697 ms) ====== [2026-03-17T22:13:33.714Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-03-17T22:13:33.714Z] GC before operation: completed in 115.371 ms, heap usage 293.409 MB -> 70.059 MB. [2026-03-17T22:13:35.962Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2675.738 ms) ====== [2026-03-17T22:13:35.962Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-03-17T22:13:35.962Z] GC before operation: completed in 109.340 ms, heap usage 450.224 MB -> 70.477 MB. [2026-03-17T22:13:39.072Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2707.984 ms) ====== [2026-03-17T22:13:39.072Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-03-17T22:13:39.072Z] GC before operation: completed in 160.326 ms, heap usage 142.040 MB -> 69.967 MB. [2026-03-17T22:13:41.313Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2488.608 ms) ====== [2026-03-17T22:13:41.313Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-03-17T22:13:42.010Z] GC before operation: completed in 142.864 ms, heap usage 445.618 MB -> 70.948 MB. [2026-03-17T22:13:44.381Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2294.072 ms) ====== [2026-03-17T22:13:44.381Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-03-17T22:13:44.381Z] GC before operation: completed in 206.462 ms, heap usage 442.032 MB -> 70.940 MB. [2026-03-17T22:13:46.687Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2419.676 ms) ====== [2026-03-17T22:13:46.687Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-03-17T22:13:46.687Z] GC before operation: completed in 147.278 ms, heap usage 442.344 MB -> 71.536 MB. [2026-03-17T22:13:49.052Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2471.989 ms) ====== [2026-03-17T22:13:49.052Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-03-17T22:13:49.741Z] GC before operation: completed in 219.734 ms, heap usage 443.079 MB -> 71.332 MB. [2026-03-17T22:13:51.962Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2373.336 ms) ====== [2026-03-17T22:13:51.962Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-03-17T22:13:51.962Z] GC before operation: completed in 200.592 ms, heap usage 442.188 MB -> 71.358 MB. [2026-03-17T22:13:54.363Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2437.017 ms) ====== [2026-03-17T22:13:54.363Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-03-17T22:13:54.363Z] GC before operation: completed in 127.671 ms, heap usage 441.596 MB -> 71.671 MB. [2026-03-17T22:13:56.530Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2208.209 ms) ====== [2026-03-17T22:13:56.530Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-03-17T22:13:57.217Z] GC before operation: completed in 137.786 ms, heap usage 441.934 MB -> 71.994 MB. [2026-03-17T22:13:58.637Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2032.651 ms) ====== [2026-03-17T22:13:58.637Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-03-17T22:13:59.341Z] GC before operation: completed in 125.413 ms, heap usage 436.626 MB -> 71.859 MB. [2026-03-17T22:14:01.617Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2166.455 ms) ====== [2026-03-17T22:14:01.617Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-03-17T22:14:01.617Z] GC before operation: completed in 185.510 ms, heap usage 276.908 MB -> 71.635 MB. [2026-03-17T22:14:03.840Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2090.982 ms) ====== [2026-03-17T22:14:03.840Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-03-17T22:14:03.840Z] GC before operation: completed in 179.108 ms, heap usage 442.325 MB -> 99.569 MB. [2026-03-17T22:14:03.840Z] 22:14:03.335 WARN [block-manager-storage-async-thread-pool-77] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_209, which does not exist [2026-03-17T22:14:05.978Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1966.064 ms) ====== [2026-03-17T22:14:05.978Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-03-17T22:14:05.978Z] GC before operation: completed in 118.217 ms, heap usage 349.248 MB -> 72.029 MB. [2026-03-17T22:14:08.273Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2245.611 ms) ====== [2026-03-17T22:14:08.273Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-03-17T22:14:08.273Z] GC before operation: completed in 207.630 ms, heap usage 275.605 MB -> 99.623 MB. [2026-03-17T22:14:10.482Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1934.186 ms) ====== [2026-03-17T22:14:10.482Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-03-17T22:14:10.482Z] GC before operation: completed in 131.132 ms, heap usage 139.987 MB -> 71.471 MB. [2026-03-17T22:14:12.692Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2254.011 ms) ====== [2026-03-17T22:14:12.692Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-03-17T22:14:12.692Z] GC before operation: completed in 156.289 ms, heap usage 249.082 MB -> 91.606 MB. [2026-03-17T22:14:14.923Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2173.987 ms) ====== [2026-03-17T22:14:14.923Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-03-17T22:14:14.923Z] GC before operation: completed in 144.192 ms, heap usage 438.991 MB -> 72.490 MB. [2026-03-17T22:14:18.050Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2613.490 ms) ====== [2026-03-17T22:14:18.050Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-03-17T22:14:18.050Z] GC before operation: completed in 146.789 ms, heap usage 270.267 MB -> 72.358 MB. [2026-03-17T22:14:20.293Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2192.955 ms) ====== [2026-03-17T22:14:20.293Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-03-17T22:14:20.293Z] GC before operation: completed in 157.589 ms, heap usage 270.987 MB -> 72.622 MB. [2026-03-17T22:14:22.551Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2400.665 ms) ====== [2026-03-17T22:14:22.551Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-03-17T22:14:22.551Z] GC before operation: completed in 164.267 ms, heap usage 431.225 MB -> 91.904 MB. [2026-03-17T22:14:24.795Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2144.775 ms) ====== [2026-03-17T22:14:24.795Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-03-17T22:14:24.795Z] GC before operation: completed in 162.726 ms, heap usage 430.370 MB -> 81.259 MB. [2026-03-17T22:14:26.971Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2086.820 ms) ====== [2026-03-17T22:14:26.971Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-03-17T22:14:26.971Z] GC before operation: completed in 136.227 ms, heap usage 150.906 MB -> 72.566 MB. [2026-03-17T22:14:29.233Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2206.600 ms) ====== [2026-03-17T22:14:29.233Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-03-17T22:14:29.931Z] GC before operation: completed in 183.228 ms, heap usage 271.170 MB -> 73.063 MB. [2026-03-17T22:14:32.248Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2126.074 ms) ====== [2026-03-17T22:14:32.248Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-03-17T22:14:32.248Z] GC before operation: completed in 329.374 ms, heap usage 431.039 MB -> 100.896 MB. [2026-03-17T22:14:34.614Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2359.238 ms) ====== [2026-03-17T22:14:34.614Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-03-17T22:14:34.614Z] GC before operation: completed in 201.667 ms, heap usage 339.526 MB -> 73.348 MB. [2026-03-17T22:14:36.897Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2068.064 ms) ====== [2026-03-17T22:14:36.897Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-03-17T22:14:36.897Z] GC before operation: completed in 189.126 ms, heap usage 395.547 MB -> 101.136 MB. [2026-03-17T22:14:39.177Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2008.387 ms) ====== [2026-03-17T22:14:39.177Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-03-17T22:14:39.177Z] GC before operation: completed in 198.816 ms, heap usage 339.908 MB -> 92.795 MB. [2026-03-17T22:14:41.472Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1843.198 ms) ====== [2026-03-17T22:14:41.472Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-03-17T22:14:41.472Z] GC before operation: completed in 233.372 ms, heap usage 229.598 MB -> 92.961 MB. [2026-03-17T22:14:42.844Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1910.541 ms) ====== [2026-03-17T22:14:42.844Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-03-17T22:14:43.632Z] GC before operation: completed in 162.706 ms, heap usage 232.295 MB -> 73.736 MB. [2026-03-17T22:14:45.643Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2261.798 ms) ====== [2026-03-17T22:14:45.644Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-03-17T22:14:45.644Z] GC before operation: completed in 201.944 ms, heap usage 393.511 MB -> 74.319 MB. [2026-03-17T22:14:48.016Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2297.115 ms) ====== [2026-03-17T22:14:48.016Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-03-17T22:14:48.016Z] GC before operation: completed in 156.452 ms, heap usage 265.866 MB -> 74.195 MB. [2026-03-17T22:14:50.382Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2072.324 ms) ====== [2026-03-17T22:14:50.382Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-03-17T22:14:50.382Z] GC before operation: completed in 218.591 ms, heap usage 427.919 MB -> 74.248 MB. [2026-03-17T22:14:50.382Z] 22:14:50.140 WARN [block-manager-storage-async-thread-pool-26] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1677_0, which does not exist [2026-03-17T22:14:52.655Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1985.107 ms) ====== [2026-03-17T22:14:52.655Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-03-17T22:14:52.655Z] GC before operation: completed in 265.257 ms, heap usage 426.799 MB -> 101.860 MB. [2026-03-17T22:14:54.922Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2016.971 ms) ====== [2026-03-17T22:14:54.922Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-03-17T22:14:54.922Z] GC before operation: completed in 164.235 ms, heap usage 179.544 MB -> 73.893 MB. [2026-03-17T22:14:57.107Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2046.290 ms) ====== [2026-03-17T22:14:57.107Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-03-17T22:14:57.107Z] GC before operation: completed in 180.427 ms, heap usage 271.390 MB -> 74.329 MB. [2026-03-17T22:14:59.342Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2102.293 ms) ====== [2026-03-17T22:14:59.342Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-03-17T22:14:59.342Z] GC before operation: completed in 242.541 ms, heap usage 422.895 MB -> 74.686 MB. [2026-03-17T22:15:01.582Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2044.368 ms) ====== [2026-03-17T22:15:02.235Z] ----------------------------------- [2026-03-17T22:15:02.235Z] renaissance-dec-tree_0_PASSED [2026-03-17T22:15:02.235Z] ----------------------------------- [2026-03-17T22:15:02.235Z] [2026-03-17T22:15:02.235Z] TEST TEARDOWN: [2026-03-17T22:15:02.235Z] Nothing to be done for teardown. [2026-03-17T22:15:02.235Z] renaissance-dec-tree_0 Finish Time: Tue Mar 17 22:15:02 2026 Epoch Time (ms): 1773785702088