[2025-12-03T22:47:19.595Z] Running test renaissance-dec-tree_0 ... [2025-12-03T22:47:19.595Z] =============================================== [2025-12-03T22:47:19.595Z] renaissance-dec-tree_0 Start Time: Wed Dec 3 22:47:19 2025 Epoch Time (ms): 1764802039377 [2025-12-03T22:47:19.595Z] variation: NoOptions [2025-12-03T22:47:19.595Z] JVM_OPTIONS: [2025-12-03T22:47:19.595Z] { \ [2025-12-03T22:47:19.595Z] echo ""; echo "TEST SETUP:"; \ [2025-12-03T22:47:19.595Z] echo "Nothing to be done for setup."; \ [2025-12-03T22:47:19.595Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648007721367/renaissance-dec-tree_0"; \ [2025-12-03T22:47:19.595Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648007721367/renaissance-dec-tree_0"; \ [2025-12-03T22:47:19.595Z] echo ""; echo "TESTING:"; \ [2025-12-03T22:47:19.595Z] "/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_17648007721367/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-12-03T22:47:19.595Z] 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_17648007721367/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-03T22:47:19.595Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-03T22:47:19.595Z] echo "Nothing to be done for teardown."; \ [2025-12-03T22:47:19.595Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648007721367/TestTargetResult"; [2025-12-03T22:47:19.595Z] [2025-12-03T22:47:19.595Z] TEST SETUP: [2025-12-03T22:47:19.595Z] Nothing to be done for setup. [2025-12-03T22:47:19.595Z] [2025-12-03T22:47:19.595Z] TESTING: [2025-12-03T22:47:34.539Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-12-03T22:47:37.621Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-12-03T22:47:37.621Z] GC before operation: completed in 105.575 ms, heap usage 57.675 MB -> 35.145 MB. [2025-12-03T22:47:52.661Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15051.160 ms) ====== [2025-12-03T22:47:52.661Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-12-03T22:47:52.661Z] GC before operation: completed in 187.191 ms, heap usage 247.928 MB -> 68.078 MB. [2025-12-03T22:47:55.947Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3674.686 ms) ====== [2025-12-03T22:47:55.947Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-12-03T22:47:56.680Z] GC before operation: completed in 142.231 ms, heap usage 141.580 MB -> 68.217 MB. [2025-12-03T22:47:59.787Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3361.006 ms) ====== [2025-12-03T22:47:59.787Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-12-03T22:47:59.787Z] GC before operation: completed in 141.596 ms, heap usage 288.260 MB -> 68.637 MB. [2025-12-03T22:48:02.972Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2791.362 ms) ====== [2025-12-03T22:48:02.972Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-12-03T22:48:02.972Z] GC before operation: completed in 226.694 ms, heap usage 102.414 MB -> 68.679 MB. [2025-12-03T22:48:06.931Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (4149.672 ms) ====== [2025-12-03T22:48:06.931Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-12-03T22:48:06.931Z] GC before operation: completed in 119.700 ms, heap usage 189.997 MB -> 69.023 MB. [2025-12-03T22:48:10.927Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3232.381 ms) ====== [2025-12-03T22:48:10.927Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-12-03T22:48:10.927Z] GC before operation: completed in 149.671 ms, heap usage 139.432 MB -> 69.326 MB. [2025-12-03T22:48:13.409Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3202.340 ms) ====== [2025-12-03T22:48:13.409Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-12-03T22:48:14.122Z] GC before operation: completed in 188.369 ms, heap usage 161.271 MB -> 69.516 MB. [2025-12-03T22:48:17.210Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3154.522 ms) ====== [2025-12-03T22:48:17.210Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-12-03T22:48:17.210Z] GC before operation: completed in 307.531 ms, heap usage 282.516 MB -> 97.196 MB. [2025-12-03T22:48:21.407Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3419.821 ms) ====== [2025-12-03T22:48:21.407Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-12-03T22:48:21.407Z] GC before operation: completed in 209.739 ms, heap usage 165.947 MB -> 69.766 MB. [2025-12-03T22:48:23.704Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (3002.740 ms) ====== [2025-12-03T22:48:23.704Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-12-03T22:48:24.350Z] GC before operation: completed in 256.014 ms, heap usage 102.305 MB -> 69.233 MB. [2025-12-03T22:48:27.485Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3079.657 ms) ====== [2025-12-03T22:48:27.485Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-12-03T22:48:27.485Z] GC before operation: completed in 462.491 ms, heap usage 413.401 MB -> 70.378 MB. [2025-12-03T22:48:31.500Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3895.895 ms) ====== [2025-12-03T22:48:31.500Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-12-03T22:48:32.188Z] GC before operation: completed in 191.280 ms, heap usage 159.982 MB -> 70.245 MB. [2025-12-03T22:48:35.343Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2999.151 ms) ====== [2025-12-03T22:48:35.343Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-12-03T22:48:35.343Z] GC before operation: completed in 145.589 ms, heap usage 227.375 MB -> 70.244 MB. [2025-12-03T22:48:37.446Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2602.474 ms) ====== [2025-12-03T22:48:37.446Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-12-03T22:48:38.307Z] GC before operation: completed in 211.025 ms, heap usage 179.836 MB -> 97.651 MB. [2025-12-03T22:48:40.427Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2758.853 ms) ====== [2025-12-03T22:48:40.427Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-12-03T22:48:41.104Z] GC before operation: completed in 169.534 ms, heap usage 364.611 MB -> 70.573 MB. [2025-12-03T22:48:43.285Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2543.713 ms) ====== [2025-12-03T22:48:43.285Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-12-03T22:48:43.285Z] GC before operation: completed in 127.234 ms, heap usage 325.989 MB -> 70.732 MB. [2025-12-03T22:48:46.322Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2523.277 ms) ====== [2025-12-03T22:48:46.322Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-12-03T22:48:46.322Z] GC before operation: completed in 151.293 ms, heap usage 233.872 MB -> 70.745 MB. [2025-12-03T22:48:48.507Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2654.598 ms) ====== [2025-12-03T22:48:48.508Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-12-03T22:48:49.243Z] GC before operation: completed in 229.463 ms, heap usage 216.347 MB -> 98.409 MB. [2025-12-03T22:48:52.364Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3259.159 ms) ====== [2025-12-03T22:48:52.364Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-12-03T22:48:52.364Z] GC before operation: completed in 179.510 ms, heap usage 362.180 MB -> 71.093 MB. [2025-12-03T22:48:55.918Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2697.473 ms) ====== [2025-12-03T22:48:55.919Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-12-03T22:48:55.919Z] GC before operation: completed in 181.998 ms, heap usage 295.456 MB -> 71.228 MB. [2025-12-03T22:48:58.269Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2535.627 ms) ====== [2025-12-03T22:48:58.269Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-12-03T22:48:58.270Z] GC before operation: completed in 131.094 ms, heap usage 120.570 MB -> 70.676 MB. [2025-12-03T22:49:01.310Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2906.928 ms) ====== [2025-12-03T22:49:01.310Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-12-03T22:49:01.310Z] GC before operation: completed in 175.254 ms, heap usage 360.459 MB -> 71.408 MB. [2025-12-03T22:49:03.522Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2483.657 ms) ====== [2025-12-03T22:49:03.522Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-12-03T22:49:03.522Z] GC before operation: completed in 161.706 ms, heap usage 193.697 MB -> 71.477 MB. [2025-12-03T22:49:06.619Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2536.600 ms) ====== [2025-12-03T22:49:06.619Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-12-03T22:49:06.619Z] GC before operation: completed in 226.783 ms, heap usage 234.690 MB -> 71.617 MB. [2025-12-03T22:49:08.933Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2567.219 ms) ====== [2025-12-03T22:49:08.933Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-12-03T22:49:09.620Z] GC before operation: completed in 246.966 ms, heap usage 213.801 MB -> 99.370 MB. [2025-12-03T22:49:11.771Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2770.056 ms) ====== [2025-12-03T22:49:11.771Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-12-03T22:49:12.431Z] GC before operation: completed in 194.210 ms, heap usage 378.128 MB -> 71.716 MB. [2025-12-03T22:49:15.556Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2816.719 ms) ====== [2025-12-03T22:49:15.556Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-12-03T22:49:15.556Z] GC before operation: completed in 348.143 ms, heap usage 306.629 MB -> 99.437 MB. [2025-12-03T22:49:15.556Z] 22:49:15.069 WARN [block-manager-storage-async-thread-pool-28] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_373_piece0, which does not exist [2025-12-03T22:49:18.593Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2959.243 ms) ====== [2025-12-03T22:49:18.593Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-12-03T22:49:18.593Z] GC before operation: completed in 181.940 ms, heap usage 138.469 MB -> 71.925 MB. [2025-12-03T22:49:21.742Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2794.401 ms) ====== [2025-12-03T22:49:21.742Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-12-03T22:49:21.742Z] GC before operation: completed in 227.218 ms, heap usage 389.719 MB -> 72.068 MB. [2025-12-03T22:49:24.862Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3274.635 ms) ====== [2025-12-03T22:49:24.862Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-12-03T22:49:24.862Z] GC before operation: completed in 185.133 ms, heap usage 327.949 MB -> 72.130 MB. [2025-12-03T22:49:28.139Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2496.131 ms) ====== [2025-12-03T22:49:28.139Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-12-03T22:49:28.139Z] GC before operation: completed in 194.059 ms, heap usage 293.509 MB -> 72.257 MB. [2025-12-03T22:49:30.456Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2686.533 ms) ====== [2025-12-03T22:49:30.456Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-12-03T22:49:30.456Z] GC before operation: completed in 230.281 ms, heap usage 216.991 MB -> 72.735 MB. [2025-12-03T22:49:32.568Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2200.523 ms) ====== [2025-12-03T22:49:32.568Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-12-03T22:49:33.257Z] GC before operation: completed in 130.423 ms, heap usage 193.679 MB -> 72.489 MB. [2025-12-03T22:49:35.432Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2502.226 ms) ====== [2025-12-03T22:49:35.432Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-12-03T22:49:35.432Z] GC before operation: completed in 168.122 ms, heap usage 341.442 MB -> 72.755 MB. [2025-12-03T22:49:38.518Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2473.848 ms) ====== [2025-12-03T22:49:38.518Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-12-03T22:49:38.518Z] GC before operation: completed in 257.101 ms, heap usage 207.734 MB -> 100.265 MB. [2025-12-03T22:49:40.819Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2021.702 ms) ====== [2025-12-03T22:49:40.819Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-12-03T22:49:40.819Z] GC before operation: completed in 170.367 ms, heap usage 282.400 MB -> 72.734 MB. [2025-12-03T22:49:43.210Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2564.590 ms) ====== [2025-12-03T22:49:43.210Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-12-03T22:49:43.210Z] GC before operation: completed in 247.866 ms, heap usage 112.074 MB -> 99.832 MB. [2025-12-03T22:49:46.370Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2781.370 ms) ====== [2025-12-03T22:49:46.370Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-12-03T22:49:46.370Z] GC before operation: completed in 168.710 ms, heap usage 303.480 MB -> 100.607 MB. [2025-12-03T22:49:48.621Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2393.148 ms) ====== [2025-12-03T22:49:48.621Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-12-03T22:49:49.288Z] GC before operation: completed in 267.512 ms, heap usage 439.198 MB -> 100.718 MB. [2025-12-03T22:49:51.506Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2421.404 ms) ====== [2025-12-03T22:49:52.308Z] ----------------------------------- [2025-12-03T22:49:52.308Z] renaissance-dec-tree_0_PASSED [2025-12-03T22:49:52.308Z] ----------------------------------- [2025-12-03T22:49:52.308Z] [2025-12-03T22:49:52.308Z] TEST TEARDOWN: [2025-12-03T22:49:52.308Z] Nothing to be done for teardown. [2025-12-03T22:49:52.308Z] renaissance-dec-tree_0 Finish Time: Wed Dec 3 22:49:51 2025 Epoch Time (ms): 1764802191737