[2026-03-04T23:05:27.309Z] Running test renaissance-dec-tree_0 ... [2026-03-04T23:05:27.309Z] =============================================== [2026-03-04T23:05:27.739Z] renaissance-dec-tree_0 Start Time: Wed Mar 4 18:05:26 2026 Epoch Time (ms): 1772665526873 [2026-03-04T23:05:27.739Z] variation: NoOptions [2026-03-04T23:05:27.739Z] JVM_OPTIONS: [2026-03-04T23:05:27.739Z] { \ [2026-03-04T23:05:27.739Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T23:05:27.740Z] echo "Nothing to be done for setup."; \ [2026-03-04T23:05:27.740Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17726633381618/renaissance-dec-tree_0"; \ [2026-03-04T23:05:27.740Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17726633381618/renaissance-dec-tree_0"; \ [2026-03-04T23:05:27.740Z] echo ""; echo "TESTING:"; \ [2026-03-04T23:05:27.740Z] "/Users/admin/workspace/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17726633381618/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-03-04T23:05:27.740Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17726633381618/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T23:05:27.740Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T23:05:27.740Z] echo "Nothing to be done for teardown."; \ [2026-03-04T23:05:27.740Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17726633381618/TestTargetResult"; [2026-03-04T23:05:27.740Z] [2026-03-04T23:05:27.740Z] TEST SETUP: [2026-03-04T23:05:27.740Z] Nothing to be done for setup. [2026-03-04T23:05:27.740Z] [2026-03-04T23:05:27.740Z] TESTING: [2026-03-04T23:05:58.905Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-03-04T23:06:08.578Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-03-04T23:06:08.578Z] GC before operation: completed in 150.131 ms, heap usage 38.070 MB -> 34.174 MB. [2026-03-04T23:06:53.567Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (40068.078 ms) ====== [2026-03-04T23:06:53.567Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-03-04T23:06:53.567Z] GC before operation: completed in 263.546 ms, heap usage 303.387 MB -> 70.091 MB. [2026-03-04T23:06:58.970Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (10037.331 ms) ====== [2026-03-04T23:06:58.970Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-03-04T23:06:58.970Z] GC before operation: completed in 167.233 ms, heap usage 210.720 MB -> 70.611 MB. [2026-03-04T23:07:10.399Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (11060.740 ms) ====== [2026-03-04T23:07:10.399Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-03-04T23:07:10.999Z] GC before operation: completed in 907.059 ms, heap usage 404.380 MB -> 98.162 MB. [2026-03-04T23:07:20.614Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9290.805 ms) ====== [2026-03-04T23:07:20.614Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-03-04T23:07:20.614Z] GC before operation: completed in 207.934 ms, heap usage 136.689 MB -> 71.106 MB. [2026-03-04T23:07:30.089Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8731.850 ms) ====== [2026-03-04T23:07:30.089Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-03-04T23:07:30.089Z] GC before operation: completed in 285.171 ms, heap usage 128.693 MB -> 71.031 MB. [2026-03-04T23:07:39.067Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (8664.823 ms) ====== [2026-03-04T23:07:39.067Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-03-04T23:07:39.067Z] GC before operation: completed in 345.089 ms, heap usage 207.641 MB -> 71.521 MB. [2026-03-04T23:07:46.859Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (7854.068 ms) ====== [2026-03-04T23:07:46.859Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-03-04T23:07:46.859Z] GC before operation: completed in 389.339 ms, heap usage 238.564 MB -> 71.753 MB. [2026-03-04T23:07:53.448Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (6362.754 ms) ====== [2026-03-04T23:07:53.448Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-03-04T23:07:53.448Z] GC before operation: completed in 520.861 ms, heap usage 217.627 MB -> 71.908 MB. [2026-03-04T23:08:02.822Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (8222.229 ms) ====== [2026-03-04T23:08:02.822Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-03-04T23:08:02.822Z] GC before operation: completed in 342.893 ms, heap usage 281.375 MB -> 99.528 MB. [2026-03-04T23:08:08.351Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6011.604 ms) ====== [2026-03-04T23:08:08.351Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-03-04T23:08:08.351Z] GC before operation: completed in 291.347 ms, heap usage 513.580 MB -> 72.093 MB. [2026-03-04T23:08:17.577Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (9131.717 ms) ====== [2026-03-04T23:08:17.577Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-03-04T23:08:18.148Z] GC before operation: completed in 349.737 ms, heap usage 154.853 MB -> 72.026 MB. [2026-03-04T23:08:27.707Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (8617.097 ms) ====== [2026-03-04T23:08:27.707Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-03-04T23:08:27.707Z] GC before operation: completed in 306.355 ms, heap usage 165.985 MB -> 72.039 MB. [2026-03-04T23:08:35.434Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (8036.142 ms) ====== [2026-03-04T23:08:35.434Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-03-04T23:08:35.434Z] GC before operation: completed in 289.398 ms, heap usage 442.532 MB -> 72.724 MB. [2026-03-04T23:08:41.648Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (6280.263 ms) ====== [2026-03-04T23:08:41.648Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-03-04T23:08:42.209Z] GC before operation: completed in 763.456 ms, heap usage 276.908 MB -> 72.924 MB. [2026-03-04T23:08:50.231Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (7529.543 ms) ====== [2026-03-04T23:08:50.231Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-03-04T23:08:50.231Z] GC before operation: completed in 193.395 ms, heap usage 275.981 MB -> 72.811 MB. [2026-03-04T23:08:58.034Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (6981.797 ms) ====== [2026-03-04T23:08:58.034Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-03-04T23:08:58.034Z] GC before operation: completed in 255.815 ms, heap usage 122.987 MB -> 73.139 MB. [2026-03-04T23:09:04.089Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (6476.473 ms) ====== [2026-03-04T23:09:04.089Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-03-04T23:09:04.089Z] GC before operation: completed in 350.194 ms, heap usage 326.878 MB -> 72.880 MB. [2026-03-04T23:09:09.270Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4958.562 ms) ====== [2026-03-04T23:09:09.270Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-03-04T23:09:09.270Z] GC before operation: completed in 306.972 ms, heap usage 299.611 MB -> 73.208 MB. [2026-03-04T23:09:15.572Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (6306.563 ms) ====== [2026-03-04T23:09:15.572Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-03-04T23:09:15.572Z] GC before operation: completed in 266.092 ms, heap usage 76.522 MB -> 73.579 MB. [2026-03-04T23:09:23.606Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (7985.702 ms) ====== [2026-03-04T23:09:23.606Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-03-04T23:09:24.036Z] GC before operation: completed in 283.735 ms, heap usage 296.974 MB -> 73.732 MB. [2026-03-04T23:09:31.427Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (6336.894 ms) ====== [2026-03-04T23:09:31.427Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-03-04T23:09:31.427Z] GC before operation: completed in 236.730 ms, heap usage 220.659 MB -> 73.674 MB. [2026-03-04T23:09:37.885Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (6526.531 ms) ====== [2026-03-04T23:09:37.885Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-03-04T23:09:38.368Z] GC before operation: completed in 1234.556 ms, heap usage 188.811 MB -> 73.242 MB. [2026-03-04T23:09:45.662Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (6291.639 ms) ====== [2026-03-04T23:09:45.662Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-03-04T23:09:45.662Z] GC before operation: completed in 233.246 ms, heap usage 588.986 MB -> 74.074 MB. [2026-03-04T23:09:50.952Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (5377.480 ms) ====== [2026-03-04T23:09:50.952Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-03-04T23:09:50.952Z] GC before operation: completed in 224.863 ms, heap usage 330.569 MB -> 73.851 MB. [2026-03-04T23:09:55.810Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (4927.652 ms) ====== [2026-03-04T23:09:55.810Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-03-04T23:09:55.810Z] GC before operation: completed in 216.594 ms, heap usage 128.630 MB -> 73.603 MB. [2026-03-04T23:10:01.979Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (5564.894 ms) ====== [2026-03-04T23:10:01.979Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-03-04T23:10:01.979Z] GC before operation: completed in 295.260 ms, heap usage 243.494 MB -> 101.688 MB. [2026-03-04T23:10:01.979Z] 18:10:00.880 WARN [block-manager-storage-async-thread-pool-145] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_359, which does not exist [2026-03-04T23:10:08.182Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (6509.965 ms) ====== [2026-03-04T23:10:08.182Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-03-04T23:10:08.182Z] GC before operation: completed in 208.198 ms, heap usage 198.958 MB -> 101.782 MB. [2026-03-04T23:10:15.740Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (6573.555 ms) ====== [2026-03-04T23:10:15.740Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-03-04T23:10:15.740Z] GC before operation: completed in 1058.201 ms, heap usage 742.686 MB -> 102.088 MB. [2026-03-04T23:10:20.832Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (4981.488 ms) ====== [2026-03-04T23:10:20.832Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-03-04T23:10:21.833Z] GC before operation: completed in 652.531 ms, heap usage 555.141 MB -> 74.778 MB. [2026-03-04T23:10:27.045Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (4935.335 ms) ====== [2026-03-04T23:10:27.045Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-03-04T23:10:27.045Z] GC before operation: completed in 246.232 ms, heap usage 141.926 MB -> 74.585 MB. [2026-03-04T23:10:33.188Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (6125.060 ms) ====== [2026-03-04T23:10:33.188Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-03-04T23:10:33.188Z] GC before operation: completed in 433.030 ms, heap usage 570.511 MB -> 102.302 MB. [2026-03-04T23:10:39.392Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (6047.447 ms) ====== [2026-03-04T23:10:39.392Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-03-04T23:10:39.392Z] GC before operation: completed in 181.046 ms, heap usage 558.912 MB -> 102.455 MB. [2026-03-04T23:10:39.392Z] 18:10:38.811 WARN [block-manager-storage-async-thread-pool-20] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1533_1, which does not exist [2026-03-04T23:10:44.499Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (5163.438 ms) ====== [2026-03-04T23:10:44.499Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-03-04T23:10:44.905Z] GC before operation: completed in 399.763 ms, heap usage 513.286 MB -> 74.921 MB. [2026-03-04T23:10:51.320Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (5858.042 ms) ====== [2026-03-04T23:10:51.320Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-03-04T23:10:52.023Z] GC before operation: completed in 763.045 ms, heap usage 288.094 MB -> 75.274 MB. [2026-03-04T23:10:59.485Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (7566.211 ms) ====== [2026-03-04T23:10:59.485Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-03-04T23:10:59.485Z] GC before operation: completed in 286.851 ms, heap usage 514.024 MB -> 75.443 MB. [2026-03-04T23:11:05.860Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (6108.408 ms) ====== [2026-03-04T23:11:05.860Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-03-04T23:11:05.860Z] GC before operation: completed in 286.320 ms, heap usage 140.367 MB -> 74.846 MB. [2026-03-04T23:11:12.227Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (5422.091 ms) ====== [2026-03-04T23:11:12.227Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-03-04T23:11:12.227Z] GC before operation: completed in 256.213 ms, heap usage 146.444 MB -> 75.089 MB. [2026-03-04T23:11:19.763Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (7087.814 ms) ====== [2026-03-04T23:11:19.763Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-03-04T23:11:19.763Z] GC before operation: completed in 209.450 ms, heap usage 512.586 MB -> 103.033 MB. [2026-03-04T23:11:26.308Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (6322.517 ms) ====== [2026-03-04T23:11:26.308Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-03-04T23:11:26.308Z] GC before operation: completed in 296.204 ms, heap usage 442.920 MB -> 103.104 MB. [2026-03-04T23:11:31.184Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5480.193 ms) ====== [2026-03-04T23:11:32.060Z] ----------------------------------- [2026-03-04T23:11:32.060Z] renaissance-dec-tree_0_PASSED [2026-03-04T23:11:32.060Z] ----------------------------------- [2026-03-04T23:11:32.060Z] [2026-03-04T23:11:32.060Z] TEST TEARDOWN: [2026-03-04T23:11:32.060Z] Nothing to be done for teardown. [2026-03-04T23:11:32.060Z] renaissance-dec-tree_0 Finish Time: Wed Mar 4 18:11:31 2026 Epoch Time (ms): 1772665891459