[2024-06-26T21:06:27.798Z] Running test renaissance-dec-tree_0 ... [2024-06-26T21:06:27.798Z] =============================================== [2024-06-26T21:06:27.798Z] renaissance-dec-tree_0 Start Time: Wed Jun 26 21:06:27 2024 Epoch Time (ms): 1719435987042 [2024-06-26T21:06:27.798Z] variation: NoOptions [2024-06-26T21:06:27.798Z] JVM_OPTIONS: [2024-06-26T21:06:27.798Z] { \ [2024-06-26T21:06:27.798Z] echo ""; echo "TEST SETUP:"; \ [2024-06-26T21:06:27.798Z] echo "Nothing to be done for setup."; \ [2024-06-26T21:06:27.798Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17194356267082/renaissance-dec-tree_0"; \ [2024-06-26T21:06:27.798Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17194356267082/renaissance-dec-tree_0"; \ [2024-06-26T21:06:27.798Z] echo ""; echo "TESTING:"; \ [2024-06-26T21:06:27.798Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/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_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17194356267082/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-06-26T21:06:27.798Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17194356267082/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-06-26T21:06:27.798Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-06-26T21:06:27.798Z] echo "Nothing to be done for teardown."; \ [2024-06-26T21:06:27.798Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17194356267082/TestTargetResult"; [2024-06-26T21:06:27.798Z] [2024-06-26T21:06:27.798Z] TEST SETUP: [2024-06-26T21:06:27.798Z] Nothing to be done for setup. [2024-06-26T21:06:27.798Z] [2024-06-26T21:06:27.798Z] TESTING: [2024-06-26T21:06:33.097Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-06-26T21:06:37.206Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-06-26T21:06:39.132Z] WARNING: An illegal reflective access operation has occurred [2024-06-26T21:06:39.132Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/output_17194356267082/renaissance-dec-tree_0/harness-210628-10485719714335727417/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-06-26T21:06:39.132Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-06-26T21:06:39.132Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-06-26T21:06:39.132Z] WARNING: All illegal access operations will be denied in a future release [2024-06-26T21:06:45.130Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-06-26T21:06:45.130Z] GC before operation: completed in 87.678 ms, heap usage 89.311 MB -> 34.513 MB. [2024-06-26T21:07:00.774Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (16162.184 ms) ====== [2024-06-26T21:07:00.774Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-06-26T21:07:00.774Z] GC before operation: completed in 166.090 ms, heap usage 287.687 MB -> 64.260 MB. [2024-06-26T21:07:04.873Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3710.215 ms) ====== [2024-06-26T21:07:04.873Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-06-26T21:07:04.873Z] GC before operation: completed in 176.882 ms, heap usage 196.859 MB -> 64.583 MB. [2024-06-26T21:07:08.001Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2981.169 ms) ====== [2024-06-26T21:07:08.001Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-06-26T21:07:08.001Z] GC before operation: completed in 183.946 ms, heap usage 255.001 MB -> 64.997 MB. [2024-06-26T21:07:10.970Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2715.114 ms) ====== [2024-06-26T21:07:10.970Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-06-26T21:07:10.970Z] GC before operation: completed in 182.601 ms, heap usage 276.029 MB -> 65.223 MB. [2024-06-26T21:07:13.972Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2496.876 ms) ====== [2024-06-26T21:07:13.972Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-06-26T21:07:13.972Z] GC before operation: completed in 195.067 ms, heap usage 172.026 MB -> 65.155 MB. [2024-06-26T21:07:15.902Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2367.389 ms) ====== [2024-06-26T21:07:15.902Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-06-26T21:07:15.902Z] GC before operation: completed in 191.835 ms, heap usage 146.889 MB -> 65.221 MB. [2024-06-26T21:07:18.880Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2212.387 ms) ====== [2024-06-26T21:07:18.880Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-06-26T21:07:18.880Z] GC before operation: completed in 202.548 ms, heap usage 146.279 MB -> 65.421 MB. [2024-06-26T21:07:20.803Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2196.688 ms) ====== [2024-06-26T21:07:20.803Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-06-26T21:07:20.803Z] GC before operation: completed in 209.169 ms, heap usage 142.806 MB -> 65.662 MB. [2024-06-26T21:07:23.836Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2208.570 ms) ====== [2024-06-26T21:07:23.836Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-06-26T21:07:23.836Z] GC before operation: completed in 205.160 ms, heap usage 165.868 MB -> 65.650 MB. [2024-06-26T21:07:25.767Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2109.893 ms) ====== [2024-06-26T21:07:25.767Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-06-26T21:07:25.767Z] GC before operation: completed in 222.653 ms, heap usage 164.994 MB -> 65.762 MB. [2024-06-26T21:07:27.692Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2021.326 ms) ====== [2024-06-26T21:07:27.692Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-06-26T21:07:27.692Z] GC before operation: completed in 208.933 ms, heap usage 99.483 MB -> 65.576 MB. [2024-06-26T21:07:29.618Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2044.330 ms) ====== [2024-06-26T21:07:29.618Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-06-26T21:07:30.556Z] GC before operation: completed in 220.887 ms, heap usage 183.403 MB -> 66.380 MB. [2024-06-26T21:07:32.482Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2041.200 ms) ====== [2024-06-26T21:07:32.482Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-06-26T21:07:32.482Z] GC before operation: completed in 214.392 ms, heap usage 116.528 MB -> 65.926 MB. [2024-06-26T21:07:34.406Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2063.471 ms) ====== [2024-06-26T21:07:34.406Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-06-26T21:07:34.406Z] GC before operation: completed in 220.917 ms, heap usage 133.340 MB -> 66.164 MB. [2024-06-26T21:07:37.381Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2027.298 ms) ====== [2024-06-26T21:07:37.381Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-06-26T21:07:37.381Z] GC before operation: completed in 220.798 ms, heap usage 144.262 MB -> 66.430 MB. [2024-06-26T21:07:39.305Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1970.748 ms) ====== [2024-06-26T21:07:39.305Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-06-26T21:07:39.305Z] GC before operation: completed in 230.726 ms, heap usage 160.949 MB -> 66.612 MB. [2024-06-26T21:07:41.229Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2019.281 ms) ====== [2024-06-26T21:07:41.229Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-06-26T21:07:41.229Z] GC before operation: completed in 239.686 ms, heap usage 297.886 MB -> 66.981 MB. [2024-06-26T21:07:43.154Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2007.835 ms) ====== [2024-06-26T21:07:43.154Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-06-26T21:07:44.778Z] GC before operation: completed in 256.140 ms, heap usage 218.242 MB -> 66.933 MB. [2024-06-26T21:07:45.715Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1976.892 ms) ====== [2024-06-26T21:07:45.715Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-06-26T21:07:45.715Z] GC before operation: completed in 245.759 ms, heap usage 199.763 MB -> 67.216 MB. [2024-06-26T21:07:47.639Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2025.675 ms) ====== [2024-06-26T21:07:47.639Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-06-26T21:07:48.575Z] GC before operation: completed in 245.556 ms, heap usage 140.074 MB -> 67.021 MB. [2024-06-26T21:07:50.499Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1929.361 ms) ====== [2024-06-26T21:07:50.499Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-06-26T21:07:50.499Z] GC before operation: completed in 252.823 ms, heap usage 215.642 MB -> 67.394 MB. [2024-06-26T21:07:52.421Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1952.237 ms) ====== [2024-06-26T21:07:52.421Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-06-26T21:07:52.421Z] GC before operation: completed in 242.175 ms, heap usage 184.345 MB -> 67.349 MB. [2024-06-26T21:07:54.345Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1944.051 ms) ====== [2024-06-26T21:07:54.345Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-06-26T21:07:55.286Z] GC before operation: completed in 253.977 ms, heap usage 163.671 MB -> 67.179 MB. [2024-06-26T21:07:57.224Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2029.727 ms) ====== [2024-06-26T21:07:57.224Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-06-26T21:07:57.224Z] GC before operation: completed in 255.909 ms, heap usage 168.143 MB -> 67.425 MB. [2024-06-26T21:07:59.146Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1931.062 ms) ====== [2024-06-26T21:07:59.146Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-06-26T21:07:59.146Z] GC before operation: completed in 260.570 ms, heap usage 142.985 MB -> 67.343 MB. [2024-06-26T21:08:01.068Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2024.362 ms) ====== [2024-06-26T21:08:01.068Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-06-26T21:08:02.005Z] GC before operation: completed in 255.057 ms, heap usage 159.666 MB -> 67.458 MB. [2024-06-26T21:08:03.928Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2029.243 ms) ====== [2024-06-26T21:08:03.928Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-06-26T21:08:03.928Z] GC before operation: completed in 252.596 ms, heap usage 168.817 MB -> 67.565 MB. [2024-06-26T21:08:05.851Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1809.371 ms) ====== [2024-06-26T21:08:05.851Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-06-26T21:08:05.851Z] GC before operation: completed in 253.938 ms, heap usage 146.528 MB -> 67.652 MB. [2024-06-26T21:08:07.773Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1957.894 ms) ====== [2024-06-26T21:08:07.773Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-06-26T21:08:07.773Z] GC before operation: completed in 253.495 ms, heap usage 145.870 MB -> 67.896 MB. [2024-06-26T21:08:09.697Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1884.331 ms) ====== [2024-06-26T21:08:09.697Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-06-26T21:08:10.638Z] GC before operation: completed in 258.578 ms, heap usage 148.364 MB -> 67.830 MB. [2024-06-26T21:08:12.563Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1922.423 ms) ====== [2024-06-26T21:08:12.563Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-06-26T21:08:12.563Z] GC before operation: completed in 263.430 ms, heap usage 113.177 MB -> 67.664 MB. [2024-06-26T21:08:14.485Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2061.245 ms) ====== [2024-06-26T21:08:14.485Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-06-26T21:08:14.485Z] GC before operation: completed in 265.163 ms, heap usage 130.990 MB -> 68.179 MB. [2024-06-26T21:08:16.410Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1879.044 ms) ====== [2024-06-26T21:08:16.410Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-06-26T21:08:17.346Z] GC before operation: completed in 254.498 ms, heap usage 263.792 MB -> 68.418 MB. [2024-06-26T21:08:19.269Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1884.196 ms) ====== [2024-06-26T21:08:19.269Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-06-26T21:08:19.269Z] GC before operation: completed in 247.316 ms, heap usage 113.750 MB -> 67.962 MB. [2024-06-26T21:08:21.192Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1863.196 ms) ====== [2024-06-26T21:08:21.192Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-06-26T21:08:21.192Z] GC before operation: completed in 283.753 ms, heap usage 261.751 MB -> 68.625 MB. [2024-06-26T21:08:23.137Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1816.560 ms) ====== [2024-06-26T21:08:23.137Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-06-26T21:08:23.137Z] GC before operation: completed in 256.906 ms, heap usage 291.116 MB -> 79.618 MB. [2024-06-26T21:08:25.062Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1800.861 ms) ====== [2024-06-26T21:08:25.062Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-06-26T21:08:25.062Z] GC before operation: completed in 266.153 ms, heap usage 315.741 MB -> 79.718 MB. [2024-06-26T21:08:26.991Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1737.031 ms) ====== [2024-06-26T21:08:26.991Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-06-26T21:08:27.929Z] GC before operation: completed in 284.386 ms, heap usage 305.816 MB -> 68.918 MB. [2024-06-26T21:08:29.854Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1882.445 ms) ====== [2024-06-26T21:08:29.855Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-06-26T21:08:29.855Z] GC before operation: completed in 258.202 ms, heap usage 143.975 MB -> 68.858 MB. [2024-06-26T21:08:31.785Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1954.726 ms) ====== [2024-06-26T21:08:31.785Z] ----------------------------------- [2024-06-26T21:08:31.785Z] renaissance-dec-tree_0_PASSED [2024-06-26T21:08:31.785Z] ----------------------------------- [2024-06-26T21:08:31.785Z] [2024-06-26T21:08:31.785Z] TEST TEARDOWN: [2024-06-26T21:08:31.785Z] Nothing to be done for teardown. [2024-06-26T21:08:31.785Z] renaissance-dec-tree_0 Finish Time: Wed Jun 26 21:08:31 2024 Epoch Time (ms): 1719436111625