[2025-10-01T21:22:01.560Z] Running test renaissance-dec-tree_0 ... [2025-10-01T21:22:01.560Z] =============================================== [2025-10-01T21:22:01.560Z] renaissance-dec-tree_0 Start Time: Wed Oct 1 21:22:00 2025 Epoch Time (ms): 1759353720876 [2025-10-01T21:22:01.560Z] variation: NoOptions [2025-10-01T21:22:01.560Z] JVM_OPTIONS: [2025-10-01T21:22:01.560Z] { \ [2025-10-01T21:22:01.560Z] echo ""; echo "TEST SETUP:"; \ [2025-10-01T21:22:01.560Z] echo "Nothing to be done for setup."; \ [2025-10-01T21:22:01.560Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17593529134678/renaissance-dec-tree_0"; \ [2025-10-01T21:22:01.560Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17593529134678/renaissance-dec-tree_0"; \ [2025-10-01T21:22:01.560Z] echo ""; echo "TESTING:"; \ [2025-10-01T21:22:01.560Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/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 "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17593529134678/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-10-01T21:22:01.560Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17593529134678/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-01T21:22:01.560Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-01T21:22:01.560Z] echo "Nothing to be done for teardown."; \ [2025-10-01T21:22:01.560Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17593529134678/TestTargetResult"; [2025-10-01T21:22:01.560Z] [2025-10-01T21:22:01.560Z] TEST SETUP: [2025-10-01T21:22:01.560Z] Nothing to be done for setup. [2025-10-01T21:22:01.560Z] [2025-10-01T21:22:01.560Z] TESTING: [2025-10-01T21:22:09.717Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-10-01T21:22:15.909Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-10-01T21:22:15.909Z] GC before operation: completed in 102.027 ms, heap usage 42.973 MB -> 35.096 MB. [2025-10-01T21:22:37.871Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (21738.990 ms) ====== [2025-10-01T21:22:37.871Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-10-01T21:22:37.871Z] GC before operation: completed in 186.300 ms, heap usage 201.281 MB -> 69.199 MB. [2025-10-01T21:22:40.397Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3239.328 ms) ====== [2025-10-01T21:22:40.397Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-10-01T21:22:40.397Z] GC before operation: completed in 158.622 ms, heap usage 124.903 MB -> 68.791 MB. [2025-10-01T21:22:43.746Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2955.385 ms) ====== [2025-10-01T21:22:43.746Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-10-01T21:22:43.746Z] GC before operation: completed in 156.579 ms, heap usage 240.836 MB -> 70.110 MB. [2025-10-01T21:22:46.673Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2819.558 ms) ====== [2025-10-01T21:22:46.673Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-10-01T21:22:46.673Z] GC before operation: completed in 171.178 ms, heap usage 387.219 MB -> 70.067 MB. [2025-10-01T21:22:50.008Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2774.217 ms) ====== [2025-10-01T21:22:50.008Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-10-01T21:22:50.008Z] GC before operation: completed in 195.817 ms, heap usage 235.792 MB -> 70.276 MB. [2025-10-01T21:22:53.342Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3201.796 ms) ====== [2025-10-01T21:22:53.342Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-10-01T21:22:53.342Z] GC before operation: completed in 124.205 ms, heap usage 157.068 MB -> 81.118 MB. [2025-10-01T21:22:55.754Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2507.626 ms) ====== [2025-10-01T21:22:55.754Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-10-01T21:22:55.754Z] GC before operation: completed in 174.247 ms, heap usage 242.176 MB -> 70.542 MB. [2025-10-01T21:22:59.086Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2781.096 ms) ====== [2025-10-01T21:22:59.086Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-10-01T21:22:59.086Z] GC before operation: completed in 159.349 ms, heap usage 340.187 MB -> 70.835 MB. [2025-10-01T21:23:01.513Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2669.632 ms) ====== [2025-10-01T21:23:01.513Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-10-01T21:23:01.513Z] GC before operation: completed in 148.864 ms, heap usage 379.309 MB -> 70.952 MB. [2025-10-01T21:23:03.932Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2696.236 ms) ====== [2025-10-01T21:23:03.932Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-10-01T21:23:04.684Z] GC before operation: completed in 186.261 ms, heap usage 188.171 MB -> 70.742 MB. [2025-10-01T21:23:07.215Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2905.429 ms) ====== [2025-10-01T21:23:07.215Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-10-01T21:23:07.974Z] GC before operation: completed in 229.078 ms, heap usage 102.923 MB -> 70.722 MB. [2025-10-01T21:23:10.391Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2981.634 ms) ====== [2025-10-01T21:23:10.391Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-10-01T21:23:10.391Z] GC before operation: completed in 180.690 ms, heap usage 145.412 MB -> 70.970 MB. [2025-10-01T21:23:14.816Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4207.733 ms) ====== [2025-10-01T21:23:14.816Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-10-01T21:23:14.816Z] GC before operation: completed in 174.145 ms, heap usage 128.194 MB -> 71.098 MB. [2025-10-01T21:23:18.157Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2844.208 ms) ====== [2025-10-01T21:23:18.157Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-10-01T21:23:18.157Z] GC before operation: completed in 224.959 ms, heap usage 178.108 MB -> 71.547 MB. [2025-10-01T21:23:18.157Z] 21:23:17.785 WARN [block-manager-storage-async-thread-pool-15] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_191_piece0, which does not exist [2025-10-01T21:23:20.564Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2398.344 ms) ====== [2025-10-01T21:23:20.564Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-10-01T21:23:20.564Z] GC before operation: completed in 207.608 ms, heap usage 268.751 MB -> 71.744 MB. [2025-10-01T21:23:23.920Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2655.213 ms) ====== [2025-10-01T21:23:23.920Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-10-01T21:23:23.920Z] GC before operation: completed in 195.220 ms, heap usage 310.448 MB -> 71.895 MB. [2025-10-01T21:23:26.482Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2967.725 ms) ====== [2025-10-01T21:23:26.482Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-10-01T21:23:27.240Z] GC before operation: completed in 237.307 ms, heap usage 340.480 MB -> 71.838 MB. [2025-10-01T21:23:29.653Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2426.705 ms) ====== [2025-10-01T21:23:29.653Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-10-01T21:23:29.653Z] GC before operation: completed in 207.022 ms, heap usage 351.683 MB -> 71.974 MB. [2025-10-01T21:23:32.069Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2851.910 ms) ====== [2025-10-01T21:23:32.069Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-10-01T21:23:32.826Z] GC before operation: completed in 200.083 ms, heap usage 347.776 MB -> 72.231 MB. [2025-10-01T21:23:35.313Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2649.541 ms) ====== [2025-10-01T21:23:35.313Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-10-01T21:23:35.313Z] GC before operation: completed in 203.536 ms, heap usage 433.264 MB -> 83.432 MB. [2025-10-01T21:23:38.783Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2820.805 ms) ====== [2025-10-01T21:23:38.783Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-10-01T21:23:38.783Z] GC before operation: completed in 195.712 ms, heap usage 195.137 MB -> 72.103 MB. [2025-10-01T21:23:41.214Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2801.386 ms) ====== [2025-10-01T21:23:41.214Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-10-01T21:23:41.214Z] GC before operation: completed in 217.031 ms, heap usage 252.145 MB -> 72.667 MB. [2025-10-01T21:23:43.646Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2355.206 ms) ====== [2025-10-01T21:23:43.646Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-10-01T21:23:43.646Z] GC before operation: completed in 168.807 ms, heap usage 296.425 MB -> 72.649 MB. [2025-10-01T21:23:46.977Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2598.821 ms) ====== [2025-10-01T21:23:46.977Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-10-01T21:23:46.977Z] GC before operation: completed in 199.199 ms, heap usage 270.649 MB -> 72.596 MB. [2025-10-01T21:23:49.475Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2358.207 ms) ====== [2025-10-01T21:23:49.475Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-10-01T21:23:49.475Z] GC before operation: completed in 173.423 ms, heap usage 308.145 MB -> 78.164 MB. [2025-10-01T21:23:51.910Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2894.126 ms) ====== [2025-10-01T21:23:51.911Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-10-01T21:23:53.020Z] GC before operation: completed in 318.308 ms, heap usage 282.066 MB -> 72.992 MB. [2025-10-01T21:23:55.431Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2461.325 ms) ====== [2025-10-01T21:23:55.431Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-10-01T21:23:55.431Z] GC before operation: completed in 184.520 ms, heap usage 320.562 MB -> 73.081 MB. [2025-10-01T21:23:57.838Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2159.105 ms) ====== [2025-10-01T21:23:57.838Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-10-01T21:23:57.838Z] GC before operation: completed in 228.072 ms, heap usage 333.328 MB -> 73.159 MB. [2025-10-01T21:24:00.255Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2480.671 ms) ====== [2025-10-01T21:24:00.255Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-10-01T21:24:00.255Z] GC before operation: completed in 282.386 ms, heap usage 312.603 MB -> 73.135 MB. [2025-10-01T21:24:02.652Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2357.408 ms) ====== [2025-10-01T21:24:02.652Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-10-01T21:24:02.652Z] GC before operation: completed in 198.514 ms, heap usage 303.428 MB -> 73.363 MB. [2025-10-01T21:24:05.076Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2458.109 ms) ====== [2025-10-01T21:24:05.076Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-10-01T21:24:05.824Z] GC before operation: completed in 210.043 ms, heap usage 325.874 MB -> 73.469 MB. [2025-10-01T21:24:08.241Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2357.459 ms) ====== [2025-10-01T21:24:08.242Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-10-01T21:24:08.242Z] GC before operation: completed in 195.107 ms, heap usage 304.751 MB -> 73.589 MB. [2025-10-01T21:24:10.694Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2836.132 ms) ====== [2025-10-01T21:24:10.694Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-10-01T21:24:11.442Z] GC before operation: completed in 216.226 ms, heap usage 273.739 MB -> 73.575 MB. [2025-10-01T21:24:13.875Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2469.507 ms) ====== [2025-10-01T21:24:13.875Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-10-01T21:24:13.875Z] GC before operation: completed in 254.341 ms, heap usage 260.958 MB -> 73.853 MB. [2025-10-01T21:24:16.357Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2247.847 ms) ====== [2025-10-01T21:24:16.357Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-10-01T21:24:16.357Z] GC before operation: completed in 190.351 ms, heap usage 269.181 MB -> 73.969 MB. [2025-10-01T21:24:19.753Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2912.499 ms) ====== [2025-10-01T21:24:19.753Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-10-01T21:24:19.753Z] GC before operation: completed in 194.360 ms, heap usage 293.565 MB -> 73.832 MB. [2025-10-01T21:24:21.319Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2065.931 ms) ====== [2025-10-01T21:24:21.319Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-10-01T21:24:22.082Z] GC before operation: completed in 181.529 ms, heap usage 334.322 MB -> 73.976 MB. [2025-10-01T21:24:23.661Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2232.940 ms) ====== [2025-10-01T21:24:23.661Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-10-01T21:24:24.434Z] GC before operation: completed in 270.560 ms, heap usage 263.514 MB -> 79.781 MB. [2025-10-01T21:24:24.434Z] 21:24:23.762 WARN [block-manager-storage-async-thread-pool-6] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_527_piece0, which does not exist [2025-10-01T21:24:26.969Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2893.738 ms) ====== [2025-10-01T21:24:26.969Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-10-01T21:24:26.969Z] GC before operation: completed in 195.544 ms, heap usage 239.436 MB -> 85.345 MB. [2025-10-01T21:24:26.969Z] 21:24:26.856 WARN [block-manager-storage-async-thread-pool-87] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1869_0, which does not exist [2025-10-01T21:24:31.392Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3548.477 ms) ====== [2025-10-01T21:24:31.392Z] ----------------------------------- [2025-10-01T21:24:31.392Z] renaissance-dec-tree_0_PASSED [2025-10-01T21:24:31.392Z] ----------------------------------- [2025-10-01T21:24:31.392Z] [2025-10-01T21:24:31.392Z] TEST TEARDOWN: [2025-10-01T21:24:31.392Z] Nothing to be done for teardown. [2025-10-01T21:24:31.392Z] renaissance-dec-tree_0 Finish Time: Wed Oct 1 21:24:30 2025 Epoch Time (ms): 1759353870917