[2024-08-15T00:12:40.963Z] Running test renaissance-dec-tree_0 ... [2024-08-15T00:12:40.963Z] =============================================== [2024-08-15T00:12:40.963Z] renaissance-dec-tree_0 Start Time: Thu Aug 15 00:12:40 2024 Epoch Time (ms): 1723680760664 [2024-08-15T00:12:40.963Z] variation: NoOptions [2024-08-15T00:12:40.963Z] JVM_OPTIONS: [2024-08-15T00:12:40.963Z] { \ [2024-08-15T00:12:40.963Z] echo ""; echo "TEST SETUP:"; \ [2024-08-15T00:12:40.963Z] echo "Nothing to be done for setup."; \ [2024-08-15T00:12:40.963Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1723680260174/renaissance-dec-tree_0"; \ [2024-08-15T00:12:40.963Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1723680260174/renaissance-dec-tree_0"; \ [2024-08-15T00:12:40.963Z] echo ""; echo "TESTING:"; \ [2024-08-15T00:12:40.963Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1723680260174/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-15T00:12:40.963Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1723680260174/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-15T00:12:40.963Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-15T00:12:40.963Z] echo "Nothing to be done for teardown."; \ [2024-08-15T00:12:40.963Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1723680260174/TestTargetResult"; [2024-08-15T00:12:40.963Z] [2024-08-15T00:12:40.963Z] TEST SETUP: [2024-08-15T00:12:40.963Z] Nothing to be done for setup. [2024-08-15T00:12:40.963Z] [2024-08-15T00:12:40.963Z] TESTING: [2024-08-15T00:12:44.583Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-15T00:12:45.827Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-15T00:12:48.573Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-15T00:12:48.573Z] GC before operation: completed in 66.571 ms, heap usage 64.724 MB -> 35.007 MB. [2024-08-15T00:12:57.014Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8478.237 ms) ====== [2024-08-15T00:12:57.014Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-15T00:12:57.014Z] GC before operation: completed in 157.206 ms, heap usage 221.871 MB -> 63.428 MB. [2024-08-15T00:12:59.781Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2871.632 ms) ====== [2024-08-15T00:12:59.781Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-15T00:12:59.781Z] GC before operation: completed in 127.712 ms, heap usage 168.368 MB -> 63.595 MB. [2024-08-15T00:13:02.557Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2573.625 ms) ====== [2024-08-15T00:13:02.557Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-15T00:13:02.557Z] GC before operation: completed in 99.773 ms, heap usage 200.113 MB -> 64.050 MB. [2024-08-15T00:13:05.329Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2586.174 ms) ====== [2024-08-15T00:13:05.329Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-15T00:13:05.329Z] GC before operation: completed in 138.971 ms, heap usage 123.777 MB -> 64.003 MB. [2024-08-15T00:13:08.065Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2480.849 ms) ====== [2024-08-15T00:13:08.065Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-15T00:13:08.065Z] GC before operation: completed in 110.012 ms, heap usage 140.253 MB -> 64.355 MB. [2024-08-15T00:13:10.026Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2195.669 ms) ====== [2024-08-15T00:13:10.026Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-15T00:13:10.026Z] GC before operation: completed in 133.959 ms, heap usage 123.527 MB -> 64.403 MB. [2024-08-15T00:13:12.402Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2266.185 ms) ====== [2024-08-15T00:13:12.402Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-15T00:13:12.402Z] GC before operation: completed in 146.242 ms, heap usage 115.210 MB -> 64.459 MB. [2024-08-15T00:13:15.189Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2269.035 ms) ====== [2024-08-15T00:13:15.189Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-15T00:13:15.189Z] GC before operation: completed in 151.755 ms, heap usage 285.263 MB -> 65.214 MB. [2024-08-15T00:13:17.198Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2100.523 ms) ====== [2024-08-15T00:13:17.198Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-15T00:13:17.198Z] GC before operation: completed in 152.474 ms, heap usage 124.637 MB -> 73.478 MB. [2024-08-15T00:13:19.974Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2294.319 ms) ====== [2024-08-15T00:13:19.974Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-15T00:13:19.974Z] GC before operation: completed in 158.185 ms, heap usage 370.897 MB -> 65.296 MB. [2024-08-15T00:13:21.964Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2336.939 ms) ====== [2024-08-15T00:13:21.964Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-15T00:13:22.579Z] GC before operation: completed in 149.759 ms, heap usage 140.097 MB -> 65.505 MB. [2024-08-15T00:13:24.599Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2153.632 ms) ====== [2024-08-15T00:13:24.599Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-15T00:13:24.599Z] GC before operation: completed in 145.853 ms, heap usage 328.055 MB -> 65.667 MB. [2024-08-15T00:13:27.355Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2321.815 ms) ====== [2024-08-15T00:13:27.355Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-15T00:13:27.355Z] GC before operation: completed in 167.586 ms, heap usage 181.047 MB -> 65.746 MB. [2024-08-15T00:13:29.360Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2057.661 ms) ====== [2024-08-15T00:13:29.360Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-15T00:13:29.360Z] GC before operation: completed in 152.693 ms, heap usage 152.827 MB -> 65.607 MB. [2024-08-15T00:13:31.348Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2240.715 ms) ====== [2024-08-15T00:13:31.349Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-15T00:13:31.972Z] GC before operation: completed in 132.424 ms, heap usage 328.380 MB -> 66.003 MB. [2024-08-15T00:13:33.957Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1980.478 ms) ====== [2024-08-15T00:13:33.957Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-15T00:13:33.957Z] GC before operation: completed in 160.518 ms, heap usage 177.251 MB -> 65.998 MB. [2024-08-15T00:13:35.941Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1981.486 ms) ====== [2024-08-15T00:13:35.941Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-15T00:13:35.941Z] GC before operation: completed in 146.079 ms, heap usage 168.456 MB -> 66.028 MB. [2024-08-15T00:13:37.933Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1897.255 ms) ====== [2024-08-15T00:13:37.933Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-15T00:13:37.933Z] GC before operation: completed in 133.577 ms, heap usage 331.617 MB -> 66.308 MB. [2024-08-15T00:13:39.923Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1941.329 ms) ====== [2024-08-15T00:13:39.923Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-15T00:13:39.923Z] GC before operation: completed in 156.482 ms, heap usage 202.396 MB -> 85.837 MB. [2024-08-15T00:13:42.712Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2167.154 ms) ====== [2024-08-15T00:13:42.712Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-15T00:13:42.712Z] GC before operation: completed in 175.664 ms, heap usage 230.057 MB -> 66.848 MB. [2024-08-15T00:13:44.723Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1899.881 ms) ====== [2024-08-15T00:13:44.723Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-15T00:13:44.723Z] GC before operation: completed in 143.040 ms, heap usage 275.373 MB -> 66.722 MB. [2024-08-15T00:13:46.728Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2311.700 ms) ====== [2024-08-15T00:13:46.728Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-15T00:13:46.728Z] GC before operation: completed in 181.670 ms, heap usage 176.055 MB -> 66.799 MB. [2024-08-15T00:13:49.549Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2150.705 ms) ====== [2024-08-15T00:13:49.549Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-15T00:13:49.549Z] GC before operation: completed in 169.075 ms, heap usage 125.396 MB -> 66.513 MB. [2024-08-15T00:13:51.596Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2296.987 ms) ====== [2024-08-15T00:13:51.596Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-15T00:13:51.596Z] GC before operation: completed in 251.022 ms, heap usage 282.255 MB -> 94.506 MB. [2024-08-15T00:13:53.612Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2022.425 ms) ====== [2024-08-15T00:13:53.612Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-15T00:13:54.236Z] GC before operation: completed in 178.104 ms, heap usage 350.318 MB -> 86.372 MB. [2024-08-15T00:13:56.299Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2069.119 ms) ====== [2024-08-15T00:13:56.300Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-15T00:13:56.300Z] GC before operation: completed in 134.813 ms, heap usage 193.404 MB -> 67.191 MB. [2024-08-15T00:13:58.317Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1940.824 ms) ====== [2024-08-15T00:13:58.317Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-15T00:13:58.317Z] GC before operation: completed in 153.337 ms, heap usage 244.599 MB -> 94.853 MB. [2024-08-15T00:14:00.359Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2158.980 ms) ====== [2024-08-15T00:14:00.359Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-15T00:14:00.359Z] GC before operation: completed in 156.943 ms, heap usage 369.166 MB -> 67.445 MB. [2024-08-15T00:14:03.119Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2116.706 ms) ====== [2024-08-15T00:14:03.119Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-15T00:14:03.119Z] GC before operation: completed in 216.811 ms, heap usage 247.721 MB -> 67.517 MB. [2024-08-15T00:14:05.079Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1934.697 ms) ====== [2024-08-15T00:14:05.079Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-15T00:14:05.080Z] GC before operation: completed in 145.577 ms, heap usage 262.467 MB -> 67.469 MB. [2024-08-15T00:14:07.081Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2101.215 ms) ====== [2024-08-15T00:14:07.081Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-15T00:14:07.081Z] GC before operation: completed in 166.347 ms, heap usage 256.389 MB -> 67.772 MB. [2024-08-15T00:14:09.843Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2051.145 ms) ====== [2024-08-15T00:14:09.843Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-15T00:14:09.843Z] GC before operation: completed in 161.692 ms, heap usage 129.390 MB -> 67.416 MB. [2024-08-15T00:14:11.859Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1994.675 ms) ====== [2024-08-15T00:14:11.859Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-15T00:14:11.859Z] GC before operation: completed in 181.755 ms, heap usage 280.501 MB -> 76.199 MB. [2024-08-15T00:14:13.800Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1979.456 ms) ====== [2024-08-15T00:14:13.800Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-15T00:14:13.800Z] GC before operation: completed in 166.751 ms, heap usage 168.311 MB -> 87.146 MB. [2024-08-15T00:14:15.767Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1848.752 ms) ====== [2024-08-15T00:14:15.767Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-15T00:14:15.767Z] GC before operation: completed in 145.726 ms, heap usage 367.935 MB -> 67.908 MB. [2024-08-15T00:14:17.741Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1972.616 ms) ====== [2024-08-15T00:14:17.741Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-15T00:14:17.741Z] GC before operation: completed in 154.139 ms, heap usage 205.966 MB -> 68.169 MB. [2024-08-15T00:14:20.135Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2054.711 ms) ====== [2024-08-15T00:14:20.135Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-15T00:14:20.135Z] GC before operation: completed in 154.853 ms, heap usage 249.397 MB -> 68.302 MB. [2024-08-15T00:14:22.235Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1939.113 ms) ====== [2024-08-15T00:14:22.235Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-15T00:14:22.235Z] GC before operation: completed in 156.221 ms, heap usage 260.390 MB -> 87.721 MB. [2024-08-15T00:14:24.254Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2071.449 ms) ====== [2024-08-15T00:14:24.254Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-15T00:14:24.854Z] GC before operation: completed in 172.126 ms, heap usage 206.532 MB -> 68.400 MB. [2024-08-15T00:14:26.116Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1815.227 ms) ====== [2024-08-15T00:14:26.721Z] ----------------------------------- [2024-08-15T00:14:26.721Z] renaissance-dec-tree_0_PASSED [2024-08-15T00:14:26.721Z] ----------------------------------- [2024-08-15T00:14:26.721Z] [2024-08-15T00:14:26.721Z] TEST TEARDOWN: [2024-08-15T00:14:26.721Z] Nothing to be done for teardown. [2024-08-15T00:14:26.721Z] renaissance-dec-tree_0 Finish Time: Thu Aug 15 00:14:26 2024 Epoch Time (ms): 1723680866384