[2026-04-22T14:30:51.831Z] Running test renaissance-dec-tree_0 ... [2026-04-22T14:30:51.831Z] =============================================== [2026-04-22T14:30:51.831Z] renaissance-dec-tree_0 Start Time: Wed Apr 22 14:30:51 2026 Epoch Time (ms): 1776868251547 [2026-04-22T14:30:51.831Z] variation: NoOptions [2026-04-22T14:30:51.831Z] JVM_OPTIONS: [2026-04-22T14:30:51.831Z] { \ [2026-04-22T14:30:51.831Z] echo ""; echo "TEST SETUP:"; \ [2026-04-22T14:30:51.831Z] echo "Nothing to be done for setup."; \ [2026-04-22T14:30:51.831Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17768676944172/renaissance-dec-tree_0"; \ [2026-04-22T14:30:51.831Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17768676944172/renaissance-dec-tree_0"; \ [2026-04-22T14:30:51.831Z] echo ""; echo "TESTING:"; \ [2026-04-22T14:30:51.831Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_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_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17768676944172/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-04-22T14:30:51.831Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17768676944172/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-22T14:30:51.831Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-22T14:30:51.831Z] echo "Nothing to be done for teardown."; \ [2026-04-22T14:30:51.831Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17768676944172/TestTargetResult"; [2026-04-22T14:30:51.831Z] [2026-04-22T14:30:51.831Z] TEST SETUP: [2026-04-22T14:30:51.831Z] Nothing to be done for setup. [2026-04-22T14:30:51.831Z] [2026-04-22T14:30:51.831Z] TESTING: [2026-04-22T14:30:56.509Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-22T14:30:58.153Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-04-22T14:30:58.153Z] GC before operation: completed in 51.971 ms, heap usage 42.909 MB -> 36.051 MB. [2026-04-22T14:31:08.871Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9583.972 ms) ====== [2026-04-22T14:31:08.871Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-04-22T14:31:08.871Z] GC before operation: completed in 109.464 ms, heap usage 478.908 MB -> 72.161 MB. [2026-04-22T14:31:10.501Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2506.729 ms) ====== [2026-04-22T14:31:10.501Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-04-22T14:31:10.501Z] GC before operation: completed in 156.981 ms, heap usage 482.449 MB -> 100.021 MB. [2026-04-22T14:31:12.745Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1894.170 ms) ====== [2026-04-22T14:31:12.745Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-04-22T14:31:12.745Z] GC before operation: completed in 89.000 ms, heap usage 515.447 MB -> 73.105 MB. [2026-04-22T14:31:14.363Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1782.397 ms) ====== [2026-04-22T14:31:14.363Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-04-22T14:31:14.363Z] GC before operation: completed in 97.482 ms, heap usage 377.774 MB -> 72.895 MB. [2026-04-22T14:31:15.988Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1505.694 ms) ====== [2026-04-22T14:31:15.988Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-04-22T14:31:15.988Z] GC before operation: completed in 96.788 ms, heap usage 476.442 MB -> 73.156 MB. [2026-04-22T14:31:17.350Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1511.222 ms) ====== [2026-04-22T14:31:17.350Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-04-22T14:31:17.673Z] GC before operation: completed in 111.503 ms, heap usage 387.455 MB -> 84.620 MB. [2026-04-22T14:31:18.786Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1305.860 ms) ====== [2026-04-22T14:31:18.786Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-04-22T14:31:18.786Z] GC before operation: completed in 101.196 ms, heap usage 399.436 MB -> 73.954 MB. [2026-04-22T14:31:20.401Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1388.157 ms) ====== [2026-04-22T14:31:20.401Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-04-22T14:31:20.401Z] GC before operation: completed in 93.683 ms, heap usage 394.292 MB -> 73.723 MB. [2026-04-22T14:31:22.017Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1322.254 ms) ====== [2026-04-22T14:31:22.017Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-04-22T14:31:22.017Z] GC before operation: completed in 106.110 ms, heap usage 327.120 MB -> 73.876 MB. [2026-04-22T14:31:23.140Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1240.119 ms) ====== [2026-04-22T14:31:23.140Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-04-22T14:31:23.140Z] GC before operation: completed in 99.307 ms, heap usage 225.079 MB -> 74.006 MB. [2026-04-22T14:31:24.759Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1337.653 ms) ====== [2026-04-22T14:31:24.759Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-04-22T14:31:24.759Z] GC before operation: completed in 128.262 ms, heap usage 220.791 MB -> 74.143 MB. [2026-04-22T14:31:25.910Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1126.920 ms) ====== [2026-04-22T14:31:25.910Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-04-22T14:31:25.910Z] GC before operation: completed in 105.392 ms, heap usage 465.394 MB -> 85.614 MB. [2026-04-22T14:31:27.036Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1194.047 ms) ====== [2026-04-22T14:31:27.036Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-04-22T14:31:27.036Z] GC before operation: completed in 100.106 ms, heap usage 167.433 MB -> 74.230 MB. [2026-04-22T14:31:28.665Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1254.147 ms) ====== [2026-04-22T14:31:28.665Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-04-22T14:31:28.665Z] GC before operation: completed in 108.284 ms, heap usage 281.951 MB -> 74.540 MB. [2026-04-22T14:31:29.798Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1169.002 ms) ====== [2026-04-22T14:31:29.798Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-04-22T14:31:29.798Z] GC before operation: completed in 115.971 ms, heap usage 443.373 MB -> 91.389 MB. [2026-04-22T14:31:30.962Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1180.498 ms) ====== [2026-04-22T14:31:30.963Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-04-22T14:31:31.281Z] GC before operation: completed in 124.886 ms, heap usage 529.595 MB -> 75.437 MB. [2026-04-22T14:31:32.412Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1189.919 ms) ====== [2026-04-22T14:31:32.412Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-04-22T14:31:32.412Z] GC before operation: completed in 122.513 ms, heap usage 113.673 MB -> 74.477 MB. [2026-04-22T14:31:33.561Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1177.236 ms) ====== [2026-04-22T14:31:33.561Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-04-22T14:31:33.888Z] GC before operation: completed in 113.290 ms, heap usage 142.990 MB -> 74.655 MB. [2026-04-22T14:31:35.039Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1223.176 ms) ====== [2026-04-22T14:31:35.039Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-04-22T14:31:35.039Z] GC before operation: completed in 114.096 ms, heap usage 241.646 MB -> 75.176 MB. [2026-04-22T14:31:36.159Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1117.082 ms) ====== [2026-04-22T14:31:36.160Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-04-22T14:31:36.479Z] GC before operation: completed in 116.858 ms, heap usage 388.603 MB -> 86.542 MB. [2026-04-22T14:31:36.479Z] 14:31:36.158 WARN [block-manager-storage-async-thread-pool-51] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_275, which does not exist [2026-04-22T14:31:37.615Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1140.148 ms) ====== [2026-04-22T14:31:37.615Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-04-22T14:31:37.615Z] GC before operation: completed in 112.050 ms, heap usage 432.517 MB -> 86.322 MB. [2026-04-22T14:31:38.735Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1194.124 ms) ====== [2026-04-22T14:31:38.735Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-04-22T14:31:39.054Z] GC before operation: completed in 126.239 ms, heap usage 654.670 MB -> 92.697 MB. [2026-04-22T14:31:40.181Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1197.179 ms) ====== [2026-04-22T14:31:40.181Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-04-22T14:31:40.181Z] GC before operation: completed in 112.211 ms, heap usage 130.125 MB -> 75.221 MB. [2026-04-22T14:31:41.307Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1139.931 ms) ====== [2026-04-22T14:31:41.307Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-04-22T14:31:41.307Z] GC before operation: completed in 116.604 ms, heap usage 168.255 MB -> 75.459 MB. [2026-04-22T14:31:42.456Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1140.105 ms) ====== [2026-04-22T14:31:42.456Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-04-22T14:31:42.778Z] GC before operation: completed in 115.671 ms, heap usage 277.984 MB -> 75.945 MB. [2026-04-22T14:31:43.900Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1141.213 ms) ====== [2026-04-22T14:31:43.900Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-04-22T14:31:43.900Z] GC before operation: completed in 138.490 ms, heap usage 349.495 MB -> 86.754 MB. [2026-04-22T14:31:45.532Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1192.142 ms) ====== [2026-04-22T14:31:45.532Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-04-22T14:31:45.532Z] GC before operation: completed in 109.884 ms, heap usage 294.399 MB -> 75.975 MB. [2026-04-22T14:31:46.670Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1150.558 ms) ====== [2026-04-22T14:31:46.670Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-04-22T14:31:46.670Z] GC before operation: completed in 125.545 ms, heap usage 430.643 MB -> 86.982 MB. [2026-04-22T14:31:47.826Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1192.013 ms) ====== [2026-04-22T14:31:47.826Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-04-22T14:31:47.826Z] GC before operation: completed in 122.276 ms, heap usage 457.384 MB -> 87.285 MB. [2026-04-22T14:31:48.945Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1135.202 ms) ====== [2026-04-22T14:31:48.945Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-04-22T14:31:49.263Z] GC before operation: completed in 122.996 ms, heap usage 649.866 MB -> 87.887 MB. [2026-04-22T14:31:50.386Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1091.498 ms) ====== [2026-04-22T14:31:50.386Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-04-22T14:31:50.386Z] GC before operation: completed in 115.844 ms, heap usage 273.528 MB -> 76.583 MB. [2026-04-22T14:31:51.515Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1144.207 ms) ====== [2026-04-22T14:31:51.515Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-04-22T14:31:51.515Z] GC before operation: completed in 126.081 ms, heap usage 403.913 MB -> 82.301 MB. [2026-04-22T14:31:53.132Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1177.046 ms) ====== [2026-04-22T14:31:53.132Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-04-22T14:31:53.132Z] GC before operation: completed in 118.392 ms, heap usage 171.041 MB -> 76.305 MB. [2026-04-22T14:31:54.264Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1243.977 ms) ====== [2026-04-22T14:31:54.264Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-04-22T14:31:54.264Z] GC before operation: completed in 118.473 ms, heap usage 295.429 MB -> 82.152 MB. [2026-04-22T14:31:55.384Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1111.909 ms) ====== [2026-04-22T14:31:55.384Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-04-22T14:31:55.384Z] GC before operation: completed in 120.961 ms, heap usage 345.459 MB -> 87.961 MB. [2026-04-22T14:31:57.013Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1184.635 ms) ====== [2026-04-22T14:31:57.013Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-04-22T14:31:57.013Z] GC before operation: completed in 132.370 ms, heap usage 621.195 MB -> 88.448 MB. [2026-04-22T14:31:58.137Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1075.048 ms) ====== [2026-04-22T14:31:58.137Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-04-22T14:31:58.137Z] GC before operation: completed in 122.295 ms, heap usage 176.467 MB -> 76.943 MB. [2026-04-22T14:31:59.265Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1160.486 ms) ====== [2026-04-22T14:31:59.265Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-04-22T14:31:59.265Z] GC before operation: completed in 122.298 ms, heap usage 279.046 MB -> 77.182 MB. [2026-04-22T14:32:00.388Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1096.583 ms) ====== [2026-04-22T14:32:00.388Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-04-22T14:32:00.712Z] GC before operation: completed in 127.525 ms, heap usage 385.682 MB -> 104.884 MB. [2026-04-22T14:32:01.832Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1149.957 ms) ====== [2026-04-22T14:32:02.148Z] ----------------------------------- [2026-04-22T14:32:02.148Z] renaissance-dec-tree_0_PASSED [2026-04-22T14:32:02.148Z] ----------------------------------- [2026-04-22T14:32:02.148Z] [2026-04-22T14:32:02.148Z] TEST TEARDOWN: [2026-04-22T14:32:02.148Z] Nothing to be done for teardown. [2026-04-22T14:32:02.148Z] renaissance-dec-tree_0 Finish Time: Wed Apr 22 14:32:01 2026 Epoch Time (ms): 1776868321848