[2024-10-31T12:39:50.568Z] Running test renaissance-dec-tree_0 ... [2024-10-31T12:39:50.568Z] =============================================== [2024-10-31T12:39:50.568Z] renaissance-dec-tree_0 Start Time: Thu Oct 31 08:39:50 2024 Epoch Time (ms): 1730378390258 [2024-10-31T12:39:50.568Z] variation: NoOptions [2024-10-31T12:39:50.568Z] JVM_OPTIONS: [2024-10-31T12:39:50.568Z] { \ [2024-10-31T12:39:50.568Z] echo ""; echo "TEST SETUP:"; \ [2024-10-31T12:39:50.568Z] echo "Nothing to be done for setup."; \ [2024-10-31T12:39:50.568Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17303776603109/renaissance-dec-tree_0"; \ [2024-10-31T12:39:50.568Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17303776603109/renaissance-dec-tree_0"; \ [2024-10-31T12:39:50.568Z] echo ""; echo "TESTING:"; \ [2024-10-31T12:39:50.568Z] "/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_17303776603109/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-31T12:39:50.568Z] 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_17303776603109/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-31T12:39:50.568Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-31T12:39:50.568Z] echo "Nothing to be done for teardown."; \ [2024-10-31T12:39:50.568Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17303776603109/TestTargetResult"; [2024-10-31T12:39:50.568Z] [2024-10-31T12:39:50.568Z] TEST SETUP: [2024-10-31T12:39:50.568Z] Nothing to be done for setup. [2024-10-31T12:39:50.568Z] [2024-10-31T12:39:50.569Z] TESTING: [2024-10-31T12:39:53.730Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-31T12:39:55.166Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-10-31T12:39:58.232Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-31T12:39:58.232Z] GC before operation: completed in 74.572 ms, heap usage 51.244 MB -> 34.985 MB. [2024-10-31T12:40:07.444Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9914.555 ms) ====== [2024-10-31T12:40:07.444Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-31T12:40:08.134Z] GC before operation: completed in 181.287 ms, heap usage 98.326 MB -> 62.866 MB. [2024-10-31T12:40:11.266Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3092.592 ms) ====== [2024-10-31T12:40:11.266Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-31T12:40:11.266Z] GC before operation: completed in 165.532 ms, heap usage 268.735 MB -> 63.792 MB. [2024-10-31T12:40:14.443Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3127.380 ms) ====== [2024-10-31T12:40:14.443Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-31T12:40:14.443Z] GC before operation: completed in 115.696 ms, heap usage 115.893 MB -> 63.696 MB. [2024-10-31T12:40:17.553Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2545.987 ms) ====== [2024-10-31T12:40:17.553Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-31T12:40:17.553Z] GC before operation: completed in 115.014 ms, heap usage 251.051 MB -> 64.340 MB. [2024-10-31T12:40:20.062Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2856.275 ms) ====== [2024-10-31T12:40:20.062Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-31T12:40:20.062Z] GC before operation: completed in 145.005 ms, heap usage 293.777 MB -> 64.539 MB. [2024-10-31T12:40:23.157Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2747.192 ms) ====== [2024-10-31T12:40:23.157Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-31T12:40:23.157Z] GC before operation: completed in 122.403 ms, heap usage 255.931 MB -> 64.731 MB. [2024-10-31T12:40:25.335Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2369.827 ms) ====== [2024-10-31T12:40:25.335Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-31T12:40:25.335Z] GC before operation: completed in 123.595 ms, heap usage 185.075 MB -> 64.935 MB. [2024-10-31T12:40:27.473Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2076.151 ms) ====== [2024-10-31T12:40:27.473Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-31T12:40:27.473Z] GC before operation: completed in 102.777 ms, heap usage 283.766 MB -> 65.275 MB. [2024-10-31T12:40:30.036Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2096.829 ms) ====== [2024-10-31T12:40:30.036Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-31T12:40:30.036Z] GC before operation: completed in 140.987 ms, heap usage 238.875 MB -> 92.934 MB. [2024-10-31T12:40:32.317Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2233.853 ms) ====== [2024-10-31T12:40:32.317Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-31T12:40:32.317Z] GC before operation: completed in 125.241 ms, heap usage 138.281 MB -> 65.094 MB. [2024-10-31T12:40:34.474Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2456.201 ms) ====== [2024-10-31T12:40:34.474Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-31T12:40:35.133Z] GC before operation: completed in 122.895 ms, heap usage 106.742 MB -> 64.926 MB. [2024-10-31T12:40:37.272Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2170.369 ms) ====== [2024-10-31T12:40:37.272Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-31T12:40:37.272Z] GC before operation: completed in 135.247 ms, heap usage 259.554 MB -> 65.634 MB. [2024-10-31T12:40:39.454Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2150.337 ms) ====== [2024-10-31T12:40:39.454Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-31T12:40:39.454Z] GC before operation: completed in 129.783 ms, heap usage 290.819 MB -> 65.706 MB. [2024-10-31T12:40:41.687Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2006.768 ms) ====== [2024-10-31T12:40:41.687Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-31T12:40:41.687Z] GC before operation: completed in 136.124 ms, heap usage 196.708 MB -> 65.982 MB. [2024-10-31T12:40:43.877Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2168.044 ms) ====== [2024-10-31T12:40:43.877Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-31T12:40:43.877Z] GC before operation: completed in 132.436 ms, heap usage 271.642 MB -> 65.955 MB. [2024-10-31T12:40:46.066Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2091.413 ms) ====== [2024-10-31T12:40:46.066Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-31T12:40:46.066Z] GC before operation: completed in 135.967 ms, heap usage 152.076 MB -> 65.968 MB. [2024-10-31T12:40:48.253Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1997.874 ms) ====== [2024-10-31T12:40:48.253Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-31T12:40:48.253Z] GC before operation: completed in 218.873 ms, heap usage 229.615 MB -> 93.880 MB. [2024-10-31T12:40:50.512Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2254.699 ms) ====== [2024-10-31T12:40:50.512Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-31T12:40:50.512Z] GC before operation: completed in 154.766 ms, heap usage 141.480 MB -> 66.217 MB. [2024-10-31T12:40:52.740Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2072.012 ms) ====== [2024-10-31T12:40:52.740Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-31T12:40:52.740Z] GC before operation: completed in 136.771 ms, heap usage 334.340 MB -> 66.491 MB. [2024-10-31T12:40:54.892Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1995.324 ms) ====== [2024-10-31T12:40:54.893Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-31T12:40:54.893Z] GC before operation: completed in 134.809 ms, heap usage 113.944 MB -> 65.936 MB. [2024-10-31T12:40:57.048Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2074.420 ms) ====== [2024-10-31T12:40:57.048Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-31T12:40:57.048Z] GC before operation: completed in 155.754 ms, heap usage 270.787 MB -> 66.628 MB. [2024-10-31T12:40:59.254Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2093.624 ms) ====== [2024-10-31T12:40:59.254Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-31T12:40:59.939Z] GC before operation: completed in 243.958 ms, heap usage 271.652 MB -> 67.185 MB. [2024-10-31T12:41:02.435Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2975.523 ms) ====== [2024-10-31T12:41:02.435Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-31T12:41:03.145Z] GC before operation: completed in 157.139 ms, heap usage 231.592 MB -> 66.917 MB. [2024-10-31T12:41:05.322Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2223.117 ms) ====== [2024-10-31T12:41:05.322Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-31T12:41:05.322Z] GC before operation: completed in 135.350 ms, heap usage 255.540 MB -> 67.071 MB. [2024-10-31T12:41:07.498Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2205.112 ms) ====== [2024-10-31T12:41:07.498Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-31T12:41:07.498Z] GC before operation: completed in 163.093 ms, heap usage 277.049 MB -> 67.145 MB. [2024-10-31T12:41:09.656Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2045.310 ms) ====== [2024-10-31T12:41:09.656Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-31T12:41:09.656Z] GC before operation: completed in 296.882 ms, heap usage 187.118 MB -> 67.289 MB. [2024-10-31T12:41:11.943Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2367.086 ms) ====== [2024-10-31T12:41:11.943Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-31T12:41:12.752Z] GC before operation: completed in 219.445 ms, heap usage 321.705 MB -> 67.371 MB. [2024-10-31T12:41:15.112Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2504.091 ms) ====== [2024-10-31T12:41:15.112Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-31T12:41:15.112Z] GC before operation: completed in 196.846 ms, heap usage 140.653 MB -> 67.197 MB. [2024-10-31T12:41:17.474Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2426.809 ms) ====== [2024-10-31T12:41:17.474Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-31T12:41:18.194Z] GC before operation: completed in 302.796 ms, heap usage 316.314 MB -> 67.353 MB. [2024-10-31T12:41:20.587Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2288.830 ms) ====== [2024-10-31T12:41:20.587Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-31T12:41:20.587Z] GC before operation: completed in 218.995 ms, heap usage 139.480 MB -> 86.675 MB. [2024-10-31T12:41:22.733Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1935.873 ms) ====== [2024-10-31T12:41:22.733Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-31T12:41:22.733Z] GC before operation: completed in 153.205 ms, heap usage 227.858 MB -> 67.546 MB. [2024-10-31T12:41:24.875Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2107.331 ms) ====== [2024-10-31T12:41:24.875Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-31T12:41:24.875Z] GC before operation: completed in 153.223 ms, heap usage 322.910 MB -> 67.668 MB. [2024-10-31T12:41:27.015Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2026.022 ms) ====== [2024-10-31T12:41:27.015Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-31T12:41:27.015Z] GC before operation: completed in 175.431 ms, heap usage 152.213 MB -> 67.666 MB. [2024-10-31T12:41:29.192Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1818.005 ms) ====== [2024-10-31T12:41:29.192Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-31T12:41:29.192Z] GC before operation: completed in 152.609 ms, heap usage 238.030 MB -> 67.865 MB. [2024-10-31T12:41:31.121Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1925.592 ms) ====== [2024-10-31T12:41:31.121Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-31T12:41:31.121Z] GC before operation: completed in 177.010 ms, heap usage 158.867 MB -> 67.814 MB. [2024-10-31T12:41:33.383Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2059.938 ms) ====== [2024-10-31T12:41:33.383Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-31T12:41:33.383Z] GC before operation: completed in 153.383 ms, heap usage 274.539 MB -> 68.065 MB. [2024-10-31T12:41:35.506Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2165.217 ms) ====== [2024-10-31T12:41:35.506Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-31T12:41:35.506Z] GC before operation: completed in 153.248 ms, heap usage 152.690 MB -> 68.022 MB. [2024-10-31T12:41:37.695Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2070.730 ms) ====== [2024-10-31T12:41:37.695Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-31T12:41:37.695Z] GC before operation: completed in 160.148 ms, heap usage 107.162 MB -> 68.213 MB. [2024-10-31T12:41:39.954Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1936.641 ms) ====== [2024-10-31T12:41:39.954Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-31T12:41:39.954Z] GC before operation: completed in 151.464 ms, heap usage 242.041 MB -> 68.557 MB. [2024-10-31T12:41:42.214Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2029.967 ms) ====== [2024-10-31T12:41:42.214Z] ----------------------------------- [2024-10-31T12:41:42.214Z] renaissance-dec-tree_0_PASSED [2024-10-31T12:41:42.214Z] ----------------------------------- [2024-10-31T12:41:42.214Z] [2024-10-31T12:41:42.214Z] TEST TEARDOWN: [2024-10-31T12:41:42.214Z] Nothing to be done for teardown. [2024-10-31T12:41:42.214Z] renaissance-dec-tree_0 Finish Time: Thu Oct 31 08:41:41 2024 Epoch Time (ms): 1730378501883