[2025-12-03T22:04:44.767Z] Running test renaissance-dec-tree_0 ... [2025-12-03T22:04:44.767Z] =============================================== [2025-12-03T22:04:44.767Z] renaissance-dec-tree_0 Start Time: Wed Dec 3 17:04:44 2025 Epoch Time (ms): 1764799484598 [2025-12-03T22:04:44.767Z] variation: NoOptions [2025-12-03T22:04:44.767Z] JVM_OPTIONS: [2025-12-03T22:04:44.767Z] { \ [2025-12-03T22:04:44.767Z] echo ""; echo "TEST SETUP:"; \ [2025-12-03T22:04:44.767Z] echo "Nothing to be done for setup."; \ [2025-12-03T22:04:44.767Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17647992112327/renaissance-dec-tree_0"; \ [2025-12-03T22:04:44.767Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17647992112327/renaissance-dec-tree_0"; \ [2025-12-03T22:04:44.767Z] echo ""; echo "TESTING:"; \ [2025-12-03T22:04:44.767Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17647992112327/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-12-03T22:04:44.767Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17647992112327/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-03T22:04:44.767Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-03T22:04:44.767Z] echo "Nothing to be done for teardown."; \ [2025-12-03T22:04:44.767Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17647992112327/TestTargetResult"; [2025-12-03T22:04:44.767Z] [2025-12-03T22:04:44.767Z] TEST SETUP: [2025-12-03T22:04:44.767Z] Nothing to be done for setup. [2025-12-03T22:04:44.767Z] [2025-12-03T22:04:44.767Z] TESTING: [2025-12-03T22:04:49.720Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-03T22:04:50.941Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-12-03T22:04:50.941Z] GC before operation: completed in 26.864 ms, heap usage 64.172 MB -> 35.143 MB. [2025-12-03T22:04:57.131Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (5768.080 ms) ====== [2025-12-03T22:04:57.131Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-12-03T22:04:57.131Z] GC before operation: completed in 45.606 ms, heap usage 574.672 MB -> 69.673 MB. [2025-12-03T22:04:57.910Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1328.522 ms) ====== [2025-12-03T22:04:57.910Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-12-03T22:04:58.274Z] GC before operation: completed in 51.097 ms, heap usage 108.849 MB -> 69.463 MB. [2025-12-03T22:04:59.508Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1156.825 ms) ====== [2025-12-03T22:04:59.508Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-12-03T22:04:59.508Z] GC before operation: completed in 51.800 ms, heap usage 349.379 MB -> 97.567 MB. [2025-12-03T22:04:59.508Z] 17:04:59.077 WARN [block-manager-storage-async-thread-pool-78] org.apache.spark.storage.BlockManager - Asked to remove block rdd_141_0, which does not exist [2025-12-03T22:05:00.275Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1122.950 ms) ====== [2025-12-03T22:05:00.275Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-12-03T22:05:00.627Z] GC before operation: completed in 57.659 ms, heap usage 101.268 MB -> 70.190 MB. [2025-12-03T22:05:01.587Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1050.416 ms) ====== [2025-12-03T22:05:01.587Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-12-03T22:05:01.587Z] GC before operation: completed in 44.238 ms, heap usage 109.585 MB -> 70.356 MB. [2025-12-03T22:05:02.850Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1150.375 ms) ====== [2025-12-03T22:05:02.850Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-12-03T22:05:02.850Z] GC before operation: completed in 59.004 ms, heap usage 454.799 MB -> 70.685 MB. [2025-12-03T22:05:04.144Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1144.515 ms) ====== [2025-12-03T22:05:04.144Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-12-03T22:05:04.144Z] GC before operation: completed in 55.921 ms, heap usage 124.280 MB -> 70.368 MB. [2025-12-03T22:05:04.934Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1024.077 ms) ====== [2025-12-03T22:05:04.934Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-12-03T22:05:05.288Z] GC before operation: completed in 105.349 ms, heap usage 339.483 MB -> 70.999 MB. [2025-12-03T22:05:06.086Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (991.705 ms) ====== [2025-12-03T22:05:06.086Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-12-03T22:05:06.086Z] GC before operation: completed in 57.657 ms, heap usage 367.020 MB -> 71.113 MB. [2025-12-03T22:05:07.384Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1082.724 ms) ====== [2025-12-03T22:05:07.384Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-12-03T22:05:07.384Z] GC before operation: completed in 55.649 ms, heap usage 398.379 MB -> 71.279 MB. [2025-12-03T22:05:08.168Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (995.196 ms) ====== [2025-12-03T22:05:08.169Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-12-03T22:05:08.523Z] GC before operation: completed in 84.893 ms, heap usage 407.069 MB -> 71.576 MB. [2025-12-03T22:05:09.304Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (997.456 ms) ====== [2025-12-03T22:05:09.304Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-12-03T22:05:09.304Z] GC before operation: completed in 57.240 ms, heap usage 111.178 MB -> 71.029 MB. [2025-12-03T22:05:10.580Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (927.549 ms) ====== [2025-12-03T22:05:10.580Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-12-03T22:05:10.580Z] GC before operation: completed in 64.648 ms, heap usage 213.238 MB -> 71.830 MB. [2025-12-03T22:05:11.348Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (953.627 ms) ====== [2025-12-03T22:05:11.348Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-12-03T22:05:11.348Z] GC before operation: completed in 74.136 ms, heap usage 392.163 MB -> 82.879 MB. [2025-12-03T22:05:12.606Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (984.219 ms) ====== [2025-12-03T22:05:12.606Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-12-03T22:05:12.606Z] GC before operation: completed in 62.799 ms, heap usage 279.133 MB -> 71.853 MB. [2025-12-03T22:05:13.363Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (896.989 ms) ====== [2025-12-03T22:05:13.363Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-12-03T22:05:13.363Z] GC before operation: completed in 75.572 ms, heap usage 124.172 MB -> 71.531 MB. [2025-12-03T22:05:14.590Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (993.779 ms) ====== [2025-12-03T22:05:14.590Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-12-03T22:05:14.590Z] GC before operation: completed in 71.668 ms, heap usage 218.893 MB -> 72.342 MB. [2025-12-03T22:05:15.347Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (924.435 ms) ====== [2025-12-03T22:05:15.347Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-12-03T22:05:15.701Z] GC before operation: completed in 62.416 ms, heap usage 311.630 MB -> 72.294 MB. [2025-12-03T22:05:16.461Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (995.750 ms) ====== [2025-12-03T22:05:16.461Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-12-03T22:05:16.461Z] GC before operation: completed in 70.294 ms, heap usage 121.654 MB -> 71.935 MB. [2025-12-03T22:05:17.685Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (854.600 ms) ====== [2025-12-03T22:05:17.685Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-12-03T22:05:17.685Z] GC before operation: completed in 88.746 ms, heap usage 238.311 MB -> 94.692 MB. [2025-12-03T22:05:18.441Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (942.666 ms) ====== [2025-12-03T22:05:18.441Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-12-03T22:05:18.441Z] GC before operation: completed in 66.446 ms, heap usage 345.861 MB -> 83.646 MB. [2025-12-03T22:05:19.661Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (895.840 ms) ====== [2025-12-03T22:05:19.661Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-12-03T22:05:19.661Z] GC before operation: completed in 83.819 ms, heap usage 446.405 MB -> 89.257 MB. [2025-12-03T22:05:20.418Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (780.181 ms) ====== [2025-12-03T22:05:20.418Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-12-03T22:05:20.418Z] GC before operation: completed in 65.871 ms, heap usage 194.878 MB -> 72.698 MB. [2025-12-03T22:05:21.178Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (902.036 ms) ====== [2025-12-03T22:05:21.178Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-12-03T22:05:21.531Z] GC before operation: completed in 78.169 ms, heap usage 332.838 MB -> 78.500 MB. [2025-12-03T22:05:22.283Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (891.140 ms) ====== [2025-12-03T22:05:22.283Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-12-03T22:05:22.283Z] GC before operation: completed in 67.295 ms, heap usage 368.300 MB -> 78.699 MB. [2025-12-03T22:05:23.522Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (922.040 ms) ====== [2025-12-03T22:05:23.522Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-12-03T22:05:23.522Z] GC before operation: completed in 70.045 ms, heap usage 350.679 MB -> 84.044 MB. [2025-12-03T22:05:24.296Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (930.169 ms) ====== [2025-12-03T22:05:24.296Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-12-03T22:05:24.296Z] GC before operation: completed in 83.669 ms, heap usage 282.666 MB -> 84.267 MB. [2025-12-03T22:05:25.525Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1001.777 ms) ====== [2025-12-03T22:05:25.525Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-12-03T22:05:25.525Z] GC before operation: completed in 74.485 ms, heap usage 289.028 MB -> 84.516 MB. [2025-12-03T22:05:26.285Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (947.065 ms) ====== [2025-12-03T22:05:26.285Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-12-03T22:05:26.285Z] GC before operation: completed in 71.963 ms, heap usage 264.828 MB -> 84.434 MB. [2025-12-03T22:05:27.504Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (846.476 ms) ====== [2025-12-03T22:05:27.504Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-12-03T22:05:27.504Z] GC before operation: completed in 77.854 ms, heap usage 276.036 MB -> 73.729 MB. [2025-12-03T22:05:28.270Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (853.726 ms) ====== [2025-12-03T22:05:28.270Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-12-03T22:05:28.270Z] GC before operation: completed in 68.096 ms, heap usage 402.003 MB -> 79.491 MB. [2025-12-03T22:05:29.031Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (883.221 ms) ====== [2025-12-03T22:05:29.031Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-12-03T22:05:29.390Z] GC before operation: completed in 73.584 ms, heap usage 331.909 MB -> 73.944 MB. [2025-12-03T22:05:30.163Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (877.654 ms) ====== [2025-12-03T22:05:30.163Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-12-03T22:05:30.163Z] GC before operation: completed in 78.338 ms, heap usage 406.913 MB -> 79.482 MB. [2025-12-03T22:05:30.924Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (895.875 ms) ====== [2025-12-03T22:05:30.924Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-12-03T22:05:31.301Z] GC before operation: completed in 72.853 ms, heap usage 344.123 MB -> 79.458 MB. [2025-12-03T22:05:32.073Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (911.838 ms) ====== [2025-12-03T22:05:32.073Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-12-03T22:05:32.073Z] GC before operation: completed in 74.956 ms, heap usage 338.888 MB -> 85.067 MB. [2025-12-03T22:05:32.933Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (829.867 ms) ====== [2025-12-03T22:05:32.933Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-12-03T22:05:33.302Z] GC before operation: completed in 81.322 ms, heap usage 435.807 MB -> 85.351 MB. [2025-12-03T22:05:34.056Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (890.485 ms) ====== [2025-12-03T22:05:34.056Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-12-03T22:05:34.056Z] GC before operation: completed in 85.743 ms, heap usage 413.404 MB -> 85.422 MB. [2025-12-03T22:05:34.833Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (797.932 ms) ====== [2025-12-03T22:05:34.833Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-12-03T22:05:34.833Z] GC before operation: completed in 69.759 ms, heap usage 258.384 MB -> 74.464 MB. [2025-12-03T22:05:35.596Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (860.311 ms) ====== [2025-12-03T22:05:35.596Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-12-03T22:05:35.968Z] GC before operation: completed in 79.544 ms, heap usage 389.013 MB -> 85.841 MB. [2025-12-03T22:05:36.720Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (904.071 ms) ====== [2025-12-03T22:05:37.071Z] ----------------------------------- [2025-12-03T22:05:37.071Z] renaissance-dec-tree_0_PASSED [2025-12-03T22:05:37.071Z] ----------------------------------- [2025-12-03T22:05:37.071Z] [2025-12-03T22:05:37.071Z] TEST TEARDOWN: [2025-12-03T22:05:37.071Z] Nothing to be done for teardown. [2025-12-03T22:05:37.071Z] renaissance-dec-tree_0 Finish Time: Wed Dec 3 17:05:36 2025 Epoch Time (ms): 1764799536785