[2026-04-06T21:56:43.845Z] Running test renaissance-dec-tree_0 ... [2026-04-06T21:56:43.845Z] =============================================== [2026-04-06T21:56:43.845Z] renaissance-dec-tree_0 Start Time: Mon Apr 6 21:56:43 2026 Epoch Time (ms): 1775512603010 [2026-04-06T21:56:43.845Z] variation: NoOptions [2026-04-06T21:56:43.845Z] JVM_OPTIONS: [2026-04-06T21:56:43.845Z] { \ [2026-04-06T21:56:43.845Z] echo ""; echo "TEST SETUP:"; \ [2026-04-06T21:56:43.845Z] echo "Nothing to be done for setup."; \ [2026-04-06T21:56:43.845Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17755115672902/renaissance-dec-tree_0"; \ [2026-04-06T21:56:43.845Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17755115672902/renaissance-dec-tree_0"; \ [2026-04-06T21:56:43.845Z] echo ""; echo "TESTING:"; \ [2026-04-06T21:56:43.845Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-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_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17755115672902/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-04-06T21:56:43.845Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17755115672902/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-06T21:56:43.845Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-06T21:56:43.845Z] echo "Nothing to be done for teardown."; \ [2026-04-06T21:56:43.845Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17755115672902/TestTargetResult"; [2026-04-06T21:56:43.845Z] [2026-04-06T21:56:43.845Z] TEST SETUP: [2026-04-06T21:56:43.845Z] Nothing to be done for setup. [2026-04-06T21:56:43.845Z] [2026-04-06T21:56:43.845Z] TESTING: [2026-04-06T21:56:53.773Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-06T21:56:55.992Z] WARNING: An illegal reflective access operation has occurred [2026-04-06T21:56:55.992Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17755115672902/renaissance-dec-tree_0/harness-215644-15864323110028894930/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-04-06T21:56:55.993Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-04-06T21:56:55.993Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-04-06T21:56:55.993Z] WARNING: All illegal access operations will be denied in a future release [2026-04-06T21:56:58.451Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-04-06T21:56:59.217Z] GC before operation: completed in 69.211 ms, heap usage 85.047 MB -> 34.385 MB. [2026-04-06T21:57:25.189Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (25687.348 ms) ====== [2026-04-06T21:57:25.189Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-04-06T21:57:25.189Z] GC before operation: completed in 278.831 ms, heap usage 162.697 MB -> 68.638 MB. [2026-04-06T21:57:32.129Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7018.683 ms) ====== [2026-04-06T21:57:32.129Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-04-06T21:57:32.129Z] GC before operation: completed in 326.538 ms, heap usage 279.249 MB -> 68.607 MB. [2026-04-06T21:57:40.437Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (7565.410 ms) ====== [2026-04-06T21:57:40.437Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-04-06T21:57:40.437Z] GC before operation: completed in 179.893 ms, heap usage 101.180 MB -> 68.556 MB. [2026-04-06T21:57:44.934Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (4640.018 ms) ====== [2026-04-06T21:57:44.934Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-04-06T21:57:44.934Z] GC before operation: completed in 436.293 ms, heap usage 113.576 MB -> 68.780 MB. [2026-04-06T21:57:48.458Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3837.946 ms) ====== [2026-04-06T21:57:48.458Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-04-06T21:57:49.235Z] GC before operation: completed in 218.214 ms, heap usage 109.439 MB -> 97.001 MB. [2026-04-06T21:57:52.663Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3522.083 ms) ====== [2026-04-06T21:57:52.663Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-04-06T21:57:52.663Z] GC before operation: completed in 269.337 ms, heap usage 337.518 MB -> 80.799 MB. [2026-04-06T21:57:56.122Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3506.058 ms) ====== [2026-04-06T21:57:56.122Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-04-06T21:57:56.891Z] GC before operation: completed in 199.637 ms, heap usage 247.970 MB -> 69.872 MB. [2026-04-06T21:58:00.351Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3545.085 ms) ====== [2026-04-06T21:58:00.351Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-04-06T21:58:00.351Z] GC before operation: completed in 283.002 ms, heap usage 243.436 MB -> 70.001 MB. [2026-04-06T21:58:03.789Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3267.208 ms) ====== [2026-04-06T21:58:03.789Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-04-06T21:58:03.789Z] GC before operation: completed in 226.819 ms, heap usage 137.599 MB -> 96.852 MB. [2026-04-06T21:58:07.227Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (3457.174 ms) ====== [2026-04-06T21:58:07.227Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-04-06T21:58:08.006Z] GC before operation: completed in 328.786 ms, heap usage 234.199 MB -> 86.775 MB. [2026-04-06T21:58:11.023Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3201.240 ms) ====== [2026-04-06T21:58:11.023Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-04-06T21:58:11.023Z] GC before operation: completed in 282.911 ms, heap usage 338.021 MB -> 70.317 MB. [2026-04-06T21:58:15.488Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3740.881 ms) ====== [2026-04-06T21:58:15.488Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-04-06T21:58:15.488Z] GC before operation: completed in 310.025 ms, heap usage 244.821 MB -> 81.576 MB. [2026-04-06T21:58:18.902Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3306.456 ms) ====== [2026-04-06T21:58:18.902Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-04-06T21:58:18.902Z] GC before operation: completed in 309.830 ms, heap usage 245.320 MB -> 81.864 MB. [2026-04-06T21:58:22.348Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3130.527 ms) ====== [2026-04-06T21:58:22.348Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-04-06T21:58:22.348Z] GC before operation: completed in 294.724 ms, heap usage 259.149 MB -> 70.504 MB. [2026-04-06T21:58:25.767Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2980.515 ms) ====== [2026-04-06T21:58:25.767Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-04-06T21:58:25.767Z] GC before operation: completed in 362.294 ms, heap usage 274.714 MB -> 70.767 MB. [2026-04-06T21:58:29.184Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3276.602 ms) ====== [2026-04-06T21:58:29.184Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-04-06T21:58:29.184Z] GC before operation: completed in 321.541 ms, heap usage 327.281 MB -> 81.888 MB. [2026-04-06T21:58:32.618Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2899.701 ms) ====== [2026-04-06T21:58:32.618Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-04-06T21:58:32.618Z] GC before operation: completed in 250.898 ms, heap usage 249.713 MB -> 71.261 MB. [2026-04-06T21:58:35.084Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2429.601 ms) ====== [2026-04-06T21:58:35.084Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-04-06T21:58:35.084Z] GC before operation: completed in 271.560 ms, heap usage 177.333 MB -> 71.171 MB. [2026-04-06T21:58:38.529Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3056.597 ms) ====== [2026-04-06T21:58:38.529Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-04-06T21:58:38.529Z] GC before operation: completed in 254.160 ms, heap usage 255.102 MB -> 71.131 MB. [2026-04-06T21:58:41.016Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2338.560 ms) ====== [2026-04-06T21:58:41.016Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-04-06T21:58:41.016Z] GC before operation: completed in 193.917 ms, heap usage 155.861 MB -> 71.355 MB. [2026-04-06T21:58:43.495Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2606.119 ms) ====== [2026-04-06T21:58:43.495Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-04-06T21:58:43.495Z] GC before operation: completed in 250.647 ms, heap usage 153.317 MB -> 71.155 MB. [2026-04-06T21:58:45.970Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2370.441 ms) ====== [2026-04-06T21:58:45.970Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-04-06T21:58:46.754Z] GC before operation: completed in 236.447 ms, heap usage 273.516 MB -> 71.581 MB. [2026-04-06T21:58:49.216Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2485.485 ms) ====== [2026-04-06T21:58:49.216Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-04-06T21:58:49.216Z] GC before operation: completed in 249.508 ms, heap usage 114.805 MB -> 71.373 MB. [2026-04-06T21:58:50.802Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1928.691 ms) ====== [2026-04-06T21:58:50.802Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-04-06T21:58:51.577Z] GC before operation: completed in 186.608 ms, heap usage 212.685 MB -> 82.766 MB. [2026-04-06T21:58:54.046Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2522.500 ms) ====== [2026-04-06T21:58:54.046Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-04-06T21:58:54.046Z] GC before operation: completed in 347.528 ms, heap usage 291.316 MB -> 71.908 MB. [2026-04-06T21:58:56.517Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2712.516 ms) ====== [2026-04-06T21:58:56.517Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-04-06T21:58:57.287Z] GC before operation: completed in 288.025 ms, heap usage 111.272 MB -> 71.953 MB. [2026-04-06T21:58:57.288Z] 21:58:56.660 WARN [block-manager-storage-async-thread-pool-30] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1245_1, which does not exist [2026-04-06T21:58:59.765Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2668.249 ms) ====== [2026-04-06T21:58:59.765Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-04-06T21:58:59.765Z] GC before operation: completed in 314.689 ms, heap usage 253.420 MB -> 72.143 MB. [2026-04-06T21:59:03.228Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3050.815 ms) ====== [2026-04-06T21:59:03.228Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-04-06T21:59:03.228Z] GC before operation: completed in 247.992 ms, heap usage 137.625 MB -> 71.768 MB. [2026-04-06T21:59:05.706Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1923.842 ms) ====== [2026-04-06T21:59:05.706Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-04-06T21:59:05.706Z] GC before operation: completed in 211.838 ms, heap usage 176.388 MB -> 72.357 MB. [2026-04-06T21:59:07.296Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1999.055 ms) ====== [2026-04-06T21:59:07.296Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-04-06T21:59:08.061Z] GC before operation: completed in 159.507 ms, heap usage 139.408 MB -> 83.217 MB. [2026-04-06T21:59:09.662Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1582.552 ms) ====== [2026-04-06T21:59:09.662Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-04-06T21:59:09.662Z] GC before operation: completed in 233.922 ms, heap usage 195.377 MB -> 77.912 MB. [2026-04-06T21:59:09.662Z] 21:59:09.049 WARN [block-manager-storage-async-thread-pool-55] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_429, which does not exist [2026-04-06T21:59:09.662Z] 21:59:09.049 WARN [block-manager-storage-async-thread-pool-55] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_429_piece0, which does not exist [2026-04-06T21:59:12.163Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2207.841 ms) ====== [2026-04-06T21:59:12.163Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-04-06T21:59:12.163Z] GC before operation: completed in 289.610 ms, heap usage 149.559 MB -> 72.195 MB. [2026-04-06T21:59:13.754Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1801.652 ms) ====== [2026-04-06T21:59:13.754Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-04-06T21:59:13.754Z] GC before operation: completed in 175.022 ms, heap usage 171.395 MB -> 72.778 MB. [2026-04-06T21:59:15.857Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1535.753 ms) ====== [2026-04-06T21:59:15.857Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-04-06T21:59:15.857Z] GC before operation: completed in 285.567 ms, heap usage 227.679 MB -> 72.721 MB. [2026-04-06T21:59:18.340Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2423.882 ms) ====== [2026-04-06T21:59:18.340Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-04-06T21:59:18.340Z] GC before operation: completed in 338.553 ms, heap usage 274.840 MB -> 72.855 MB. [2026-04-06T21:59:20.838Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2640.162 ms) ====== [2026-04-06T21:59:20.838Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-04-06T21:59:21.616Z] GC before operation: completed in 301.037 ms, heap usage 305.944 MB -> 73.084 MB. [2026-04-06T21:59:24.099Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2626.089 ms) ====== [2026-04-06T21:59:24.099Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-04-06T21:59:24.100Z] GC before operation: completed in 239.085 ms, heap usage 264.427 MB -> 73.194 MB. [2026-04-06T21:59:26.566Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1759.367 ms) ====== [2026-04-06T21:59:26.566Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-04-06T21:59:26.566Z] GC before operation: completed in 176.870 ms, heap usage 223.109 MB -> 84.216 MB. [2026-04-06T21:59:28.147Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1446.583 ms) ====== [2026-04-06T21:59:28.147Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-04-06T21:59:28.147Z] GC before operation: completed in 174.505 ms, heap usage 245.139 MB -> 84.148 MB. [2026-04-06T21:59:29.733Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1445.909 ms) ====== [2026-04-06T21:59:29.733Z] ----------------------------------- [2026-04-06T21:59:29.733Z] renaissance-dec-tree_0_PASSED [2026-04-06T21:59:29.733Z] ----------------------------------- [2026-04-06T21:59:29.733Z] [2026-04-06T21:59:29.733Z] TEST TEARDOWN: [2026-04-06T21:59:29.733Z] Nothing to be done for teardown. [2026-04-06T21:59:29.733Z] renaissance-dec-tree_0 Finish Time: Mon Apr 6 21:59:29 2026 Epoch Time (ms): 1775512769590