[2026-04-22T14:40:15.427Z] Running test renaissance-dec-tree_0 ... [2026-04-22T14:40:15.427Z] =============================================== [2026-04-22T14:40:15.427Z] renaissance-dec-tree_0 Start Time: Wed Apr 22 14:40:15 2026 Epoch Time (ms): 1776868815254 [2026-04-22T14:40:15.427Z] variation: NoOptions [2026-04-22T14:40:15.820Z] JVM_OPTIONS: [2026-04-22T14:40:15.820Z] { \ [2026-04-22T14:40:15.820Z] echo ""; echo "TEST SETUP:"; \ [2026-04-22T14:40:15.820Z] echo "Nothing to be done for setup."; \ [2026-04-22T14:40:15.820Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-dec-tree_0"; \ [2026-04-22T14:40:15.820Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-dec-tree_0"; \ [2026-04-22T14:40:15.820Z] echo ""; echo "TESTING:"; \ [2026-04-22T14:40:15.820Z] "c:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/jdkbinary/j2sdk-image\\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 "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2026-04-22T14:40:15.820Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-22T14:40:15.820Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-22T14:40:15.820Z] echo "Nothing to be done for teardown."; \ [2026-04-22T14:40:15.820Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17768678844701\\TestTargetResult"; [2026-04-22T14:40:15.820Z] [2026-04-22T14:40:15.820Z] TEST SETUP: [2026-04-22T14:40:15.820Z] Nothing to be done for setup. [2026-04-22T14:40:15.820Z] [2026-04-22T14:40:15.820Z] TESTING: [2026-04-22T14:40:29.925Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-22T14:40:29.925Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-04-22T14:40:29.925Z] GC before operation: completed in 47.849 ms, heap usage 63.770 MB -> 35.228 MB. [2026-04-22T14:40:39.339Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9348.896 ms) ====== [2026-04-22T14:40:39.339Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-04-22T14:40:39.339Z] GC before operation: completed in 88.124 ms, heap usage 166.624 MB -> 68.994 MB. [2026-04-22T14:40:41.908Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2395.434 ms) ====== [2026-04-22T14:40:41.908Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-04-22T14:40:41.908Z] GC before operation: completed in 74.547 ms, heap usage 336.963 MB -> 69.667 MB. [2026-04-22T14:40:43.853Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2035.780 ms) ====== [2026-04-22T14:40:43.853Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-04-22T14:40:43.853Z] GC before operation: completed in 76.096 ms, heap usage 313.280 MB -> 69.951 MB. [2026-04-22T14:40:45.770Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1888.677 ms) ====== [2026-04-22T14:40:45.771Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-04-22T14:40:45.771Z] GC before operation: completed in 74.399 ms, heap usage 291.840 MB -> 70.246 MB. [2026-04-22T14:40:47.556Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1616.423 ms) ====== [2026-04-22T14:40:47.556Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-04-22T14:40:47.556Z] GC before operation: completed in 95.765 ms, heap usage 257.047 MB -> 81.537 MB. [2026-04-22T14:40:49.361Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1489.586 ms) ====== [2026-04-22T14:40:49.361Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-04-22T14:40:49.361Z] GC before operation: completed in 81.939 ms, heap usage 342.094 MB -> 81.799 MB. [2026-04-22T14:40:50.572Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1456.370 ms) ====== [2026-04-22T14:40:50.572Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-04-22T14:40:50.572Z] GC before operation: completed in 82.544 ms, heap usage 355.716 MB -> 81.792 MB. [2026-04-22T14:40:51.906Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1389.097 ms) ====== [2026-04-22T14:40:51.906Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-04-22T14:40:52.272Z] GC before operation: completed in 85.762 ms, heap usage 329.149 MB -> 92.995 MB. [2026-04-22T14:40:53.514Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1492.517 ms) ====== [2026-04-22T14:40:53.514Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-04-22T14:40:53.895Z] GC before operation: completed in 89.112 ms, heap usage 526.387 MB -> 87.695 MB. [2026-04-22T14:40:55.134Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1383.908 ms) ====== [2026-04-22T14:40:55.134Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-04-22T14:40:55.134Z] GC before operation: completed in 85.291 ms, heap usage 252.405 MB -> 87.823 MB. [2026-04-22T14:40:56.924Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1369.286 ms) ====== [2026-04-22T14:40:56.924Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-04-22T14:40:56.924Z] GC before operation: completed in 89.313 ms, heap usage 242.745 MB -> 87.976 MB. [2026-04-22T14:40:58.119Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1382.365 ms) ====== [2026-04-22T14:40:58.119Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-04-22T14:40:58.119Z] GC before operation: completed in 87.774 ms, heap usage 230.714 MB -> 82.432 MB. [2026-04-22T14:40:59.391Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1389.976 ms) ====== [2026-04-22T14:40:59.391Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-04-22T14:40:59.769Z] GC before operation: completed in 92.585 ms, heap usage 296.747 MB -> 88.218 MB. [2026-04-22T14:41:00.973Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1391.535 ms) ====== [2026-04-22T14:41:00.973Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-04-22T14:41:00.973Z] GC before operation: completed in 90.210 ms, heap usage 226.214 MB -> 82.951 MB. [2026-04-22T14:41:02.349Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1400.976 ms) ====== [2026-04-22T14:41:02.349Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-04-22T14:41:02.735Z] GC before operation: completed in 95.508 ms, heap usage 295.635 MB -> 88.684 MB. [2026-04-22T14:41:03.975Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1405.384 ms) ====== [2026-04-22T14:41:03.975Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-04-22T14:41:03.975Z] GC before operation: completed in 89.183 ms, heap usage 230.694 MB -> 72.284 MB. [2026-04-22T14:41:05.719Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1362.723 ms) ====== [2026-04-22T14:41:05.719Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-04-22T14:41:05.719Z] GC before operation: completed in 92.840 ms, heap usage 119.736 MB -> 82.914 MB. [2026-04-22T14:41:06.966Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1345.799 ms) ====== [2026-04-22T14:41:06.966Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-04-22T14:41:06.966Z] GC before operation: completed in 97.865 ms, heap usage 459.578 MB -> 88.850 MB. [2026-04-22T14:41:08.227Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1392.864 ms) ====== [2026-04-22T14:41:08.227Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-04-22T14:41:08.614Z] GC before operation: completed in 94.291 ms, heap usage 164.048 MB -> 94.139 MB. [2026-04-22T14:41:09.822Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1351.546 ms) ====== [2026-04-22T14:41:09.822Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-04-22T14:41:09.822Z] GC before operation: completed in 105.575 ms, heap usage 422.189 MB -> 94.577 MB. [2026-04-22T14:41:11.162Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1352.063 ms) ====== [2026-04-22T14:41:11.162Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-04-22T14:41:11.528Z] GC before operation: completed in 104.841 ms, heap usage 466.057 MB -> 89.231 MB. [2026-04-22T14:41:12.720Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1362.369 ms) ====== [2026-04-22T14:41:12.720Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-04-22T14:41:12.720Z] GC before operation: completed in 105.637 ms, heap usage 123.494 MB -> 72.236 MB. [2026-04-22T14:41:14.054Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1340.600 ms) ====== [2026-04-22T14:41:14.054Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-04-22T14:41:14.423Z] GC before operation: completed in 105.604 ms, heap usage 149.550 MB -> 94.815 MB. [2026-04-22T14:41:15.617Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1338.356 ms) ====== [2026-04-22T14:41:15.617Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-04-22T14:41:15.617Z] GC before operation: completed in 101.448 ms, heap usage 417.469 MB -> 89.684 MB. [2026-04-22T14:41:17.344Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1323.491 ms) ====== [2026-04-22T14:41:17.344Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-04-22T14:41:17.344Z] GC before operation: completed in 102.037 ms, heap usage 140.082 MB -> 89.000 MB. [2026-04-22T14:41:18.616Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1367.937 ms) ====== [2026-04-22T14:41:18.616Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-04-22T14:41:18.616Z] GC before operation: completed in 102.291 ms, heap usage 419.976 MB -> 84.273 MB. [2026-04-22T14:41:19.862Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1369.726 ms) ====== [2026-04-22T14:41:19.862Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-04-22T14:41:20.245Z] GC before operation: completed in 103.005 ms, heap usage 248.417 MB -> 89.875 MB. [2026-04-22T14:41:21.563Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1356.915 ms) ====== [2026-04-22T14:41:21.563Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-04-22T14:41:21.563Z] GC before operation: completed in 104.192 ms, heap usage 200.003 MB -> 89.619 MB. [2026-04-22T14:41:22.793Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1315.175 ms) ====== [2026-04-22T14:41:22.793Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-04-22T14:41:22.793Z] GC before operation: completed in 109.567 ms, heap usage 517.728 MB -> 95.535 MB. [2026-04-22T14:41:24.507Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1324.256 ms) ====== [2026-04-22T14:41:24.507Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-04-22T14:41:24.507Z] GC before operation: completed in 115.557 ms, heap usage 457.775 MB -> 90.348 MB. [2026-04-22T14:41:25.713Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1326.577 ms) ====== [2026-04-22T14:41:25.713Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-04-22T14:41:25.713Z] GC before operation: completed in 101.824 ms, heap usage 126.915 MB -> 78.738 MB. [2026-04-22T14:41:27.461Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1335.686 ms) ====== [2026-04-22T14:41:27.461Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-04-22T14:41:27.461Z] GC before operation: completed in 107.487 ms, heap usage 554.499 MB -> 90.559 MB. [2026-04-22T14:41:28.662Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1366.079 ms) ====== [2026-04-22T14:41:28.662Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-04-22T14:41:28.662Z] GC before operation: completed in 102.156 ms, heap usage 194.471 MB -> 90.165 MB. [2026-04-22T14:41:28.662Z] 14:41:28.539 WARN [block-manager-storage-async-thread-pool-54] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1581_0, which does not exist [2026-04-22T14:41:30.452Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1366.110 ms) ====== [2026-04-22T14:41:30.452Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-04-22T14:41:30.452Z] GC before operation: completed in 109.523 ms, heap usage 508.929 MB -> 90.781 MB. [2026-04-22T14:41:31.700Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1351.828 ms) ====== [2026-04-22T14:41:31.700Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-04-22T14:41:31.700Z] GC before operation: completed in 102.706 ms, heap usage 162.987 MB -> 90.411 MB. [2026-04-22T14:41:31.700Z] 14:41:31.468 WARN [block-manager-storage-async-thread-pool-4] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1677_1, which does not exist [2026-04-22T14:41:32.956Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1378.719 ms) ====== [2026-04-22T14:41:32.956Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-04-22T14:41:33.321Z] GC before operation: completed in 115.292 ms, heap usage 462.461 MB -> 96.276 MB. [2026-04-22T14:41:34.524Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1350.216 ms) ====== [2026-04-22T14:41:34.524Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-04-22T14:41:34.524Z] GC before operation: completed in 109.639 ms, heap usage 448.187 MB -> 102.057 MB. [2026-04-22T14:41:35.850Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1284.065 ms) ====== [2026-04-22T14:41:35.850Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-04-22T14:41:35.850Z] GC before operation: completed in 106.026 ms, heap usage 403.599 MB -> 91.049 MB. [2026-04-22T14:41:37.563Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1275.025 ms) ====== [2026-04-22T14:41:37.563Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-04-22T14:41:37.563Z] GC before operation: completed in 107.357 ms, heap usage 525.049 MB -> 91.212 MB. [2026-04-22T14:41:38.764Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1289.750 ms) ====== [2026-04-22T14:41:39.104Z] ----------------------------------- [2026-04-22T14:41:39.105Z] renaissance-dec-tree_0_PASSED [2026-04-22T14:41:39.105Z] ----------------------------------- [2026-04-22T14:41:39.105Z] [2026-04-22T14:41:39.105Z] TEST TEARDOWN: [2026-04-22T14:41:39.105Z] Nothing to be done for teardown. [2026-04-22T14:41:39.442Z] renaissance-dec-tree_0 Finish Time: Wed Apr 22 14:41:39 2026 Epoch Time (ms): 1776868899169