[2025-12-17T22:29:08.976Z] Running test renaissance-dec-tree_0 ... [2025-12-17T22:29:08.976Z] =============================================== [2025-12-17T22:29:08.976Z] renaissance-dec-tree_0 Start Time: Wed Dec 17 22:29:08 2025 Epoch Time (ms): 1766010548421 [2025-12-17T22:29:08.976Z] variation: NoOptions [2025-12-17T22:29:08.976Z] JVM_OPTIONS: [2025-12-17T22:29:08.976Z] { \ [2025-12-17T22:29:08.976Z] echo ""; echo "TEST SETUP:"; \ [2025-12-17T22:29:08.976Z] echo "Nothing to be done for setup."; \ [2025-12-17T22:29:08.976Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17660096091385/renaissance-dec-tree_0"; \ [2025-12-17T22:29:08.976Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17660096091385/renaissance-dec-tree_0"; \ [2025-12-17T22:29:08.976Z] echo ""; echo "TESTING:"; \ [2025-12-17T22:29:08.976Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17660096091385/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-12-17T22:29:08.976Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17660096091385/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-17T22:29:08.976Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-17T22:29:08.976Z] echo "Nothing to be done for teardown."; \ [2025-12-17T22:29:08.976Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17660096091385/TestTargetResult"; [2025-12-17T22:29:08.976Z] [2025-12-17T22:29:08.976Z] TEST SETUP: [2025-12-17T22:29:08.976Z] Nothing to be done for setup. [2025-12-17T22:29:08.976Z] [2025-12-17T22:29:08.976Z] TESTING: [2025-12-17T22:29:27.640Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-17T22:29:33.492Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-12-17T22:29:34.660Z] GC before operation: completed in 170.375 ms, heap usage 39.392 MB -> 35.050 MB. [2025-12-17T22:30:15.010Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (39859.058 ms) ====== [2025-12-17T22:30:15.010Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-12-17T22:30:15.010Z] GC before operation: completed in 288.641 ms, heap usage 305.606 MB -> 69.139 MB. [2025-12-17T22:30:23.742Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (9155.490 ms) ====== [2025-12-17T22:30:23.742Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-12-17T22:30:23.742Z] GC before operation: completed in 244.849 ms, heap usage 115.734 MB -> 69.421 MB. [2025-12-17T22:30:30.603Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (6719.729 ms) ====== [2025-12-17T22:30:30.603Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-12-17T22:30:30.603Z] GC before operation: completed in 454.252 ms, heap usage 342.569 MB -> 69.772 MB. [2025-12-17T22:30:36.241Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (5171.256 ms) ====== [2025-12-17T22:30:36.241Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-12-17T22:30:36.241Z] GC before operation: completed in 251.627 ms, heap usage 168.176 MB -> 69.956 MB. [2025-12-17T22:30:40.780Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (4800.488 ms) ====== [2025-12-17T22:30:40.780Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-12-17T22:30:41.770Z] GC before operation: completed in 308.090 ms, heap usage 334.208 MB -> 70.236 MB. [2025-12-17T22:30:47.355Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (5284.855 ms) ====== [2025-12-17T22:30:47.355Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-12-17T22:30:47.355Z] GC before operation: completed in 403.547 ms, heap usage 420.168 MB -> 81.558 MB. [2025-12-17T22:30:51.699Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (5032.742 ms) ====== [2025-12-17T22:30:51.700Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-12-17T22:30:52.674Z] GC before operation: completed in 331.182 ms, heap usage 340.640 MB -> 81.808 MB. [2025-12-17T22:30:57.023Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (4847.282 ms) ====== [2025-12-17T22:30:57.023Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-12-17T22:30:58.005Z] GC before operation: completed in 484.389 ms, heap usage 353.438 MB -> 70.849 MB. [2025-12-17T22:31:02.351Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4744.247 ms) ====== [2025-12-17T22:31:02.351Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-12-17T22:31:03.411Z] GC before operation: completed in 436.550 ms, heap usage 373.290 MB -> 87.581 MB. [2025-12-17T22:31:03.411Z] 22:31:02.368 WARN [block-manager-storage-async-thread-pool-84] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_121_piece0, which does not exist [2025-12-17T22:31:07.290Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4530.538 ms) ====== [2025-12-17T22:31:07.290Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-12-17T22:31:08.286Z] GC before operation: completed in 368.867 ms, heap usage 254.478 MB -> 70.962 MB. [2025-12-17T22:31:11.416Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3938.335 ms) ====== [2025-12-17T22:31:11.416Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-12-17T22:31:12.398Z] GC before operation: completed in 346.930 ms, heap usage 252.237 MB -> 71.249 MB. [2025-12-17T22:31:16.689Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3884.404 ms) ====== [2025-12-17T22:31:16.689Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-12-17T22:31:16.689Z] GC before operation: completed in 321.574 ms, heap usage 382.570 MB -> 87.979 MB. [2025-12-17T22:31:20.949Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4026.225 ms) ====== [2025-12-17T22:31:20.949Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-12-17T22:31:20.949Z] GC before operation: completed in 314.726 ms, heap usage 250.886 MB -> 71.319 MB. [2025-12-17T22:31:24.125Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3571.185 ms) ====== [2025-12-17T22:31:24.125Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-12-17T22:31:24.125Z] GC before operation: completed in 325.212 ms, heap usage 335.183 MB -> 71.575 MB. [2025-12-17T22:31:28.401Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (3712.327 ms) ====== [2025-12-17T22:31:28.401Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-12-17T22:31:28.401Z] GC before operation: completed in 336.544 ms, heap usage 393.932 MB -> 82.824 MB. [2025-12-17T22:31:32.643Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3659.665 ms) ====== [2025-12-17T22:31:32.643Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-12-17T22:31:32.643Z] GC before operation: completed in 258.873 ms, heap usage 305.545 MB -> 71.848 MB. [2025-12-17T22:31:36.906Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4040.789 ms) ====== [2025-12-17T22:31:36.906Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-12-17T22:31:36.906Z] GC before operation: completed in 313.274 ms, heap usage 385.981 MB -> 82.912 MB. [2025-12-17T22:31:41.176Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (3908.141 ms) ====== [2025-12-17T22:31:41.176Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-12-17T22:31:41.176Z] GC before operation: completed in 366.368 ms, heap usage 263.112 MB -> 71.919 MB. [2025-12-17T22:31:45.427Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3797.595 ms) ====== [2025-12-17T22:31:45.427Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-12-17T22:31:45.427Z] GC before operation: completed in 345.418 ms, heap usage 377.799 MB -> 72.219 MB. [2025-12-17T22:31:49.828Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3995.422 ms) ====== [2025-12-17T22:31:49.828Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-12-17T22:31:49.828Z] GC before operation: completed in 281.103 ms, heap usage 377.325 MB -> 72.333 MB. [2025-12-17T22:31:52.920Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (3581.528 ms) ====== [2025-12-17T22:31:52.920Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-12-17T22:31:53.892Z] GC before operation: completed in 452.809 ms, heap usage 403.883 MB -> 72.294 MB. [2025-12-17T22:31:56.962Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3639.670 ms) ====== [2025-12-17T22:31:56.962Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-12-17T22:31:57.938Z] GC before operation: completed in 322.986 ms, heap usage 373.056 MB -> 72.529 MB. [2025-12-17T22:32:01.015Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (3444.173 ms) ====== [2025-12-17T22:32:01.015Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-12-17T22:32:01.015Z] GC before operation: completed in 356.826 ms, heap usage 371.443 MB -> 83.440 MB. [2025-12-17T22:32:05.278Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (3817.000 ms) ====== [2025-12-17T22:32:05.278Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-12-17T22:32:05.278Z] GC before operation: completed in 367.403 ms, heap usage 269.437 MB -> 72.626 MB. [2025-12-17T22:32:09.510Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (3483.895 ms) ====== [2025-12-17T22:32:09.510Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-12-17T22:32:09.510Z] GC before operation: completed in 355.407 ms, heap usage 294.631 MB -> 100.359 MB. [2025-12-17T22:32:13.348Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3431.716 ms) ====== [2025-12-17T22:32:13.348Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-12-17T22:32:13.348Z] GC before operation: completed in 323.430 ms, heap usage 454.398 MB -> 72.775 MB. [2025-12-17T22:32:16.450Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3110.765 ms) ====== [2025-12-17T22:32:16.450Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-12-17T22:32:16.450Z] GC before operation: completed in 354.078 ms, heap usage 394.430 MB -> 72.887 MB. [2025-12-17T22:32:20.685Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3367.731 ms) ====== [2025-12-17T22:32:20.685Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-12-17T22:32:20.685Z] GC before operation: completed in 316.944 ms, heap usage 364.758 MB -> 73.201 MB. [2025-12-17T22:32:23.750Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3435.947 ms) ====== [2025-12-17T22:32:23.750Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-12-17T22:32:23.750Z] GC before operation: completed in 351.316 ms, heap usage 354.588 MB -> 84.546 MB. [2025-12-17T22:32:28.006Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3473.975 ms) ====== [2025-12-17T22:32:28.006Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-12-17T22:32:28.006Z] GC before operation: completed in 315.946 ms, heap usage 265.983 MB -> 73.373 MB. [2025-12-17T22:32:31.083Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3181.125 ms) ====== [2025-12-17T22:32:31.083Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-12-17T22:32:31.083Z] GC before operation: completed in 414.059 ms, heap usage 310.533 MB -> 73.503 MB. [2025-12-17T22:32:35.343Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3306.861 ms) ====== [2025-12-17T22:32:35.343Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-12-17T22:32:35.343Z] GC before operation: completed in 360.703 ms, heap usage 293.663 MB -> 73.424 MB. [2025-12-17T22:32:38.413Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3356.752 ms) ====== [2025-12-17T22:32:38.413Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-12-17T22:32:38.413Z] GC before operation: completed in 329.551 ms, heap usage 329.285 MB -> 73.822 MB. [2025-12-17T22:32:42.660Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (3222.555 ms) ====== [2025-12-17T22:32:42.660Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-12-17T22:32:42.660Z] GC before operation: completed in 344.057 ms, heap usage 322.523 MB -> 74.083 MB. [2025-12-17T22:32:45.764Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3410.784 ms) ====== [2025-12-17T22:32:45.764Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-12-17T22:32:46.737Z] GC before operation: completed in 378.757 ms, heap usage 340.564 MB -> 79.215 MB. [2025-12-17T22:32:49.883Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (3307.421 ms) ====== [2025-12-17T22:32:49.883Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-12-17T22:32:49.883Z] GC before operation: completed in 353.071 ms, heap usage 346.667 MB -> 74.334 MB. [2025-12-17T22:32:54.116Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3535.462 ms) ====== [2025-12-17T22:32:54.116Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-12-17T22:32:54.116Z] GC before operation: completed in 296.459 ms, heap usage 342.936 MB -> 74.160 MB. [2025-12-17T22:32:57.196Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (3184.962 ms) ====== [2025-12-17T22:32:57.196Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-12-17T22:32:57.196Z] GC before operation: completed in 437.176 ms, heap usage 378.654 MB -> 84.999 MB. [2025-12-17T22:33:00.270Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (3226.148 ms) ====== [2025-12-17T22:33:00.270Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-12-17T22:33:01.233Z] GC before operation: completed in 342.021 ms, heap usage 215.882 MB -> 74.277 MB. [2025-12-17T22:33:04.309Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3562.142 ms) ====== [2025-12-17T22:33:06.301Z] ----------------------------------- [2025-12-17T22:33:06.301Z] renaissance-dec-tree_0_PASSED [2025-12-17T22:33:06.301Z] ----------------------------------- [2025-12-17T22:33:06.301Z] [2025-12-17T22:33:06.301Z] TEST TEARDOWN: [2025-12-17T22:33:06.301Z] Nothing to be done for teardown. [2025-12-17T22:33:06.301Z] renaissance-dec-tree_0 Finish Time: Wed Dec 17 22:33:05 2025 Epoch Time (ms): 1766010785302