[2026-04-25T14:03:21.107Z] Running test renaissance-dec-tree_0 ... [2026-04-25T14:03:21.107Z] =============================================== [2026-04-25T14:03:21.107Z] renaissance-dec-tree_0 Start Time: Sat Apr 25 14:03:21 2026 Epoch Time (ms): 1777125801013 [2026-04-25T14:03:21.107Z] variation: NoOptions [2026-04-25T14:03:21.107Z] JVM_OPTIONS: [2026-04-25T14:03:21.107Z] { \ [2026-04-25T14:03:21.107Z] echo ""; echo "TEST SETUP:"; \ [2026-04-25T14:03:21.107Z] echo "Nothing to be done for setup."; \ [2026-04-25T14:03:21.107Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17771251517059/renaissance-dec-tree_0"; \ [2026-04-25T14:03:21.107Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17771251517059/renaissance-dec-tree_0"; \ [2026-04-25T14:03:21.107Z] echo ""; echo "TESTING:"; \ [2026-04-25T14:03:21.107Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17771251517059/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-04-25T14:03:21.107Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17771251517059/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-25T14:03:21.107Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-25T14:03:21.107Z] echo "Nothing to be done for teardown."; \ [2026-04-25T14:03:21.107Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17771251517059/TestTargetResult"; [2026-04-25T14:03:21.107Z] [2026-04-25T14:03:21.107Z] TEST SETUP: [2026-04-25T14:03:21.107Z] Nothing to be done for setup. [2026-04-25T14:03:21.107Z] [2026-04-25T14:03:21.107Z] TESTING: [2026-04-25T14:03:26.906Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-25T14:03:27.224Z] WARNING: An illegal reflective access operation has occurred [2026-04-25T14:03:27.224Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_17771251517059/renaissance-dec-tree_0/harness-140321-7967219358994847733/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-04-25T14:03:27.224Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-04-25T14:03:27.224Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-04-25T14:03:27.224Z] WARNING: All illegal access operations will be denied in a future release [2026-04-25T14:03:28.341Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-04-25T14:03:28.341Z] GC before operation: completed in 62.073 ms, heap usage 77.910 MB -> 34.389 MB. [2026-04-25T14:03:39.055Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10615.012 ms) ====== [2026-04-25T14:03:39.055Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-04-25T14:03:39.374Z] GC before operation: completed in 145.903 ms, heap usage 258.605 MB -> 68.240 MB. [2026-04-25T14:03:41.581Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2289.237 ms) ====== [2026-04-25T14:03:41.581Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-04-25T14:03:41.581Z] GC before operation: completed in 138.053 ms, heap usage 222.515 MB -> 68.590 MB. [2026-04-25T14:03:43.787Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1897.091 ms) ====== [2026-04-25T14:03:43.787Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-04-25T14:03:43.787Z] GC before operation: completed in 112.230 ms, heap usage 107.994 MB -> 68.548 MB. [2026-04-25T14:03:45.415Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1805.302 ms) ====== [2026-04-25T14:03:45.415Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-04-25T14:03:45.733Z] GC before operation: completed in 110.010 ms, heap usage 146.346 MB -> 69.218 MB. [2026-04-25T14:03:47.373Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1644.956 ms) ====== [2026-04-25T14:03:47.373Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-04-25T14:03:47.373Z] GC before operation: completed in 113.719 ms, heap usage 224.324 MB -> 80.378 MB. [2026-04-25T14:03:48.990Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1638.538 ms) ====== [2026-04-25T14:03:48.990Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-04-25T14:03:48.990Z] GC before operation: completed in 143.034 ms, heap usage 266.737 MB -> 69.917 MB. [2026-04-25T14:03:50.621Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1531.851 ms) ====== [2026-04-25T14:03:50.621Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-04-25T14:03:50.946Z] GC before operation: completed in 142.793 ms, heap usage 157.422 MB -> 97.308 MB. [2026-04-25T14:03:52.700Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1540.277 ms) ====== [2026-04-25T14:03:52.700Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-04-25T14:03:52.700Z] GC before operation: completed in 118.603 ms, heap usage 238.255 MB -> 80.933 MB. [2026-04-25T14:03:53.822Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1432.997 ms) ====== [2026-04-25T14:03:53.822Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-04-25T14:03:54.138Z] GC before operation: completed in 119.652 ms, heap usage 259.749 MB -> 75.574 MB. [2026-04-25T14:03:55.768Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1453.652 ms) ====== [2026-04-25T14:03:55.768Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-04-25T14:03:55.768Z] GC before operation: completed in 124.331 ms, heap usage 226.084 MB -> 86.798 MB. [2026-04-25T14:03:55.768Z] 14:03:55.451 WARN [block-manager-storage-async-thread-pool-62] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_135, which does not exist [2026-04-25T14:03:56.882Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1425.083 ms) ====== [2026-04-25T14:03:56.882Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-04-25T14:03:57.204Z] GC before operation: completed in 125.295 ms, heap usage 229.987 MB -> 86.904 MB. [2026-04-25T14:03:58.827Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1382.336 ms) ====== [2026-04-25T14:03:58.827Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-04-25T14:03:58.828Z] GC before operation: completed in 129.573 ms, heap usage 261.961 MB -> 81.655 MB. [2026-04-25T14:03:59.947Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1381.712 ms) ====== [2026-04-25T14:03:59.947Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-04-25T14:04:00.274Z] GC before operation: completed in 150.715 ms, heap usage 259.516 MB -> 81.365 MB. [2026-04-25T14:04:01.893Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1462.209 ms) ====== [2026-04-25T14:04:01.893Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-04-25T14:04:01.893Z] GC before operation: completed in 135.713 ms, heap usage 252.145 MB -> 87.097 MB. [2026-04-25T14:04:03.011Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1322.365 ms) ====== [2026-04-25T14:04:03.011Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-04-25T14:04:03.328Z] GC before operation: completed in 133.416 ms, heap usage 292.744 MB -> 87.191 MB. [2026-04-25T14:04:03.328Z] 14:04:03.098 WARN [block-manager-storage-async-thread-pool-3] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_205_piece0, which does not exist [2026-04-25T14:04:04.446Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1286.684 ms) ====== [2026-04-25T14:04:04.446Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-04-25T14:04:04.765Z] GC before operation: completed in 134.214 ms, heap usage 194.460 MB -> 70.742 MB. [2026-04-25T14:04:05.880Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1315.088 ms) ====== [2026-04-25T14:04:05.880Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-04-25T14:04:06.198Z] GC before operation: completed in 131.541 ms, heap usage 113.022 MB -> 71.065 MB. [2026-04-25T14:04:07.314Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1255.902 ms) ====== [2026-04-25T14:04:07.314Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-04-25T14:04:07.639Z] GC before operation: completed in 135.894 ms, heap usage 251.827 MB -> 87.618 MB. [2026-04-25T14:04:08.767Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1279.358 ms) ====== [2026-04-25T14:04:08.767Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-04-25T14:04:09.086Z] GC before operation: completed in 138.351 ms, heap usage 302.967 MB -> 93.205 MB. [2026-04-25T14:04:10.202Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1240.444 ms) ====== [2026-04-25T14:04:10.202Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-04-25T14:04:10.202Z] GC before operation: completed in 139.955 ms, heap usage 310.792 MB -> 71.343 MB. [2026-04-25T14:04:11.826Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1368.876 ms) ====== [2026-04-25T14:04:11.826Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-04-25T14:04:11.826Z] GC before operation: completed in 132.106 ms, heap usage 242.944 MB -> 88.129 MB. [2026-04-25T14:04:13.447Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1302.231 ms) ====== [2026-04-25T14:04:13.447Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-04-25T14:04:13.447Z] GC before operation: completed in 154.792 ms, heap usage 245.202 MB -> 88.248 MB. [2026-04-25T14:04:14.563Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1312.135 ms) ====== [2026-04-25T14:04:14.563Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-04-25T14:04:14.879Z] GC before operation: completed in 148.672 ms, heap usage 194.805 MB -> 93.131 MB. [2026-04-25T14:04:15.993Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1250.724 ms) ====== [2026-04-25T14:04:15.994Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-04-25T14:04:15.994Z] GC before operation: completed in 148.681 ms, heap usage 132.575 MB -> 82.730 MB. [2026-04-25T14:04:17.641Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1158.832 ms) ====== [2026-04-25T14:04:17.641Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-04-25T14:04:17.641Z] GC before operation: completed in 141.165 ms, heap usage 282.182 MB -> 99.467 MB. [2026-04-25T14:04:18.754Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1188.203 ms) ====== [2026-04-25T14:04:18.754Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-04-25T14:04:18.754Z] GC before operation: completed in 139.101 ms, heap usage 221.007 MB -> 88.463 MB. [2026-04-25T14:04:20.369Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1254.667 ms) ====== [2026-04-25T14:04:20.369Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-04-25T14:04:20.369Z] GC before operation: completed in 140.579 ms, heap usage 219.082 MB -> 88.605 MB. [2026-04-25T14:04:21.483Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1325.952 ms) ====== [2026-04-25T14:04:21.483Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-04-25T14:04:21.483Z] GC before operation: completed in 139.944 ms, heap usage 119.737 MB -> 72.018 MB. [2026-04-25T14:04:23.095Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1353.151 ms) ====== [2026-04-25T14:04:23.095Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-04-25T14:04:23.095Z] GC before operation: completed in 177.526 ms, heap usage 118.244 MB -> 72.106 MB. [2026-04-25T14:04:24.712Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1251.862 ms) ====== [2026-04-25T14:04:24.712Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-04-25T14:04:24.712Z] GC before operation: completed in 146.708 ms, heap usage 219.128 MB -> 83.498 MB. [2026-04-25T14:04:25.825Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1288.440 ms) ====== [2026-04-25T14:04:25.825Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-04-25T14:04:26.142Z] GC before operation: completed in 146.613 ms, heap usage 268.746 MB -> 88.988 MB. [2026-04-25T14:04:27.263Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1298.639 ms) ====== [2026-04-25T14:04:27.263Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-04-25T14:04:27.582Z] GC before operation: completed in 164.375 ms, heap usage 165.056 MB -> 83.359 MB. [2026-04-25T14:04:28.697Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1203.050 ms) ====== [2026-04-25T14:04:28.697Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-04-25T14:04:28.697Z] GC before operation: completed in 142.585 ms, heap usage 124.282 MB -> 72.536 MB. [2026-04-25T14:04:30.318Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1254.037 ms) ====== [2026-04-25T14:04:30.318Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-04-25T14:04:30.318Z] GC before operation: completed in 147.340 ms, heap usage 314.909 MB -> 89.526 MB. [2026-04-25T14:04:31.439Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1339.724 ms) ====== [2026-04-25T14:04:31.439Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-04-25T14:04:31.761Z] GC before operation: completed in 145.831 ms, heap usage 267.162 MB -> 72.982 MB. [2026-04-25T14:04:33.381Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1407.071 ms) ====== [2026-04-25T14:04:33.381Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-04-25T14:04:33.381Z] GC before operation: completed in 144.193 ms, heap usage 211.396 MB -> 95.171 MB. [2026-04-25T14:04:34.501Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1194.733 ms) ====== [2026-04-25T14:04:34.501Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-04-25T14:04:34.501Z] GC before operation: completed in 143.192 ms, heap usage 224.152 MB -> 89.609 MB. [2026-04-25T14:04:36.118Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1287.873 ms) ====== [2026-04-25T14:04:36.118Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-04-25T14:04:36.118Z] GC before operation: completed in 155.267 ms, heap usage 429.973 MB -> 95.382 MB. [2026-04-25T14:04:37.238Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1244.967 ms) ====== [2026-04-25T14:04:37.238Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-04-25T14:04:37.560Z] GC before operation: completed in 140.823 ms, heap usage 162.801 MB -> 73.286 MB. [2026-04-25T14:04:38.681Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1206.353 ms) ====== [2026-04-25T14:04:38.999Z] ----------------------------------- [2026-04-25T14:04:38.999Z] renaissance-dec-tree_0_PASSED [2026-04-25T14:04:38.999Z] ----------------------------------- [2026-04-25T14:04:38.999Z] [2026-04-25T14:04:38.999Z] TEST TEARDOWN: [2026-04-25T14:04:38.999Z] Nothing to be done for teardown. [2026-04-25T14:04:38.999Z] renaissance-dec-tree_0 Finish Time: Sat Apr 25 14:04:38 2026 Epoch Time (ms): 1777125878738