[2026-01-12T09:49:44.564Z] Running test renaissance-dec-tree_0 ... [2026-01-12T09:49:44.564Z] =============================================== [2026-01-12T09:49:44.564Z] renaissance-dec-tree_0 Start Time: Mon Jan 12 04:49:44 2026 Epoch Time (ms): 1768211384491 [2026-01-12T09:49:44.564Z] variation: NoOptions [2026-01-12T09:49:44.994Z] JVM_OPTIONS: [2026-01-12T09:49:44.994Z] { \ [2026-01-12T09:49:44.994Z] echo ""; echo "TEST SETUP:"; \ [2026-01-12T09:49:44.994Z] echo "Nothing to be done for setup."; \ [2026-01-12T09:49:44.994Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17682097197127/renaissance-dec-tree_0"; \ [2026-01-12T09:49:44.994Z] cd "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17682097197127/renaissance-dec-tree_0"; \ [2026-01-12T09:49:44.994Z] echo ""; echo "TESTING:"; \ [2026-01-12T09:49:44.994Z] "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/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_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17682097197127/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-12T09:49:44.994Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17682097197127/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-12T09:49:44.994Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-12T09:49:44.994Z] echo "Nothing to be done for teardown."; \ [2026-01-12T09:49:44.994Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17682097197127/TestTargetResult"; [2026-01-12T09:49:44.994Z] [2026-01-12T09:49:44.994Z] TEST SETUP: [2026-01-12T09:49:44.994Z] Nothing to be done for setup. [2026-01-12T09:49:44.994Z] [2026-01-12T09:49:44.994Z] TESTING: [2026-01-12T09:49:48.409Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-12T09:49:48.409Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/output_17682097197127/renaissance-dec-tree_0/launcher-044945-15574730718664248100/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-12T09:49:48.409Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-12T09:49:48.409Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-12T09:50:10.105Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-12T09:50:16.196Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-12T09:50:16.662Z] GC before operation: completed in 186.829 ms, heap usage 51.258 MB -> 33.959 MB. [2026-01-12T09:51:00.071Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (37900.467 ms) ====== [2026-01-12T09:51:00.071Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-12T09:51:00.071Z] GC before operation: completed in 688.795 ms, heap usage 185.464 MB -> 69.282 MB. [2026-01-12T09:51:02.979Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7930.385 ms) ====== [2026-01-12T09:51:02.979Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-12T09:51:03.552Z] GC before operation: completed in 323.445 ms, heap usage 222.579 MB -> 97.645 MB. [2026-01-12T09:51:11.638Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (7846.037 ms) ====== [2026-01-12T09:51:11.638Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-12T09:51:12.278Z] GC before operation: completed in 722.207 ms, heap usage 268.641 MB -> 70.142 MB. [2026-01-12T09:51:23.129Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9789.367 ms) ====== [2026-01-12T09:51:23.129Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-12T09:51:23.129Z] GC before operation: completed in 260.566 ms, heap usage 326.204 MB -> 70.496 MB. [2026-01-12T09:51:27.563Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (5500.512 ms) ====== [2026-01-12T09:51:27.563Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-12T09:51:27.563Z] GC before operation: completed in 220.814 ms, heap usage 343.277 MB -> 70.937 MB. [2026-01-12T09:51:32.736Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4393.719 ms) ====== [2026-01-12T09:51:32.736Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-12T09:51:32.736Z] GC before operation: completed in 152.468 ms, heap usage 212.130 MB -> 71.055 MB. [2026-01-12T09:51:38.263Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (5595.618 ms) ====== [2026-01-12T09:51:38.263Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-12T09:51:38.263Z] GC before operation: completed in 177.859 ms, heap usage 345.815 MB -> 71.154 MB. [2026-01-12T09:51:45.953Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (7080.704 ms) ====== [2026-01-12T09:51:45.953Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-12T09:51:45.953Z] GC before operation: completed in 446.735 ms, heap usage 287.160 MB -> 71.286 MB. [2026-01-12T09:51:51.111Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (5008.200 ms) ====== [2026-01-12T09:51:51.111Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-12T09:51:51.111Z] GC before operation: completed in 317.451 ms, heap usage 268.359 MB -> 71.326 MB. [2026-01-12T09:51:56.218Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4458.218 ms) ====== [2026-01-12T09:51:56.218Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-12T09:51:56.218Z] GC before operation: completed in 229.408 ms, heap usage 287.408 MB -> 71.406 MB. [2026-01-12T09:52:00.147Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4162.380 ms) ====== [2026-01-12T09:52:00.147Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-12T09:52:00.742Z] GC before operation: completed in 1062.319 ms, heap usage 255.572 MB -> 71.674 MB. [2026-01-12T09:52:05.834Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (4798.803 ms) ====== [2026-01-12T09:52:05.834Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-12T09:52:06.328Z] GC before operation: completed in 609.333 ms, heap usage 427.248 MB -> 71.711 MB. [2026-01-12T09:52:10.262Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4255.207 ms) ====== [2026-01-12T09:52:10.262Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-12T09:52:10.701Z] GC before operation: completed in 251.579 ms, heap usage 105.955 MB -> 71.546 MB. [2026-01-12T09:52:17.371Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (6296.045 ms) ====== [2026-01-12T09:52:17.371Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-12T09:52:17.371Z] GC before operation: completed in 206.440 ms, heap usage 561.822 MB -> 72.499 MB. [2026-01-12T09:52:23.599Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5784.648 ms) ====== [2026-01-12T09:52:23.599Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-12T09:52:24.046Z] GC before operation: completed in 849.945 ms, heap usage 342.820 MB -> 72.160 MB. [2026-01-12T09:52:30.402Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (6269.494 ms) ====== [2026-01-12T09:52:30.402Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-12T09:52:30.402Z] GC before operation: completed in 223.620 ms, heap usage 439.984 MB -> 72.514 MB. [2026-01-12T09:52:34.590Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4219.213 ms) ====== [2026-01-12T09:52:34.590Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-12T09:52:35.221Z] GC before operation: completed in 749.271 ms, heap usage 209.921 MB -> 72.373 MB. [2026-01-12T09:52:41.569Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (5331.645 ms) ====== [2026-01-12T09:52:41.569Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-12T09:52:41.569Z] GC before operation: completed in 212.630 ms, heap usage 142.614 MB -> 72.154 MB. [2026-01-12T09:52:46.703Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5866.433 ms) ====== [2026-01-12T09:52:46.703Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-12T09:52:47.373Z] GC before operation: completed in 297.496 ms, heap usage 174.780 MB -> 72.321 MB. [2026-01-12T09:52:53.932Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (6317.333 ms) ====== [2026-01-12T09:52:53.932Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-12T09:52:54.445Z] GC before operation: completed in 1001.760 ms, heap usage 175.398 MB -> 72.601 MB. [2026-01-12T09:52:59.413Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (4686.785 ms) ====== [2026-01-12T09:52:59.413Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-12T09:52:59.413Z] GC before operation: completed in 321.629 ms, heap usage 339.314 MB -> 100.245 MB. [2026-01-12T09:53:04.537Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (5192.943 ms) ====== [2026-01-12T09:53:04.537Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-12T09:53:04.989Z] GC before operation: completed in 359.491 ms, heap usage 289.991 MB -> 100.538 MB. [2026-01-12T09:53:04.989Z] 04:53:04.663 WARN [block-manager-storage-async-thread-pool-71] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_307_piece0, which does not exist [2026-01-12T09:53:11.058Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (5480.935 ms) ====== [2026-01-12T09:53:11.059Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-12T09:53:11.059Z] GC before operation: completed in 349.555 ms, heap usage 257.655 MB -> 73.048 MB. [2026-01-12T09:53:16.651Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (5482.501 ms) ====== [2026-01-12T09:53:16.651Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-12T09:53:17.268Z] GC before operation: completed in 1165.066 ms, heap usage 450.922 MB -> 100.850 MB. [2026-01-12T09:53:25.455Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (6907.112 ms) ====== [2026-01-12T09:53:25.456Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-12T09:53:25.456Z] GC before operation: completed in 381.842 ms, heap usage 673.439 MB -> 73.765 MB. [2026-01-12T09:53:30.574Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (5827.078 ms) ====== [2026-01-12T09:53:30.574Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-12T09:53:31.139Z] GC before operation: completed in 292.178 ms, heap usage 352.836 MB -> 73.242 MB. [2026-01-12T09:53:35.202Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3802.785 ms) ====== [2026-01-12T09:53:35.202Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-12T09:53:35.202Z] GC before operation: completed in 734.993 ms, heap usage 211.366 MB -> 73.349 MB. [2026-01-12T09:53:40.192Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4183.153 ms) ====== [2026-01-12T09:53:40.192Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-12T09:53:40.192Z] GC before operation: completed in 427.433 ms, heap usage 217.170 MB -> 73.584 MB. [2026-01-12T09:53:47.632Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (6775.458 ms) ====== [2026-01-12T09:53:47.632Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-12T09:53:47.632Z] GC before operation: completed in 204.378 ms, heap usage 144.677 MB -> 73.616 MB. [2026-01-12T09:53:54.047Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (6343.138 ms) ====== [2026-01-12T09:53:54.047Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-12T09:53:54.047Z] GC before operation: completed in 317.037 ms, heap usage 471.017 MB -> 74.071 MB. [2026-01-12T09:53:59.001Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (5156.322 ms) ====== [2026-01-12T09:53:59.001Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-12T09:53:59.001Z] GC before operation: completed in 354.264 ms, heap usage 351.901 MB -> 73.776 MB. [2026-01-12T09:54:05.235Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (5042.050 ms) ====== [2026-01-12T09:54:05.235Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-12T09:54:05.235Z] GC before operation: completed in 553.435 ms, heap usage 471.688 MB -> 74.129 MB. [2026-01-12T09:54:10.285Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (4968.208 ms) ====== [2026-01-12T09:54:10.285Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-12T09:54:10.285Z] GC before operation: completed in 295.993 ms, heap usage 212.318 MB -> 74.117 MB. [2026-01-12T09:54:15.730Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (5611.147 ms) ====== [2026-01-12T09:54:15.730Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-12T09:54:16.361Z] GC before operation: completed in 985.329 ms, heap usage 109.039 MB -> 73.709 MB. [2026-01-12T09:54:22.871Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (6269.979 ms) ====== [2026-01-12T09:54:22.871Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-12T09:54:23.357Z] GC before operation: completed in 257.200 ms, heap usage 352.424 MB -> 74.585 MB. [2026-01-12T09:54:28.376Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (5001.208 ms) ====== [2026-01-12T09:54:28.376Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-12T09:54:28.376Z] GC before operation: completed in 302.947 ms, heap usage 217.601 MB -> 74.459 MB. [2026-01-12T09:54:32.545Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4085.831 ms) ====== [2026-01-12T09:54:32.545Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-12T09:54:32.545Z] GC before operation: completed in 269.446 ms, heap usage 318.994 MB -> 74.566 MB. [2026-01-12T09:54:37.602Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4470.827 ms) ====== [2026-01-12T09:54:37.602Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-12T09:54:37.602Z] GC before operation: completed in 302.175 ms, heap usage 126.377 MB -> 74.079 MB. [2026-01-12T09:54:43.902Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (5519.265 ms) ====== [2026-01-12T09:54:43.902Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-12T09:54:43.902Z] GC before operation: completed in 331.989 ms, heap usage 547.786 MB -> 74.887 MB. [2026-01-12T09:54:48.663Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (4858.148 ms) ====== [2026-01-12T09:54:49.143Z] ----------------------------------- [2026-01-12T09:54:49.143Z] renaissance-dec-tree_0_PASSED [2026-01-12T09:54:49.143Z] ----------------------------------- [2026-01-12T09:54:49.143Z] [2026-01-12T09:54:49.143Z] TEST TEARDOWN: [2026-01-12T09:54:49.143Z] Nothing to be done for teardown. [2026-01-12T09:54:49.143Z] renaissance-dec-tree_0 Finish Time: Mon Jan 12 04:54:49 2026 Epoch Time (ms): 1768211689048