[2025-07-01T06:37:18.219Z] Running test renaissance-dec-tree_0 ... [2025-07-01T06:37:18.219Z] =============================================== [2025-07-01T06:37:18.219Z] renaissance-dec-tree_0 Start Time: Mon Jun 30 23:37:15 2025 Epoch Time (ms): 1751351835258 [2025-07-01T06:37:18.219Z] variation: NoOptions [2025-07-01T06:37:18.219Z] JVM_OPTIONS: [2025-07-01T06:37:18.219Z] { \ [2025-07-01T06:37:18.219Z] echo ""; echo "TEST SETUP:"; \ [2025-07-01T06:37:18.219Z] echo "Nothing to be done for setup."; \ [2025-07-01T06:37:18.219Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1751349785180/renaissance-dec-tree_0"; \ [2025-07-01T06:37:18.219Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1751349785180/renaissance-dec-tree_0"; \ [2025-07-01T06:37:18.219Z] echo ""; echo "TESTING:"; \ [2025-07-01T06:37:18.219Z] "/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_1751349785180/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-07-01T06:37:18.219Z] 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_1751349785180/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-07-01T06:37:18.219Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-07-01T06:37:18.219Z] echo "Nothing to be done for teardown."; \ [2025-07-01T06:37:18.219Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1751349785180/TestTargetResult"; [2025-07-01T06:37:18.219Z] [2025-07-01T06:37:18.219Z] TEST SETUP: [2025-07-01T06:37:18.219Z] Nothing to be done for setup. [2025-07-01T06:37:18.219Z] [2025-07-01T06:37:18.219Z] TESTING: [2025-07-01T06:37:36.777Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-07-01T06:37:44.061Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-07-01T06:37:44.061Z] GC before operation: completed in 105.512 ms, heap usage 105.934 MB -> 35.114 MB. [2025-07-01T06:38:20.940Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (35847.740 ms) ====== [2025-07-01T06:38:20.940Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-07-01T06:38:20.940Z] GC before operation: completed in 298.998 ms, heap usage 155.666 MB -> 96.474 MB. [2025-07-01T06:38:34.230Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (12604.201 ms) ====== [2025-07-01T06:38:34.231Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-07-01T06:38:34.231Z] GC before operation: completed in 246.954 ms, heap usage 158.728 MB -> 68.868 MB. [2025-07-01T06:38:41.597Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (8141.052 ms) ====== [2025-07-01T06:38:41.597Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-07-01T06:38:41.597Z] GC before operation: completed in 276.094 ms, heap usage 337.120 MB -> 69.730 MB. [2025-07-01T06:38:48.990Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (7018.103 ms) ====== [2025-07-01T06:38:48.990Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-07-01T06:38:48.990Z] GC before operation: completed in 772.233 ms, heap usage 149.541 MB -> 69.621 MB. [2025-07-01T06:38:55.140Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (6564.337 ms) ====== [2025-07-01T06:38:55.140Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-07-01T06:38:55.578Z] GC before operation: completed in 177.917 ms, heap usage 216.196 MB -> 70.284 MB. [2025-07-01T06:39:03.010Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (6978.637 ms) ====== [2025-07-01T06:39:03.010Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-07-01T06:39:03.010Z] GC before operation: completed in 219.451 ms, heap usage 266.475 MB -> 97.992 MB. [2025-07-01T06:39:09.639Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6340.759 ms) ====== [2025-07-01T06:39:09.639Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-07-01T06:39:09.639Z] GC before operation: completed in 331.166 ms, heap usage 179.534 MB -> 70.413 MB. [2025-07-01T06:39:15.743Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (6190.463 ms) ====== [2025-07-01T06:39:15.743Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-07-01T06:39:15.743Z] GC before operation: completed in 203.906 ms, heap usage 361.481 MB -> 70.731 MB. [2025-07-01T06:39:20.975Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (5479.254 ms) ====== [2025-07-01T06:39:20.975Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-07-01T06:39:21.445Z] GC before operation: completed in 196.279 ms, heap usage 286.421 MB -> 98.585 MB. [2025-07-01T06:39:27.918Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6274.576 ms) ====== [2025-07-01T06:39:27.918Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-07-01T06:39:27.918Z] GC before operation: completed in 273.383 ms, heap usage 456.617 MB -> 71.325 MB. [2025-07-01T06:39:33.787Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (5438.458 ms) ====== [2025-07-01T06:39:33.787Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-07-01T06:39:33.787Z] GC before operation: completed in 255.368 ms, heap usage 243.539 MB -> 71.470 MB. [2025-07-01T06:39:39.915Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (5773.837 ms) ====== [2025-07-01T06:39:39.915Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-07-01T06:39:39.915Z] GC before operation: completed in 207.481 ms, heap usage 270.539 MB -> 71.357 MB. [2025-07-01T06:39:44.611Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4856.925 ms) ====== [2025-07-01T06:39:44.612Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-07-01T06:39:45.833Z] GC before operation: completed in 1169.203 ms, heap usage 373.005 MB -> 71.738 MB. [2025-07-01T06:39:50.663Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (4754.830 ms) ====== [2025-07-01T06:39:50.663Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-07-01T06:39:50.663Z] GC before operation: completed in 202.073 ms, heap usage 149.249 MB -> 98.924 MB. [2025-07-01T06:39:56.970Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5633.634 ms) ====== [2025-07-01T06:39:56.970Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-07-01T06:39:56.970Z] GC before operation: completed in 216.472 ms, heap usage 336.939 MB -> 71.750 MB. [2025-07-01T06:40:01.976Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (4820.137 ms) ====== [2025-07-01T06:40:01.976Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-07-01T06:40:01.976Z] GC before operation: completed in 306.791 ms, heap usage 272.332 MB -> 99.128 MB. [2025-07-01T06:40:06.818Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (5187.252 ms) ====== [2025-07-01T06:40:06.818Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-07-01T06:40:07.543Z] GC before operation: completed in 524.265 ms, heap usage 511.639 MB -> 71.930 MB. [2025-07-01T06:40:13.492Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (5372.697 ms) ====== [2025-07-01T06:40:13.492Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-07-01T06:40:13.492Z] GC before operation: completed in 229.191 ms, heap usage 187.482 MB -> 71.668 MB. [2025-07-01T06:40:19.505Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5909.975 ms) ====== [2025-07-01T06:40:19.505Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-07-01T06:40:19.505Z] GC before operation: completed in 182.540 ms, heap usage 361.075 MB -> 72.110 MB. [2025-07-01T06:40:25.637Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (6117.261 ms) ====== [2025-07-01T06:40:25.637Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-07-01T06:40:26.306Z] GC before operation: completed in 808.195 ms, heap usage 336.317 MB -> 72.249 MB. [2025-07-01T06:40:31.237Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (4970.433 ms) ====== [2025-07-01T06:40:31.237Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-07-01T06:40:32.479Z] GC before operation: completed in 1383.273 ms, heap usage 233.325 MB -> 72.403 MB. [2025-07-01T06:40:38.782Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (5675.488 ms) ====== [2025-07-01T06:40:38.782Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-07-01T06:40:38.782Z] GC before operation: completed in 509.508 ms, heap usage 234.989 MB -> 72.541 MB. [2025-07-01T06:40:43.981Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (5028.021 ms) ====== [2025-07-01T06:40:43.981Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-07-01T06:40:43.981Z] GC before operation: completed in 249.780 ms, heap usage 425.992 MB -> 72.698 MB. [2025-07-01T06:40:47.881Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (4253.655 ms) ====== [2025-07-01T06:40:47.881Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-07-01T06:40:48.407Z] GC before operation: completed in 381.452 ms, heap usage 326.327 MB -> 72.697 MB. [2025-07-01T06:40:54.781Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (5342.812 ms) ====== [2025-07-01T06:40:54.781Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-07-01T06:40:54.781Z] GC before operation: completed in 936.141 ms, heap usage 414.238 MB -> 72.828 MB. [2025-07-01T06:41:00.745Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (5211.629 ms) ====== [2025-07-01T06:41:00.745Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-07-01T06:41:00.745Z] GC before operation: completed in 252.450 ms, heap usage 366.686 MB -> 73.075 MB. [2025-07-01T06:41:05.929Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (5375.828 ms) ====== [2025-07-01T06:41:05.929Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-07-01T06:41:05.929Z] GC before operation: completed in 273.948 ms, heap usage 394.141 MB -> 73.224 MB. [2025-07-01T06:41:11.066Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (5401.321 ms) ====== [2025-07-01T06:41:11.066Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-07-01T06:41:12.209Z] GC before operation: completed in 673.673 ms, heap usage 237.293 MB -> 73.100 MB. [2025-07-01T06:41:23.278Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (11312.022 ms) ====== [2025-07-01T06:41:23.278Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-07-01T06:41:23.278Z] GC before operation: completed in 277.827 ms, heap usage 375.676 MB -> 73.354 MB. [2025-07-01T06:41:26.838Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3385.689 ms) ====== [2025-07-01T06:41:26.838Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-07-01T06:41:26.838Z] GC before operation: completed in 159.402 ms, heap usage 305.645 MB -> 73.339 MB. [2025-07-01T06:41:31.579Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4570.532 ms) ====== [2025-07-01T06:41:31.579Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-07-01T06:41:32.163Z] GC before operation: completed in 658.762 ms, heap usage 354.481 MB -> 73.662 MB. [2025-07-01T06:41:37.132Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (4661.303 ms) ====== [2025-07-01T06:41:37.132Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-07-01T06:41:37.132Z] GC before operation: completed in 267.892 ms, heap usage 451.449 MB -> 73.589 MB. [2025-07-01T06:41:43.274Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (5691.051 ms) ====== [2025-07-01T06:41:43.274Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-07-01T06:41:43.274Z] GC before operation: completed in 293.146 ms, heap usage 111.757 MB -> 73.075 MB. [2025-07-01T06:41:49.088Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (5342.057 ms) ====== [2025-07-01T06:41:49.088Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-07-01T06:41:49.088Z] GC before operation: completed in 322.475 ms, heap usage 410.643 MB -> 101.400 MB. [2025-07-01T06:41:55.079Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (5728.424 ms) ====== [2025-07-01T06:41:55.079Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-07-01T06:41:55.079Z] GC before operation: completed in 309.723 ms, heap usage 492.334 MB -> 73.940 MB. [2025-07-01T06:42:00.037Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4491.680 ms) ====== [2025-07-01T06:42:00.037Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-07-01T06:42:00.037Z] GC before operation: completed in 252.282 ms, heap usage 283.454 MB -> 73.946 MB. [2025-07-01T06:42:04.052Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4398.359 ms) ====== [2025-07-01T06:42:04.052Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-07-01T06:42:04.972Z] GC before operation: completed in 579.108 ms, heap usage 470.276 MB -> 74.060 MB. [2025-07-01T06:42:11.370Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (6084.626 ms) ====== [2025-07-01T06:42:11.371Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-07-01T06:42:11.371Z] GC before operation: completed in 726.696 ms, heap usage 240.228 MB -> 74.164 MB. [2025-07-01T06:42:16.356Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4414.688 ms) ====== [2025-07-01T06:42:16.356Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-07-01T06:42:16.356Z] GC before operation: completed in 226.632 ms, heap usage 284.112 MB -> 101.950 MB. [2025-07-01T06:42:21.481Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5445.445 ms) ====== [2025-07-01T06:42:23.829Z] ----------------------------------- [2025-07-01T06:42:23.829Z] renaissance-dec-tree_0_PASSED [2025-07-01T06:42:23.829Z] ----------------------------------- [2025-07-01T06:42:23.829Z] [2025-07-01T06:42:23.829Z] TEST TEARDOWN: [2025-07-01T06:42:23.829Z] Nothing to be done for teardown. [2025-07-01T06:42:23.830Z] renaissance-dec-tree_0 Finish Time: Mon Jun 30 23:42:23 2025 Epoch Time (ms): 1751352143355