[2025-06-18T21:09:20.515Z] Running test renaissance-dec-tree_0 ... [2025-06-18T21:09:20.515Z] =============================================== [2025-06-18T21:09:20.515Z] renaissance-dec-tree_0 Start Time: Wed Jun 18 14:09:19 2025 Epoch Time (ms): 1750280959863 [2025-06-18T21:09:20.515Z] variation: NoOptions [2025-06-18T21:09:21.027Z] JVM_OPTIONS: [2025-06-18T21:09:21.027Z] { \ [2025-06-18T21:09:21.027Z] echo ""; echo "TEST SETUP:"; \ [2025-06-18T21:09:21.027Z] echo "Nothing to be done for setup."; \ [2025-06-18T21:09:21.027Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17502793121144/renaissance-dec-tree_0"; \ [2025-06-18T21:09:21.028Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17502793121144/renaissance-dec-tree_0"; \ [2025-06-18T21:09:21.028Z] echo ""; echo "TESTING:"; \ [2025-06-18T21:09:21.028Z] "/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_17502793121144/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-06-18T21:09:21.028Z] 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_17502793121144/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-18T21:09:21.028Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-18T21:09:21.028Z] echo "Nothing to be done for teardown."; \ [2025-06-18T21:09:21.028Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17502793121144/TestTargetResult"; [2025-06-18T21:09:21.028Z] [2025-06-18T21:09:21.028Z] TEST SETUP: [2025-06-18T21:09:21.028Z] Nothing to be done for setup. [2025-06-18T21:09:21.028Z] [2025-06-18T21:09:21.028Z] TESTING: [2025-06-18T21:09:46.666Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-06-18T21:09:53.015Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-06-18T21:09:53.015Z] GC before operation: completed in 61.796 ms, heap usage 47.697 MB -> 34.833 MB. [2025-06-18T21:10:37.367Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (39461.842 ms) ====== [2025-06-18T21:10:37.367Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-06-18T21:10:37.367Z] GC before operation: completed in 181.944 ms, heap usage 405.360 MB -> 69.142 MB. [2025-06-18T21:10:44.413Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (12155.941 ms) ====== [2025-06-18T21:10:44.413Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-06-18T21:10:45.004Z] GC before operation: completed in 243.438 ms, heap usage 281.196 MB -> 71.380 MB. [2025-06-18T21:10:53.056Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (7908.651 ms) ====== [2025-06-18T21:10:53.056Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-06-18T21:10:53.056Z] GC before operation: completed in 224.443 ms, heap usage 314.453 MB -> 69.799 MB. [2025-06-18T21:11:02.369Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (8024.990 ms) ====== [2025-06-18T21:11:02.369Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-06-18T21:11:02.369Z] GC before operation: completed in 379.019 ms, heap usage 260.158 MB -> 97.556 MB. [2025-06-18T21:11:10.322Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8968.383 ms) ====== [2025-06-18T21:11:10.322Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-06-18T21:11:10.874Z] GC before operation: completed in 284.318 ms, heap usage 361.596 MB -> 70.076 MB. [2025-06-18T21:11:20.527Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (8669.334 ms) ====== [2025-06-18T21:11:20.527Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-06-18T21:11:20.527Z] GC before operation: completed in 147.617 ms, heap usage 322.227 MB -> 70.415 MB. [2025-06-18T21:11:25.799Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6426.103 ms) ====== [2025-06-18T21:11:25.799Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-06-18T21:11:27.114Z] GC before operation: completed in 758.338 ms, heap usage 293.722 MB -> 70.576 MB. [2025-06-18T21:11:36.428Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (8501.632 ms) ====== [2025-06-18T21:11:36.428Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-06-18T21:11:36.428Z] GC before operation: completed in 378.414 ms, heap usage 489.365 MB -> 98.144 MB. [2025-06-18T21:11:42.775Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (6275.717 ms) ====== [2025-06-18T21:11:42.775Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-06-18T21:11:42.775Z] GC before operation: completed in 239.372 ms, heap usage 557.830 MB -> 98.506 MB. [2025-06-18T21:11:49.327Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6866.391 ms) ====== [2025-06-18T21:11:49.327Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-06-18T21:11:49.327Z] GC before operation: completed in 332.379 ms, heap usage 566.218 MB -> 98.644 MB. [2025-06-18T21:11:58.621Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (8173.843 ms) ====== [2025-06-18T21:11:58.621Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-06-18T21:11:58.621Z] GC before operation: completed in 249.747 ms, heap usage 319.461 MB -> 71.123 MB. [2025-06-18T21:12:05.124Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (7045.444 ms) ====== [2025-06-18T21:12:05.124Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-06-18T21:12:05.124Z] GC before operation: completed in 261.433 ms, heap usage 295.470 MB -> 98.608 MB. [2025-06-18T21:12:12.959Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (7866.814 ms) ====== [2025-06-18T21:12:12.959Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-06-18T21:12:12.959Z] GC before operation: completed in 281.600 ms, heap usage 298.808 MB -> 71.161 MB. [2025-06-18T21:12:20.800Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (6761.875 ms) ====== [2025-06-18T21:12:20.800Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-06-18T21:12:20.800Z] GC before operation: completed in 390.175 ms, heap usage 206.108 MB -> 99.006 MB. [2025-06-18T21:12:25.956Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5326.536 ms) ====== [2025-06-18T21:12:25.956Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-06-18T21:12:25.956Z] GC before operation: completed in 349.435 ms, heap usage 352.065 MB -> 71.504 MB. [2025-06-18T21:12:33.820Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (7121.976 ms) ====== [2025-06-18T21:12:33.820Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-06-18T21:12:33.820Z] GC before operation: completed in 763.246 ms, heap usage 386.236 MB -> 71.555 MB. [2025-06-18T21:12:41.650Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (7271.369 ms) ====== [2025-06-18T21:12:41.650Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-06-18T21:12:41.650Z] GC before operation: completed in 224.777 ms, heap usage 274.695 MB -> 71.750 MB. [2025-06-18T21:12:46.358Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4663.300 ms) ====== [2025-06-18T21:12:46.358Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-06-18T21:12:46.358Z] GC before operation: completed in 192.533 ms, heap usage 285.141 MB -> 71.847 MB. [2025-06-18T21:12:52.197Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5832.211 ms) ====== [2025-06-18T21:12:52.197Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-06-18T21:12:52.197Z] GC before operation: completed in 185.941 ms, heap usage 294.909 MB -> 72.041 MB. [2025-06-18T21:12:58.103Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (5432.270 ms) ====== [2025-06-18T21:12:58.103Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-06-18T21:12:58.103Z] GC before operation: completed in 252.717 ms, heap usage 343.038 MB -> 72.009 MB. [2025-06-18T21:13:04.517Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (6460.722 ms) ====== [2025-06-18T21:13:04.517Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-06-18T21:13:04.517Z] GC before operation: completed in 248.157 ms, heap usage 427.319 MB -> 72.125 MB. [2025-06-18T21:13:10.334Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (5598.512 ms) ====== [2025-06-18T21:13:10.334Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-06-18T21:13:10.769Z] GC before operation: completed in 496.205 ms, heap usage 399.115 MB -> 72.279 MB. [2025-06-18T21:13:16.828Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (5112.477 ms) ====== [2025-06-18T21:13:16.828Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-06-18T21:13:16.828Z] GC before operation: completed in 286.375 ms, heap usage 337.791 MB -> 72.264 MB. [2025-06-18T21:13:23.171Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (6772.350 ms) ====== [2025-06-18T21:13:23.171Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-06-18T21:13:24.363Z] GC before operation: completed in 1071.679 ms, heap usage 307.759 MB -> 72.515 MB. [2025-06-18T21:13:32.127Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (7482.528 ms) ====== [2025-06-18T21:13:32.127Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-06-18T21:13:32.127Z] GC before operation: completed in 279.206 ms, heap usage 212.867 MB -> 72.625 MB. [2025-06-18T21:13:38.585Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (6387.752 ms) ====== [2025-06-18T21:13:38.585Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-06-18T21:13:38.585Z] GC before operation: completed in 318.314 ms, heap usage 253.498 MB -> 72.600 MB. [2025-06-18T21:13:44.902Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (6241.198 ms) ====== [2025-06-18T21:13:44.902Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-06-18T21:13:44.902Z] GC before operation: completed in 279.902 ms, heap usage 282.006 MB -> 100.430 MB. [2025-06-18T21:13:51.280Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (6282.665 ms) ====== [2025-06-18T21:13:51.280Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-06-18T21:13:51.694Z] GC before operation: completed in 203.895 ms, heap usage 328.494 MB -> 72.830 MB. [2025-06-18T21:13:57.621Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (6038.723 ms) ====== [2025-06-18T21:13:57.621Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-06-18T21:13:57.621Z] GC before operation: completed in 281.183 ms, heap usage 419.826 MB -> 73.087 MB. [2025-06-18T21:14:04.055Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (6048.237 ms) ====== [2025-06-18T21:14:04.055Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-06-18T21:14:04.055Z] GC before operation: completed in 211.821 ms, heap usage 149.540 MB -> 72.813 MB. [2025-06-18T21:14:08.753Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4486.407 ms) ====== [2025-06-18T21:14:08.753Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-06-18T21:14:09.511Z] GC before operation: completed in 449.732 ms, heap usage 410.328 MB -> 73.331 MB. [2025-06-18T21:14:17.472Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (7735.277 ms) ====== [2025-06-18T21:14:17.472Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-06-18T21:14:17.472Z] GC before operation: completed in 288.694 ms, heap usage 113.030 MB -> 73.051 MB. [2025-06-18T21:14:23.734Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (6391.317 ms) ====== [2025-06-18T21:14:23.734Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-06-18T21:14:23.734Z] GC before operation: completed in 325.384 ms, heap usage 350.320 MB -> 73.905 MB. [2025-06-18T21:14:29.914Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (5958.047 ms) ====== [2025-06-18T21:14:29.914Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-06-18T21:14:29.914Z] GC before operation: completed in 374.746 ms, heap usage 251.784 MB -> 101.274 MB. [2025-06-18T21:14:37.045Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (7166.805 ms) ====== [2025-06-18T21:14:37.045Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-06-18T21:14:37.520Z] GC before operation: completed in 308.728 ms, heap usage 311.188 MB -> 73.585 MB. [2025-06-18T21:14:42.409Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4432.278 ms) ====== [2025-06-18T21:14:42.409Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-06-18T21:14:42.409Z] GC before operation: completed in 283.064 ms, heap usage 148.552 MB -> 73.411 MB. [2025-06-18T21:14:47.376Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4387.045 ms) ====== [2025-06-18T21:14:47.376Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-06-18T21:14:47.376Z] GC before operation: completed in 512.979 ms, heap usage 453.114 MB -> 73.871 MB. [2025-06-18T21:14:53.630Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (5698.822 ms) ====== [2025-06-18T21:14:53.630Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-06-18T21:14:53.630Z] GC before operation: completed in 178.254 ms, heap usage 192.743 MB -> 73.739 MB. [2025-06-18T21:14:58.856Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (5303.758 ms) ====== [2025-06-18T21:14:58.856Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-06-18T21:14:58.856Z] GC before operation: completed in 206.576 ms, heap usage 366.113 MB -> 73.982 MB. [2025-06-18T21:15:05.073Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5998.292 ms) ====== [2025-06-18T21:15:05.073Z] ----------------------------------- [2025-06-18T21:15:05.073Z] renaissance-dec-tree_0_PASSED [2025-06-18T21:15:05.073Z] ----------------------------------- [2025-06-18T21:15:05.073Z] [2025-06-18T21:15:05.073Z] TEST TEARDOWN: [2025-06-18T21:15:05.073Z] Nothing to be done for teardown. [2025-06-18T21:15:05.446Z] renaissance-dec-tree_0 Finish Time: Wed Jun 18 14:15:04 2025 Epoch Time (ms): 1750281304669