[2025-02-12T21:40:56.221Z] Running test renaissance-dec-tree_0 ... [2025-02-12T21:40:56.221Z] =============================================== [2025-02-12T21:40:56.221Z] renaissance-dec-tree_0 Start Time: Wed Feb 12 21:40:55 2025 Epoch Time (ms): 1739396455433 [2025-02-12T21:40:56.221Z] variation: NoOptions [2025-02-12T21:40:56.221Z] JVM_OPTIONS: [2025-02-12T21:40:56.221Z] { \ [2025-02-12T21:40:56.221Z] echo ""; echo "TEST SETUP:"; \ [2025-02-12T21:40:56.221Z] echo "Nothing to be done for setup."; \ [2025-02-12T21:40:56.221Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17393961392082/renaissance-dec-tree_0"; \ [2025-02-12T21:40:56.221Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17393961392082/renaissance-dec-tree_0"; \ [2025-02-12T21:40:56.221Z] echo ""; echo "TESTING:"; \ [2025-02-12T21:40:56.221Z] "/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_17393961392082/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-12T21:40:56.221Z] 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_17393961392082/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-12T21:40:56.221Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-12T21:40:56.221Z] echo "Nothing to be done for teardown."; \ [2025-02-12T21:40:56.221Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17393961392082/TestTargetResult"; [2025-02-12T21:40:56.221Z] [2025-02-12T21:40:56.221Z] TEST SETUP: [2025-02-12T21:40:56.221Z] Nothing to be done for setup. [2025-02-12T21:40:56.221Z] [2025-02-12T21:40:56.221Z] TESTING: [2025-02-12T21:40:59.268Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-12T21:41:02.303Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2025-02-12T21:41:09.123Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-12T21:41:09.123Z] GC before operation: completed in 70.616 ms, heap usage 59.214 MB -> 37.135 MB. [2025-02-12T21:41:24.950Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (13899.148 ms) ====== [2025-02-12T21:41:24.950Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-12T21:41:24.950Z] GC before operation: completed in 139.051 ms, heap usage 200.896 MB -> 68.641 MB. [2025-02-12T21:41:26.926Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3281.090 ms) ====== [2025-02-12T21:41:26.926Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-12T21:41:26.926Z] GC before operation: completed in 129.544 ms, heap usage 139.443 MB -> 69.194 MB. [2025-02-12T21:41:29.967Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2538.776 ms) ====== [2025-02-12T21:41:29.967Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-12T21:41:29.968Z] GC before operation: completed in 126.713 ms, heap usage 365.444 MB -> 69.442 MB. [2025-02-12T21:41:31.937Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2290.128 ms) ====== [2025-02-12T21:41:31.937Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-12T21:41:31.937Z] GC before operation: completed in 135.180 ms, heap usage 195.073 MB -> 69.639 MB. [2025-02-12T21:41:33.904Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2259.410 ms) ====== [2025-02-12T21:41:33.904Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-12T21:41:34.862Z] GC before operation: completed in 142.879 ms, heap usage 221.064 MB -> 69.859 MB. [2025-02-12T21:41:36.830Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2183.719 ms) ====== [2025-02-12T21:41:36.830Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-12T21:41:36.830Z] GC before operation: completed in 149.427 ms, heap usage 213.224 MB -> 70.254 MB. [2025-02-12T21:41:38.797Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2123.512 ms) ====== [2025-02-12T21:41:38.797Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-12T21:41:38.797Z] GC before operation: completed in 138.914 ms, heap usage 180.604 MB -> 70.216 MB. [2025-02-12T21:41:40.765Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2059.933 ms) ====== [2025-02-12T21:41:40.766Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-12T21:41:41.723Z] GC before operation: completed in 147.850 ms, heap usage 476.242 MB -> 81.761 MB. [2025-02-12T21:41:43.689Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2032.678 ms) ====== [2025-02-12T21:41:43.689Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-12T21:41:43.689Z] GC before operation: completed in 156.546 ms, heap usage 344.557 MB -> 70.733 MB. [2025-02-12T21:41:45.655Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2087.347 ms) ====== [2025-02-12T21:41:45.655Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-12T21:41:45.655Z] GC before operation: completed in 151.073 ms, heap usage 406.199 MB -> 70.754 MB. [2025-02-12T21:41:47.623Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1993.240 ms) ====== [2025-02-12T21:41:47.623Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-12T21:41:47.623Z] GC before operation: completed in 158.743 ms, heap usage 135.827 MB -> 70.683 MB. [2025-02-12T21:41:49.592Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2087.152 ms) ====== [2025-02-12T21:41:49.592Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-12T21:41:50.551Z] GC before operation: completed in 160.629 ms, heap usage 407.244 MB -> 70.980 MB. [2025-02-12T21:41:52.516Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1991.859 ms) ====== [2025-02-12T21:41:52.516Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-12T21:41:52.516Z] GC before operation: completed in 180.731 ms, heap usage 138.361 MB -> 70.751 MB. [2025-02-12T21:41:54.491Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2025.942 ms) ====== [2025-02-12T21:41:54.491Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-12T21:41:54.491Z] GC before operation: completed in 164.674 ms, heap usage 421.961 MB -> 71.358 MB. [2025-02-12T21:41:56.465Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1960.491 ms) ====== [2025-02-12T21:41:56.465Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-12T21:41:56.465Z] GC before operation: completed in 165.375 ms, heap usage 152.532 MB -> 71.132 MB. [2025-02-12T21:41:58.441Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1940.480 ms) ====== [2025-02-12T21:41:58.441Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-12T21:41:58.441Z] GC before operation: completed in 181.111 ms, heap usage 427.032 MB -> 71.634 MB. [2025-02-12T21:42:00.407Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1904.333 ms) ====== [2025-02-12T21:42:00.407Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-12T21:42:00.407Z] GC before operation: completed in 192.683 ms, heap usage 149.917 MB -> 71.264 MB. [2025-02-12T21:42:02.373Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1882.123 ms) ====== [2025-02-12T21:42:02.373Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-12T21:42:03.330Z] GC before operation: completed in 181.329 ms, heap usage 412.002 MB -> 71.858 MB. [2025-02-12T21:42:04.287Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1854.494 ms) ====== [2025-02-12T21:42:04.287Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-12T21:42:05.248Z] GC before operation: completed in 163.561 ms, heap usage 182.588 MB -> 71.648 MB. [2025-02-12T21:42:06.397Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1923.364 ms) ====== [2025-02-12T21:42:06.397Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-12T21:42:07.362Z] GC before operation: completed in 173.419 ms, heap usage 446.449 MB -> 72.084 MB. [2025-02-12T21:42:09.937Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1914.817 ms) ====== [2025-02-12T21:42:09.937Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-12T21:42:09.937Z] GC before operation: completed in 175.174 ms, heap usage 139.721 MB -> 71.687 MB. [2025-02-12T21:42:11.422Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2031.118 ms) ====== [2025-02-12T21:42:11.422Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-12T21:42:11.422Z] GC before operation: completed in 175.384 ms, heap usage 390.195 MB -> 72.067 MB. [2025-02-12T21:42:13.439Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1910.098 ms) ====== [2025-02-12T21:42:13.439Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-12T21:42:13.439Z] GC before operation: completed in 196.957 ms, heap usage 148.528 MB -> 71.877 MB. [2025-02-12T21:42:15.428Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1870.572 ms) ====== [2025-02-12T21:42:15.428Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-12T21:42:15.428Z] GC before operation: completed in 185.861 ms, heap usage 386.264 MB -> 72.282 MB. [2025-02-12T21:42:17.398Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1858.439 ms) ====== [2025-02-12T21:42:17.398Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-12T21:42:17.398Z] GC before operation: completed in 174.055 ms, heap usage 139.723 MB -> 72.223 MB. [2025-02-12T21:42:19.364Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1894.975 ms) ====== [2025-02-12T21:42:19.364Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-12T21:42:19.364Z] GC before operation: completed in 201.561 ms, heap usage 384.191 MB -> 72.484 MB. [2025-02-12T21:42:21.328Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1811.995 ms) ====== [2025-02-12T21:42:21.328Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-12T21:42:21.328Z] GC before operation: completed in 182.283 ms, heap usage 141.801 MB -> 72.325 MB. [2025-02-12T21:42:23.293Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1870.490 ms) ====== [2025-02-12T21:42:23.293Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-12T21:42:23.293Z] GC before operation: completed in 204.127 ms, heap usage 359.175 MB -> 83.805 MB. [2025-02-12T21:42:25.263Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1856.747 ms) ====== [2025-02-12T21:42:25.263Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-12T21:42:26.220Z] GC before operation: completed in 227.684 ms, heap usage 325.896 MB -> 83.947 MB. [2025-02-12T21:42:27.178Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1830.172 ms) ====== [2025-02-12T21:42:27.178Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-12T21:42:28.134Z] GC before operation: completed in 193.182 ms, heap usage 313.792 MB -> 83.840 MB. [2025-02-12T21:42:30.099Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1842.522 ms) ====== [2025-02-12T21:42:30.099Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-12T21:42:30.099Z] GC before operation: completed in 203.160 ms, heap usage 296.522 MB -> 72.949 MB. [2025-02-12T21:42:32.065Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1815.419 ms) ====== [2025-02-12T21:42:32.065Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-12T21:42:32.065Z] GC before operation: completed in 197.075 ms, heap usage 464.693 MB -> 73.250 MB. [2025-02-12T21:42:34.032Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1816.620 ms) ====== [2025-02-12T21:42:34.032Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-12T21:42:34.032Z] GC before operation: completed in 199.153 ms, heap usage 444.199 MB -> 73.493 MB. [2025-02-12T21:42:36.004Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1796.858 ms) ====== [2025-02-12T21:42:36.004Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-12T21:42:36.004Z] GC before operation: completed in 192.663 ms, heap usage 428.485 MB -> 78.706 MB. [2025-02-12T21:42:37.980Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1808.523 ms) ====== [2025-02-12T21:42:37.980Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-12T21:42:37.980Z] GC before operation: completed in 193.195 ms, heap usage 331.894 MB -> 73.500 MB. [2025-02-12T21:42:40.006Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1732.102 ms) ====== [2025-02-12T21:42:40.006Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-12T21:42:40.006Z] GC before operation: completed in 181.628 ms, heap usage 279.425 MB -> 79.021 MB. [2025-02-12T21:42:41.981Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1760.380 ms) ====== [2025-02-12T21:42:41.981Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-12T21:42:41.981Z] GC before operation: completed in 191.052 ms, heap usage 406.198 MB -> 84.454 MB. [2025-02-12T21:42:43.961Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1828.245 ms) ====== [2025-02-12T21:42:43.961Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-12T21:42:43.961Z] GC before operation: completed in 202.885 ms, heap usage 310.086 MB -> 73.659 MB. [2025-02-12T21:42:45.988Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1804.718 ms) ====== [2025-02-12T21:42:45.988Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-12T21:42:45.988Z] GC before operation: completed in 200.982 ms, heap usage 428.613 MB -> 84.838 MB. [2025-02-12T21:42:47.959Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1764.446 ms) ====== [2025-02-12T21:42:47.959Z] ----------------------------------- [2025-02-12T21:42:47.959Z] renaissance-dec-tree_0_PASSED [2025-02-12T21:42:47.959Z] ----------------------------------- [2025-02-12T21:42:47.959Z] [2025-02-12T21:42:47.959Z] TEST TEARDOWN: [2025-02-12T21:42:47.959Z] Nothing to be done for teardown. [2025-02-12T21:42:47.959Z] renaissance-dec-tree_0 Finish Time: Wed Feb 12 21:42:47 2025 Epoch Time (ms): 1739396567445