[2026-04-23T14:53:15.159Z] Running test renaissance-dec-tree_0 ... [2026-04-23T14:53:15.159Z] =============================================== [2026-04-23T14:53:15.159Z] renaissance-dec-tree_0 Start Time: Thu Apr 23 14:53:14 2026 Epoch Time (ms): 1776955994636 [2026-04-23T14:53:15.159Z] variation: NoOptions [2026-04-23T14:53:15.159Z] JVM_OPTIONS: [2026-04-23T14:53:15.159Z] { \ [2026-04-23T14:53:15.159Z] echo ""; echo "TEST SETUP:"; \ [2026-04-23T14:53:15.159Z] echo "Nothing to be done for setup."; \ [2026-04-23T14:53:15.159Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/renaissance-dec-tree_0"; \ [2026-04-23T14:53:15.159Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/renaissance-dec-tree_0"; \ [2026-04-23T14:53:15.159Z] echo ""; echo "TESTING:"; \ [2026-04-23T14:53:15.159Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-04-23T14:53:15.159Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-23T14:53:15.159Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-23T14:53:15.159Z] echo "Nothing to be done for teardown."; \ [2026-04-23T14:53:15.159Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769549632582/TestTargetResult"; [2026-04-23T14:53:15.159Z] [2026-04-23T14:53:15.159Z] TEST SETUP: [2026-04-23T14:53:15.159Z] Nothing to be done for setup. [2026-04-23T14:53:15.159Z] [2026-04-23T14:53:15.159Z] TESTING: [2026-04-23T14:53:21.083Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-04-23T14:53:22.417Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-04-23T14:53:22.417Z] GC before operation: completed in 50.148 ms, heap usage 55.007 MB -> 35.050 MB. [2026-04-23T14:53:32.772Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9666.175 ms) ====== [2026-04-23T14:53:32.772Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-04-23T14:53:32.772Z] GC before operation: completed in 110.876 ms, heap usage 248.469 MB -> 95.696 MB. [2026-04-23T14:53:35.654Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2921.348 ms) ====== [2026-04-23T14:53:35.654Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-04-23T14:53:35.654Z] GC before operation: completed in 126.330 ms, heap usage 295.608 MB -> 87.848 MB. [2026-04-23T14:53:37.711Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2431.075 ms) ====== [2026-04-23T14:53:37.712Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-04-23T14:53:37.712Z] GC before operation: completed in 110.542 ms, heap usage 299.659 MB -> 68.881 MB. [2026-04-23T14:53:40.581Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2508.308 ms) ====== [2026-04-23T14:53:40.581Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-04-23T14:53:40.581Z] GC before operation: completed in 114.559 ms, heap usage 265.139 MB -> 68.874 MB. [2026-04-23T14:53:42.699Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2257.981 ms) ====== [2026-04-23T14:53:42.699Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-04-23T14:53:42.699Z] GC before operation: completed in 141.293 ms, heap usage 191.764 MB -> 69.194 MB. [2026-04-23T14:53:44.767Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2027.826 ms) ====== [2026-04-23T14:53:44.767Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-04-23T14:53:44.767Z] GC before operation: completed in 113.813 ms, heap usage 207.504 MB -> 69.414 MB. [2026-04-23T14:53:46.865Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1980.762 ms) ====== [2026-04-23T14:53:46.865Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-04-23T14:53:46.865Z] GC before operation: completed in 104.217 ms, heap usage 175.778 MB -> 69.533 MB. [2026-04-23T14:53:48.926Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2072.476 ms) ====== [2026-04-23T14:53:48.926Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-04-23T14:53:49.570Z] GC before operation: completed in 128.716 ms, heap usage 299.213 MB -> 69.665 MB. [2026-04-23T14:53:51.635Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1987.220 ms) ====== [2026-04-23T14:53:51.635Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-04-23T14:53:51.635Z] GC before operation: completed in 123.344 ms, heap usage 306.939 MB -> 78.355 MB. [2026-04-23T14:53:53.726Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2187.053 ms) ====== [2026-04-23T14:53:53.726Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-04-23T14:53:53.726Z] GC before operation: completed in 114.022 ms, heap usage 300.410 MB -> 70.076 MB. [2026-04-23T14:53:55.791Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2093.214 ms) ====== [2026-04-23T14:53:55.791Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-04-23T14:53:55.791Z] GC before operation: completed in 117.186 ms, heap usage 72.647 MB -> 70.007 MB. [2026-04-23T14:53:57.876Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2133.053 ms) ====== [2026-04-23T14:53:57.876Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-04-23T14:53:58.503Z] GC before operation: completed in 135.152 ms, heap usage 351.693 MB -> 89.597 MB. [2026-04-23T14:54:00.567Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2117.677 ms) ====== [2026-04-23T14:54:00.567Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-04-23T14:54:00.567Z] GC before operation: completed in 123.890 ms, heap usage 158.764 MB -> 97.983 MB. [2026-04-23T14:54:01.923Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1727.140 ms) ====== [2026-04-23T14:54:01.923Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-04-23T14:54:02.569Z] GC before operation: completed in 147.214 ms, heap usage 272.069 MB -> 89.842 MB. [2026-04-23T14:54:04.650Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1878.278 ms) ====== [2026-04-23T14:54:04.650Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-04-23T14:54:04.650Z] GC before operation: completed in 144.877 ms, heap usage 155.622 MB -> 89.194 MB. [2026-04-23T14:54:06.164Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2040.520 ms) ====== [2026-04-23T14:54:06.164Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-04-23T14:54:06.792Z] GC before operation: completed in 118.830 ms, heap usage 219.164 MB -> 70.858 MB. [2026-04-23T14:54:08.118Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1796.478 ms) ====== [2026-04-23T14:54:08.118Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-04-23T14:54:08.753Z] GC before operation: completed in 119.561 ms, heap usage 147.786 MB -> 70.473 MB. [2026-04-23T14:54:10.065Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1730.634 ms) ====== [2026-04-23T14:54:10.066Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-04-23T14:54:10.066Z] GC before operation: completed in 149.640 ms, heap usage 342.271 MB -> 90.439 MB. [2026-04-23T14:54:12.141Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1944.404 ms) ====== [2026-04-23T14:54:12.141Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-04-23T14:54:12.141Z] GC before operation: completed in 154.056 ms, heap usage 144.693 MB -> 70.833 MB. [2026-04-23T14:54:14.207Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1957.048 ms) ====== [2026-04-23T14:54:14.207Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-04-23T14:54:14.836Z] GC before operation: completed in 153.411 ms, heap usage 288.428 MB -> 99.101 MB. [2026-04-23T14:54:16.168Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1773.427 ms) ====== [2026-04-23T14:54:16.168Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-04-23T14:54:16.868Z] GC before operation: completed in 163.343 ms, heap usage 247.145 MB -> 98.902 MB. [2026-04-23T14:54:18.203Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1924.644 ms) ====== [2026-04-23T14:54:18.203Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-04-23T14:54:18.873Z] GC before operation: completed in 148.463 ms, heap usage 320.980 MB -> 99.134 MB. [2026-04-23T14:54:20.282Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1817.886 ms) ====== [2026-04-23T14:54:20.282Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-04-23T14:54:20.282Z] GC before operation: completed in 168.950 ms, heap usage 245.244 MB -> 71.654 MB. [2026-04-23T14:54:22.462Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1937.408 ms) ====== [2026-04-23T14:54:22.462Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-04-23T14:54:22.462Z] GC before operation: completed in 155.657 ms, heap usage 150.658 MB -> 71.619 MB. [2026-04-23T14:54:24.655Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1983.644 ms) ====== [2026-04-23T14:54:24.655Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-04-23T14:54:24.655Z] GC before operation: completed in 137.894 ms, heap usage 175.065 MB -> 99.120 MB. [2026-04-23T14:54:26.836Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2001.094 ms) ====== [2026-04-23T14:54:26.836Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-04-23T14:54:26.836Z] GC before operation: completed in 161.389 ms, heap usage 254.925 MB -> 71.935 MB. [2026-04-23T14:54:29.034Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1923.792 ms) ====== [2026-04-23T14:54:29.034Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-04-23T14:54:29.034Z] GC before operation: completed in 150.134 ms, heap usage 210.434 MB -> 72.010 MB. [2026-04-23T14:54:31.170Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1914.130 ms) ====== [2026-04-23T14:54:31.170Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-04-23T14:54:31.170Z] GC before operation: completed in 140.750 ms, heap usage 142.111 MB -> 71.947 MB. [2026-04-23T14:54:33.367Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1897.478 ms) ====== [2026-04-23T14:54:33.367Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-04-23T14:54:33.367Z] GC before operation: completed in 166.747 ms, heap usage 197.709 MB -> 99.972 MB. [2026-04-23T14:54:33.367Z] 14:54:32.789 WARN [block-manager-storage-async-thread-pool-27] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_401, which does not exist [2026-04-23T14:54:35.516Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1946.953 ms) ====== [2026-04-23T14:54:35.516Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-04-23T14:54:35.516Z] GC before operation: completed in 142.292 ms, heap usage 241.755 MB -> 72.246 MB. [2026-04-23T14:54:36.925Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1899.694 ms) ====== [2026-04-23T14:54:36.925Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-04-23T14:54:37.603Z] GC before operation: completed in 184.290 ms, heap usage 304.799 MB -> 72.311 MB. [2026-04-23T14:54:39.767Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2096.783 ms) ====== [2026-04-23T14:54:39.767Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-04-23T14:54:39.767Z] GC before operation: completed in 133.630 ms, heap usage 139.692 MB -> 72.135 MB. [2026-04-23T14:54:41.904Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1899.095 ms) ====== [2026-04-23T14:54:41.904Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-04-23T14:54:41.904Z] GC before operation: completed in 175.240 ms, heap usage 212.507 MB -> 72.940 MB. [2026-04-23T14:54:43.234Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1844.837 ms) ====== [2026-04-23T14:54:43.234Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-04-23T14:54:43.872Z] GC before operation: completed in 162.885 ms, heap usage 271.302 MB -> 92.146 MB. [2026-04-23T14:54:46.091Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1991.244 ms) ====== [2026-04-23T14:54:46.091Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-04-23T14:54:46.091Z] GC before operation: completed in 149.245 ms, heap usage 135.943 MB -> 72.573 MB. [2026-04-23T14:54:47.425Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1884.918 ms) ====== [2026-04-23T14:54:47.425Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-04-23T14:54:48.095Z] GC before operation: completed in 155.746 ms, heap usage 274.384 MB -> 72.871 MB. [2026-04-23T14:54:50.176Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1980.015 ms) ====== [2026-04-23T14:54:50.176Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-04-23T14:54:50.176Z] GC before operation: completed in 155.676 ms, heap usage 280.597 MB -> 100.762 MB. [2026-04-23T14:54:51.574Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1793.050 ms) ====== [2026-04-23T14:54:51.574Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-04-23T14:54:52.237Z] GC before operation: completed in 156.149 ms, heap usage 227.397 MB -> 100.774 MB. [2026-04-23T14:54:52.237Z] 14:54:51.541 WARN [block-manager-storage-async-thread-pool-25] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_527_piece0, which does not exist [2026-04-23T14:54:53.591Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1813.037 ms) ====== [2026-04-23T14:54:53.591Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-04-23T14:54:53.591Z] GC before operation: completed in 146.476 ms, heap usage 295.826 MB -> 73.555 MB. [2026-04-23T14:54:55.704Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1840.635 ms) ====== [2026-04-23T14:54:55.704Z] ----------------------------------- [2026-04-23T14:54:55.704Z] renaissance-dec-tree_0_PASSED [2026-04-23T14:54:55.704Z] ----------------------------------- [2026-04-23T14:54:55.704Z] [2026-04-23T14:54:55.704Z] TEST TEARDOWN: [2026-04-23T14:54:55.704Z] Nothing to be done for teardown. [2026-04-23T14:54:55.704Z] renaissance-dec-tree_0 Finish Time: Thu Apr 23 14:54:55 2026 Epoch Time (ms): 1776956095635