[2024-08-10T00:18:39.926Z] Running test renaissance-dec-tree_0 ... [2024-08-10T00:18:39.926Z] =============================================== [2024-08-10T00:18:39.926Z] renaissance-dec-tree_0 Start Time: Sat Aug 10 00:18:39 2024 Epoch Time (ms): 1723249119234 [2024-08-10T00:18:39.926Z] variation: NoOptions [2024-08-10T00:18:39.926Z] JVM_OPTIONS: [2024-08-10T00:18:39.926Z] { \ [2024-08-10T00:18:39.926Z] echo ""; echo "TEST SETUP:"; \ [2024-08-10T00:18:39.926Z] echo "Nothing to be done for setup."; \ [2024-08-10T00:18:39.926Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232487606933/renaissance-dec-tree_0"; \ [2024-08-10T00:18:39.926Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232487606933/renaissance-dec-tree_0"; \ [2024-08-10T00:18:39.926Z] echo ""; echo "TESTING:"; \ [2024-08-10T00:18:39.926Z] "/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_17232487606933/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-10T00:18:39.926Z] 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_17232487606933/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-10T00:18:39.927Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-10T00:18:39.927Z] echo "Nothing to be done for teardown."; \ [2024-08-10T00:18:39.927Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232487606933/TestTargetResult"; [2024-08-10T00:18:39.927Z] [2024-08-10T00:18:39.927Z] TEST SETUP: [2024-08-10T00:18:39.927Z] Nothing to be done for setup. [2024-08-10T00:18:39.927Z] [2024-08-10T00:18:39.927Z] TESTING: [2024-08-10T00:18:44.058Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-10T00:18:47.060Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-10T00:18:49.006Z] WARNING: An illegal reflective access operation has occurred [2024-08-10T00:18:49.006Z] 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_17232487606933/renaissance-dec-tree_0/harness-001840-7332728150393767299/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-10T00:18:49.006Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-10T00:18:49.006Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-10T00:18:49.006Z] WARNING: All illegal access operations will be denied in a future release [2024-08-10T00:18:54.758Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-10T00:18:54.758Z] GC before operation: completed in 83.804 ms, heap usage 71.380 MB -> 34.330 MB. [2024-08-10T00:19:10.489Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15649.549 ms) ====== [2024-08-10T00:19:10.489Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-10T00:19:10.489Z] GC before operation: completed in 186.679 ms, heap usage 174.687 MB -> 63.997 MB. [2024-08-10T00:19:13.505Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3409.578 ms) ====== [2024-08-10T00:19:13.505Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-10T00:19:13.505Z] GC before operation: completed in 181.754 ms, heap usage 194.053 MB -> 64.593 MB. [2024-08-10T00:19:16.517Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2743.860 ms) ====== [2024-08-10T00:19:16.517Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-10T00:19:16.517Z] GC before operation: completed in 193.179 ms, heap usage 262.022 MB -> 65.014 MB. [2024-08-10T00:19:19.522Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2460.800 ms) ====== [2024-08-10T00:19:19.522Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-10T00:19:19.522Z] GC before operation: completed in 185.948 ms, heap usage 220.556 MB -> 65.239 MB. [2024-08-10T00:19:21.489Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2386.694 ms) ====== [2024-08-10T00:19:21.489Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-10T00:19:22.436Z] GC before operation: completed in 187.255 ms, heap usage 207.104 MB -> 65.312 MB. [2024-08-10T00:19:24.384Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2208.597 ms) ====== [2024-08-10T00:19:24.384Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-10T00:19:24.384Z] GC before operation: completed in 215.372 ms, heap usage 185.646 MB -> 65.517 MB. [2024-08-10T00:19:26.335Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2194.731 ms) ====== [2024-08-10T00:19:26.335Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-10T00:19:27.285Z] GC before operation: completed in 204.698 ms, heap usage 186.293 MB -> 65.720 MB. [2024-08-10T00:19:29.239Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2071.984 ms) ====== [2024-08-10T00:19:29.239Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-10T00:19:29.239Z] GC before operation: completed in 209.259 ms, heap usage 209.746 MB -> 65.845 MB. [2024-08-10T00:19:31.194Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2150.247 ms) ====== [2024-08-10T00:19:31.194Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-10T00:19:31.194Z] GC before operation: completed in 209.939 ms, heap usage 231.036 MB -> 65.938 MB. [2024-08-10T00:19:34.197Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2157.035 ms) ====== [2024-08-10T00:19:34.197Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-10T00:19:34.197Z] GC before operation: completed in 226.932 ms, heap usage 218.669 MB -> 66.038 MB. [2024-08-10T00:19:36.158Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2001.742 ms) ====== [2024-08-10T00:19:36.158Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-10T00:19:36.158Z] GC before operation: completed in 210.911 ms, heap usage 200.084 MB -> 66.297 MB. [2024-08-10T00:19:38.104Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2058.061 ms) ====== [2024-08-10T00:19:38.104Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-10T00:19:38.104Z] GC before operation: completed in 225.656 ms, heap usage 216.199 MB -> 66.435 MB. [2024-08-10T00:19:41.107Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2125.329 ms) ====== [2024-08-10T00:19:41.107Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-10T00:19:41.107Z] GC before operation: completed in 232.871 ms, heap usage 198.814 MB -> 66.401 MB. [2024-08-10T00:19:43.056Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2071.907 ms) ====== [2024-08-10T00:19:43.056Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-10T00:19:43.056Z] GC before operation: completed in 225.612 ms, heap usage 232.364 MB -> 66.694 MB. [2024-08-10T00:19:45.002Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2070.517 ms) ====== [2024-08-10T00:19:45.002Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-10T00:19:45.002Z] GC before operation: completed in 232.409 ms, heap usage 214.139 MB -> 66.618 MB. [2024-08-10T00:19:48.005Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2049.002 ms) ====== [2024-08-10T00:19:48.005Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-10T00:19:48.005Z] GC before operation: completed in 229.655 ms, heap usage 196.439 MB -> 66.927 MB. [2024-08-10T00:19:49.953Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2023.484 ms) ====== [2024-08-10T00:19:49.953Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-10T00:19:49.953Z] GC before operation: completed in 252.407 ms, heap usage 231.257 MB -> 66.883 MB. [2024-08-10T00:19:51.899Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1938.260 ms) ====== [2024-08-10T00:19:51.899Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-10T00:19:51.899Z] GC before operation: completed in 239.971 ms, heap usage 164.763 MB -> 66.715 MB. [2024-08-10T00:19:53.845Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1936.443 ms) ====== [2024-08-10T00:19:53.845Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-10T00:19:53.845Z] GC before operation: completed in 227.897 ms, heap usage 204.118 MB -> 67.075 MB. [2024-08-10T00:19:55.791Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1958.328 ms) ====== [2024-08-10T00:19:55.791Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-10T00:19:57.603Z] GC before operation: completed in 251.949 ms, heap usage 193.593 MB -> 67.172 MB. [2024-08-10T00:19:58.553Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1877.056 ms) ====== [2024-08-10T00:19:58.553Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-10T00:19:58.553Z] GC before operation: completed in 243.457 ms, heap usage 191.439 MB -> 67.279 MB. [2024-08-10T00:20:00.502Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1946.661 ms) ====== [2024-08-10T00:20:00.502Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-10T00:20:00.502Z] GC before operation: completed in 240.601 ms, heap usage 196.583 MB -> 67.389 MB. [2024-08-10T00:20:02.445Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1959.328 ms) ====== [2024-08-10T00:20:02.445Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-10T00:20:03.393Z] GC before operation: completed in 245.410 ms, heap usage 171.280 MB -> 67.197 MB. [2024-08-10T00:20:05.336Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1951.638 ms) ====== [2024-08-10T00:20:05.336Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-10T00:20:05.336Z] GC before operation: completed in 251.967 ms, heap usage 160.074 MB -> 67.296 MB. [2024-08-10T00:20:07.278Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1952.353 ms) ====== [2024-08-10T00:20:07.278Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-10T00:20:07.278Z] GC before operation: completed in 247.603 ms, heap usage 145.241 MB -> 67.379 MB. [2024-08-10T00:20:09.219Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1919.535 ms) ====== [2024-08-10T00:20:09.219Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-10T00:20:09.219Z] GC before operation: completed in 255.993 ms, heap usage 196.356 MB -> 67.768 MB. [2024-08-10T00:20:11.165Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1899.936 ms) ====== [2024-08-10T00:20:11.165Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-10T00:20:12.114Z] GC before operation: completed in 241.609 ms, heap usage 165.024 MB -> 67.601 MB. [2024-08-10T00:20:14.062Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1947.404 ms) ====== [2024-08-10T00:20:14.062Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-10T00:20:14.062Z] GC before operation: completed in 260.668 ms, heap usage 198.619 MB -> 67.950 MB. [2024-08-10T00:20:16.010Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1844.526 ms) ====== [2024-08-10T00:20:16.010Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-10T00:20:16.010Z] GC before operation: completed in 260.754 ms, heap usage 287.875 MB -> 79.171 MB. [2024-08-10T00:20:17.961Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1904.824 ms) ====== [2024-08-10T00:20:17.961Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-10T00:20:17.961Z] GC before operation: completed in 252.065 ms, heap usage 276.593 MB -> 68.148 MB. [2024-08-10T00:20:20.036Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1774.705 ms) ====== [2024-08-10T00:20:20.036Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-10T00:20:20.036Z] GC before operation: completed in 277.055 ms, heap usage 197.782 MB -> 68.246 MB. [2024-08-10T00:20:21.982Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1932.474 ms) ====== [2024-08-10T00:20:21.982Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-10T00:20:22.932Z] GC before operation: completed in 272.384 ms, heap usage 286.131 MB -> 68.488 MB. [2024-08-10T00:20:23.879Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1754.434 ms) ====== [2024-08-10T00:20:23.880Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-10T00:20:24.826Z] GC before operation: completed in 264.168 ms, heap usage 156.882 MB -> 68.160 MB. [2024-08-10T00:20:26.773Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1888.899 ms) ====== [2024-08-10T00:20:26.773Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-10T00:20:26.773Z] GC before operation: completed in 264.019 ms, heap usage 307.660 MB -> 68.544 MB. [2024-08-10T00:20:28.722Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1871.865 ms) ====== [2024-08-10T00:20:28.722Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-10T00:20:28.722Z] GC before operation: completed in 268.592 ms, heap usage 222.156 MB -> 68.795 MB. [2024-08-10T00:20:30.670Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1906.606 ms) ====== [2024-08-10T00:20:30.670Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-10T00:20:30.670Z] GC before operation: completed in 278.851 ms, heap usage 192.231 MB -> 68.753 MB. [2024-08-10T00:20:32.614Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1857.202 ms) ====== [2024-08-10T00:20:32.614Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-10T00:20:33.560Z] GC before operation: completed in 260.803 ms, heap usage 270.257 MB -> 79.740 MB. [2024-08-10T00:20:34.507Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1825.326 ms) ====== [2024-08-10T00:20:34.507Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-10T00:20:35.453Z] GC before operation: completed in 268.063 ms, heap usage 141.379 MB -> 68.647 MB. [2024-08-10T00:20:37.399Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1868.997 ms) ====== [2024-08-10T00:20:37.399Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-10T00:20:37.399Z] GC before operation: completed in 257.965 ms, heap usage 108.926 MB -> 68.477 MB. [2024-08-10T00:20:39.368Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1824.144 ms) ====== [2024-08-10T00:20:39.368Z] ----------------------------------- [2024-08-10T00:20:39.368Z] renaissance-dec-tree_0_PASSED [2024-08-10T00:20:39.368Z] ----------------------------------- [2024-08-10T00:20:39.368Z] [2024-08-10T00:20:39.368Z] TEST TEARDOWN: [2024-08-10T00:20:39.368Z] Nothing to be done for teardown. [2024-08-10T00:20:39.368Z] renaissance-dec-tree_0 Finish Time: Sat Aug 10 00:20:39 2024 Epoch Time (ms): 1723249239201