[2025-11-12T23:09:37.764Z] Running test renaissance-dec-tree_0 ... [2025-11-12T23:09:37.764Z] =============================================== [2025-11-12T23:09:37.764Z] renaissance-dec-tree_0 Start Time: Wed Nov 12 23:09:37 2025 Epoch Time (ms): 1762988977540 [2025-11-12T23:09:37.764Z] variation: NoOptions [2025-11-12T23:09:37.764Z] JVM_OPTIONS: [2025-11-12T23:09:37.764Z] { \ [2025-11-12T23:09:37.764Z] echo ""; echo "TEST SETUP:"; \ [2025-11-12T23:09:37.764Z] echo "Nothing to be done for setup."; \ [2025-11-12T23:09:37.764Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17629880619860/renaissance-dec-tree_0"; \ [2025-11-12T23:09:37.764Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17629880619860/renaissance-dec-tree_0"; \ [2025-11-12T23:09:37.764Z] echo ""; echo "TESTING:"; \ [2025-11-12T23:09:37.764Z] "/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_17629880619860/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-11-12T23:09:37.764Z] 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_17629880619860/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-12T23:09:37.764Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-12T23:09:37.764Z] echo "Nothing to be done for teardown."; \ [2025-11-12T23:09:37.764Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17629880619860/TestTargetResult"; [2025-11-12T23:09:37.764Z] [2025-11-12T23:09:37.764Z] TEST SETUP: [2025-11-12T23:09:37.764Z] Nothing to be done for setup. [2025-11-12T23:09:37.764Z] [2025-11-12T23:09:37.764Z] TESTING: [2025-11-12T23:09:43.886Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-11-12T23:09:46.463Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-11-12T23:09:46.463Z] GC before operation: completed in 45.070 ms, heap usage 44.185 MB -> 34.701 MB. [2025-11-12T23:10:00.083Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (13676.716 ms) ====== [2025-11-12T23:10:00.083Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-11-12T23:10:00.427Z] GC before operation: completed in 183.133 ms, heap usage 216.292 MB -> 67.721 MB. [2025-11-12T23:10:04.481Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3374.540 ms) ====== [2025-11-12T23:10:04.481Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-11-12T23:10:04.481Z] GC before operation: completed in 136.114 ms, heap usage 189.840 MB -> 87.546 MB. [2025-11-12T23:10:04.481Z] 23:10:03.694 WARN [block-manager-storage-async-thread-pool-6] org.apache.spark.storage.BlockManager - Asked to remove block rdd_93_0, which does not exist [2025-11-12T23:10:06.854Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2658.573 ms) ====== [2025-11-12T23:10:06.854Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-11-12T23:10:06.854Z] GC before operation: completed in 134.325 ms, heap usage 287.158 MB -> 68.409 MB. [2025-11-12T23:10:09.237Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2424.741 ms) ====== [2025-11-12T23:10:09.237Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-11-12T23:10:09.237Z] GC before operation: completed in 115.564 ms, heap usage 364.593 MB -> 96.100 MB. [2025-11-12T23:10:11.610Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2203.968 ms) ====== [2025-11-12T23:10:11.610Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-11-12T23:10:11.610Z] GC before operation: completed in 101.842 ms, heap usage 378.921 MB -> 68.724 MB. [2025-11-12T23:10:13.951Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2318.848 ms) ====== [2025-11-12T23:10:13.951Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-11-12T23:10:13.951Z] GC before operation: completed in 103.890 ms, heap usage 192.748 MB -> 69.098 MB. [2025-11-12T23:10:16.396Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2186.324 ms) ====== [2025-11-12T23:10:16.396Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-11-12T23:10:16.396Z] GC before operation: completed in 105.208 ms, heap usage 330.636 MB -> 69.221 MB. [2025-11-12T23:10:18.090Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1979.959 ms) ====== [2025-11-12T23:10:18.090Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-11-12T23:10:18.424Z] GC before operation: completed in 109.928 ms, heap usage 360.784 MB -> 69.413 MB. [2025-11-12T23:10:20.719Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2015.554 ms) ====== [2025-11-12T23:10:20.719Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-11-12T23:10:20.719Z] GC before operation: completed in 128.032 ms, heap usage 357.617 MB -> 97.057 MB. [2025-11-12T23:10:22.418Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1978.677 ms) ====== [2025-11-12T23:10:22.418Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-11-12T23:10:22.418Z] GC before operation: completed in 108.341 ms, heap usage 351.139 MB -> 69.555 MB. [2025-11-12T23:10:24.716Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1967.586 ms) ====== [2025-11-12T23:10:24.716Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-11-12T23:10:24.716Z] GC before operation: completed in 105.972 ms, heap usage 202.171 MB -> 69.841 MB. [2025-11-12T23:10:26.425Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1965.343 ms) ====== [2025-11-12T23:10:26.425Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-11-12T23:10:26.763Z] GC before operation: completed in 109.660 ms, heap usage 321.611 MB -> 70.126 MB. [2025-11-12T23:10:28.449Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1850.425 ms) ====== [2025-11-12T23:10:28.449Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-11-12T23:10:28.791Z] GC before operation: completed in 108.805 ms, heap usage 363.272 MB -> 70.096 MB. [2025-11-12T23:10:30.568Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1875.740 ms) ====== [2025-11-12T23:10:30.568Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-11-12T23:10:30.569Z] GC before operation: completed in 118.267 ms, heap usage 346.653 MB -> 89.394 MB. [2025-11-12T23:10:32.907Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1823.182 ms) ====== [2025-11-12T23:10:32.907Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-11-12T23:10:32.907Z] GC before operation: completed in 123.746 ms, heap usage 389.501 MB -> 70.120 MB. [2025-11-12T23:10:34.608Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1686.524 ms) ====== [2025-11-12T23:10:34.608Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-11-12T23:10:34.608Z] GC before operation: completed in 116.974 ms, heap usage 205.520 MB -> 70.699 MB. [2025-11-12T23:10:36.317Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1667.752 ms) ====== [2025-11-12T23:10:36.317Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-11-12T23:10:36.317Z] GC before operation: completed in 116.492 ms, heap usage 293.457 MB -> 70.475 MB. [2025-11-12T23:10:38.016Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1647.696 ms) ====== [2025-11-12T23:10:38.016Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-11-12T23:10:38.016Z] GC before operation: completed in 128.691 ms, heap usage 313.475 MB -> 98.242 MB. [2025-11-12T23:10:39.820Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1854.135 ms) ====== [2025-11-12T23:10:39.820Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-11-12T23:10:39.820Z] GC before operation: completed in 126.650 ms, heap usage 316.220 MB -> 90.145 MB. [2025-11-12T23:10:41.525Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1654.182 ms) ====== [2025-11-12T23:10:41.525Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-11-12T23:10:41.866Z] GC before operation: completed in 133.762 ms, heap usage 374.633 MB -> 98.413 MB. [2025-11-12T23:10:43.556Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1806.018 ms) ====== [2025-11-12T23:10:43.556Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-11-12T23:10:43.556Z] GC before operation: completed in 120.807 ms, heap usage 302.403 MB -> 79.090 MB. [2025-11-12T23:10:45.266Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1659.492 ms) ====== [2025-11-12T23:10:45.266Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-11-12T23:10:45.605Z] GC before operation: completed in 118.155 ms, heap usage 357.984 MB -> 71.120 MB. [2025-11-12T23:10:47.291Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1630.996 ms) ====== [2025-11-12T23:10:47.291Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-11-12T23:10:47.291Z] GC before operation: completed in 117.153 ms, heap usage 304.303 MB -> 71.195 MB. [2025-11-12T23:10:49.055Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1727.184 ms) ====== [2025-11-12T23:10:49.055Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-11-12T23:10:49.055Z] GC before operation: completed in 119.908 ms, heap usage 312.958 MB -> 79.702 MB. [2025-11-12T23:10:50.748Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1651.428 ms) ====== [2025-11-12T23:10:50.748Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-11-12T23:10:50.748Z] GC before operation: completed in 121.358 ms, heap usage 335.531 MB -> 79.849 MB. [2025-11-12T23:10:52.448Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1592.414 ms) ====== [2025-11-12T23:10:52.448Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-11-12T23:10:52.448Z] 23:10:52.358 WARN [block-manager-storage-async-thread-pool-29] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_359_piece0, which does not exist [2025-11-12T23:10:52.448Z] GC before operation: completed in 127.621 ms, heap usage 157.581 MB -> 99.036 MB. [2025-11-12T23:10:54.143Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1668.214 ms) ====== [2025-11-12T23:10:54.143Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-11-12T23:10:54.484Z] GC before operation: completed in 134.360 ms, heap usage 272.815 MB -> 99.310 MB. [2025-11-12T23:10:56.179Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1651.417 ms) ====== [2025-11-12T23:10:56.180Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-11-12T23:10:56.180Z] GC before operation: completed in 122.350 ms, heap usage 527.939 MB -> 72.001 MB. [2025-11-12T23:10:57.875Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1555.236 ms) ====== [2025-11-12T23:10:57.875Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-11-12T23:10:57.875Z] GC before operation: completed in 125.619 ms, heap usage 203.524 MB -> 80.239 MB. [2025-11-12T23:10:59.581Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1685.342 ms) ====== [2025-11-12T23:10:59.581Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-11-12T23:10:59.581Z] GC before operation: completed in 125.608 ms, heap usage 488.120 MB -> 72.055 MB. [2025-11-12T23:11:01.276Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1518.018 ms) ====== [2025-11-12T23:11:01.276Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-11-12T23:11:01.276Z] GC before operation: completed in 132.745 ms, heap usage 325.808 MB -> 91.407 MB. [2025-11-12T23:11:02.982Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1574.906 ms) ====== [2025-11-12T23:11:02.982Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-11-12T23:11:02.982Z] GC before operation: completed in 123.890 ms, heap usage 352.668 MB -> 72.229 MB. [2025-11-12T23:11:04.677Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1636.681 ms) ====== [2025-11-12T23:11:04.677Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-11-12T23:11:04.677Z] GC before operation: completed in 123.226 ms, heap usage 296.017 MB -> 72.357 MB. [2025-11-12T23:11:06.368Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1704.798 ms) ====== [2025-11-12T23:11:06.368Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-11-12T23:11:06.705Z] GC before operation: completed in 135.086 ms, heap usage 302.510 MB -> 91.787 MB. [2025-11-12T23:11:08.391Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1577.846 ms) ====== [2025-11-12T23:11:08.391Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-11-12T23:11:08.391Z] GC before operation: completed in 131.550 ms, heap usage 362.409 MB -> 72.511 MB. [2025-11-12T23:11:10.083Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1597.190 ms) ====== [2025-11-12T23:11:10.083Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-11-12T23:11:10.083Z] GC before operation: completed in 128.608 ms, heap usage 293.508 MB -> 72.780 MB. [2025-11-12T23:11:11.859Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1698.560 ms) ====== [2025-11-12T23:11:11.859Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-11-12T23:11:11.859Z] GC before operation: completed in 131.087 ms, heap usage 290.785 MB -> 81.066 MB. [2025-11-12T23:11:13.545Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1606.021 ms) ====== [2025-11-12T23:11:13.545Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-11-12T23:11:13.545Z] GC before operation: completed in 132.971 ms, heap usage 156.468 MB -> 80.592 MB. [2025-11-12T23:11:15.242Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1537.756 ms) ====== [2025-11-12T23:11:15.242Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-11-12T23:11:15.242Z] GC before operation: completed in 141.152 ms, heap usage 394.129 MB -> 92.237 MB. [2025-11-12T23:11:16.923Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1554.567 ms) ====== [2025-11-12T23:11:16.923Z] ----------------------------------- [2025-11-12T23:11:16.923Z] renaissance-dec-tree_0_PASSED [2025-11-12T23:11:16.923Z] ----------------------------------- [2025-11-12T23:11:16.923Z] [2025-11-12T23:11:16.923Z] TEST TEARDOWN: [2025-11-12T23:11:16.923Z] Nothing to be done for teardown. [2025-11-12T23:11:16.923Z] renaissance-dec-tree_0 Finish Time: Wed Nov 12 23:11:16 2025 Epoch Time (ms): 1762989076890