[2025-10-02T04:08:47.989Z] Running test renaissance-dec-tree_0 ... [2025-10-02T04:08:47.989Z] =============================================== [2025-10-02T04:08:47.989Z] renaissance-dec-tree_0 Start Time: Thu Oct 2 04:08:47 2025 Epoch Time (ms): 1759378127898 [2025-10-02T04:08:48.939Z] variation: NoOptions [2025-10-02T04:08:48.939Z] JVM_OPTIONS: [2025-10-02T04:08:48.939Z] { \ [2025-10-02T04:08:48.939Z] echo ""; echo "TEST SETUP:"; \ [2025-10-02T04:08:48.939Z] echo "Nothing to be done for setup."; \ [2025-10-02T04:08:48.939Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17593772234129/renaissance-dec-tree_0"; \ [2025-10-02T04:08:48.939Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17593772234129/renaissance-dec-tree_0"; \ [2025-10-02T04:08:48.939Z] echo ""; echo "TESTING:"; \ [2025-10-02T04:08:48.939Z] "/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_17593772234129/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-10-02T04:08:48.940Z] 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_17593772234129/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-02T04:08:48.940Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-02T04:08:48.940Z] echo "Nothing to be done for teardown."; \ [2025-10-02T04:08:48.940Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17593772234129/TestTargetResult"; [2025-10-02T04:08:48.940Z] [2025-10-02T04:08:48.940Z] TEST SETUP: [2025-10-02T04:08:48.940Z] Nothing to be done for setup. [2025-10-02T04:08:48.940Z] [2025-10-02T04:08:48.940Z] TESTING: [2025-10-02T04:09:07.253Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-10-02T04:09:10.275Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-10-02T04:09:10.276Z] GC before operation: completed in 62.243 ms, heap usage 63.864 MB -> 35.091 MB. [2025-10-02T04:09:28.609Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (16586.027 ms) ====== [2025-10-02T04:09:28.609Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-10-02T04:09:28.609Z] GC before operation: completed in 136.663 ms, heap usage 337.939 MB -> 69.421 MB. [2025-10-02T04:09:30.663Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4008.892 ms) ====== [2025-10-02T04:09:30.663Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-10-02T04:09:31.805Z] GC before operation: completed in 119.397 ms, heap usage 318.333 MB -> 69.587 MB. [2025-10-02T04:09:34.824Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3472.423 ms) ====== [2025-10-02T04:09:34.824Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-10-02T04:09:34.824Z] GC before operation: completed in 123.925 ms, heap usage 242.346 MB -> 80.907 MB. [2025-10-02T04:09:34.824Z] 04:09:34.238 WARN [block-manager-storage-async-thread-pool-77] org.apache.spark.storage.BlockManager - Asked to remove block rdd_141_0, which does not exist [2025-10-02T04:09:37.855Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3432.738 ms) ====== [2025-10-02T04:09:37.855Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-10-02T04:09:38.812Z] GC before operation: completed in 128.880 ms, heap usage 285.615 MB -> 70.114 MB. [2025-10-02T04:09:41.906Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3112.494 ms) ====== [2025-10-02T04:09:41.906Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-10-02T04:09:41.906Z] GC before operation: completed in 140.387 ms, heap usage 369.861 MB -> 70.492 MB. [2025-10-02T04:09:44.588Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3062.944 ms) ====== [2025-10-02T04:09:44.588Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-10-02T04:09:44.588Z] GC before operation: completed in 130.165 ms, heap usage 373.000 MB -> 70.696 MB. [2025-10-02T04:09:47.610Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2826.149 ms) ====== [2025-10-02T04:09:47.610Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-10-02T04:09:47.610Z] GC before operation: completed in 122.618 ms, heap usage 358.265 MB -> 70.767 MB. [2025-10-02T04:09:50.640Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2838.564 ms) ====== [2025-10-02T04:09:50.640Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-10-02T04:09:50.640Z] GC before operation: completed in 133.031 ms, heap usage 356.657 MB -> 71.071 MB. [2025-10-02T04:09:53.699Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3142.338 ms) ====== [2025-10-02T04:09:53.699Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-10-02T04:09:53.700Z] GC before operation: completed in 138.543 ms, heap usage 365.411 MB -> 71.071 MB. [2025-10-02T04:09:57.909Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (3655.092 ms) ====== [2025-10-02T04:09:57.909Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-10-02T04:09:57.909Z] GC before operation: completed in 147.291 ms, heap usage 370.691 MB -> 71.162 MB. [2025-10-02T04:10:00.933Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2708.619 ms) ====== [2025-10-02T04:10:00.933Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-10-02T04:10:00.933Z] GC before operation: completed in 132.228 ms, heap usage 332.798 MB -> 88.097 MB. [2025-10-02T04:10:00.933Z] 04:10:00.106 WARN [block-manager-storage-async-thread-pool-24] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_149_piece0, which does not exist [2025-10-02T04:10:03.974Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2947.742 ms) ====== [2025-10-02T04:10:03.974Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-10-02T04:10:03.974Z] GC before operation: completed in 162.512 ms, heap usage 305.877 MB -> 71.447 MB. [2025-10-02T04:10:07.006Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3020.511 ms) ====== [2025-10-02T04:10:07.006Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-10-02T04:10:07.006Z] GC before operation: completed in 176.729 ms, heap usage 348.947 MB -> 72.013 MB. [2025-10-02T04:10:10.023Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3461.213 ms) ====== [2025-10-02T04:10:10.023Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-10-02T04:10:10.974Z] GC before operation: completed in 140.405 ms, heap usage 352.196 MB -> 83.016 MB. [2025-10-02T04:10:17.611Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2430.900 ms) ====== [2025-10-02T04:10:17.611Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-10-02T04:10:17.611Z] GC before operation: completed in 132.923 ms, heap usage 340.571 MB -> 82.928 MB. [2025-10-02T04:10:20.628Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (7156.896 ms) ====== [2025-10-02T04:10:20.628Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-10-02T04:10:20.628Z] GC before operation: completed in 135.096 ms, heap usage 344.021 MB -> 72.137 MB. [2025-10-02T04:10:23.656Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2743.745 ms) ====== [2025-10-02T04:10:23.656Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-10-02T04:10:23.656Z] GC before operation: completed in 146.957 ms, heap usage 331.213 MB -> 72.247 MB. [2025-10-02T04:10:25.610Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2420.582 ms) ====== [2025-10-02T04:10:25.610Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-10-02T04:10:25.610Z] GC before operation: completed in 151.941 ms, heap usage 348.238 MB -> 72.260 MB. [2025-10-02T04:10:28.634Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2495.526 ms) ====== [2025-10-02T04:10:28.634Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-10-02T04:10:28.634Z] GC before operation: completed in 141.221 ms, heap usage 341.838 MB -> 83.640 MB. [2025-10-02T04:10:30.595Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2497.955 ms) ====== [2025-10-02T04:10:30.595Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-10-02T04:10:31.546Z] GC before operation: completed in 137.265 ms, heap usage 343.246 MB -> 72.778 MB. [2025-10-02T04:10:33.504Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2284.711 ms) ====== [2025-10-02T04:10:33.504Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-10-02T04:10:33.504Z] GC before operation: completed in 141.250 ms, heap usage 319.399 MB -> 72.519 MB. [2025-10-02T04:10:35.462Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2309.549 ms) ====== [2025-10-02T04:10:35.462Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-10-02T04:10:36.418Z] GC before operation: completed in 149.396 ms, heap usage 324.571 MB -> 89.204 MB. [2025-10-02T04:10:38.372Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2329.369 ms) ====== [2025-10-02T04:10:38.372Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-10-02T04:10:38.372Z] GC before operation: completed in 156.213 ms, heap usage 293.734 MB -> 83.845 MB. [2025-10-02T04:10:41.393Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2335.514 ms) ====== [2025-10-02T04:10:41.393Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-10-02T04:10:41.393Z] GC before operation: completed in 146.262 ms, heap usage 160.042 MB -> 72.718 MB. [2025-10-02T04:10:43.346Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2442.703 ms) ====== [2025-10-02T04:10:43.346Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-10-02T04:10:43.346Z] GC before operation: completed in 156.335 ms, heap usage 237.990 MB -> 89.384 MB. [2025-10-02T04:10:46.369Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2449.610 ms) ====== [2025-10-02T04:10:46.369Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-10-02T04:10:46.369Z] GC before operation: completed in 156.213 ms, heap usage 452.293 MB -> 73.247 MB. [2025-10-02T04:10:49.145Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2398.941 ms) ====== [2025-10-02T04:10:49.145Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-10-02T04:10:49.145Z] GC before operation: completed in 163.970 ms, heap usage 313.193 MB -> 89.946 MB. [2025-10-02T04:10:51.094Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2547.194 ms) ====== [2025-10-02T04:10:51.094Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-10-02T04:10:51.094Z] GC before operation: completed in 153.924 ms, heap usage 291.681 MB -> 73.427 MB. [2025-10-02T04:10:54.122Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2529.077 ms) ====== [2025-10-02T04:10:54.122Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-10-02T04:10:54.122Z] GC before operation: completed in 152.544 ms, heap usage 325.025 MB -> 84.307 MB. [2025-10-02T04:10:57.252Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2440.348 ms) ====== [2025-10-02T04:10:57.252Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-10-02T04:10:57.252Z] GC before operation: completed in 157.536 ms, heap usage 174.913 MB -> 73.322 MB. [2025-10-02T04:10:59.257Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2440.182 ms) ====== [2025-10-02T04:10:59.257Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-10-02T04:10:59.257Z] GC before operation: completed in 156.453 ms, heap usage 246.201 MB -> 73.647 MB. [2025-10-02T04:11:02.282Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2352.469 ms) ====== [2025-10-02T04:11:02.282Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-10-02T04:11:02.282Z] GC before operation: completed in 151.137 ms, heap usage 338.951 MB -> 73.791 MB. [2025-10-02T04:11:04.245Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2380.833 ms) ====== [2025-10-02T04:11:04.245Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-10-02T04:11:04.245Z] GC before operation: completed in 157.634 ms, heap usage 330.920 MB -> 73.907 MB. [2025-10-02T04:11:07.265Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2391.881 ms) ====== [2025-10-02T04:11:07.265Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-10-02T04:11:07.265Z] GC before operation: completed in 156.265 ms, heap usage 332.912 MB -> 85.250 MB. [2025-10-02T04:11:07.265Z] 04:11:06.430 WARN [block-manager-storage-async-thread-pool-93] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_475_piece0, which does not exist [2025-10-02T04:11:09.229Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2414.616 ms) ====== [2025-10-02T04:11:09.229Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-10-02T04:11:09.229Z] GC before operation: completed in 165.037 ms, heap usage 495.800 MB -> 74.161 MB. [2025-10-02T04:11:12.271Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2595.356 ms) ====== [2025-10-02T04:11:12.271Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-10-02T04:11:12.271Z] GC before operation: completed in 168.092 ms, heap usage 311.582 MB -> 85.326 MB. [2025-10-02T04:11:15.295Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2599.947 ms) ====== [2025-10-02T04:11:15.295Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-10-02T04:11:15.295Z] GC before operation: completed in 172.841 ms, heap usage 123.606 MB -> 73.853 MB. [2025-10-02T04:11:17.248Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2544.902 ms) ====== [2025-10-02T04:11:17.248Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-10-02T04:11:18.201Z] GC before operation: completed in 196.352 ms, heap usage 517.636 MB -> 85.778 MB. [2025-10-02T04:11:20.172Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2570.567 ms) ====== [2025-10-02T04:11:20.172Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-10-02T04:11:20.172Z] GC before operation: completed in 177.144 ms, heap usage 441.147 MB -> 85.871 MB. [2025-10-02T04:11:23.194Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2480.800 ms) ====== [2025-10-02T04:11:24.148Z] ----------------------------------- [2025-10-02T04:11:24.149Z] renaissance-dec-tree_0_PASSED [2025-10-02T04:11:24.149Z] ----------------------------------- [2025-10-02T04:11:24.149Z] [2025-10-02T04:11:24.149Z] TEST TEARDOWN: [2025-10-02T04:11:24.149Z] Nothing to be done for teardown. [2025-10-02T04:11:24.149Z] renaissance-dec-tree_0 Finish Time: Thu Oct 2 04:11:23 2025 Epoch Time (ms): 1759378283224