[2025-06-18T19:58:41.609Z] Running test renaissance-dec-tree_0 ... [2025-06-18T19:58:41.609Z] =============================================== [2025-06-18T19:58:41.609Z] renaissance-dec-tree_0 Start Time: Wed Jun 18 15:58:41 2025 Epoch Time (ms): 1750276721409 [2025-06-18T19:58:41.609Z] variation: NoOptions [2025-06-18T19:58:41.609Z] JVM_OPTIONS: [2025-06-18T19:58:41.609Z] { \ [2025-06-18T19:58:41.609Z] echo ""; echo "TEST SETUP:"; \ [2025-06-18T19:58:41.609Z] echo "Nothing to be done for setup."; \ [2025-06-18T19:58:41.609Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17502765649868/renaissance-dec-tree_0"; \ [2025-06-18T19:58:41.609Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17502765649868/renaissance-dec-tree_0"; \ [2025-06-18T19:58:41.609Z] echo ""; echo "TESTING:"; \ [2025-06-18T19:58:41.609Z] "/Users/admin/workspace/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17502765649868/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-06-18T19:58:41.609Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17502765649868/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-18T19:58:41.609Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-18T19:58:41.609Z] echo "Nothing to be done for teardown."; \ [2025-06-18T19:58:41.609Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17502765649868/TestTargetResult"; [2025-06-18T19:58:41.609Z] [2025-06-18T19:58:41.609Z] TEST SETUP: [2025-06-18T19:58:41.609Z] Nothing to be done for setup. [2025-06-18T19:58:41.609Z] [2025-06-18T19:58:41.609Z] TESTING: [2025-06-18T19:58:44.769Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-06-18T19:58:45.549Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-06-18T19:58:45.549Z] GC before operation: completed in 27.470 ms, heap usage 66.958 MB -> 35.162 MB. [2025-06-18T19:58:51.784Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (5270.664 ms) ====== [2025-06-18T19:58:51.784Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-06-18T19:58:51.784Z] GC before operation: completed in 67.081 ms, heap usage 181.162 MB -> 69.042 MB. [2025-06-18T19:58:52.148Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1254.658 ms) ====== [2025-06-18T19:58:52.148Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-06-18T19:58:52.531Z] GC before operation: completed in 68.657 ms, heap usage 348.473 MB -> 69.546 MB. [2025-06-18T19:58:53.333Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1022.374 ms) ====== [2025-06-18T19:58:53.333Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-06-18T19:58:53.333Z] GC before operation: completed in 53.555 ms, heap usage 349.353 MB -> 97.437 MB. [2025-06-18T19:58:54.605Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (964.474 ms) ====== [2025-06-18T19:58:54.605Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-06-18T19:58:54.605Z] GC before operation: completed in 52.814 ms, heap usage 227.776 MB -> 70.149 MB. [2025-06-18T19:58:55.389Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (888.028 ms) ====== [2025-06-18T19:58:55.389Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-06-18T19:58:55.389Z] GC before operation: completed in 53.212 ms, heap usage 278.082 MB -> 70.228 MB. [2025-06-18T19:58:56.652Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (935.334 ms) ====== [2025-06-18T19:58:56.652Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-06-18T19:58:56.652Z] GC before operation: completed in 61.925 ms, heap usage 333.385 MB -> 70.437 MB. [2025-06-18T19:58:57.423Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (897.084 ms) ====== [2025-06-18T19:58:57.423Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-06-18T19:58:57.423Z] GC before operation: completed in 96.607 ms, heap usage 110.269 MB -> 70.046 MB. [2025-06-18T19:58:58.246Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (807.232 ms) ====== [2025-06-18T19:58:58.246Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-06-18T19:58:58.246Z] GC before operation: completed in 54.027 ms, heap usage 107.915 MB -> 70.529 MB. [2025-06-18T19:58:59.030Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (843.801 ms) ====== [2025-06-18T19:58:59.030Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-06-18T19:58:59.030Z] GC before operation: completed in 81.042 ms, heap usage 457.105 MB -> 71.127 MB. [2025-06-18T19:59:00.313Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (907.805 ms) ====== [2025-06-18T19:59:00.314Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-06-18T19:59:00.314Z] GC before operation: completed in 66.914 ms, heap usage 327.654 MB -> 73.110 MB. [2025-06-18T19:59:01.102Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (902.190 ms) ====== [2025-06-18T19:59:01.102Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-06-18T19:59:01.102Z] GC before operation: completed in 59.674 ms, heap usage 300.797 MB -> 71.239 MB. [2025-06-18T19:59:01.887Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (824.051 ms) ====== [2025-06-18T19:59:01.887Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-06-18T19:59:01.887Z] GC before operation: completed in 60.180 ms, heap usage 171.838 MB -> 71.123 MB. [2025-06-18T19:59:02.669Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (763.069 ms) ====== [2025-06-18T19:59:02.669Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-06-18T19:59:02.669Z] GC before operation: completed in 47.860 ms, heap usage 297.577 MB -> 71.531 MB. [2025-06-18T19:59:03.961Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (808.284 ms) ====== [2025-06-18T19:59:03.961Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-06-18T19:59:03.961Z] GC before operation: completed in 74.586 ms, heap usage 335.713 MB -> 71.846 MB. [2025-06-18T19:59:04.332Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (752.682 ms) ====== [2025-06-18T19:59:04.332Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-06-18T19:59:04.702Z] GC before operation: completed in 67.289 ms, heap usage 284.977 MB -> 86.641 MB. [2025-06-18T19:59:05.465Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (758.613 ms) ====== [2025-06-18T19:59:05.465Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-06-18T19:59:05.465Z] GC before operation: completed in 73.180 ms, heap usage 387.644 MB -> 85.008 MB. [2025-06-18T19:59:06.235Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (770.800 ms) ====== [2025-06-18T19:59:06.235Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-06-18T19:59:06.235Z] GC before operation: completed in 71.999 ms, heap usage 408.310 MB -> 72.008 MB. [2025-06-18T19:59:07.043Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (827.464 ms) ====== [2025-06-18T19:59:07.043Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-06-18T19:59:07.043Z] GC before operation: completed in 60.265 ms, heap usage 340.833 MB -> 72.308 MB. [2025-06-18T19:59:07.828Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (853.660 ms) ====== [2025-06-18T19:59:07.828Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-06-18T19:59:08.206Z] GC before operation: completed in 71.725 ms, heap usage 175.319 MB -> 71.968 MB. [2025-06-18T19:59:08.976Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (788.005 ms) ====== [2025-06-18T19:59:08.976Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-06-18T19:59:08.976Z] GC before operation: completed in 65.662 ms, heap usage 365.074 MB -> 72.395 MB. [2025-06-18T19:59:09.745Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (765.627 ms) ====== [2025-06-18T19:59:09.745Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-06-18T19:59:09.745Z] GC before operation: completed in 62.978 ms, heap usage 290.527 MB -> 72.471 MB. [2025-06-18T19:59:10.535Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (700.048 ms) ====== [2025-06-18T19:59:10.535Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-06-18T19:59:10.535Z] GC before operation: completed in 73.245 ms, heap usage 300.278 MB -> 72.663 MB. [2025-06-18T19:59:11.328Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (750.451 ms) ====== [2025-06-18T19:59:11.328Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-06-18T19:59:11.328Z] GC before operation: completed in 71.943 ms, heap usage 299.759 MB -> 87.550 MB. [2025-06-18T19:59:12.175Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (753.481 ms) ====== [2025-06-18T19:59:12.175Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-06-18T19:59:12.175Z] GC before operation: completed in 76.702 ms, heap usage 374.144 MB -> 87.497 MB. [2025-06-18T19:59:12.988Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (763.030 ms) ====== [2025-06-18T19:59:12.988Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-06-18T19:59:12.989Z] GC before operation: completed in 60.288 ms, heap usage 128.557 MB -> 87.517 MB. [2025-06-18T19:59:13.794Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (783.050 ms) ====== [2025-06-18T19:59:13.794Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-06-18T19:59:13.794Z] GC before operation: completed in 73.504 ms, heap usage 122.163 MB -> 72.912 MB. [2025-06-18T19:59:14.562Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (751.324 ms) ====== [2025-06-18T19:59:14.562Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-06-18T19:59:14.562Z] GC before operation: completed in 63.058 ms, heap usage 492.012 MB -> 73.165 MB. [2025-06-18T19:59:15.342Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (742.009 ms) ====== [2025-06-18T19:59:15.342Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-06-18T19:59:15.342Z] GC before operation: completed in 70.240 ms, heap usage 352.271 MB -> 100.854 MB. [2025-06-18T19:59:16.110Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (725.139 ms) ====== [2025-06-18T19:59:16.110Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-06-18T19:59:16.110Z] GC before operation: completed in 66.473 ms, heap usage 341.368 MB -> 73.369 MB. [2025-06-18T19:59:16.883Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (711.453 ms) ====== [2025-06-18T19:59:16.883Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-06-18T19:59:16.883Z] GC before operation: completed in 65.354 ms, heap usage 357.320 MB -> 73.446 MB. [2025-06-18T19:59:17.646Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (705.319 ms) ====== [2025-06-18T19:59:17.646Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-06-18T19:59:17.646Z] GC before operation: completed in 59.514 ms, heap usage 291.446 MB -> 73.572 MB. [2025-06-18T19:59:18.422Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (743.931 ms) ====== [2025-06-18T19:59:18.422Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-06-18T19:59:18.422Z] GC before operation: completed in 64.214 ms, heap usage 287.591 MB -> 73.715 MB. [2025-06-18T19:59:19.259Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (735.275 ms) ====== [2025-06-18T19:59:19.259Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-06-18T19:59:19.259Z] GC before operation: completed in 68.466 ms, heap usage 162.855 MB -> 73.512 MB. [2025-06-18T19:59:20.051Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (747.321 ms) ====== [2025-06-18T19:59:20.051Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-06-18T19:59:20.051Z] GC before operation: completed in 72.031 ms, heap usage 337.116 MB -> 101.507 MB. [2025-06-18T19:59:20.825Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (737.955 ms) ====== [2025-06-18T19:59:20.825Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-06-18T19:59:21.183Z] GC before operation: completed in 56.644 ms, heap usage 343.669 MB -> 74.154 MB. [2025-06-18T19:59:21.969Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (766.956 ms) ====== [2025-06-18T19:59:21.970Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-06-18T19:59:21.970Z] GC before operation: completed in 68.950 ms, heap usage 234.895 MB -> 74.151 MB. [2025-06-18T19:59:22.770Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (759.316 ms) ====== [2025-06-18T19:59:22.770Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-06-18T19:59:22.770Z] GC before operation: completed in 76.419 ms, heap usage 389.540 MB -> 101.770 MB. [2025-06-18T19:59:25.486Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (705.707 ms) ====== [2025-06-18T19:59:25.486Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-06-18T19:59:25.486Z] GC before operation: completed in 67.338 ms, heap usage 333.257 MB -> 74.289 MB. [2025-06-18T19:59:25.486Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (750.570 ms) ====== [2025-06-18T19:59:25.486Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-06-18T19:59:25.486Z] GC before operation: completed in 72.073 ms, heap usage 211.410 MB -> 74.435 MB. [2025-06-18T19:59:25.486Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (718.258 ms) ====== [2025-06-18T19:59:25.486Z] ----------------------------------- [2025-06-18T19:59:25.486Z] renaissance-dec-tree_0_PASSED [2025-06-18T19:59:25.486Z] ----------------------------------- [2025-06-18T19:59:25.486Z] [2025-06-18T19:59:25.486Z] TEST TEARDOWN: [2025-06-18T19:59:25.486Z] Nothing to be done for teardown. [2025-06-18T19:59:25.486Z] renaissance-dec-tree_0 Finish Time: Wed Jun 18 15:59:24 2025 Epoch Time (ms): 1750276764992