[2024-08-16T22:36:09.466Z] Running test renaissance-dec-tree_0 ... [2024-08-16T22:36:09.466Z] =============================================== [2024-08-16T22:36:09.466Z] renaissance-dec-tree_0 Start Time: Fri Aug 16 22:36:08 2024 Epoch Time (ms): 1723847768954 [2024-08-16T22:36:09.466Z] variation: NoOptions [2024-08-16T22:36:09.466Z] JVM_OPTIONS: [2024-08-16T22:36:09.466Z] { \ [2024-08-16T22:36:09.466Z] echo ""; echo "TEST SETUP:"; \ [2024-08-16T22:36:09.466Z] echo "Nothing to be done for setup."; \ [2024-08-16T22:36:09.466Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17238471998043/renaissance-dec-tree_0"; \ [2024-08-16T22:36:09.466Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17238471998043/renaissance-dec-tree_0"; \ [2024-08-16T22:36:09.466Z] echo ""; echo "TESTING:"; \ [2024-08-16T22:36:09.466Z] "/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_17238471998043/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-16T22:36:09.466Z] 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_17238471998043/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-16T22:36:09.466Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-16T22:36:09.466Z] echo "Nothing to be done for teardown."; \ [2024-08-16T22:36:09.466Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17238471998043/TestTargetResult"; [2024-08-16T22:36:09.466Z] [2024-08-16T22:36:09.466Z] TEST SETUP: [2024-08-16T22:36:09.466Z] Nothing to be done for setup. [2024-08-16T22:36:09.466Z] [2024-08-16T22:36:09.466Z] TESTING: [2024-08-16T22:36:13.211Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-16T22:36:15.238Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-16T22:36:19.039Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-16T22:36:19.039Z] GC before operation: completed in 52.256 ms, heap usage 84.418 MB -> 35.099 MB. [2024-08-16T22:36:29.322Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9673.045 ms) ====== [2024-08-16T22:36:29.322Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-16T22:36:29.322Z] GC before operation: completed in 269.774 ms, heap usage 185.883 MB -> 63.521 MB. [2024-08-16T22:36:33.056Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3543.841 ms) ====== [2024-08-16T22:36:33.056Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-16T22:36:33.056Z] GC before operation: completed in 188.852 ms, heap usage 295.521 MB -> 63.911 MB. [2024-08-16T22:36:36.277Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2873.425 ms) ====== [2024-08-16T22:36:36.277Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-16T22:36:36.277Z] GC before operation: completed in 161.971 ms, heap usage 177.010 MB -> 64.157 MB. [2024-08-16T22:36:39.064Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2950.784 ms) ====== [2024-08-16T22:36:39.064Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-16T22:36:39.064Z] GC before operation: completed in 164.430 ms, heap usage 279.338 MB -> 64.384 MB. [2024-08-16T22:36:41.186Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2494.182 ms) ====== [2024-08-16T22:36:41.186Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-16T22:36:41.846Z] GC before operation: completed in 201.679 ms, heap usage 160.845 MB -> 92.045 MB. [2024-08-16T22:36:41.846Z] 24/08/16 22:36:41 WARN BlockManager: Asked to remove block broadcast_64, which does not exist [2024-08-16T22:36:44.693Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2755.464 ms) ====== [2024-08-16T22:36:44.693Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-16T22:36:44.693Z] GC before operation: completed in 106.214 ms, heap usage 316.633 MB -> 64.790 MB. [2024-08-16T22:36:47.480Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2707.882 ms) ====== [2024-08-16T22:36:47.480Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-16T22:36:47.480Z] GC before operation: completed in 115.293 ms, heap usage 246.172 MB -> 64.974 MB. [2024-08-16T22:36:50.395Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2684.618 ms) ====== [2024-08-16T22:36:50.395Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-16T22:36:50.395Z] GC before operation: completed in 118.749 ms, heap usage 259.905 MB -> 65.325 MB. [2024-08-16T22:36:52.528Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2463.251 ms) ====== [2024-08-16T22:36:52.528Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-16T22:36:52.528Z] GC before operation: completed in 126.693 ms, heap usage 219.075 MB -> 65.371 MB. [2024-08-16T22:36:55.304Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2344.003 ms) ====== [2024-08-16T22:36:55.304Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-16T22:36:55.304Z] GC before operation: completed in 194.973 ms, heap usage 157.322 MB -> 93.042 MB. [2024-08-16T22:36:57.341Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2460.300 ms) ====== [2024-08-16T22:36:57.341Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-16T22:36:57.945Z] GC before operation: completed in 141.454 ms, heap usage 356.583 MB -> 65.669 MB. [2024-08-16T22:36:59.954Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2437.154 ms) ====== [2024-08-16T22:36:59.954Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-16T22:37:00.563Z] GC before operation: completed in 173.814 ms, heap usage 259.682 MB -> 66.016 MB. [2024-08-16T22:37:02.579Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2293.751 ms) ====== [2024-08-16T22:37:02.579Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-16T22:37:02.579Z] GC before operation: completed in 159.593 ms, heap usage 187.648 MB -> 85.128 MB. [2024-08-16T22:37:05.365Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2498.468 ms) ====== [2024-08-16T22:37:05.365Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-16T22:37:05.365Z] GC before operation: completed in 132.903 ms, heap usage 131.808 MB -> 65.438 MB. [2024-08-16T22:37:08.259Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2391.775 ms) ====== [2024-08-16T22:37:08.259Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-16T22:37:08.259Z] GC before operation: completed in 127.547 ms, heap usage 124.043 MB -> 65.873 MB. [2024-08-16T22:37:10.328Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2294.913 ms) ====== [2024-08-16T22:37:10.328Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-16T22:37:10.328Z] GC before operation: completed in 274.487 ms, heap usage 379.399 MB -> 66.362 MB. [2024-08-16T22:37:13.147Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2629.486 ms) ====== [2024-08-16T22:37:13.147Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-16T22:37:13.147Z] GC before operation: completed in 187.247 ms, heap usage 211.809 MB -> 66.445 MB. [2024-08-16T22:37:16.364Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2296.301 ms) ====== [2024-08-16T22:37:16.364Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-16T22:37:16.364Z] GC before operation: completed in 167.127 ms, heap usage 137.638 MB -> 85.846 MB. [2024-08-16T22:37:18.413Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2219.811 ms) ====== [2024-08-16T22:37:18.413Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-16T22:37:18.413Z] GC before operation: completed in 160.611 ms, heap usage 261.269 MB -> 66.449 MB. [2024-08-16T22:37:20.441Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2289.408 ms) ====== [2024-08-16T22:37:20.441Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-16T22:37:20.441Z] GC before operation: completed in 209.055 ms, heap usage 268.058 MB -> 94.199 MB. [2024-08-16T22:37:23.211Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2086.219 ms) ====== [2024-08-16T22:37:23.211Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-16T22:37:23.211Z] GC before operation: completed in 148.443 ms, heap usage 270.716 MB -> 66.863 MB. [2024-08-16T22:37:25.257Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2149.677 ms) ====== [2024-08-16T22:37:25.257Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-16T22:37:25.257Z] GC before operation: completed in 159.772 ms, heap usage 234.331 MB -> 94.401 MB. [2024-08-16T22:37:27.256Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2046.620 ms) ====== [2024-08-16T22:37:27.256Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-16T22:37:27.256Z] GC before operation: completed in 207.009 ms, heap usage 280.408 MB -> 67.299 MB. [2024-08-16T22:37:30.118Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2368.213 ms) ====== [2024-08-16T22:37:30.118Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-16T22:37:30.118Z] GC before operation: completed in 118.485 ms, heap usage 99.895 MB -> 66.419 MB. [2024-08-16T22:37:32.113Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2269.620 ms) ====== [2024-08-16T22:37:32.113Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-16T22:37:32.717Z] GC before operation: completed in 167.209 ms, heap usage 181.056 MB -> 67.509 MB. [2024-08-16T22:37:34.710Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2302.062 ms) ====== [2024-08-16T22:37:34.711Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-16T22:37:34.711Z] GC before operation: completed in 168.824 ms, heap usage 129.904 MB -> 66.876 MB. [2024-08-16T22:37:36.730Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2112.192 ms) ====== [2024-08-16T22:37:36.730Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-16T22:37:37.362Z] GC before operation: completed in 137.024 ms, heap usage 139.331 MB -> 67.349 MB. [2024-08-16T22:37:39.394Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2144.842 ms) ====== [2024-08-16T22:37:39.394Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-16T22:37:39.394Z] GC before operation: completed in 167.832 ms, heap usage 195.652 MB -> 67.586 MB. [2024-08-16T22:37:42.220Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2267.525 ms) ====== [2024-08-16T22:37:42.220Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-16T22:37:42.220Z] GC before operation: completed in 228.906 ms, heap usage 324.078 MB -> 87.024 MB. [2024-08-16T22:37:44.243Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2150.994 ms) ====== [2024-08-16T22:37:44.244Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-16T22:37:44.244Z] GC before operation: completed in 128.887 ms, heap usage 175.357 MB -> 67.371 MB. [2024-08-16T22:37:46.402Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1975.612 ms) ====== [2024-08-16T22:37:46.402Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-16T22:37:46.402Z] GC before operation: completed in 132.883 ms, heap usage 107.537 MB -> 67.099 MB. [2024-08-16T22:37:48.394Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2255.614 ms) ====== [2024-08-16T22:37:48.394Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-16T22:37:48.997Z] GC before operation: completed in 225.962 ms, heap usage 392.447 MB -> 67.966 MB. [2024-08-16T22:37:51.383Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2147.623 ms) ====== [2024-08-16T22:37:51.383Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-16T22:37:51.383Z] GC before operation: completed in 150.169 ms, heap usage 206.391 MB -> 68.304 MB. [2024-08-16T22:37:53.400Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2023.747 ms) ====== [2024-08-16T22:37:53.401Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-16T22:37:53.401Z] GC before operation: completed in 159.870 ms, heap usage 126.617 MB -> 67.879 MB. [2024-08-16T22:37:56.229Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2425.445 ms) ====== [2024-08-16T22:37:56.229Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-16T22:37:56.229Z] GC before operation: completed in 169.884 ms, heap usage 247.288 MB -> 68.501 MB. [2024-08-16T22:37:58.204Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2024.804 ms) ====== [2024-08-16T22:37:58.204Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-16T22:37:58.204Z] GC before operation: completed in 148.532 ms, heap usage 109.521 MB -> 67.926 MB. [2024-08-16T22:38:00.188Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2040.832 ms) ====== [2024-08-16T22:38:00.188Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-16T22:38:00.188Z] GC before operation: completed in 150.554 ms, heap usage 206.726 MB -> 68.400 MB. [2024-08-16T22:38:02.238Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2207.400 ms) ====== [2024-08-16T22:38:02.238Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-16T22:38:02.846Z] GC before operation: completed in 186.813 ms, heap usage 227.583 MB -> 96.168 MB. [2024-08-16T22:38:04.857Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1902.454 ms) ====== [2024-08-16T22:38:04.857Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-16T22:38:04.857Z] GC before operation: completed in 156.916 ms, heap usage 274.064 MB -> 68.670 MB. [2024-08-16T22:38:06.894Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2032.530 ms) ====== [2024-08-16T22:38:06.894Z] ----------------------------------- [2024-08-16T22:38:06.894Z] renaissance-dec-tree_0_PASSED [2024-08-16T22:38:06.894Z] ----------------------------------- [2024-08-16T22:38:06.894Z] [2024-08-16T22:38:06.894Z] TEST TEARDOWN: [2024-08-16T22:38:06.894Z] Nothing to be done for teardown. [2024-08-16T22:38:06.894Z] renaissance-dec-tree_0 Finish Time: Fri Aug 16 22:38:06 2024 Epoch Time (ms): 1723847886806