[2025-06-19T03:29:41.064Z] Running test renaissance-dec-tree_0 ... [2025-06-19T03:29:41.064Z] =============================================== [2025-06-19T03:29:41.064Z] renaissance-dec-tree_0 Start Time: Thu Jun 19 03:29:40 2025 Epoch Time (ms): 1750303780952 [2025-06-19T03:29:41.064Z] variation: NoOptions [2025-06-19T03:29:41.064Z] JVM_OPTIONS: [2025-06-19T03:29:41.064Z] { \ [2025-06-19T03:29:41.064Z] echo ""; echo "TEST SETUP:"; \ [2025-06-19T03:29:41.064Z] echo "Nothing to be done for setup."; \ [2025-06-19T03:29:41.064Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503031877704/renaissance-dec-tree_0"; \ [2025-06-19T03:29:41.064Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503031877704/renaissance-dec-tree_0"; \ [2025-06-19T03:29:41.064Z] echo ""; echo "TESTING:"; \ [2025-06-19T03:29:41.064Z] "/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_17503031877704/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-06-19T03:29:41.065Z] 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_17503031877704/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-19T03:29:41.065Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-19T03:29:41.065Z] echo "Nothing to be done for teardown."; \ [2025-06-19T03:29:41.065Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503031877704/TestTargetResult"; [2025-06-19T03:29:41.065Z] [2025-06-19T03:29:41.065Z] TEST SETUP: [2025-06-19T03:29:41.065Z] Nothing to be done for setup. [2025-06-19T03:29:41.065Z] [2025-06-19T03:29:41.065Z] TESTING: [2025-06-19T03:29:47.533Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-06-19T03:29:49.062Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-06-19T03:29:49.062Z] GC before operation: completed in 51.796 ms, heap usage 63.024 MB -> 35.024 MB. [2025-06-19T03:30:01.571Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11635.743 ms) ====== [2025-06-19T03:30:01.571Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-06-19T03:30:01.571Z] GC before operation: completed in 177.695 ms, heap usage 240.430 MB -> 68.084 MB. [2025-06-19T03:30:03.640Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3338.580 ms) ====== [2025-06-19T03:30:03.640Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-06-19T03:30:04.281Z] GC before operation: completed in 177.677 ms, heap usage 305.385 MB -> 68.220 MB. [2025-06-19T03:30:06.351Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2476.890 ms) ====== [2025-06-19T03:30:06.351Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-06-19T03:30:06.985Z] GC before operation: completed in 136.388 ms, heap usage 250.287 MB -> 87.930 MB. [2025-06-19T03:30:06.985Z] 03:30:06.362 WARN [block-manager-storage-async-thread-pool-72] org.apache.spark.storage.BlockManager - Asked to remove block rdd_141_0, which does not exist [2025-06-19T03:30:09.056Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2372.164 ms) ====== [2025-06-19T03:30:09.056Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-06-19T03:30:09.056Z] GC before operation: completed in 159.439 ms, heap usage 305.890 MB -> 68.844 MB. [2025-06-19T03:30:12.001Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2457.387 ms) ====== [2025-06-19T03:30:12.001Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-06-19T03:30:12.001Z] GC before operation: completed in 154.429 ms, heap usage 211.854 MB -> 68.901 MB. [2025-06-19T03:30:14.909Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2705.189 ms) ====== [2025-06-19T03:30:14.909Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-06-19T03:30:14.909Z] GC before operation: completed in 170.757 ms, heap usage 213.596 MB -> 69.096 MB. [2025-06-19T03:30:17.003Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2394.206 ms) ====== [2025-06-19T03:30:17.003Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-06-19T03:30:17.649Z] GC before operation: completed in 261.756 ms, heap usage 306.947 MB -> 69.421 MB. [2025-06-19T03:30:19.827Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2447.965 ms) ====== [2025-06-19T03:30:19.827Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-06-19T03:30:19.827Z] GC before operation: completed in 148.590 ms, heap usage 277.815 MB -> 69.614 MB. [2025-06-19T03:30:22.019Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2230.593 ms) ====== [2025-06-19T03:30:22.019Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-06-19T03:30:22.655Z] GC before operation: completed in 175.024 ms, heap usage 306.605 MB -> 69.637 MB. [2025-06-19T03:30:24.743Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2268.247 ms) ====== [2025-06-19T03:30:24.743Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-06-19T03:30:24.743Z] GC before operation: completed in 117.189 ms, heap usage 169.475 MB -> 69.430 MB. [2025-06-19T03:30:27.290Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2131.596 ms) ====== [2025-06-19T03:30:27.291Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-06-19T03:30:27.291Z] GC before operation: completed in 167.790 ms, heap usage 294.381 MB -> 70.004 MB. [2025-06-19T03:30:29.398Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2301.731 ms) ====== [2025-06-19T03:30:29.398Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-06-19T03:30:29.398Z] GC before operation: completed in 147.814 ms, heap usage 287.709 MB -> 70.172 MB. [2025-06-19T03:30:32.332Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2273.253 ms) ====== [2025-06-19T03:30:32.332Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-06-19T03:30:32.332Z] GC before operation: completed in 171.987 ms, heap usage 320.819 MB -> 97.780 MB. [2025-06-19T03:30:34.462Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2294.319 ms) ====== [2025-06-19T03:30:34.462Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-06-19T03:30:34.462Z] GC before operation: completed in 181.846 ms, heap usage 245.958 MB -> 70.335 MB. [2025-06-19T03:30:36.548Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2278.450 ms) ====== [2025-06-19T03:30:36.548Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-06-19T03:30:36.548Z] GC before operation: completed in 115.884 ms, heap usage 164.920 MB -> 97.628 MB. [2025-06-19T03:30:38.627Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2084.289 ms) ====== [2025-06-19T03:30:38.628Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-06-19T03:30:39.279Z] GC before operation: completed in 147.081 ms, heap usage 267.976 MB -> 98.187 MB. [2025-06-19T03:30:41.377Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2143.272 ms) ====== [2025-06-19T03:30:41.377Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-06-19T03:30:41.377Z] GC before operation: completed in 165.276 ms, heap usage 352.570 MB -> 70.660 MB. [2025-06-19T03:30:43.556Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2119.426 ms) ====== [2025-06-19T03:30:43.556Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-06-19T03:30:43.556Z] GC before operation: completed in 185.167 ms, heap usage 214.824 MB -> 70.940 MB. [2025-06-19T03:30:45.694Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2158.191 ms) ====== [2025-06-19T03:30:45.694Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-06-19T03:30:45.694Z] GC before operation: completed in 161.394 ms, heap usage 141.479 MB -> 70.556 MB. [2025-06-19T03:30:48.621Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2284.748 ms) ====== [2025-06-19T03:30:48.621Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-06-19T03:30:48.621Z] GC before operation: completed in 164.045 ms, heap usage 204.022 MB -> 98.990 MB. [2025-06-19T03:30:50.751Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2089.678 ms) ====== [2025-06-19T03:30:50.752Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-06-19T03:30:50.752Z] GC before operation: completed in 176.873 ms, heap usage 253.833 MB -> 71.258 MB. [2025-06-19T03:30:52.857Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2216.995 ms) ====== [2025-06-19T03:30:52.857Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-06-19T03:30:52.857Z] GC before operation: completed in 111.367 ms, heap usage 336.892 MB -> 71.198 MB. [2025-06-19T03:30:54.952Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2078.764 ms) ====== [2025-06-19T03:30:54.952Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-06-19T03:30:55.599Z] GC before operation: completed in 177.734 ms, heap usage 155.417 MB -> 71.100 MB. [2025-06-19T03:30:57.679Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2000.340 ms) ====== [2025-06-19T03:30:57.679Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-06-19T03:30:57.679Z] GC before operation: completed in 166.248 ms, heap usage 206.038 MB -> 99.327 MB. [2025-06-19T03:30:59.804Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2135.988 ms) ====== [2025-06-19T03:30:59.804Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-06-19T03:30:59.804Z] GC before operation: completed in 123.413 ms, heap usage 256.304 MB -> 71.891 MB. [2025-06-19T03:31:01.928Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2085.451 ms) ====== [2025-06-19T03:31:01.928Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-06-19T03:31:01.928Z] GC before operation: completed in 177.569 ms, heap usage 210.780 MB -> 99.384 MB. [2025-06-19T03:31:01.928Z] 03:31:01.646 WARN [block-manager-storage-async-thread-pool-64] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_359, which does not exist [2025-06-19T03:31:04.011Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2179.993 ms) ====== [2025-06-19T03:31:04.011Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-06-19T03:31:05.164Z] GC before operation: completed in 157.219 ms, heap usage 327.986 MB -> 72.068 MB. [2025-06-19T03:31:06.485Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2206.213 ms) ====== [2025-06-19T03:31:06.485Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-06-19T03:31:06.485Z] GC before operation: completed in 216.060 ms, heap usage 149.697 MB -> 71.902 MB. [2025-06-19T03:31:08.612Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2108.610 ms) ====== [2025-06-19T03:31:08.612Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-06-19T03:31:09.264Z] GC before operation: completed in 201.018 ms, heap usage 275.665 MB -> 72.090 MB. [2025-06-19T03:31:11.395Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2282.691 ms) ====== [2025-06-19T03:31:11.395Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-06-19T03:31:11.395Z] GC before operation: completed in 152.546 ms, heap usage 182.760 MB -> 71.803 MB. [2025-06-19T03:31:13.482Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1983.532 ms) ====== [2025-06-19T03:31:13.482Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-06-19T03:31:13.482Z] GC before operation: completed in 141.236 ms, heap usage 112.702 MB -> 71.758 MB. [2025-06-19T03:31:15.570Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2092.014 ms) ====== [2025-06-19T03:31:15.570Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-06-19T03:31:16.212Z] GC before operation: completed in 179.895 ms, heap usage 362.663 MB -> 72.272 MB. [2025-06-19T03:31:18.316Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1984.808 ms) ====== [2025-06-19T03:31:18.316Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-06-19T03:31:18.316Z] GC before operation: completed in 175.927 ms, heap usage 120.078 MB -> 71.808 MB. [2025-06-19T03:31:20.541Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2035.978 ms) ====== [2025-06-19T03:31:20.541Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-06-19T03:31:20.541Z] GC before operation: completed in 235.037 ms, heap usage 395.347 MB -> 99.884 MB. [2025-06-19T03:31:22.718Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2342.898 ms) ====== [2025-06-19T03:31:22.718Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-06-19T03:31:22.718Z] GC before operation: completed in 180.305 ms, heap usage 202.217 MB -> 72.655 MB. [2025-06-19T03:31:24.853Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2137.842 ms) ====== [2025-06-19T03:31:24.853Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-06-19T03:31:25.509Z] GC before operation: completed in 173.192 ms, heap usage 324.326 MB -> 72.779 MB. [2025-06-19T03:31:27.637Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2178.828 ms) ====== [2025-06-19T03:31:27.637Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-06-19T03:31:27.637Z] GC before operation: completed in 169.331 ms, heap usage 230.443 MB -> 73.140 MB. [2025-06-19T03:31:29.784Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2260.169 ms) ====== [2025-06-19T03:31:29.784Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-06-19T03:31:29.784Z] GC before operation: completed in 180.958 ms, heap usage 214.497 MB -> 72.866 MB. [2025-06-19T03:31:31.912Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2066.369 ms) ====== [2025-06-19T03:31:31.912Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-06-19T03:31:32.566Z] GC before operation: completed in 247.396 ms, heap usage 271.225 MB -> 100.826 MB. [2025-06-19T03:31:34.661Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1969.005 ms) ====== [2025-06-19T03:31:34.661Z] ----------------------------------- [2025-06-19T03:31:34.661Z] renaissance-dec-tree_0_PASSED [2025-06-19T03:31:34.661Z] ----------------------------------- [2025-06-19T03:31:34.661Z] [2025-06-19T03:31:34.661Z] TEST TEARDOWN: [2025-06-19T03:31:34.661Z] Nothing to be done for teardown. [2025-06-19T03:31:34.661Z] renaissance-dec-tree_0 Finish Time: Thu Jun 19 03:31:34 2025 Epoch Time (ms): 1750303894225