[2026-03-01T22:34:12.997Z] Running test renaissance-dec-tree_0 ... [2026-03-01T22:34:12.997Z] =============================================== [2026-03-01T22:34:12.997Z] renaissance-dec-tree_0 Start Time: Sun Mar 1 17:34:12 2026 Epoch Time (ms): 1772404452819 [2026-03-01T22:34:12.997Z] variation: NoOptions [2026-03-01T22:34:12.997Z] JVM_OPTIONS: [2026-03-01T22:34:12.997Z] { \ [2026-03-01T22:34:12.997Z] echo ""; echo "TEST SETUP:"; \ [2026-03-01T22:34:12.997Z] echo "Nothing to be done for setup."; \ [2026-03-01T22:34:12.997Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17724036589625/renaissance-dec-tree_0"; \ [2026-03-01T22:34:12.997Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17724036589625/renaissance-dec-tree_0"; \ [2026-03-01T22:34:12.997Z] echo ""; echo "TESTING:"; \ [2026-03-01T22:34:12.997Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17724036589625/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-03-01T22:34:12.997Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17724036589625/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-01T22:34:12.997Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-01T22:34:12.997Z] echo "Nothing to be done for teardown."; \ [2026-03-01T22:34:12.997Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17724036589625/TestTargetResult"; [2026-03-01T22:34:13.433Z] [2026-03-01T22:34:13.433Z] TEST SETUP: [2026-03-01T22:34:13.433Z] Nothing to be done for setup. [2026-03-01T22:34:13.433Z] [2026-03-01T22:34:13.433Z] TESTING: [2026-03-01T22:34:43.958Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-03-01T22:34:55.547Z] WARNING: An illegal reflective access operation has occurred [2026-03-01T22:34:55.547Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/output_17724036589625/renaissance-dec-tree_0/harness-173415-6506966601688671279/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-03-01T22:34:55.547Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-03-01T22:34:55.547Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-03-01T22:34:55.547Z] WARNING: All illegal access operations will be denied in a future release [2026-03-01T22:35:02.506Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-03-01T22:35:03.159Z] GC before operation: completed in 277.127 ms, heap usage 90.575 MB -> 34.650 MB. [2026-03-01T22:36:07.443Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (57259.456 ms) ====== [2026-03-01T22:36:07.443Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-03-01T22:36:07.443Z] GC before operation: completed in 541.941 ms, heap usage 193.837 MB -> 68.316 MB. [2026-03-01T22:36:28.660Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (27128.895 ms) ====== [2026-03-01T22:36:28.660Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-03-01T22:36:29.333Z] GC before operation: completed in 1377.766 ms, heap usage 314.632 MB -> 68.912 MB. [2026-03-01T22:36:44.259Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (15072.368 ms) ====== [2026-03-01T22:36:44.259Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-03-01T22:36:45.529Z] GC before operation: completed in 1124.000 ms, heap usage 271.275 MB -> 69.023 MB. [2026-03-01T22:36:58.966Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (12211.238 ms) ====== [2026-03-01T22:36:58.966Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-03-01T22:36:58.966Z] GC before operation: completed in 929.464 ms, heap usage 255.711 MB -> 69.242 MB. [2026-03-01T22:37:12.624Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (12535.581 ms) ====== [2026-03-01T22:37:12.624Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-03-01T22:37:12.624Z] GC before operation: completed in 509.499 ms, heap usage 259.746 MB -> 69.646 MB. [2026-03-01T22:37:22.488Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (9585.270 ms) ====== [2026-03-01T22:37:22.488Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-03-01T22:37:22.488Z] GC before operation: completed in 407.177 ms, heap usage 183.187 MB -> 96.988 MB. [2026-03-01T22:37:31.954Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (8879.580 ms) ====== [2026-03-01T22:37:31.954Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-03-01T22:37:31.954Z] GC before operation: completed in 1188.247 ms, heap usage 305.278 MB -> 92.037 MB. [2026-03-01T22:37:41.668Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (8862.271 ms) ====== [2026-03-01T22:37:41.668Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-03-01T22:37:42.138Z] GC before operation: completed in 1238.512 ms, heap usage 480.035 MB -> 70.113 MB. [2026-03-01T22:37:50.135Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (8024.606 ms) ====== [2026-03-01T22:37:50.135Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-03-01T22:37:51.415Z] GC before operation: completed in 1282.435 ms, heap usage 171.036 MB -> 70.084 MB. [2026-03-01T22:38:03.146Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (10299.258 ms) ====== [2026-03-01T22:38:03.146Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-03-01T22:38:03.146Z] GC before operation: completed in 375.715 ms, heap usage 116.888 MB -> 69.879 MB. [2026-03-01T22:38:11.673Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (9227.486 ms) ====== [2026-03-01T22:38:11.673Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-03-01T22:38:12.312Z] GC before operation: completed in 1279.484 ms, heap usage 247.560 MB -> 70.453 MB. [2026-03-01T22:38:20.282Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (7992.806 ms) ====== [2026-03-01T22:38:20.282Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-03-01T22:38:20.785Z] GC before operation: completed in 435.567 ms, heap usage 149.354 MB -> 70.099 MB. [2026-03-01T22:38:32.391Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (11075.828 ms) ====== [2026-03-01T22:38:32.391Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-03-01T22:38:32.391Z] GC before operation: completed in 394.210 ms, heap usage 262.172 MB -> 70.938 MB. [2026-03-01T22:38:40.385Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (8009.466 ms) ====== [2026-03-01T22:38:40.385Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-03-01T22:38:42.301Z] GC before operation: completed in 1632.513 ms, heap usage 247.190 MB -> 70.656 MB. [2026-03-01T22:38:50.812Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (8843.583 ms) ====== [2026-03-01T22:38:50.812Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-03-01T22:38:51.300Z] GC before operation: completed in 459.156 ms, heap usage 272.783 MB -> 70.767 MB. [2026-03-01T22:38:59.239Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (7849.992 ms) ====== [2026-03-01T22:38:59.239Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-03-01T22:39:00.420Z] GC before operation: completed in 1191.150 ms, heap usage 274.996 MB -> 71.089 MB. [2026-03-01T22:39:08.555Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (8340.342 ms) ====== [2026-03-01T22:39:08.555Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-03-01T22:39:09.099Z] GC before operation: completed in 474.124 ms, heap usage 238.222 MB -> 98.670 MB. [2026-03-01T22:39:16.886Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (7043.587 ms) ====== [2026-03-01T22:39:16.886Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-03-01T22:39:16.886Z] GC before operation: completed in 580.256 ms, heap usage 370.713 MB -> 71.157 MB. [2026-03-01T22:39:26.412Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (8818.541 ms) ====== [2026-03-01T22:39:26.412Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-03-01T22:39:26.853Z] GC before operation: completed in 1117.597 ms, heap usage 255.922 MB -> 93.446 MB. [2026-03-01T22:39:33.573Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (7005.443 ms) ====== [2026-03-01T22:39:33.573Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-03-01T22:39:35.124Z] GC before operation: completed in 967.802 ms, heap usage 357.177 MB -> 98.967 MB. [2026-03-01T22:39:42.471Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (7597.593 ms) ====== [2026-03-01T22:39:42.471Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-03-01T22:39:42.938Z] GC before operation: completed in 455.101 ms, heap usage 441.132 MB -> 99.072 MB. [2026-03-01T22:39:52.616Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (8749.723 ms) ====== [2026-03-01T22:39:52.616Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-03-01T22:39:52.616Z] GC before operation: completed in 405.553 ms, heap usage 201.958 MB -> 71.289 MB. [2026-03-01T22:40:00.848Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (8580.886 ms) ====== [2026-03-01T22:40:00.848Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-03-01T22:40:01.359Z] GC before operation: completed in 580.930 ms, heap usage 386.219 MB -> 71.700 MB. [2026-03-01T22:40:09.806Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (7940.586 ms) ====== [2026-03-01T22:40:09.806Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-03-01T22:40:10.321Z] GC before operation: completed in 954.774 ms, heap usage 303.340 MB -> 88.473 MB. [2026-03-01T22:40:18.904Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (7603.871 ms) ====== [2026-03-01T22:40:18.904Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-03-01T22:40:18.905Z] GC before operation: completed in 786.176 ms, heap usage 268.710 MB -> 71.905 MB. [2026-03-01T22:40:26.689Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (7439.373 ms) ====== [2026-03-01T22:40:26.690Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-03-01T22:40:26.690Z] GC before operation: completed in 326.522 ms, heap usage 297.144 MB -> 99.605 MB. [2026-03-01T22:40:34.785Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (8370.312 ms) ====== [2026-03-01T22:40:34.785Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-03-01T22:40:35.343Z] GC before operation: completed in 787.982 ms, heap usage 340.007 MB -> 72.260 MB. [2026-03-01T22:40:45.056Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (8249.767 ms) ====== [2026-03-01T22:40:45.056Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-03-01T22:40:45.056Z] GC before operation: completed in 1247.288 ms, heap usage 185.828 MB -> 71.917 MB. [2026-03-01T22:40:53.449Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (8510.981 ms) ====== [2026-03-01T22:40:53.449Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-03-01T22:40:53.962Z] GC before operation: completed in 547.683 ms, heap usage 114.577 MB -> 71.702 MB. [2026-03-01T22:41:00.644Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (6097.162 ms) ====== [2026-03-01T22:41:00.644Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-03-01T22:41:00.644Z] GC before operation: completed in 542.522 ms, heap usage 311.597 MB -> 100.035 MB. [2026-03-01T22:41:00.645Z] 17:41:00.254 WARN [block-manager-storage-async-thread-pool-198] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_419_piece0, which does not exist [2026-03-01T22:41:12.551Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (10639.762 ms) ====== [2026-03-01T22:41:12.551Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-03-01T22:41:13.023Z] GC before operation: completed in 1746.688 ms, heap usage 209.319 MB -> 100.165 MB. [2026-03-01T22:41:22.746Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (9767.655 ms) ====== [2026-03-01T22:41:22.746Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-03-01T22:41:24.500Z] GC before operation: completed in 1618.159 ms, heap usage 177.856 MB -> 72.666 MB. [2026-03-01T22:41:35.791Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (10297.210 ms) ====== [2026-03-01T22:41:35.791Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-03-01T22:41:35.791Z] GC before operation: completed in 508.549 ms, heap usage 266.664 MB -> 72.772 MB. [2026-03-01T22:41:42.099Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (6890.151 ms) ====== [2026-03-01T22:41:42.099Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-03-01T22:41:42.742Z] GC before operation: completed in 574.017 ms, heap usage 122.740 MB -> 99.870 MB. [2026-03-01T22:41:50.588Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (7993.116 ms) ====== [2026-03-01T22:41:50.588Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-03-01T22:41:51.879Z] GC before operation: completed in 1032.729 ms, heap usage 377.531 MB -> 73.132 MB. [2026-03-01T22:42:03.133Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (9852.213 ms) ====== [2026-03-01T22:42:03.133Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-03-01T22:42:03.133Z] GC before operation: completed in 428.504 ms, heap usage 377.092 MB -> 100.674 MB. [2026-03-01T22:42:08.983Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (7111.235 ms) ====== [2026-03-01T22:42:08.983Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-03-01T22:42:09.463Z] GC before operation: completed in 543.243 ms, heap usage 293.196 MB -> 73.183 MB. [2026-03-01T22:42:17.668Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (7731.819 ms) ====== [2026-03-01T22:42:17.668Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-03-01T22:42:18.361Z] GC before operation: completed in 547.903 ms, heap usage 275.253 MB -> 100.737 MB. [2026-03-01T22:42:26.477Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (7490.510 ms) ====== [2026-03-01T22:42:26.477Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-03-01T22:42:26.477Z] GC before operation: completed in 499.221 ms, heap usage 405.356 MB -> 73.390 MB. [2026-03-01T22:42:33.031Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (6781.829 ms) ====== [2026-03-01T22:42:37.221Z] ----------------------------------- [2026-03-01T22:42:37.221Z] renaissance-dec-tree_0_PASSED [2026-03-01T22:42:37.221Z] ----------------------------------- [2026-03-01T22:42:37.221Z] [2026-03-01T22:42:37.221Z] TEST TEARDOWN: [2026-03-01T22:42:37.221Z] Nothing to be done for teardown. [2026-03-01T22:42:37.637Z] renaissance-dec-tree_0 Finish Time: Sun Mar 1 17:42:36 2026 Epoch Time (ms): 1772404956911