[2024-08-28T21:17:12.458Z] Running test renaissance-dec-tree_0 ... [2024-08-28T21:17:12.458Z] =============================================== [2024-08-28T21:17:12.458Z] renaissance-dec-tree_0 Start Time: Wed Aug 28 21:17:12 2024 Epoch Time (ms): 1724879832260 [2024-08-28T21:17:12.458Z] variation: NoOptions [2024-08-28T21:17:12.458Z] JVM_OPTIONS: [2024-08-28T21:17:12.458Z] { \ [2024-08-28T21:17:12.458Z] echo ""; echo "TEST SETUP:"; \ [2024-08-28T21:17:12.458Z] echo "Nothing to be done for setup."; \ [2024-08-28T21:17:12.458Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17248791343223/renaissance-dec-tree_0"; \ [2024-08-28T21:17:12.458Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17248791343223/renaissance-dec-tree_0"; \ [2024-08-28T21:17:12.458Z] echo ""; echo "TESTING:"; \ [2024-08-28T21:17:12.458Z] "/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_17248791343223/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-28T21:17:12.458Z] 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_17248791343223/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-28T21:17:12.458Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-28T21:17:12.458Z] echo "Nothing to be done for teardown."; \ [2024-08-28T21:17:12.458Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17248791343223/TestTargetResult"; [2024-08-28T21:17:12.458Z] [2024-08-28T21:17:12.458Z] TEST SETUP: [2024-08-28T21:17:12.458Z] Nothing to be done for setup. [2024-08-28T21:17:12.458Z] [2024-08-28T21:17:12.458Z] TESTING: [2024-08-28T21:17:17.265Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-28T21:17:19.302Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-28T21:17:23.001Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-28T21:17:23.001Z] GC before operation: completed in 52.772 ms, heap usage 40.497 MB -> 34.827 MB. [2024-08-28T21:17:33.245Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10453.685 ms) ====== [2024-08-28T21:17:33.245Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-28T21:17:33.245Z] GC before operation: completed in 149.852 ms, heap usage 191.244 MB -> 63.138 MB. [2024-08-28T21:17:36.936Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3134.748 ms) ====== [2024-08-28T21:17:36.937Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-28T21:17:36.937Z] GC before operation: completed in 127.787 ms, heap usage 128.180 MB -> 63.611 MB. [2024-08-28T21:17:39.469Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2527.550 ms) ====== [2024-08-28T21:17:39.469Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-28T21:17:39.469Z] GC before operation: completed in 140.029 ms, heap usage 287.824 MB -> 83.697 MB. [2024-08-28T21:17:41.559Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2301.912 ms) ====== [2024-08-28T21:17:41.559Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-28T21:17:41.559Z] GC before operation: completed in 125.695 ms, heap usage 231.071 MB -> 64.016 MB. [2024-08-28T21:17:44.399Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2548.436 ms) ====== [2024-08-28T21:17:44.399Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-28T21:17:44.399Z] GC before operation: completed in 159.676 ms, heap usage 295.955 MB -> 83.705 MB. [2024-08-28T21:17:47.280Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2440.051 ms) ====== [2024-08-28T21:17:47.280Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-28T21:17:47.280Z] GC before operation: completed in 156.771 ms, heap usage 182.492 MB -> 64.361 MB. [2024-08-28T21:17:49.360Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2614.610 ms) ====== [2024-08-28T21:17:49.360Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-28T21:17:49.974Z] GC before operation: completed in 161.398 ms, heap usage 190.558 MB -> 65.002 MB. [2024-08-28T21:17:52.075Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2455.874 ms) ====== [2024-08-28T21:17:52.075Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-28T21:17:52.075Z] GC before operation: completed in 152.729 ms, heap usage 258.508 MB -> 65.232 MB. [2024-08-28T21:17:54.961Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2441.995 ms) ====== [2024-08-28T21:17:54.961Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-28T21:17:54.961Z] GC before operation: completed in 161.828 ms, heap usage 254.306 MB -> 64.929 MB. [2024-08-28T21:17:56.981Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2178.001 ms) ====== [2024-08-28T21:17:56.981Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-28T21:17:56.981Z] GC before operation: completed in 125.227 ms, heap usage 179.215 MB -> 65.006 MB. [2024-08-28T21:17:59.806Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2593.035 ms) ====== [2024-08-28T21:17:59.807Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-28T21:17:59.807Z] GC before operation: completed in 158.632 ms, heap usage 281.474 MB -> 65.139 MB. [2024-08-28T21:18:02.647Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2151.931 ms) ====== [2024-08-28T21:18:02.647Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-28T21:18:02.647Z] GC before operation: completed in 135.612 ms, heap usage 194.567 MB -> 65.303 MB. [2024-08-28T21:18:04.672Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2305.512 ms) ====== [2024-08-28T21:18:04.672Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-28T21:18:04.672Z] GC before operation: completed in 133.676 ms, heap usage 246.846 MB -> 65.376 MB. [2024-08-28T21:18:06.760Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2290.807 ms) ====== [2024-08-28T21:18:06.760Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-28T21:18:07.405Z] GC before operation: completed in 176.326 ms, heap usage 177.681 MB -> 65.636 MB. [2024-08-28T21:18:10.268Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2674.037 ms) ====== [2024-08-28T21:18:10.268Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-28T21:18:10.268Z] GC before operation: completed in 189.314 ms, heap usage 262.299 MB -> 65.776 MB. [2024-08-28T21:18:12.269Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2362.870 ms) ====== [2024-08-28T21:18:12.269Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-28T21:18:12.269Z] GC before operation: completed in 134.895 ms, heap usage 197.205 MB -> 65.768 MB. [2024-08-28T21:18:15.073Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2225.157 ms) ====== [2024-08-28T21:18:15.073Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-28T21:18:15.073Z] GC before operation: completed in 192.346 ms, heap usage 167.908 MB -> 65.572 MB. [2024-08-28T21:18:17.223Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2364.553 ms) ====== [2024-08-28T21:18:17.223Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-28T21:18:17.223Z] GC before operation: completed in 156.917 ms, heap usage 124.440 MB -> 66.083 MB. [2024-08-28T21:18:20.388Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2462.261 ms) ====== [2024-08-28T21:18:20.388Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-28T21:18:20.388Z] GC before operation: completed in 206.017 ms, heap usage 302.517 MB -> 66.272 MB. [2024-08-28T21:18:22.471Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2050.043 ms) ====== [2024-08-28T21:18:22.471Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-28T21:18:22.471Z] GC before operation: completed in 207.616 ms, heap usage 250.471 MB -> 66.252 MB. [2024-08-28T21:18:24.493Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2293.566 ms) ====== [2024-08-28T21:18:24.493Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-28T21:18:25.119Z] GC before operation: completed in 165.952 ms, heap usage 259.877 MB -> 94.048 MB. [2024-08-28T21:18:27.154Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2280.174 ms) ====== [2024-08-28T21:18:27.154Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-28T21:18:27.154Z] GC before operation: completed in 154.375 ms, heap usage 208.005 MB -> 94.407 MB. [2024-08-28T21:18:29.240Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2073.185 ms) ====== [2024-08-28T21:18:29.240Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-28T21:18:29.922Z] GC before operation: completed in 168.896 ms, heap usage 300.289 MB -> 66.705 MB. [2024-08-28T21:18:31.986Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2129.759 ms) ====== [2024-08-28T21:18:31.986Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-28T21:18:31.986Z] GC before operation: completed in 126.075 ms, heap usage 241.721 MB -> 66.643 MB. [2024-08-28T21:18:34.002Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2003.237 ms) ====== [2024-08-28T21:18:34.002Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-28T21:18:34.002Z] GC before operation: completed in 171.784 ms, heap usage 184.692 MB -> 67.075 MB. [2024-08-28T21:18:36.012Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2194.198 ms) ====== [2024-08-28T21:18:36.012Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-28T21:18:36.650Z] GC before operation: completed in 184.589 ms, heap usage 155.474 MB -> 66.968 MB. [2024-08-28T21:18:38.706Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2115.943 ms) ====== [2024-08-28T21:18:38.706Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-28T21:18:38.706Z] GC before operation: completed in 171.045 ms, heap usage 184.828 MB -> 66.912 MB. [2024-08-28T21:18:40.819Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2347.066 ms) ====== [2024-08-28T21:18:40.819Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-28T21:18:41.428Z] GC before operation: completed in 145.934 ms, heap usage 159.992 MB -> 66.681 MB. [2024-08-28T21:18:43.453Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2096.624 ms) ====== [2024-08-28T21:18:43.453Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-28T21:18:43.453Z] GC before operation: completed in 212.892 ms, heap usage 320.545 MB -> 67.249 MB. [2024-08-28T21:18:45.477Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2008.150 ms) ====== [2024-08-28T21:18:45.477Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-28T21:18:45.477Z] GC before operation: completed in 199.347 ms, heap usage 222.701 MB -> 67.315 MB. [2024-08-28T21:18:47.475Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2024.874 ms) ====== [2024-08-28T21:18:47.475Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-28T21:18:48.115Z] GC before operation: completed in 206.054 ms, heap usage 137.645 MB -> 67.195 MB. [2024-08-28T21:18:50.203Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1901.696 ms) ====== [2024-08-28T21:18:50.203Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-28T21:18:50.203Z] GC before operation: completed in 176.234 ms, heap usage 292.090 MB -> 67.583 MB. [2024-08-28T21:18:52.254Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2106.071 ms) ====== [2024-08-28T21:18:52.254Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-28T21:18:52.254Z] GC before operation: completed in 178.679 ms, heap usage 115.289 MB -> 67.093 MB. [2024-08-28T21:18:54.224Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2152.194 ms) ====== [2024-08-28T21:18:54.224Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-28T21:18:54.844Z] GC before operation: completed in 180.339 ms, heap usage 190.187 MB -> 67.764 MB. [2024-08-28T21:18:56.456Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2131.580 ms) ====== [2024-08-28T21:18:56.456Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-28T21:18:57.142Z] GC before operation: completed in 241.476 ms, heap usage 321.027 MB -> 67.705 MB. [2024-08-28T21:18:59.213Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2159.383 ms) ====== [2024-08-28T21:18:59.213Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-28T21:18:59.213Z] GC before operation: completed in 193.298 ms, heap usage 116.261 MB -> 67.376 MB. [2024-08-28T21:19:02.022Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2305.856 ms) ====== [2024-08-28T21:19:02.022Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-28T21:19:02.022Z] GC before operation: completed in 224.405 ms, heap usage 213.884 MB -> 68.082 MB. [2024-08-28T21:19:04.062Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2162.597 ms) ====== [2024-08-28T21:19:04.062Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-28T21:19:04.709Z] GC before operation: completed in 395.104 ms, heap usage 239.837 MB -> 95.754 MB. [2024-08-28T21:19:06.792Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2200.185 ms) ====== [2024-08-28T21:19:06.792Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-28T21:19:06.792Z] GC before operation: completed in 182.725 ms, heap usage 170.804 MB -> 68.120 MB. [2024-08-28T21:19:08.888Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2368.590 ms) ====== [2024-08-28T21:19:09.524Z] ----------------------------------- [2024-08-28T21:19:09.524Z] renaissance-dec-tree_0_PASSED [2024-08-28T21:19:09.524Z] ----------------------------------- [2024-08-28T21:19:09.524Z] [2024-08-28T21:19:09.524Z] TEST TEARDOWN: [2024-08-28T21:19:09.524Z] Nothing to be done for teardown. [2024-08-28T21:19:09.524Z] renaissance-dec-tree_0 Finish Time: Wed Aug 28 21:19:09 2024 Epoch Time (ms): 1724879949250