[2026-01-10T09:54:04.685Z] Running test renaissance-dec-tree_0 ... [2026-01-10T09:54:04.685Z] =============================================== [2026-01-10T09:54:04.685Z] renaissance-dec-tree_0 Start Time: Sat Jan 10 09:54:04 2026 Epoch Time (ms): 1768038844609 [2026-01-10T09:54:04.685Z] variation: NoOptions [2026-01-10T09:54:04.685Z] JVM_OPTIONS: [2026-01-10T09:54:04.685Z] { \ [2026-01-10T09:54:04.685Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T09:54:04.685Z] echo "Nothing to be done for setup."; \ [2026-01-10T09:54:04.685Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680377394286/renaissance-dec-tree_0"; \ [2026-01-10T09:54:04.685Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680377394286/renaissance-dec-tree_0"; \ [2026-01-10T09:54:04.685Z] echo ""; echo "TESTING:"; \ [2026-01-10T09:54:04.685Z] "/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_17680377394286/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-10T09:54:04.685Z] 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_17680377394286/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T09:54:04.685Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T09:54:04.685Z] echo "Nothing to be done for teardown."; \ [2026-01-10T09:54:04.685Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680377394286/TestTargetResult"; [2026-01-10T09:54:04.685Z] [2026-01-10T09:54:04.685Z] TEST SETUP: [2026-01-10T09:54:04.685Z] Nothing to be done for setup. [2026-01-10T09:54:04.685Z] [2026-01-10T09:54:04.685Z] TESTING: [2026-01-10T09:54:16.175Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T09:54:19.531Z] WARNING: An illegal reflective access operation has occurred [2026-01-10T09:54:19.531Z] 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_17680377394286/renaissance-dec-tree_0/harness-095406-13650440461297189893/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-01-10T09:54:19.531Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-01-10T09:54:19.531Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-01-10T09:54:19.531Z] WARNING: All illegal access operations will be denied in a future release [2026-01-10T09:54:22.876Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-10T09:54:22.876Z] GC before operation: completed in 131.958 ms, heap usage 88.900 MB -> 34.390 MB. [2026-01-10T09:54:53.245Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (26822.624 ms) ====== [2026-01-10T09:54:53.245Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-10T09:54:53.245Z] GC before operation: completed in 247.355 ms, heap usage 402.844 MB -> 68.452 MB. [2026-01-10T09:54:57.622Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7308.035 ms) ====== [2026-01-10T09:54:57.622Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-10T09:54:57.622Z] GC before operation: completed in 304.395 ms, heap usage 134.344 MB -> 68.601 MB. [2026-01-10T09:55:03.176Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (5901.945 ms) ====== [2026-01-10T09:55:03.176Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-10T09:55:03.946Z] GC before operation: completed in 268.864 ms, heap usage 224.381 MB -> 69.267 MB. [2026-01-10T09:55:08.314Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (4641.142 ms) ====== [2026-01-10T09:55:08.314Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-10T09:55:08.314Z] GC before operation: completed in 322.836 ms, heap usage 270.638 MB -> 85.802 MB. [2026-01-10T09:55:12.725Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (4182.238 ms) ====== [2026-01-10T09:55:12.725Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-10T09:55:12.725Z] GC before operation: completed in 240.710 ms, heap usage 197.188 MB -> 69.446 MB. [2026-01-10T09:55:18.263Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4714.714 ms) ====== [2026-01-10T09:55:18.263Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-10T09:55:18.263Z] GC before operation: completed in 307.596 ms, heap usage 203.562 MB -> 69.660 MB. [2026-01-10T09:55:21.610Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3924.424 ms) ====== [2026-01-10T09:55:21.610Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-10T09:55:22.370Z] GC before operation: completed in 304.689 ms, heap usage 205.473 MB -> 69.880 MB. [2026-01-10T09:55:26.768Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (4107.110 ms) ====== [2026-01-10T09:55:26.768Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-10T09:55:26.768Z] GC before operation: completed in 292.950 ms, heap usage 204.319 MB -> 70.033 MB. [2026-01-10T09:55:30.126Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3442.551 ms) ====== [2026-01-10T09:55:30.126Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-10T09:55:30.126Z] GC before operation: completed in 294.867 ms, heap usage 278.508 MB -> 70.361 MB. [2026-01-10T09:55:34.256Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (3523.114 ms) ====== [2026-01-10T09:55:34.256Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-10T09:55:34.256Z] GC before operation: completed in 339.670 ms, heap usage 142.348 MB -> 69.734 MB. [2026-01-10T09:55:37.610Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3374.211 ms) ====== [2026-01-10T09:55:37.610Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-10T09:55:37.610Z] GC before operation: completed in 352.701 ms, heap usage 218.046 MB -> 70.303 MB. [2026-01-10T09:55:40.968Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3361.442 ms) ====== [2026-01-10T09:55:40.968Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-10T09:55:41.852Z] GC before operation: completed in 272.013 ms, heap usage 126.053 MB -> 70.431 MB. [2026-01-10T09:55:45.339Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3495.473 ms) ====== [2026-01-10T09:55:45.339Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-10T09:55:45.339Z] GC before operation: completed in 270.408 ms, heap usage 246.778 MB -> 70.529 MB. [2026-01-10T09:55:49.082Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3582.547 ms) ====== [2026-01-10T09:55:49.082Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-10T09:55:49.082Z] GC before operation: completed in 353.283 ms, heap usage 241.875 MB -> 70.647 MB. [2026-01-10T09:55:52.408Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2996.486 ms) ====== [2026-01-10T09:55:52.408Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-10T09:55:52.408Z] GC before operation: completed in 307.116 ms, heap usage 344.724 MB -> 70.620 MB. [2026-01-10T09:55:55.784Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3364.237 ms) ====== [2026-01-10T09:55:55.784Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-10T09:55:56.538Z] GC before operation: completed in 391.110 ms, heap usage 159.234 MB -> 70.605 MB. [2026-01-10T09:55:59.933Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (3032.762 ms) ====== [2026-01-10T09:55:59.933Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-10T09:55:59.933Z] GC before operation: completed in 288.448 ms, heap usage 249.357 MB -> 70.911 MB. [2026-01-10T09:56:03.288Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (3347.347 ms) ====== [2026-01-10T09:56:03.288Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-10T09:56:03.288Z] GC before operation: completed in 304.872 ms, heap usage 221.907 MB -> 71.167 MB. [2026-01-10T09:56:06.681Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3429.222 ms) ====== [2026-01-10T09:56:06.681Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-10T09:56:07.436Z] GC before operation: completed in 315.986 ms, heap usage 185.984 MB -> 70.822 MB. [2026-01-10T09:56:09.882Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3116.675 ms) ====== [2026-01-10T09:56:09.882Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-10T09:56:10.643Z] GC before operation: completed in 301.542 ms, heap usage 281.348 MB -> 71.380 MB. [2026-01-10T09:56:14.010Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (3172.394 ms) ====== [2026-01-10T09:56:14.010Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-10T09:56:14.010Z] GC before operation: completed in 291.954 ms, heap usage 258.178 MB -> 71.478 MB. [2026-01-10T09:56:17.403Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3222.905 ms) ====== [2026-01-10T09:56:17.403Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-10T09:56:17.403Z] GC before operation: completed in 326.337 ms, heap usage 265.660 MB -> 71.596 MB. [2026-01-10T09:56:20.788Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2925.271 ms) ====== [2026-01-10T09:56:20.788Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-10T09:56:20.788Z] GC before operation: completed in 320.216 ms, heap usage 215.832 MB -> 71.557 MB. [2026-01-10T09:56:24.183Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2886.938 ms) ====== [2026-01-10T09:56:24.183Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-10T09:56:24.183Z] GC before operation: completed in 292.234 ms, heap usage 172.453 MB -> 71.720 MB. [2026-01-10T09:56:26.621Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2832.079 ms) ====== [2026-01-10T09:56:26.621Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-10T09:56:27.386Z] GC before operation: completed in 273.586 ms, heap usage 260.233 MB -> 77.734 MB. [2026-01-10T09:56:30.766Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3183.864 ms) ====== [2026-01-10T09:56:30.766Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-10T09:56:30.766Z] GC before operation: completed in 322.713 ms, heap usage 122.605 MB -> 71.243 MB. [2026-01-10T09:56:34.164Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3180.087 ms) ====== [2026-01-10T09:56:34.164Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-10T09:56:34.164Z] GC before operation: completed in 336.757 ms, heap usage 253.292 MB -> 72.082 MB. [2026-01-10T09:56:36.625Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2795.935 ms) ====== [2026-01-10T09:56:36.626Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-10T09:56:37.380Z] GC before operation: completed in 290.636 ms, heap usage 276.758 MB -> 72.048 MB. [2026-01-10T09:56:40.056Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2981.109 ms) ====== [2026-01-10T09:56:40.056Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-10T09:56:40.056Z] GC before operation: completed in 279.232 ms, heap usage 208.529 MB -> 72.164 MB. [2026-01-10T09:56:43.428Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3135.073 ms) ====== [2026-01-10T09:56:43.428Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-10T09:56:44.184Z] GC before operation: completed in 374.335 ms, heap usage 278.365 MB -> 72.415 MB. [2026-01-10T09:56:47.565Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3160.695 ms) ====== [2026-01-10T09:56:47.565Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-10T09:56:47.565Z] GC before operation: completed in 337.139 ms, heap usage 272.066 MB -> 88.686 MB. [2026-01-10T09:56:50.933Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3014.407 ms) ====== [2026-01-10T09:56:50.933Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-10T09:56:50.933Z] GC before operation: completed in 362.601 ms, heap usage 311.946 MB -> 72.629 MB. [2026-01-10T09:56:54.304Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3070.106 ms) ====== [2026-01-10T09:56:54.304Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-10T09:56:54.304Z] GC before operation: completed in 285.068 ms, heap usage 177.469 MB -> 72.424 MB. [2026-01-10T09:56:56.760Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2950.319 ms) ====== [2026-01-10T09:56:56.760Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-10T09:56:57.511Z] GC before operation: completed in 305.014 ms, heap usage 177.159 MB -> 72.529 MB. [2026-01-10T09:57:00.891Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3157.887 ms) ====== [2026-01-10T09:57:00.892Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-10T09:57:00.892Z] GC before operation: completed in 336.322 ms, heap usage 215.803 MB -> 72.806 MB. [2026-01-10T09:57:04.292Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (3185.116 ms) ====== [2026-01-10T09:57:04.292Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-10T09:57:04.292Z] GC before operation: completed in 394.498 ms, heap usage 317.612 MB -> 73.040 MB. [2026-01-10T09:57:07.673Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3139.790 ms) ====== [2026-01-10T09:57:07.673Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-10T09:57:07.673Z] GC before operation: completed in 294.065 ms, heap usage 113.596 MB -> 83.672 MB. [2026-01-10T09:57:07.673Z] 09:57:07.508 WARN [block-manager-storage-async-thread-pool-64] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_513, which does not exist [2026-01-10T09:57:11.055Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2824.576 ms) ====== [2026-01-10T09:57:11.055Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-10T09:57:11.055Z] GC before operation: completed in 267.759 ms, heap usage 224.293 MB -> 73.273 MB. [2026-01-10T09:57:13.494Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2776.147 ms) ====== [2026-01-10T09:57:13.494Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-10T09:57:14.245Z] GC before operation: completed in 282.873 ms, heap usage 220.950 MB -> 73.372 MB. [2026-01-10T09:57:17.621Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3275.083 ms) ====== [2026-01-10T09:57:17.621Z] ----------------------------------- [2026-01-10T09:57:17.621Z] renaissance-dec-tree_0_PASSED [2026-01-10T09:57:17.621Z] ----------------------------------- [2026-01-10T09:57:17.621Z] [2026-01-10T09:57:17.621Z] TEST TEARDOWN: [2026-01-10T09:57:17.621Z] Nothing to be done for teardown. [2026-01-10T09:57:17.621Z] renaissance-dec-tree_0 Finish Time: Sat Jan 10 09:57:17 2026 Epoch Time (ms): 1768039037548