[2026-02-04T23:09:22.783Z] Running test renaissance-dec-tree_0 ... [2026-02-04T23:09:22.783Z] =============================================== [2026-02-04T23:09:23.574Z] renaissance-dec-tree_0 Start Time: Wed Feb 4 23:09:22 2026 Epoch Time (ms): 1770246562688 [2026-02-04T23:09:23.574Z] variation: NoOptions [2026-02-04T23:09:23.574Z] JVM_OPTIONS: [2026-02-04T23:09:23.574Z] { \ [2026-02-04T23:09:23.574Z] echo ""; echo "TEST SETUP:"; \ [2026-02-04T23:09:23.574Z] echo "Nothing to be done for setup."; \ [2026-02-04T23:09:23.574Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17702455819805/renaissance-dec-tree_0"; \ [2026-02-04T23:09:23.574Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17702455819805/renaissance-dec-tree_0"; \ [2026-02-04T23:09:23.574Z] echo ""; echo "TESTING:"; \ [2026-02-04T23:09:23.574Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/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_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17702455819805/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-02-04T23:09:23.574Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17702455819805/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-04T23:09:23.574Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-04T23:09:23.574Z] echo "Nothing to be done for teardown."; \ [2026-02-04T23:09:23.574Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17702455819805/TestTargetResult"; [2026-02-04T23:09:23.574Z] [2026-02-04T23:09:23.574Z] TEST SETUP: [2026-02-04T23:09:23.574Z] Nothing to be done for setup. [2026-02-04T23:09:23.574Z] [2026-02-04T23:09:23.574Z] TESTING: [2026-02-04T23:10:12.188Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 16) threads. [2026-02-04T23:10:20.547Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-02-04T23:10:20.547Z] GC before operation: completed in 78.118 ms, heap usage 45.534 MB -> 34.574 MB. [2026-02-04T23:10:36.801Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15395.042 ms) ====== [2026-02-04T23:10:36.801Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-02-04T23:10:36.801Z] GC before operation: completed in 158.290 ms, heap usage 164.297 MB -> 70.365 MB. [2026-02-04T23:10:39.294Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2646.916 ms) ====== [2026-02-04T23:10:39.294Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-02-04T23:10:39.294Z] GC before operation: completed in 153.035 ms, heap usage 199.775 MB -> 70.651 MB. [2026-02-04T23:10:40.902Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2119.328 ms) ====== [2026-02-04T23:10:40.902Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-02-04T23:10:40.902Z] GC before operation: completed in 157.291 ms, heap usage 335.714 MB -> 71.178 MB. [2026-02-04T23:10:43.389Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2038.214 ms) ====== [2026-02-04T23:10:43.389Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-02-04T23:10:43.389Z] GC before operation: completed in 148.326 ms, heap usage 357.253 MB -> 82.306 MB. [2026-02-04T23:10:44.984Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1901.379 ms) ====== [2026-02-04T23:10:44.984Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-02-04T23:10:45.762Z] GC before operation: completed in 156.832 ms, heap usage 323.911 MB -> 88.218 MB. [2026-02-04T23:10:47.368Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1901.646 ms) ====== [2026-02-04T23:10:47.368Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-02-04T23:10:47.368Z] GC before operation: completed in 167.486 ms, heap usage 261.969 MB -> 71.714 MB. [2026-02-04T23:10:49.851Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1902.760 ms) ====== [2026-02-04T23:10:49.851Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-02-04T23:10:49.851Z] GC before operation: completed in 175.556 ms, heap usage 124.429 MB -> 71.675 MB. [2026-02-04T23:10:51.449Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1899.729 ms) ====== [2026-02-04T23:10:51.449Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-02-04T23:10:51.449Z] GC before operation: completed in 179.530 ms, heap usage 649.914 MB -> 94.524 MB. [2026-02-04T23:10:53.960Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1911.886 ms) ====== [2026-02-04T23:10:53.960Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-02-04T23:10:53.960Z] GC before operation: completed in 187.794 ms, heap usage 218.831 MB -> 71.856 MB. [2026-02-04T23:10:55.566Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1832.753 ms) ====== [2026-02-04T23:10:55.566Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-02-04T23:10:55.566Z] GC before operation: completed in 179.109 ms, heap usage 541.008 MB -> 89.005 MB. [2026-02-04T23:10:57.355Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1751.402 ms) ====== [2026-02-04T23:10:57.355Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-02-04T23:10:58.142Z] GC before operation: completed in 185.429 ms, heap usage 452.941 MB -> 78.183 MB. [2026-02-04T23:10:59.795Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1790.842 ms) ====== [2026-02-04T23:10:59.795Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-02-04T23:10:59.795Z] GC before operation: completed in 185.238 ms, heap usage 120.303 MB -> 83.069 MB. [2026-02-04T23:11:01.400Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1822.469 ms) ====== [2026-02-04T23:11:01.400Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-02-04T23:11:01.400Z] GC before operation: completed in 206.993 ms, heap usage 468.443 MB -> 94.811 MB. [2026-02-04T23:11:03.937Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1945.460 ms) ====== [2026-02-04T23:11:03.937Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-02-04T23:11:03.937Z] GC before operation: completed in 194.859 ms, heap usage 400.282 MB -> 84.054 MB. [2026-02-04T23:11:05.572Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1802.117 ms) ====== [2026-02-04T23:11:05.572Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-02-04T23:11:05.572Z] GC before operation: completed in 200.536 ms, heap usage 424.278 MB -> 72.877 MB. [2026-02-04T23:11:08.064Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1767.044 ms) ====== [2026-02-04T23:11:08.064Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-02-04T23:11:08.064Z] GC before operation: completed in 204.658 ms, heap usage 114.496 MB -> 72.366 MB. [2026-02-04T23:11:09.692Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1746.852 ms) ====== [2026-02-04T23:11:09.692Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-02-04T23:11:09.692Z] GC before operation: completed in 185.482 ms, heap usage 601.107 MB -> 84.218 MB. [2026-02-04T23:11:11.301Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1725.874 ms) ====== [2026-02-04T23:11:11.301Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-02-04T23:11:12.111Z] GC before operation: completed in 213.715 ms, heap usage 460.501 MB -> 89.678 MB. [2026-02-04T23:11:13.726Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1738.372 ms) ====== [2026-02-04T23:11:13.726Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-02-04T23:11:13.726Z] GC before operation: completed in 214.488 ms, heap usage 428.701 MB -> 84.206 MB. [2026-02-04T23:11:15.325Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1753.966 ms) ====== [2026-02-04T23:11:15.325Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-02-04T23:11:15.325Z] GC before operation: completed in 216.444 ms, heap usage 447.491 MB -> 95.420 MB. [2026-02-04T23:11:17.811Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1750.597 ms) ====== [2026-02-04T23:11:17.811Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-02-04T23:11:17.811Z] GC before operation: completed in 210.812 ms, heap usage 435.722 MB -> 84.420 MB. [2026-02-04T23:11:19.411Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1795.381 ms) ====== [2026-02-04T23:11:19.411Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-02-04T23:11:19.411Z] GC before operation: completed in 213.098 ms, heap usage 450.628 MB -> 90.174 MB. [2026-02-04T23:11:21.907Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1743.757 ms) ====== [2026-02-04T23:11:21.907Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-02-04T23:11:21.907Z] GC before operation: completed in 218.616 ms, heap usage 431.165 MB -> 90.438 MB. [2026-02-04T23:11:23.507Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1735.053 ms) ====== [2026-02-04T23:11:23.507Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-02-04T23:11:23.507Z] GC before operation: completed in 209.967 ms, heap usage 453.069 MB -> 90.375 MB. [2026-02-04T23:11:25.115Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1699.000 ms) ====== [2026-02-04T23:11:25.115Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-02-04T23:11:25.115Z] GC before operation: completed in 195.510 ms, heap usage 429.276 MB -> 90.608 MB. [2026-02-04T23:11:27.622Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1721.194 ms) ====== [2026-02-04T23:11:27.622Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-02-04T23:11:27.622Z] GC before operation: completed in 213.611 ms, heap usage 430.805 MB -> 84.956 MB. [2026-02-04T23:11:29.228Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1695.009 ms) ====== [2026-02-04T23:11:29.228Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-02-04T23:11:29.228Z] GC before operation: completed in 197.835 ms, heap usage 447.598 MB -> 74.174 MB. [2026-02-04T23:11:31.052Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1695.462 ms) ====== [2026-02-04T23:11:31.052Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-02-04T23:11:31.052Z] GC before operation: completed in 197.422 ms, heap usage 113.880 MB -> 84.546 MB. [2026-02-04T23:11:32.659Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1724.212 ms) ====== [2026-02-04T23:11:32.659Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-02-04T23:11:33.441Z] GC before operation: completed in 218.823 ms, heap usage 515.385 MB -> 85.442 MB. [2026-02-04T23:11:35.055Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1687.105 ms) ====== [2026-02-04T23:11:35.055Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-02-04T23:11:35.055Z] GC before operation: completed in 211.067 ms, heap usage 449.830 MB -> 85.380 MB. [2026-02-04T23:11:36.659Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1681.699 ms) ====== [2026-02-04T23:11:36.659Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-02-04T23:11:36.659Z] GC before operation: completed in 209.508 ms, heap usage 447.953 MB -> 91.249 MB. [2026-02-04T23:11:39.162Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1735.601 ms) ====== [2026-02-04T23:11:39.162Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-02-04T23:11:39.162Z] GC before operation: completed in 217.083 ms, heap usage 430.953 MB -> 74.708 MB. [2026-02-04T23:11:40.778Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1683.006 ms) ====== [2026-02-04T23:11:40.778Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-02-04T23:11:40.778Z] GC before operation: completed in 213.916 ms, heap usage 514.704 MB -> 91.533 MB. [2026-02-04T23:11:40.778Z] 23:11:40.348 WARN [block-manager-storage-async-thread-pool-30] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_461, which does not exist [2026-02-04T23:11:42.388Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1698.884 ms) ====== [2026-02-04T23:11:42.388Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-02-04T23:11:42.388Z] GC before operation: completed in 229.580 ms, heap usage 457.085 MB -> 91.701 MB. [2026-02-04T23:11:44.900Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1776.956 ms) ====== [2026-02-04T23:11:44.900Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-02-04T23:11:44.900Z] GC before operation: completed in 187.784 ms, heap usage 429.768 MB -> 86.065 MB. [2026-02-04T23:11:44.900Z] 23:11:44.208 WARN [block-manager-storage-async-thread-pool-80] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1677_2, which does not exist [2026-02-04T23:11:46.501Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1720.115 ms) ====== [2026-02-04T23:11:46.501Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-02-04T23:11:46.501Z] GC before operation: completed in 207.678 ms, heap usage 447.959 MB -> 86.316 MB. [2026-02-04T23:11:48.097Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1714.090 ms) ====== [2026-02-04T23:11:48.097Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-02-04T23:11:48.877Z] GC before operation: completed in 187.965 ms, heap usage 448.907 MB -> 86.300 MB. [2026-02-04T23:11:50.485Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1723.262 ms) ====== [2026-02-04T23:11:50.485Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-02-04T23:11:50.485Z] GC before operation: completed in 207.610 ms, heap usage 448.885 MB -> 75.499 MB. [2026-02-04T23:11:52.092Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1653.706 ms) ====== [2026-02-04T23:11:52.092Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-02-04T23:11:52.092Z] GC before operation: completed in 177.894 ms, heap usage 514.438 MB -> 86.679 MB. [2026-02-04T23:11:53.701Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1621.773 ms) ====== [2026-02-04T23:11:54.476Z] ----------------------------------- [2026-02-04T23:11:54.476Z] renaissance-dec-tree_0_PASSED [2026-02-04T23:11:54.476Z] ----------------------------------- [2026-02-04T23:11:54.476Z] [2026-02-04T23:11:54.476Z] TEST TEARDOWN: [2026-02-04T23:11:54.476Z] Nothing to be done for teardown. [2026-02-04T23:11:54.476Z] renaissance-dec-tree_0 Finish Time: Wed Feb 4 23:11:53 2026 Epoch Time (ms): 1770246713981