[2026-02-26T14:32:59.608Z] Running test renaissance-dec-tree_0 ... [2026-02-26T14:32:59.608Z] =============================================== [2026-02-26T14:32:59.608Z] renaissance-dec-tree_0 Start Time: Thu Feb 26 14:32:58 2026 Epoch Time (ms): 1772116378847 [2026-02-26T14:32:59.608Z] variation: NoOptions [2026-02-26T14:32:59.608Z] JVM_OPTIONS: [2026-02-26T14:32:59.608Z] { \ [2026-02-26T14:32:59.608Z] echo ""; echo "TEST SETUP:"; \ [2026-02-26T14:32:59.608Z] echo "Nothing to be done for setup."; \ [2026-02-26T14:32:59.608Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17721159293204/renaissance-dec-tree_0"; \ [2026-02-26T14:32:59.608Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17721159293204/renaissance-dec-tree_0"; \ [2026-02-26T14:32:59.608Z] echo ""; echo "TESTING:"; \ [2026-02-26T14:32:59.608Z] "/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_17721159293204/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-02-26T14:32:59.608Z] 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_17721159293204/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-26T14:32:59.608Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-26T14:32:59.608Z] echo "Nothing to be done for teardown."; \ [2026-02-26T14:32:59.608Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17721159293204/TestTargetResult"; [2026-02-26T14:32:59.608Z] [2026-02-26T14:32:59.608Z] TEST SETUP: [2026-02-26T14:32:59.608Z] Nothing to be done for setup. [2026-02-26T14:32:59.608Z] [2026-02-26T14:32:59.608Z] TESTING: [2026-02-26T14:33:06.507Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2026-02-26T14:33:09.956Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-02-26T14:33:09.956Z] GC before operation: completed in 70.909 ms, heap usage 56.435 MB -> 34.656 MB. [2026-02-26T14:33:21.698Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10307.337 ms) ====== [2026-02-26T14:33:21.698Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-02-26T14:33:21.698Z] GC before operation: completed in 130.582 ms, heap usage 321.912 MB -> 70.987 MB. [2026-02-26T14:33:22.472Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2058.781 ms) ====== [2026-02-26T14:33:22.472Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-02-26T14:33:22.472Z] GC before operation: completed in 109.179 ms, heap usage 250.422 MB -> 71.279 MB. [2026-02-26T14:33:24.957Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1749.351 ms) ====== [2026-02-26T14:33:24.957Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-02-26T14:33:24.957Z] GC before operation: completed in 111.135 ms, heap usage 529.718 MB -> 71.846 MB. [2026-02-26T14:33:26.558Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1726.767 ms) ====== [2026-02-26T14:33:26.558Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-02-26T14:33:26.558Z] GC before operation: completed in 118.792 ms, heap usage 426.668 MB -> 71.750 MB. [2026-02-26T14:33:28.158Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1670.610 ms) ====== [2026-02-26T14:33:28.158Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-02-26T14:33:28.158Z] GC before operation: completed in 122.775 ms, heap usage 416.029 MB -> 72.192 MB. [2026-02-26T14:33:29.756Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1669.375 ms) ====== [2026-02-26T14:33:29.756Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-02-26T14:33:29.756Z] GC before operation: completed in 117.082 ms, heap usage 416.290 MB -> 83.168 MB. [2026-02-26T14:33:31.358Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1592.840 ms) ====== [2026-02-26T14:33:31.358Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-02-26T14:33:31.358Z] GC before operation: completed in 112.387 ms, heap usage 232.087 MB -> 72.259 MB. [2026-02-26T14:33:32.955Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1587.052 ms) ====== [2026-02-26T14:33:32.955Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-02-26T14:33:33.731Z] GC before operation: completed in 125.532 ms, heap usage 119.189 MB -> 71.750 MB. [2026-02-26T14:33:35.350Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1616.998 ms) ====== [2026-02-26T14:33:35.350Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-02-26T14:33:35.350Z] GC before operation: completed in 134.503 ms, heap usage 244.700 MB -> 72.526 MB. [2026-02-26T14:33:36.966Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1589.145 ms) ====== [2026-02-26T14:33:36.966Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-02-26T14:33:36.966Z] GC before operation: completed in 135.874 ms, heap usage 604.722 MB -> 78.695 MB. [2026-02-26T14:33:38.592Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1564.765 ms) ====== [2026-02-26T14:33:38.592Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-02-26T14:33:38.592Z] GC before operation: completed in 131.679 ms, heap usage 311.122 MB -> 100.374 MB. [2026-02-26T14:33:40.217Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1552.123 ms) ====== [2026-02-26T14:33:40.217Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-02-26T14:33:40.217Z] GC before operation: completed in 139.802 ms, heap usage 220.216 MB -> 83.476 MB. [2026-02-26T14:33:41.834Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1538.655 ms) ====== [2026-02-26T14:33:41.834Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-02-26T14:33:41.834Z] GC before operation: completed in 129.151 ms, heap usage 338.312 MB -> 84.026 MB. [2026-02-26T14:33:43.454Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1522.624 ms) ====== [2026-02-26T14:33:43.454Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-02-26T14:33:43.454Z] GC before operation: completed in 143.630 ms, heap usage 247.842 MB -> 84.137 MB. [2026-02-26T14:33:45.074Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1518.045 ms) ====== [2026-02-26T14:33:45.074Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-02-26T14:33:45.074Z] GC before operation: completed in 140.030 ms, heap usage 281.721 MB -> 73.589 MB. [2026-02-26T14:33:46.695Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1533.817 ms) ====== [2026-02-26T14:33:46.695Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-02-26T14:33:46.695Z] GC before operation: completed in 147.323 ms, heap usage 303.797 MB -> 84.238 MB. [2026-02-26T14:33:48.293Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1513.719 ms) ====== [2026-02-26T14:33:48.293Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-02-26T14:33:48.293Z] GC before operation: completed in 149.162 ms, heap usage 279.170 MB -> 84.479 MB. [2026-02-26T14:33:49.891Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1519.875 ms) ====== [2026-02-26T14:33:49.891Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-02-26T14:33:50.671Z] GC before operation: completed in 149.761 ms, heap usage 283.414 MB -> 84.591 MB. [2026-02-26T14:33:51.451Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1488.433 ms) ====== [2026-02-26T14:33:51.451Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-02-26T14:33:52.223Z] GC before operation: completed in 146.866 ms, heap usage 280.322 MB -> 84.718 MB. [2026-02-26T14:33:53.896Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1540.340 ms) ====== [2026-02-26T14:33:53.896Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-02-26T14:33:53.896Z] GC before operation: completed in 148.415 ms, heap usage 549.649 MB -> 96.177 MB. [2026-02-26T14:33:55.497Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1510.632 ms) ====== [2026-02-26T14:33:55.497Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-02-26T14:33:55.497Z] GC before operation: completed in 145.407 ms, heap usage 521.649 MB -> 84.940 MB. [2026-02-26T14:33:57.099Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1509.198 ms) ====== [2026-02-26T14:33:57.099Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-02-26T14:33:57.099Z] GC before operation: completed in 147.917 ms, heap usage 320.107 MB -> 90.525 MB. [2026-02-26T14:33:58.723Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1486.720 ms) ====== [2026-02-26T14:33:58.723Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-02-26T14:33:58.723Z] GC before operation: completed in 150.105 ms, heap usage 248.014 MB -> 79.905 MB. [2026-02-26T14:34:00.328Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1511.152 ms) ====== [2026-02-26T14:34:00.328Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-02-26T14:34:00.329Z] GC before operation: completed in 143.024 ms, heap usage 273.019 MB -> 90.818 MB. [2026-02-26T14:34:01.944Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1494.124 ms) ====== [2026-02-26T14:34:01.944Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-02-26T14:34:01.944Z] GC before operation: completed in 142.168 ms, heap usage 458.905 MB -> 91.001 MB. [2026-02-26T14:34:03.554Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1509.325 ms) ====== [2026-02-26T14:34:03.554Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-02-26T14:34:03.554Z] GC before operation: completed in 160.573 ms, heap usage 583.156 MB -> 102.028 MB. [2026-02-26T14:34:05.170Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1461.131 ms) ====== [2026-02-26T14:34:05.170Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-02-26T14:34:05.170Z] GC before operation: completed in 157.508 ms, heap usage 257.546 MB -> 85.800 MB. [2026-02-26T14:34:05.170Z] 14:34:04.688 WARN [block-manager-storage-async-thread-pool-24] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_373, which does not exist [2026-02-26T14:34:06.779Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1526.044 ms) ====== [2026-02-26T14:34:06.779Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-02-26T14:34:06.779Z] GC before operation: completed in 158.987 ms, heap usage 412.064 MB -> 85.673 MB. [2026-02-26T14:34:08.382Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1511.934 ms) ====== [2026-02-26T14:34:08.382Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-02-26T14:34:08.382Z] GC before operation: completed in 149.483 ms, heap usage 317.259 MB -> 86.039 MB. [2026-02-26T14:34:10.056Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1479.820 ms) ====== [2026-02-26T14:34:10.056Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-02-26T14:34:10.056Z] GC before operation: completed in 177.305 ms, heap usage 549.095 MB -> 91.625 MB. [2026-02-26T14:34:11.667Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1468.245 ms) ====== [2026-02-26T14:34:11.667Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-02-26T14:34:11.667Z] GC before operation: completed in 138.619 ms, heap usage 248.723 MB -> 80.379 MB. [2026-02-26T14:34:13.281Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1469.028 ms) ====== [2026-02-26T14:34:13.281Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-02-26T14:34:13.281Z] GC before operation: completed in 137.321 ms, heap usage 314.813 MB -> 75.075 MB. [2026-02-26T14:34:14.884Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1465.869 ms) ====== [2026-02-26T14:34:14.884Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-02-26T14:34:14.884Z] GC before operation: completed in 136.264 ms, heap usage 304.936 MB -> 91.657 MB. [2026-02-26T14:34:16.488Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1423.566 ms) ====== [2026-02-26T14:34:16.488Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-02-26T14:34:16.488Z] GC before operation: completed in 152.825 ms, heap usage 517.100 MB -> 91.853 MB. [2026-02-26T14:34:18.148Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1434.223 ms) ====== [2026-02-26T14:34:18.148Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-02-26T14:34:18.148Z] GC before operation: completed in 150.210 ms, heap usage 553.421 MB -> 92.174 MB. [2026-02-26T14:34:19.743Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1430.427 ms) ====== [2026-02-26T14:34:19.743Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-02-26T14:34:19.743Z] GC before operation: completed in 143.730 ms, heap usage 556.187 MB -> 86.787 MB. [2026-02-26T14:34:21.350Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1419.999 ms) ====== [2026-02-26T14:34:21.350Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-02-26T14:34:21.350Z] GC before operation: completed in 143.236 ms, heap usage 552.370 MB -> 92.317 MB. [2026-02-26T14:34:22.948Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1433.692 ms) ====== [2026-02-26T14:34:22.948Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-02-26T14:34:22.948Z] GC before operation: completed in 136.935 ms, heap usage 517.543 MB -> 92.222 MB. [2026-02-26T14:34:22.948Z] 14:34:22.376 WARN [block-manager-storage-async-thread-pool-89] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1821_1, which does not exist [2026-02-26T14:34:24.572Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1416.948 ms) ====== [2026-02-26T14:34:24.572Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-02-26T14:34:24.572Z] GC before operation: completed in 140.921 ms, heap usage 556.295 MB -> 92.554 MB. [2026-02-26T14:34:26.171Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1423.312 ms) ====== [2026-02-26T14:34:26.171Z] ----------------------------------- [2026-02-26T14:34:26.171Z] renaissance-dec-tree_0_PASSED [2026-02-26T14:34:26.171Z] ----------------------------------- [2026-02-26T14:34:26.171Z] [2026-02-26T14:34:26.171Z] TEST TEARDOWN: [2026-02-26T14:34:26.171Z] Nothing to be done for teardown. [2026-02-26T14:34:26.171Z] renaissance-dec-tree_0 Finish Time: Thu Feb 26 14:34:25 2026 Epoch Time (ms): 1772116465754