[2025-03-06T00:34:47.647Z] Running test renaissance-dec-tree_0 ... [2025-03-06T00:34:47.647Z] =============================================== [2025-03-06T00:34:47.647Z] renaissance-dec-tree_0 Start Time: Thu Mar 6 00:34:47 2025 Epoch Time (ms): 1741221287266 [2025-03-06T00:34:47.647Z] variation: NoOptions [2025-03-06T00:34:47.647Z] JVM_OPTIONS: [2025-03-06T00:34:47.647Z] { \ [2025-03-06T00:34:47.647Z] echo ""; echo "TEST SETUP:"; \ [2025-03-06T00:34:47.647Z] echo "Nothing to be done for setup."; \ [2025-03-06T00:34:47.647Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-dec-tree_0"; \ [2025-03-06T00:34:47.647Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-dec-tree_0"; \ [2025-03-06T00:34:47.647Z] echo ""; echo "TESTING:"; \ [2025-03-06T00:34:47.647Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-03-06T00:34:47.647Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-06T00:34:47.647Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-06T00:34:47.647Z] echo "Nothing to be done for teardown."; \ [2025-03-06T00:34:47.647Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/TestTargetResult"; [2025-03-06T00:34:47.647Z] [2025-03-06T00:34:47.647Z] TEST SETUP: [2025-03-06T00:34:47.647Z] Nothing to be done for setup. [2025-03-06T00:34:47.647Z] [2025-03-06T00:34:47.647Z] TESTING: [2025-03-06T00:34:53.000Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-06T00:34:57.333Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-03-06T00:34:59.330Z] WARNING: An illegal reflective access operation has occurred [2025-03-06T00:34:59.330Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17412198715947/renaissance-dec-tree_0/harness-003448-3530535215038719152/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-03-06T00:34:59.330Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-03-06T00:34:59.330Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-03-06T00:34:59.330Z] WARNING: All illegal access operations will be denied in a future release [2025-03-06T00:35:04.100Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-03-06T00:35:04.100Z] GC before operation: completed in 371.242 ms, heap usage 38.462 MB -> 33.738 MB. [2025-03-06T00:35:30.029Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (26183.379 ms) ====== [2025-03-06T00:35:30.029Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-03-06T00:35:31.267Z] GC before operation: completed in 395.559 ms, heap usage 108.889 MB -> 62.332 MB. [2025-03-06T00:35:40.161Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (8996.115 ms) ====== [2025-03-06T00:35:40.161Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-03-06T00:35:40.161Z] GC before operation: completed in 423.986 ms, heap usage 125.860 MB -> 63.063 MB. [2025-03-06T00:35:45.167Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4725.308 ms) ====== [2025-03-06T00:35:45.167Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-03-06T00:35:45.167Z] GC before operation: completed in 450.841 ms, heap usage 164.298 MB -> 63.312 MB. [2025-03-06T00:35:51.630Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (6237.560 ms) ====== [2025-03-06T00:35:51.630Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-03-06T00:35:52.354Z] GC before operation: completed in 660.983 ms, heap usage 263.579 MB -> 63.631 MB. [2025-03-06T00:35:55.717Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3821.816 ms) ====== [2025-03-06T00:35:55.717Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-03-06T00:35:56.488Z] GC before operation: completed in 487.469 ms, heap usage 184.979 MB -> 63.603 MB. [2025-03-06T00:36:01.771Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (5564.808 ms) ====== [2025-03-06T00:36:01.771Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-03-06T00:36:02.569Z] GC before operation: completed in 422.645 ms, heap usage 101.426 MB -> 63.654 MB. [2025-03-06T00:36:10.084Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6649.994 ms) ====== [2025-03-06T00:36:10.084Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-03-06T00:36:10.084Z] GC before operation: completed in 174.734 ms, heap usage 261.550 MB -> 63.968 MB. [2025-03-06T00:36:14.327Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (5103.616 ms) ====== [2025-03-06T00:36:14.327Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-03-06T00:36:16.480Z] GC before operation: completed in 1626.631 ms, heap usage 137.050 MB -> 64.258 MB. [2025-03-06T00:36:22.811Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (6997.299 ms) ====== [2025-03-06T00:36:22.811Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-03-06T00:36:23.597Z] GC before operation: completed in 219.017 ms, heap usage 249.870 MB -> 64.241 MB. [2025-03-06T00:36:30.845Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6848.645 ms) ====== [2025-03-06T00:36:30.845Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-03-06T00:36:30.845Z] GC before operation: completed in 305.211 ms, heap usage 177.713 MB -> 64.359 MB. [2025-03-06T00:36:34.037Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3196.583 ms) ====== [2025-03-06T00:36:34.037Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-03-06T00:36:34.037Z] GC before operation: completed in 314.963 ms, heap usage 132.794 MB -> 64.446 MB. [2025-03-06T00:36:38.567Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (4819.439 ms) ====== [2025-03-06T00:36:38.567Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-03-06T00:36:41.829Z] GC before operation: completed in 2402.186 ms, heap usage 280.423 MB -> 64.556 MB. [2025-03-06T00:36:45.248Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3717.951 ms) ====== [2025-03-06T00:36:45.248Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-03-06T00:36:45.248Z] GC before operation: completed in 231.694 ms, heap usage 160.651 MB -> 64.658 MB. [2025-03-06T00:36:57.056Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (11926.943 ms) ====== [2025-03-06T00:36:57.056Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-03-06T00:36:57.829Z] GC before operation: completed in 423.625 ms, heap usage 103.560 MB -> 64.612 MB. [2025-03-06T00:37:02.045Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4378.329 ms) ====== [2025-03-06T00:37:02.045Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-03-06T00:37:02.045Z] GC before operation: completed in 371.239 ms, heap usage 233.791 MB -> 92.468 MB. [2025-03-06T00:37:02.045Z] 25/03/06 00:37:01 WARN BlockManager: Asked to remove block broadcast_208, which does not exist [2025-03-06T00:37:06.239Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3284.285 ms) ====== [2025-03-06T00:37:06.239Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-03-06T00:37:06.239Z] GC before operation: completed in 287.005 ms, heap usage 206.714 MB -> 65.183 MB. [2025-03-06T00:37:09.384Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (3746.871 ms) ====== [2025-03-06T00:37:09.384Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-03-06T00:37:10.945Z] GC before operation: completed in 1163.003 ms, heap usage 187.170 MB -> 65.141 MB. [2025-03-06T00:37:17.623Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (6627.608 ms) ====== [2025-03-06T00:37:17.623Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-03-06T00:37:18.886Z] GC before operation: completed in 906.789 ms, heap usage 205.796 MB -> 65.241 MB. [2025-03-06T00:37:24.529Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5660.052 ms) ====== [2025-03-06T00:37:24.529Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-03-06T00:37:24.529Z] GC before operation: completed in 465.654 ms, heap usage 217.389 MB -> 65.345 MB. [2025-03-06T00:37:31.642Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (6959.459 ms) ====== [2025-03-06T00:37:31.642Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-03-06T00:37:31.642Z] GC before operation: completed in 558.634 ms, heap usage 151.750 MB -> 65.807 MB. [2025-03-06T00:37:34.806Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2896.563 ms) ====== [2025-03-06T00:37:34.806Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-03-06T00:37:34.806Z] GC before operation: completed in 266.219 ms, heap usage 227.947 MB -> 65.906 MB. [2025-03-06T00:37:34.806Z] 25/03/06 00:37:34 WARN BlockManager: Asked to remove block broadcast_288, which does not exist [2025-03-06T00:37:38.829Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3527.591 ms) ====== [2025-03-06T00:37:38.829Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-03-06T00:37:39.551Z] GC before operation: completed in 545.136 ms, heap usage 221.876 MB -> 65.806 MB. [2025-03-06T00:37:41.715Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2714.022 ms) ====== [2025-03-06T00:37:41.715Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-03-06T00:37:42.421Z] GC before operation: completed in 357.693 ms, heap usage 285.911 MB -> 65.756 MB. [2025-03-06T00:37:49.370Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (6881.302 ms) ====== [2025-03-06T00:37:49.370Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-03-06T00:37:49.370Z] GC before operation: completed in 540.302 ms, heap usage 103.837 MB -> 65.433 MB. [2025-03-06T00:37:53.290Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (3223.892 ms) ====== [2025-03-06T00:37:53.290Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-03-06T00:37:53.290Z] GC before operation: completed in 364.732 ms, heap usage 237.879 MB -> 66.311 MB. [2025-03-06T00:37:56.408Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2846.978 ms) ====== [2025-03-06T00:37:56.408Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-03-06T00:37:56.408Z] GC before operation: completed in 212.157 ms, heap usage 211.989 MB -> 66.191 MB. [2025-03-06T00:38:00.572Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3821.376 ms) ====== [2025-03-06T00:38:00.572Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-03-06T00:38:00.572Z] GC before operation: completed in 759.699 ms, heap usage 152.996 MB -> 66.278 MB. [2025-03-06T00:38:04.779Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3645.794 ms) ====== [2025-03-06T00:38:04.779Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-03-06T00:38:04.779Z] GC before operation: completed in 424.150 ms, heap usage 289.867 MB -> 93.826 MB. [2025-03-06T00:38:07.851Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2767.040 ms) ====== [2025-03-06T00:38:07.851Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-03-06T00:38:07.851Z] GC before operation: completed in 241.252 ms, heap usage 131.685 MB -> 66.030 MB. [2025-03-06T00:38:10.932Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3012.962 ms) ====== [2025-03-06T00:38:10.933Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-03-06T00:38:10.933Z] GC before operation: completed in 254.874 ms, heap usage 234.171 MB -> 66.554 MB. [2025-03-06T00:38:14.939Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3123.425 ms) ====== [2025-03-06T00:38:14.939Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-03-06T00:38:14.939Z] GC before operation: completed in 399.639 ms, heap usage 198.744 MB -> 66.655 MB. [2025-03-06T00:38:18.039Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2982.088 ms) ====== [2025-03-06T00:38:18.039Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-03-06T00:38:18.039Z] GC before operation: completed in 215.279 ms, heap usage 193.964 MB -> 66.768 MB. [2025-03-06T00:38:23.164Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (4663.426 ms) ====== [2025-03-06T00:38:23.164Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-03-06T00:38:23.164Z] GC before operation: completed in 508.904 ms, heap usage 114.292 MB -> 66.154 MB. [2025-03-06T00:38:25.389Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2564.452 ms) ====== [2025-03-06T00:38:25.389Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-03-06T00:38:26.020Z] GC before operation: completed in 465.570 ms, heap usage 182.509 MB -> 66.805 MB. [2025-03-06T00:38:29.058Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3064.587 ms) ====== [2025-03-06T00:38:29.058Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-03-06T00:38:29.742Z] GC before operation: completed in 412.389 ms, heap usage 226.950 MB -> 66.905 MB. [2025-03-06T00:38:32.870Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2989.179 ms) ====== [2025-03-06T00:38:32.870Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-03-06T00:38:32.870Z] GC before operation: completed in 239.992 ms, heap usage 127.807 MB -> 94.300 MB. [2025-03-06T00:38:36.213Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3555.929 ms) ====== [2025-03-06T00:38:36.213Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-03-06T00:38:36.968Z] GC before operation: completed in 771.423 ms, heap usage 273.140 MB -> 67.239 MB. [2025-03-06T00:38:43.828Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (6543.557 ms) ====== [2025-03-06T00:38:43.828Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-03-06T00:38:44.482Z] GC before operation: completed in 728.925 ms, heap usage 152.498 MB -> 67.053 MB. [2025-03-06T00:38:49.553Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (3972.253 ms) ====== [2025-03-06T00:38:49.553Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-03-06T00:38:49.553Z] GC before operation: completed in 535.747 ms, heap usage 126.220 MB -> 67.127 MB. [2025-03-06T00:38:56.918Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (7130.877 ms) ====== [2025-03-06T00:38:56.918Z] ----------------------------------- [2025-03-06T00:38:56.918Z] renaissance-dec-tree_0_PASSED [2025-03-06T00:38:56.918Z] ----------------------------------- [2025-03-06T00:38:56.918Z] [2025-03-06T00:38:56.918Z] TEST TEARDOWN: [2025-03-06T00:38:56.918Z] Nothing to be done for teardown. [2025-03-06T00:38:56.918Z] renaissance-dec-tree_0 Finish Time: Thu Mar 6 00:38:56 2025 Epoch Time (ms): 1741221536397