[2025-12-24T22:53:57.980Z] Running test renaissance-dec-tree_0 ... [2025-12-24T22:53:57.980Z] =============================================== [2025-12-24T22:53:57.980Z] renaissance-dec-tree_0 Start Time: Wed Dec 24 22:53:57 2025 Epoch Time (ms): 1766616837061 [2025-12-24T22:53:57.980Z] variation: NoOptions [2025-12-24T22:53:57.980Z] JVM_OPTIONS: [2025-12-24T22:53:57.980Z] { \ [2025-12-24T22:53:57.980Z] echo ""; echo "TEST SETUP:"; \ [2025-12-24T22:53:57.980Z] echo "Nothing to be done for setup."; \ [2025-12-24T22:53:57.981Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17666158943115/renaissance-dec-tree_0"; \ [2025-12-24T22:53:57.981Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17666158943115/renaissance-dec-tree_0"; \ [2025-12-24T22:53:57.981Z] echo ""; echo "TESTING:"; \ [2025-12-24T22:53:57.981Z] "/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_17666158943115/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-12-24T22:53:57.981Z] 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_17666158943115/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-24T22:53:57.981Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-24T22:53:57.981Z] echo "Nothing to be done for teardown."; \ [2025-12-24T22:53:57.981Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17666158943115/TestTargetResult"; [2025-12-24T22:53:57.981Z] [2025-12-24T22:53:57.981Z] TEST SETUP: [2025-12-24T22:53:57.981Z] Nothing to be done for setup. [2025-12-24T22:53:57.981Z] [2025-12-24T22:53:57.981Z] TESTING: [2025-12-24T22:54:03.947Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-12-24T22:54:06.233Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-12-24T22:54:06.233Z] GC before operation: completed in 62.552 ms, heap usage 44.458 MB -> 34.774 MB. [2025-12-24T22:54:22.201Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (14031.362 ms) ====== [2025-12-24T22:54:22.201Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-12-24T22:54:22.201Z] GC before operation: completed in 99.730 ms, heap usage 262.880 MB -> 67.769 MB. [2025-12-24T22:54:24.495Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3743.995 ms) ====== [2025-12-24T22:54:24.496Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-12-24T22:54:24.496Z] GC before operation: completed in 99.283 ms, heap usage 179.867 MB -> 67.706 MB. [2025-12-24T22:54:27.492Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2922.982 ms) ====== [2025-12-24T22:54:27.492Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-12-24T22:54:27.492Z] GC before operation: completed in 139.255 ms, heap usage 203.751 MB -> 68.591 MB. [2025-12-24T22:54:29.783Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2598.978 ms) ====== [2025-12-24T22:54:29.783Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-12-24T22:54:30.121Z] GC before operation: completed in 96.573 ms, heap usage 313.247 MB -> 68.605 MB. [2025-12-24T22:54:32.406Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2411.482 ms) ====== [2025-12-24T22:54:32.406Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-12-24T22:54:32.406Z] GC before operation: completed in 97.363 ms, heap usage 154.639 MB -> 68.477 MB. [2025-12-24T22:54:35.409Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2450.018 ms) ====== [2025-12-24T22:54:35.409Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-12-24T22:54:35.409Z] GC before operation: completed in 111.959 ms, heap usage 383.131 MB -> 68.999 MB. [2025-12-24T22:54:37.095Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2143.217 ms) ====== [2025-12-24T22:54:37.095Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-12-24T22:54:37.431Z] GC before operation: completed in 101.562 ms, heap usage 242.010 MB -> 69.044 MB. [2025-12-24T22:54:39.744Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2201.232 ms) ====== [2025-12-24T22:54:39.744Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-12-24T22:54:39.744Z] GC before operation: completed in 111.198 ms, heap usage 131.346 MB -> 77.215 MB. [2025-12-24T22:54:41.537Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1994.024 ms) ====== [2025-12-24T22:54:41.537Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-12-24T22:54:41.921Z] GC before operation: completed in 115.673 ms, heap usage 143.253 MB -> 69.182 MB. [2025-12-24T22:54:43.608Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2046.310 ms) ====== [2025-12-24T22:54:43.608Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-12-24T22:54:43.945Z] GC before operation: completed in 106.626 ms, heap usage 286.245 MB -> 69.655 MB. [2025-12-24T22:54:46.250Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1972.945 ms) ====== [2025-12-24T22:54:46.250Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-12-24T22:54:46.250Z] GC before operation: completed in 111.325 ms, heap usage 292.129 MB -> 78.225 MB. [2025-12-24T22:54:48.546Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2205.714 ms) ====== [2025-12-24T22:54:48.546Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-12-24T22:54:48.546Z] GC before operation: completed in 114.754 ms, heap usage 310.227 MB -> 69.884 MB. [2025-12-24T22:54:50.236Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2096.518 ms) ====== [2025-12-24T22:54:50.236Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-12-24T22:54:50.575Z] GC before operation: completed in 106.369 ms, heap usage 119.771 MB -> 69.288 MB. [2025-12-24T22:54:52.259Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1783.524 ms) ====== [2025-12-24T22:54:52.259Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-12-24T22:54:52.259Z] GC before operation: completed in 110.639 ms, heap usage 231.542 MB -> 69.947 MB. [2025-12-24T22:54:54.547Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1863.680 ms) ====== [2025-12-24T22:54:54.547Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-12-24T22:54:54.547Z] GC before operation: completed in 109.149 ms, heap usage 127.797 MB -> 69.893 MB. [2025-12-24T22:54:56.232Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1881.030 ms) ====== [2025-12-24T22:54:56.232Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-12-24T22:54:56.232Z] GC before operation: completed in 112.698 ms, heap usage 244.984 MB -> 70.415 MB. [2025-12-24T22:54:57.920Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1698.606 ms) ====== [2025-12-24T22:54:57.920Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-12-24T22:54:58.258Z] GC before operation: completed in 117.588 ms, heap usage 104.836 MB -> 69.927 MB. [2025-12-24T22:54:59.945Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1699.858 ms) ====== [2025-12-24T22:54:59.945Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-12-24T22:54:59.945Z] GC before operation: completed in 114.745 ms, heap usage 169.510 MB -> 70.659 MB. [2025-12-24T22:55:01.972Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1823.497 ms) ====== [2025-12-24T22:55:01.972Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-12-24T22:55:01.972Z] GC before operation: completed in 113.851 ms, heap usage 352.041 MB -> 70.727 MB. [2025-12-24T22:55:03.665Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1776.338 ms) ====== [2025-12-24T22:55:03.665Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-12-24T22:55:03.665Z] GC before operation: completed in 121.646 ms, heap usage 253.711 MB -> 98.504 MB. [2025-12-24T22:55:05.353Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1640.746 ms) ====== [2025-12-24T22:55:05.353Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-12-24T22:55:05.691Z] GC before operation: completed in 129.323 ms, heap usage 403.848 MB -> 98.472 MB. [2025-12-24T22:55:05.691Z] 22:55:05.414 WARN [block-manager-storage-async-thread-pool-96] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1005_0, which does not exist [2025-12-24T22:55:07.383Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1680.477 ms) ====== [2025-12-24T22:55:07.383Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-12-24T22:55:07.383Z] GC before operation: completed in 113.520 ms, heap usage 228.894 MB -> 71.153 MB. [2025-12-24T22:55:09.076Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1686.161 ms) ====== [2025-12-24T22:55:09.076Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-12-24T22:55:09.076Z] GC before operation: completed in 122.838 ms, heap usage 226.936 MB -> 90.772 MB. [2025-12-24T22:55:10.770Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1709.530 ms) ====== [2025-12-24T22:55:10.770Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-12-24T22:55:11.107Z] GC before operation: completed in 126.187 ms, heap usage 476.017 MB -> 79.731 MB. [2025-12-24T22:55:12.789Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1590.368 ms) ====== [2025-12-24T22:55:12.789Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-12-24T22:55:12.789Z] GC before operation: completed in 126.603 ms, heap usage 269.517 MB -> 99.131 MB. [2025-12-24T22:55:14.478Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1679.113 ms) ====== [2025-12-24T22:55:14.478Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-12-24T22:55:14.478Z] GC before operation: completed in 122.928 ms, heap usage 396.831 MB -> 71.543 MB. [2025-12-24T22:55:16.174Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1598.807 ms) ====== [2025-12-24T22:55:16.174Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-12-24T22:55:16.174Z] GC before operation: completed in 122.389 ms, heap usage 253.918 MB -> 80.219 MB. [2025-12-24T22:55:17.865Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1665.430 ms) ====== [2025-12-24T22:55:17.865Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-12-24T22:55:18.204Z] GC before operation: completed in 122.407 ms, heap usage 261.530 MB -> 71.789 MB. [2025-12-24T22:55:19.966Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1596.158 ms) ====== [2025-12-24T22:55:19.966Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-12-24T22:55:19.966Z] GC before operation: completed in 129.285 ms, heap usage 388.184 MB -> 80.216 MB. [2025-12-24T22:55:21.650Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1655.841 ms) ====== [2025-12-24T22:55:21.650Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-12-24T22:55:21.650Z] GC before operation: completed in 131.973 ms, heap usage 254.829 MB -> 71.933 MB. [2025-12-24T22:55:23.340Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1564.311 ms) ====== [2025-12-24T22:55:23.340Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-12-24T22:55:23.340Z] GC before operation: completed in 126.621 ms, heap usage 378.328 MB -> 72.069 MB. [2025-12-24T22:55:25.030Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1642.612 ms) ====== [2025-12-24T22:55:25.030Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-12-24T22:55:25.030Z] GC before operation: completed in 141.945 ms, heap usage 377.069 MB -> 99.684 MB. [2025-12-24T22:55:26.721Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1650.697 ms) ====== [2025-12-24T22:55:26.721Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-12-24T22:55:26.721Z] GC before operation: completed in 128.968 ms, heap usage 221.824 MB -> 99.973 MB. [2025-12-24T22:55:29.019Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1746.527 ms) ====== [2025-12-24T22:55:29.019Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-12-24T22:55:29.019Z] GC before operation: completed in 128.234 ms, heap usage 196.544 MB -> 91.468 MB. [2025-12-24T22:55:30.712Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1731.901 ms) ====== [2025-12-24T22:55:30.712Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-12-24T22:55:30.712Z] GC before operation: completed in 134.370 ms, heap usage 510.469 MB -> 92.109 MB. [2025-12-24T22:55:30.712Z] 22:55:30.402 WARN [block-manager-storage-async-thread-pool-18] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1677_0, which does not exist [2025-12-24T22:55:32.399Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1563.742 ms) ====== [2025-12-24T22:55:32.399Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-12-24T22:55:32.399Z] GC before operation: completed in 132.682 ms, heap usage 302.729 MB -> 91.725 MB. [2025-12-24T22:55:34.089Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1553.497 ms) ====== [2025-12-24T22:55:34.089Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-12-24T22:55:34.089Z] GC before operation: completed in 129.308 ms, heap usage 287.725 MB -> 81.076 MB. [2025-12-24T22:55:35.781Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1706.588 ms) ====== [2025-12-24T22:55:35.781Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-12-24T22:55:35.781Z] GC before operation: completed in 140.281 ms, heap usage 414.998 MB -> 100.246 MB. [2025-12-24T22:55:35.781Z] 22:55:35.634 WARN [block-manager-storage-async-thread-pool-42] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1821_1, which does not exist [2025-12-24T22:55:37.495Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1545.345 ms) ====== [2025-12-24T22:55:37.495Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-12-24T22:55:37.495Z] GC before operation: completed in 138.168 ms, heap usage 375.632 MB -> 100.469 MB. [2025-12-24T22:55:39.183Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1513.846 ms) ====== [2025-12-24T22:55:39.183Z] ----------------------------------- [2025-12-24T22:55:39.183Z] renaissance-dec-tree_0_PASSED [2025-12-24T22:55:39.183Z] ----------------------------------- [2025-12-24T22:55:39.183Z] [2025-12-24T22:55:39.183Z] TEST TEARDOWN: [2025-12-24T22:55:39.183Z] Nothing to be done for teardown. [2025-12-24T22:55:39.183Z] renaissance-dec-tree_0 Finish Time: Wed Dec 24 22:55:39 2025 Epoch Time (ms): 1766616939125