[2026-04-23T14:17:23.160Z] Running test renaissance-dec-tree_0 ... [2026-04-23T14:17:23.160Z] =============================================== [2026-04-23T14:17:23.160Z] renaissance-dec-tree_0 Start Time: Thu Apr 23 14:17:22 2026 Epoch Time (ms): 1776953842931 [2026-04-23T14:17:23.160Z] variation: NoOptions [2026-04-23T14:17:23.160Z] JVM_OPTIONS: [2026-04-23T14:17:23.160Z] { \ [2026-04-23T14:17:23.160Z] echo ""; echo "TEST SETUP:"; \ [2026-04-23T14:17:23.160Z] echo "Nothing to be done for setup."; \ [2026-04-23T14:17:23.160Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-dec-tree_0"; \ [2026-04-23T14:17:23.160Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-dec-tree_0"; \ [2026-04-23T14:17:23.160Z] echo ""; echo "TESTING:"; \ [2026-04-23T14:17:23.160Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-04-23T14:17:23.160Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-23T14:17:23.160Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-23T14:17:23.160Z] echo "Nothing to be done for teardown."; \ [2026-04-23T14:17:23.160Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17769527899467/TestTargetResult"; [2026-04-23T14:17:23.160Z] [2026-04-23T14:17:23.160Z] TEST SETUP: [2026-04-23T14:17:23.160Z] Nothing to be done for setup. [2026-04-23T14:17:23.160Z] [2026-04-23T14:17:23.160Z] TESTING: [2026-04-23T14:17:43.984Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-04-23T14:17:44.684Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-04-23T14:17:44.684Z] GC before operation: completed in 96.201 ms, heap usage 52.332 MB -> 35.101 MB. [2026-04-23T14:17:59.978Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (14207.643 ms) ====== [2026-04-23T14:17:59.978Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-04-23T14:17:59.978Z] GC before operation: completed in 219.817 ms, heap usage 129.742 MB -> 67.935 MB. [2026-04-23T14:18:04.105Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (5178.168 ms) ====== [2026-04-23T14:18:04.105Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-04-23T14:18:04.105Z] GC before operation: completed in 193.428 ms, heap usage 148.421 MB -> 68.551 MB. [2026-04-23T14:18:08.276Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4212.507 ms) ====== [2026-04-23T14:18:08.276Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-04-23T14:18:08.986Z] GC before operation: completed in 153.344 ms, heap usage 155.215 MB -> 68.769 MB. [2026-04-23T14:18:12.089Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2988.286 ms) ====== [2026-04-23T14:18:12.089Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-04-23T14:18:12.089Z] GC before operation: completed in 160.854 ms, heap usage 271.504 MB -> 69.248 MB. [2026-04-23T14:18:15.226Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3321.002 ms) ====== [2026-04-23T14:18:15.226Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-04-23T14:18:15.226Z] GC before operation: completed in 169.020 ms, heap usage 129.506 MB -> 96.751 MB. [2026-04-23T14:18:18.835Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3485.552 ms) ====== [2026-04-23T14:18:18.835Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-04-23T14:18:18.835Z] GC before operation: completed in 199.412 ms, heap usage 221.837 MB -> 69.267 MB. [2026-04-23T14:18:21.976Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3269.212 ms) ====== [2026-04-23T14:18:21.976Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-04-23T14:18:22.672Z] GC before operation: completed in 249.793 ms, heap usage 254.503 MB -> 69.591 MB. [2026-04-23T14:18:26.688Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3767.194 ms) ====== [2026-04-23T14:18:26.688Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-04-23T14:18:26.688Z] GC before operation: completed in 175.442 ms, heap usage 321.384 MB -> 69.654 MB. [2026-04-23T14:18:29.813Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3409.662 ms) ====== [2026-04-23T14:18:29.813Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-04-23T14:18:29.813Z] GC before operation: completed in 165.749 ms, heap usage 135.065 MB -> 69.895 MB. [2026-04-23T14:18:33.002Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (3052.527 ms) ====== [2026-04-23T14:18:33.002Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-04-23T14:18:33.002Z] GC before operation: completed in 176.507 ms, heap usage 284.071 MB -> 69.918 MB. [2026-04-23T14:18:37.069Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3337.867 ms) ====== [2026-04-23T14:18:37.069Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-04-23T14:18:37.069Z] GC before operation: completed in 211.275 ms, heap usage 348.209 MB -> 70.186 MB. [2026-04-23T14:18:40.161Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3346.041 ms) ====== [2026-04-23T14:18:40.161Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-04-23T14:18:40.161Z] GC before operation: completed in 223.331 ms, heap usage 229.096 MB -> 89.560 MB. [2026-04-23T14:18:43.256Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2812.766 ms) ====== [2026-04-23T14:18:43.256Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-04-23T14:18:43.256Z] GC before operation: completed in 176.610 ms, heap usage 202.391 MB -> 97.909 MB. [2026-04-23T14:18:46.429Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2794.301 ms) ====== [2026-04-23T14:18:46.429Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-04-23T14:18:46.429Z] GC before operation: completed in 185.306 ms, heap usage 251.731 MB -> 71.347 MB. [2026-04-23T14:18:49.596Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2959.902 ms) ====== [2026-04-23T14:18:49.596Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-04-23T14:18:49.596Z] GC before operation: completed in 177.439 ms, heap usage 239.008 MB -> 70.537 MB. [2026-04-23T14:18:52.706Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3033.292 ms) ====== [2026-04-23T14:18:52.706Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-04-23T14:18:52.706Z] GC before operation: completed in 194.560 ms, heap usage 276.956 MB -> 98.269 MB. [2026-04-23T14:18:55.826Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2853.307 ms) ====== [2026-04-23T14:18:55.826Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-04-23T14:18:55.826Z] GC before operation: completed in 158.200 ms, heap usage 299.793 MB -> 70.896 MB. [2026-04-23T14:18:58.976Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (3094.076 ms) ====== [2026-04-23T14:18:58.976Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-04-23T14:18:58.976Z] GC before operation: completed in 173.386 ms, heap usage 116.552 MB -> 70.524 MB. [2026-04-23T14:19:02.107Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3190.740 ms) ====== [2026-04-23T14:19:02.107Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-04-23T14:19:02.107Z] GC before operation: completed in 202.170 ms, heap usage 214.616 MB -> 71.126 MB. [2026-04-23T14:19:05.196Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2965.353 ms) ====== [2026-04-23T14:19:05.196Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-04-23T14:19:05.876Z] GC before operation: completed in 203.377 ms, heap usage 112.042 MB -> 71.114 MB. [2026-04-23T14:19:08.976Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2850.844 ms) ====== [2026-04-23T14:19:08.976Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-04-23T14:19:08.976Z] GC before operation: completed in 235.361 ms, heap usage 403.142 MB -> 98.824 MB. [2026-04-23T14:19:12.076Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3002.361 ms) ====== [2026-04-23T14:19:12.076Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-04-23T14:19:12.076Z] GC before operation: completed in 182.872 ms, heap usage 118.566 MB -> 71.030 MB. [2026-04-23T14:19:15.137Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2779.609 ms) ====== [2026-04-23T14:19:15.137Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-04-23T14:19:15.137Z] GC before operation: completed in 223.065 ms, heap usage 373.178 MB -> 90.652 MB. [2026-04-23T14:19:18.377Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2973.998 ms) ====== [2026-04-23T14:19:18.377Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-04-23T14:19:18.377Z] GC before operation: completed in 213.343 ms, heap usage 125.579 MB -> 70.993 MB. [2026-04-23T14:19:21.436Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2915.871 ms) ====== [2026-04-23T14:19:21.436Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-04-23T14:19:21.436Z] GC before operation: completed in 229.636 ms, heap usage 235.678 MB -> 71.764 MB. [2026-04-23T14:19:24.573Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3107.862 ms) ====== [2026-04-23T14:19:24.573Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-04-23T14:19:24.573Z] GC before operation: completed in 225.118 ms, heap usage 116.465 MB -> 99.066 MB. [2026-04-23T14:19:24.573Z] 14:19:24.165 WARN [block-manager-storage-async-thread-pool-35] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1245_0, which does not exist [2026-04-23T14:19:27.709Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2882.569 ms) ====== [2026-04-23T14:19:27.709Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-04-23T14:19:27.709Z] GC before operation: completed in 272.647 ms, heap usage 132.077 MB -> 71.584 MB. [2026-04-23T14:19:30.887Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2835.675 ms) ====== [2026-04-23T14:19:30.887Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-04-23T14:19:30.887Z] GC before operation: completed in 229.851 ms, heap usage 358.900 MB -> 99.608 MB. [2026-04-23T14:19:34.010Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2755.230 ms) ====== [2026-04-23T14:19:34.010Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-04-23T14:19:34.010Z] GC before operation: completed in 223.952 ms, heap usage 301.871 MB -> 99.672 MB. [2026-04-23T14:19:34.010Z] 14:19:33.356 WARN [block-manager-storage-async-thread-pool-17] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1389_1, which does not exist [2026-04-23T14:19:36.199Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2767.274 ms) ====== [2026-04-23T14:19:36.199Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-04-23T14:19:36.907Z] GC before operation: completed in 201.991 ms, heap usage 310.430 MB -> 72.519 MB. [2026-04-23T14:19:40.029Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3045.240 ms) ====== [2026-04-23T14:19:40.029Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-04-23T14:19:40.029Z] GC before operation: completed in 172.660 ms, heap usage 117.844 MB -> 72.335 MB. [2026-04-23T14:19:43.476Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3120.937 ms) ====== [2026-04-23T14:19:43.476Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-04-23T14:19:43.476Z] GC before operation: completed in 257.602 ms, heap usage 286.386 MB -> 72.532 MB. [2026-04-23T14:19:46.536Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2991.359 ms) ====== [2026-04-23T14:19:46.536Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-04-23T14:19:46.536Z] GC before operation: completed in 176.254 ms, heap usage 116.954 MB -> 72.545 MB. [2026-04-23T14:19:49.734Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2915.760 ms) ====== [2026-04-23T14:19:49.734Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-04-23T14:19:49.734Z] GC before operation: completed in 255.244 ms, heap usage 260.908 MB -> 100.266 MB. [2026-04-23T14:19:52.926Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2810.940 ms) ====== [2026-04-23T14:19:52.926Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-04-23T14:19:52.926Z] GC before operation: completed in 201.663 ms, heap usage 352.831 MB -> 72.864 MB. [2026-04-23T14:19:56.082Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2903.838 ms) ====== [2026-04-23T14:19:56.082Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-04-23T14:19:56.082Z] GC before operation: completed in 195.820 ms, heap usage 278.121 MB -> 73.221 MB. [2026-04-23T14:19:58.294Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2761.469 ms) ====== [2026-04-23T14:19:58.294Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-04-23T14:19:58.996Z] GC before operation: completed in 183.914 ms, heap usage 232.045 MB -> 73.081 MB. [2026-04-23T14:20:02.065Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2831.680 ms) ====== [2026-04-23T14:20:02.066Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-04-23T14:20:02.066Z] GC before operation: completed in 300.968 ms, heap usage 277.631 MB -> 100.709 MB. [2026-04-23T14:20:04.215Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2616.746 ms) ====== [2026-04-23T14:20:04.215Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-04-23T14:20:04.864Z] GC before operation: completed in 219.463 ms, heap usage 205.786 MB -> 100.495 MB. [2026-04-23T14:20:04.864Z] 14:20:04.294 WARN [block-manager-storage-async-thread-pool-95] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_541_piece0, which does not exist [2026-04-23T14:20:04.864Z] 14:20:04.295 WARN [block-manager-storage-async-thread-pool-0] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1869_1, which does not exist [2026-04-23T14:20:04.864Z] 14:20:04.297 WARN [block-manager-storage-async-thread-pool-0] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1869_0, which does not exist [2026-04-23T14:20:07.901Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2769.802 ms) ====== [2026-04-23T14:20:07.901Z] ----------------------------------- [2026-04-23T14:20:07.901Z] renaissance-dec-tree_0_PASSED [2026-04-23T14:20:07.901Z] ----------------------------------- [2026-04-23T14:20:07.901Z] [2026-04-23T14:20:07.901Z] TEST TEARDOWN: [2026-04-23T14:20:07.901Z] Nothing to be done for teardown. [2026-04-23T14:20:07.901Z] renaissance-dec-tree_0 Finish Time: Thu Apr 23 14:20:07 2026 Epoch Time (ms): 1776954007510