[2024-08-09T20:56:16.254Z] Running test renaissance-dec-tree_0 ... [2024-08-09T20:56:16.254Z] =============================================== [2024-08-09T20:56:16.254Z] renaissance-dec-tree_0 Start Time: Fri Aug 9 20:56:15 2024 Epoch Time (ms): 1723236975558 [2024-08-09T20:56:16.254Z] variation: NoOptions [2024-08-09T20:56:16.254Z] JVM_OPTIONS: [2024-08-09T20:56:16.254Z] { \ [2024-08-09T20:56:16.254Z] echo ""; echo "TEST SETUP:"; \ [2024-08-09T20:56:16.254Z] echo "Nothing to be done for setup."; \ [2024-08-09T20:56:16.254Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232366558997/renaissance-dec-tree_0"; \ [2024-08-09T20:56:16.254Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232366558997/renaissance-dec-tree_0"; \ [2024-08-09T20:56:16.254Z] echo ""; echo "TESTING:"; \ [2024-08-09T20:56:16.254Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232366558997/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-09T20:56:16.254Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232366558997/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-09T20:56:16.254Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-09T20:56:16.254Z] echo "Nothing to be done for teardown."; \ [2024-08-09T20:56:16.254Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232366558997/TestTargetResult"; [2024-08-09T20:56:16.254Z] [2024-08-09T20:56:16.254Z] TEST SETUP: [2024-08-09T20:56:16.254Z] Nothing to be done for setup. [2024-08-09T20:56:16.254Z] [2024-08-09T20:56:16.254Z] TESTING: [2024-08-09T20:56:20.385Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-09T20:56:23.386Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-09T20:56:31.496Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-09T20:56:31.496Z] GC before operation: completed in 63.777 ms, heap usage 56.642 MB -> 37.275 MB. [2024-08-09T20:56:44.958Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (13154.728 ms) ====== [2024-08-09T20:56:44.958Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-09T20:56:44.958Z] GC before operation: completed in 162.177 ms, heap usage 255.224 MB -> 68.930 MB. [2024-08-09T20:56:47.981Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3364.201 ms) ====== [2024-08-09T20:56:47.981Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-09T20:56:47.981Z] GC before operation: completed in 174.338 ms, heap usage 397.244 MB -> 69.230 MB. [2024-08-09T20:56:49.952Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2530.372 ms) ====== [2024-08-09T20:56:49.953Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-09T20:56:50.901Z] GC before operation: completed in 157.186 ms, heap usage 320.405 MB -> 69.513 MB. [2024-08-09T20:56:53.380Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2308.721 ms) ====== [2024-08-09T20:56:53.380Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-09T20:56:53.380Z] GC before operation: completed in 179.535 ms, heap usage 166.546 MB -> 69.487 MB. [2024-08-09T20:56:55.556Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2186.602 ms) ====== [2024-08-09T20:56:55.556Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-09T20:56:55.556Z] GC before operation: completed in 180.446 ms, heap usage 454.578 MB -> 70.165 MB. [2024-08-09T20:56:57.504Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2212.926 ms) ====== [2024-08-09T20:56:57.504Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-09T20:56:57.504Z] GC before operation: completed in 173.781 ms, heap usage 156.685 MB -> 69.874 MB. [2024-08-09T20:56:59.471Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2125.712 ms) ====== [2024-08-09T20:56:59.471Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-09T20:57:00.417Z] GC before operation: completed in 181.274 ms, heap usage 464.643 MB -> 70.726 MB. [2024-08-09T20:57:02.364Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2072.124 ms) ====== [2024-08-09T20:57:02.364Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-09T20:57:02.364Z] GC before operation: completed in 180.238 ms, heap usage 108.154 MB -> 70.251 MB. [2024-08-09T20:57:04.311Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2139.523 ms) ====== [2024-08-09T20:57:04.311Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-09T20:57:04.311Z] GC before operation: completed in 190.269 ms, heap usage 354.928 MB -> 70.608 MB. [2024-08-09T20:57:07.315Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2159.760 ms) ====== [2024-08-09T20:57:07.315Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-09T20:57:07.315Z] GC before operation: completed in 186.832 ms, heap usage 115.737 MB -> 70.162 MB. [2024-08-09T20:57:09.262Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2056.240 ms) ====== [2024-08-09T20:57:09.262Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-09T20:57:09.262Z] GC before operation: completed in 186.636 ms, heap usage 367.243 MB -> 70.978 MB. [2024-08-09T20:57:11.229Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2215.808 ms) ====== [2024-08-09T20:57:11.229Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-09T20:57:11.229Z] GC before operation: completed in 195.225 ms, heap usage 154.288 MB -> 70.829 MB. [2024-08-09T20:57:13.174Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2047.940 ms) ====== [2024-08-09T20:57:13.174Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-09T20:57:14.122Z] GC before operation: completed in 213.552 ms, heap usage 454.707 MB -> 71.444 MB. [2024-08-09T20:57:16.068Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2009.088 ms) ====== [2024-08-09T20:57:16.068Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-09T20:57:16.068Z] GC before operation: completed in 198.445 ms, heap usage 107.267 MB -> 70.720 MB. [2024-08-09T20:57:18.015Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1998.397 ms) ====== [2024-08-09T20:57:18.015Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-09T20:57:18.015Z] GC before operation: completed in 205.386 ms, heap usage 343.799 MB -> 71.401 MB. [2024-08-09T20:57:19.965Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2035.371 ms) ====== [2024-08-09T20:57:19.965Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-09T20:57:20.912Z] GC before operation: completed in 178.711 ms, heap usage 110.049 MB -> 71.192 MB. [2024-08-09T20:57:22.859Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1973.589 ms) ====== [2024-08-09T20:57:22.859Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-09T20:57:22.859Z] GC before operation: completed in 197.199 ms, heap usage 339.458 MB -> 71.611 MB. [2024-08-09T20:57:24.804Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1906.015 ms) ====== [2024-08-09T20:57:24.805Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-09T20:57:24.805Z] GC before operation: completed in 189.487 ms, heap usage 104.548 MB -> 71.379 MB. [2024-08-09T20:57:26.749Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2015.497 ms) ====== [2024-08-09T20:57:26.749Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-09T20:57:26.749Z] GC before operation: completed in 179.895 ms, heap usage 318.231 MB -> 71.875 MB. [2024-08-09T20:57:28.696Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1906.460 ms) ====== [2024-08-09T20:57:28.696Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-09T20:57:28.696Z] GC before operation: completed in 178.439 ms, heap usage 451.639 MB -> 77.616 MB. [2024-08-09T20:57:30.653Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1774.145 ms) ====== [2024-08-09T20:57:30.653Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-09T20:57:30.653Z] GC before operation: completed in 193.357 ms, heap usage 357.400 MB -> 72.151 MB. [2024-08-09T20:57:32.597Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1878.016 ms) ====== [2024-08-09T20:57:32.597Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-09T20:57:33.570Z] GC before operation: completed in 186.937 ms, heap usage 415.238 MB -> 72.162 MB. [2024-08-09T20:57:34.520Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1855.093 ms) ====== [2024-08-09T20:57:34.520Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-09T20:57:35.548Z] GC before operation: completed in 187.694 ms, heap usage 409.443 MB -> 72.258 MB. [2024-08-09T20:57:36.496Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1832.646 ms) ====== [2024-08-09T20:57:36.496Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-09T20:57:37.483Z] GC before operation: completed in 193.036 ms, heap usage 417.545 MB -> 77.781 MB. [2024-08-09T20:57:39.439Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1862.639 ms) ====== [2024-08-09T20:57:39.439Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-09T20:57:39.439Z] GC before operation: completed in 184.552 ms, heap usage 329.431 MB -> 83.340 MB. [2024-08-09T20:57:41.382Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1848.256 ms) ====== [2024-08-09T20:57:41.382Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-09T20:57:41.382Z] GC before operation: completed in 194.123 ms, heap usage 330.045 MB -> 72.760 MB. [2024-08-09T20:57:43.354Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1816.800 ms) ====== [2024-08-09T20:57:43.354Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-09T20:57:43.354Z] GC before operation: completed in 187.015 ms, heap usage 446.362 MB -> 73.088 MB. [2024-08-09T20:57:45.296Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1807.129 ms) ====== [2024-08-09T20:57:45.296Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-09T20:57:45.296Z] GC before operation: completed in 178.932 ms, heap usage 435.324 MB -> 72.870 MB. [2024-08-09T20:57:47.246Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1797.222 ms) ====== [2024-08-09T20:57:47.246Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-09T20:57:47.246Z] GC before operation: completed in 197.934 ms, heap usage 394.121 MB -> 84.059 MB. [2024-08-09T20:57:49.318Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1795.106 ms) ====== [2024-08-09T20:57:49.318Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-09T20:57:49.318Z] GC before operation: completed in 189.257 ms, heap usage 298.658 MB -> 73.050 MB. [2024-08-09T20:57:51.261Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1776.265 ms) ====== [2024-08-09T20:57:51.261Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-09T20:57:51.261Z] GC before operation: completed in 203.378 ms, heap usage 385.232 MB -> 84.060 MB. [2024-08-09T20:57:53.204Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1818.701 ms) ====== [2024-08-09T20:57:53.204Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-09T20:57:53.204Z] GC before operation: completed in 210.242 ms, heap usage 321.787 MB -> 73.320 MB. [2024-08-09T20:57:55.156Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1841.460 ms) ====== [2024-08-09T20:57:55.156Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-09T20:57:55.156Z] GC before operation: completed in 206.140 ms, heap usage 443.727 MB -> 73.478 MB. [2024-08-09T20:57:56.829Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1746.252 ms) ====== [2024-08-09T20:57:56.829Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-09T20:57:56.829Z] GC before operation: completed in 212.806 ms, heap usage 238.854 MB -> 73.380 MB. [2024-08-09T20:57:58.773Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1766.209 ms) ====== [2024-08-09T20:57:58.773Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-09T20:57:58.773Z] GC before operation: completed in 205.224 ms, heap usage 247.732 MB -> 73.489 MB. [2024-08-09T20:58:00.718Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1745.031 ms) ====== [2024-08-09T20:58:00.718Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-09T20:58:00.718Z] GC before operation: completed in 197.069 ms, heap usage 263.174 MB -> 73.737 MB. [2024-08-09T20:58:02.730Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1766.947 ms) ====== [2024-08-09T20:58:02.730Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-09T20:58:02.730Z] GC before operation: completed in 218.570 ms, heap usage 458.321 MB -> 73.909 MB. [2024-08-09T20:58:04.672Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1781.856 ms) ====== [2024-08-09T20:58:04.673Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-09T20:58:04.673Z] GC before operation: completed in 205.509 ms, heap usage 418.870 MB -> 73.832 MB. [2024-08-09T20:58:06.651Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1743.825 ms) ====== [2024-08-09T20:58:06.651Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-09T20:58:06.651Z] GC before operation: completed in 212.814 ms, heap usage 237.974 MB -> 74.035 MB. [2024-08-09T20:58:08.596Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1685.850 ms) ====== [2024-08-09T20:58:09.542Z] ----------------------------------- [2024-08-09T20:58:09.542Z] renaissance-dec-tree_0_PASSED [2024-08-09T20:58:09.542Z] ----------------------------------- [2024-08-09T20:58:09.542Z] [2024-08-09T20:58:09.542Z] TEST TEARDOWN: [2024-08-09T20:58:09.542Z] Nothing to be done for teardown. [2024-08-09T20:58:09.542Z] renaissance-dec-tree_0 Finish Time: Fri Aug 9 20:58:08 2024 Epoch Time (ms): 1723237088750