[2026-01-10T17:16:51.631Z] Running test renaissance-dec-tree_0 ... [2026-01-10T17:16:51.631Z] =============================================== [2026-01-10T17:16:51.631Z] renaissance-dec-tree_0 Start Time: Sat Jan 10 12:16:51 2026 Epoch Time (ms): 1768065411382 [2026-01-10T17:16:51.631Z] variation: NoOptions [2026-01-10T17:16:51.631Z] JVM_OPTIONS: [2026-01-10T17:16:51.631Z] { \ [2026-01-10T17:16:51.631Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T17:16:51.631Z] echo "Nothing to be done for setup."; \ [2026-01-10T17:16:51.631Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17680643681164/renaissance-dec-tree_0"; \ [2026-01-10T17:16:51.631Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17680643681164/renaissance-dec-tree_0"; \ [2026-01-10T17:16:51.631Z] echo ""; echo "TESTING:"; \ [2026-01-10T17:16:51.631Z] "/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_17680643681164/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-10T17:16:51.631Z] 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_17680643681164/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T17:16:51.631Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T17:16:51.631Z] echo "Nothing to be done for teardown."; \ [2026-01-10T17:16:51.631Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17680643681164/TestTargetResult"; [2026-01-10T17:16:51.631Z] [2026-01-10T17:16:51.631Z] TEST SETUP: [2026-01-10T17:16:51.631Z] Nothing to be done for setup. [2026-01-10T17:16:51.631Z] [2026-01-10T17:16:51.631Z] TESTING: [2026-01-10T17:17:28.532Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T17:17:32.874Z] WARNING: An illegal reflective access operation has occurred [2026-01-10T17:17:32.874Z] 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_17680643681164/renaissance-dec-tree_0/harness-121654-1532748786901868839/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-01-10T17:17:32.874Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-01-10T17:17:32.874Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-01-10T17:17:32.874Z] WARNING: All illegal access operations will be denied in a future release [2026-01-10T17:17:41.748Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-10T17:17:41.748Z] GC before operation: completed in 234.377 ms, heap usage 54.968 MB -> 34.621 MB. [2026-01-10T17:18:33.732Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (51909.158 ms) ====== [2026-01-10T17:18:33.732Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-10T17:18:33.732Z] GC before operation: completed in 483.513 ms, heap usage 348.629 MB -> 68.523 MB. [2026-01-10T17:18:46.957Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (12682.775 ms) ====== [2026-01-10T17:18:46.957Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-10T17:18:46.957Z] GC before operation: completed in 495.260 ms, heap usage 146.025 MB -> 68.804 MB. [2026-01-10T17:19:00.561Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (13375.945 ms) ====== [2026-01-10T17:19:00.561Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-10T17:19:00.561Z] GC before operation: completed in 396.923 ms, heap usage 211.458 MB -> 69.575 MB. [2026-01-10T17:19:00.561Z] 12:19:00.335 WARN [block-manager-storage-async-thread-pool-79] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_37, which does not exist [2026-01-10T17:19:10.560Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9383.279 ms) ====== [2026-01-10T17:19:10.560Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-10T17:19:10.560Z] GC before operation: completed in 516.326 ms, heap usage 126.566 MB -> 96.295 MB. [2026-01-10T17:19:20.449Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8741.154 ms) ====== [2026-01-10T17:19:20.449Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-10T17:19:20.449Z] GC before operation: completed in 355.371 ms, heap usage 269.133 MB -> 69.664 MB. [2026-01-10T17:19:27.956Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (8470.563 ms) ====== [2026-01-10T17:19:27.956Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-10T17:19:29.199Z] GC before operation: completed in 1158.983 ms, heap usage 187.292 MB -> 69.870 MB. [2026-01-10T17:19:38.970Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (9513.342 ms) ====== [2026-01-10T17:19:38.970Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-10T17:19:39.460Z] GC before operation: completed in 474.422 ms, heap usage 364.983 MB -> 97.506 MB. [2026-01-10T17:19:53.431Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (13169.661 ms) ====== [2026-01-10T17:19:53.431Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-10T17:19:53.431Z] GC before operation: completed in 452.752 ms, heap usage 303.859 MB -> 97.625 MB. [2026-01-10T17:19:59.515Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (5804.677 ms) ====== [2026-01-10T17:19:59.515Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-10T17:19:59.515Z] GC before operation: completed in 424.711 ms, heap usage 202.686 MB -> 70.000 MB. [2026-01-10T17:20:05.930Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6742.133 ms) ====== [2026-01-10T17:20:05.930Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-10T17:20:05.930Z] GC before operation: completed in 257.062 ms, heap usage 323.158 MB -> 70.371 MB. [2026-01-10T17:20:15.471Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (8426.699 ms) ====== [2026-01-10T17:20:15.471Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-10T17:20:15.471Z] GC before operation: completed in 788.475 ms, heap usage 107.969 MB -> 70.090 MB. [2026-01-10T17:20:22.921Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (7241.840 ms) ====== [2026-01-10T17:20:22.921Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-10T17:20:22.921Z] GC before operation: completed in 397.013 ms, heap usage 339.028 MB -> 70.454 MB. [2026-01-10T17:20:29.293Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (6269.706 ms) ====== [2026-01-10T17:20:29.293Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-10T17:20:29.922Z] GC before operation: completed in 337.262 ms, heap usage 328.314 MB -> 70.579 MB. [2026-01-10T17:20:37.689Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (7407.255 ms) ====== [2026-01-10T17:20:37.689Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-10T17:20:38.165Z] GC before operation: completed in 1020.869 ms, heap usage 326.520 MB -> 70.841 MB. [2026-01-10T17:20:44.368Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (6098.481 ms) ====== [2026-01-10T17:20:44.368Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-10T17:20:44.368Z] GC before operation: completed in 439.887 ms, heap usage 312.331 MB -> 70.814 MB. [2026-01-10T17:20:51.974Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (6485.550 ms) ====== [2026-01-10T17:20:51.974Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-10T17:20:52.533Z] GC before operation: completed in 1402.044 ms, heap usage 418.340 MB -> 71.133 MB. [2026-01-10T17:21:00.542Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (7344.589 ms) ====== [2026-01-10T17:21:00.542Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-10T17:21:00.542Z] GC before operation: completed in 305.432 ms, heap usage 344.715 MB -> 71.296 MB. [2026-01-10T17:21:06.842Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (6403.733 ms) ====== [2026-01-10T17:21:06.842Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-10T17:21:06.842Z] GC before operation: completed in 303.354 ms, heap usage 257.314 MB -> 71.330 MB. [2026-01-10T17:21:13.171Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (6092.301 ms) ====== [2026-01-10T17:21:13.171Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-10T17:21:13.171Z] GC before operation: completed in 420.883 ms, heap usage 274.100 MB -> 71.433 MB. [2026-01-10T17:21:22.435Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (8505.866 ms) ====== [2026-01-10T17:21:22.435Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-10T17:21:22.435Z] GC before operation: completed in 496.932 ms, heap usage 335.634 MB -> 71.410 MB. [2026-01-10T17:21:29.847Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (6706.202 ms) ====== [2026-01-10T17:21:29.847Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-10T17:21:30.322Z] GC before operation: completed in 1235.463 ms, heap usage 262.834 MB -> 88.217 MB. [2026-01-10T17:21:37.655Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (7021.398 ms) ====== [2026-01-10T17:21:37.655Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-10T17:21:37.655Z] GC before operation: completed in 501.972 ms, heap usage 248.005 MB -> 72.018 MB. [2026-01-10T17:21:46.818Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (7661.869 ms) ====== [2026-01-10T17:21:46.818Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-10T17:21:46.818Z] GC before operation: completed in 458.669 ms, heap usage 308.491 MB -> 99.586 MB. [2026-01-10T17:21:58.277Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (12212.278 ms) ====== [2026-01-10T17:21:58.277Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-10T17:21:58.714Z] GC before operation: completed in 422.347 ms, heap usage 384.089 MB -> 71.866 MB. [2026-01-10T17:22:04.876Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (6172.926 ms) ====== [2026-01-10T17:22:04.876Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-10T17:22:05.906Z] GC before operation: completed in 1112.279 ms, heap usage 222.117 MB -> 71.943 MB. [2026-01-10T17:22:11.950Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (6170.703 ms) ====== [2026-01-10T17:22:11.950Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-10T17:22:12.424Z] GC before operation: completed in 494.780 ms, heap usage 249.487 MB -> 72.443 MB. [2026-01-10T17:22:18.823Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (6388.207 ms) ====== [2026-01-10T17:22:18.823Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-10T17:22:19.250Z] GC before operation: completed in 452.471 ms, heap usage 107.833 MB -> 99.756 MB. [2026-01-10T17:22:25.649Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (5747.171 ms) ====== [2026-01-10T17:22:25.649Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-10T17:22:25.649Z] GC before operation: completed in 479.476 ms, heap usage 254.011 MB -> 99.876 MB. [2026-01-10T17:22:32.573Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (7181.587 ms) ====== [2026-01-10T17:22:32.573Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-10T17:22:34.109Z] GC before operation: completed in 1101.036 ms, heap usage 312.726 MB -> 72.530 MB. [2026-01-10T17:22:39.436Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (5707.222 ms) ====== [2026-01-10T17:22:39.436Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-10T17:22:39.914Z] GC before operation: completed in 440.387 ms, heap usage 331.910 MB -> 100.111 MB. [2026-01-10T17:22:39.914Z] 12:22:39.651 WARN [block-manager-storage-async-thread-pool-183] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_419, which does not exist [2026-01-10T17:22:46.319Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (6233.875 ms) ====== [2026-01-10T17:22:46.319Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-10T17:22:47.627Z] GC before operation: completed in 1569.580 ms, heap usage 269.120 MB -> 72.765 MB. [2026-01-10T17:23:02.372Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (12410.947 ms) ====== [2026-01-10T17:23:02.372Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-10T17:23:02.372Z] GC before operation: completed in 2032.045 ms, heap usage 176.731 MB -> 99.991 MB. [2026-01-10T17:23:07.130Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (4374.996 ms) ====== [2026-01-10T17:23:07.130Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-10T17:23:07.130Z] GC before operation: completed in 421.817 ms, heap usage 523.986 MB -> 73.000 MB. [2026-01-10T17:23:13.324Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (5780.913 ms) ====== [2026-01-10T17:23:13.324Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-10T17:23:13.324Z] GC before operation: completed in 413.494 ms, heap usage 235.437 MB -> 100.501 MB. [2026-01-10T17:23:19.776Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (6494.124 ms) ====== [2026-01-10T17:23:19.776Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-10T17:23:20.545Z] GC before operation: completed in 549.664 ms, heap usage 487.626 MB -> 100.638 MB. [2026-01-10T17:23:28.310Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (7661.411 ms) ====== [2026-01-10T17:23:28.310Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-10T17:23:28.310Z] GC before operation: completed in 387.692 ms, heap usage 447.615 MB -> 73.491 MB. [2026-01-10T17:23:35.655Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6544.502 ms) ====== [2026-01-10T17:23:35.655Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-10T17:23:35.655Z] GC before operation: completed in 325.409 ms, heap usage 252.384 MB -> 73.370 MB. [2026-01-10T17:23:40.974Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (5508.422 ms) ====== [2026-01-10T17:23:40.974Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-10T17:23:40.974Z] GC before operation: completed in 505.131 ms, heap usage 269.391 MB -> 73.326 MB. [2026-01-10T17:23:48.463Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (6665.533 ms) ====== [2026-01-10T17:23:48.463Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-10T17:23:49.029Z] GC before operation: completed in 1007.194 ms, heap usage 144.731 MB -> 73.102 MB. [2026-01-10T17:23:56.740Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (7434.061 ms) ====== [2026-01-10T17:23:59.280Z] ----------------------------------- [2026-01-10T17:23:59.280Z] renaissance-dec-tree_0_PASSED [2026-01-10T17:23:59.280Z] ----------------------------------- [2026-01-10T17:23:59.280Z] [2026-01-10T17:23:59.280Z] TEST TEARDOWN: [2026-01-10T17:23:59.280Z] Nothing to be done for teardown. [2026-01-10T17:23:59.280Z] renaissance-dec-tree_0 Finish Time: Sat Jan 10 12:23:58 2026 Epoch Time (ms): 1768065838614