[2025-02-06T07:01:01.273Z] Running test renaissance-dec-tree_0 ... [2025-02-06T07:01:01.273Z] =============================================== [2025-02-06T07:01:01.273Z] renaissance-dec-tree_0 Start Time: Thu Feb 6 02:01:00 2025 Epoch Time (ms): 1738825260716 [2025-02-06T07:01:01.273Z] variation: NoOptions [2025-02-06T07:01:01.273Z] JVM_OPTIONS: [2025-02-06T07:01:01.273Z] { \ [2025-02-06T07:01:01.273Z] echo ""; echo "TEST SETUP:"; \ [2025-02-06T07:01:01.273Z] echo "Nothing to be done for setup."; \ [2025-02-06T07:01:01.273Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/renaissance-dec-tree_0"; \ [2025-02-06T07:01:01.273Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/renaissance-dec-tree_0"; \ [2025-02-06T07:01:01.273Z] echo ""; echo "TESTING:"; \ [2025-02-06T07:01:01.274Z] "/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_17388242733326/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-06T07:01:01.274Z] 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_17388242733326/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-06T07:01:01.274Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-06T07:01:01.274Z] echo "Nothing to be done for teardown."; \ [2025-02-06T07:01:01.274Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/TestTargetResult"; [2025-02-06T07:01:01.274Z] [2025-02-06T07:01:01.274Z] TEST SETUP: [2025-02-06T07:01:01.274Z] Nothing to be done for setup. [2025-02-06T07:01:01.274Z] [2025-02-06T07:01:01.274Z] TESTING: [2025-02-06T07:01:06.457Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-06T07:01:10.729Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-02-06T07:01:12.158Z] WARNING: An illegal reflective access operation has occurred [2025-02-06T07:01:12.158Z] 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_17388242733326/renaissance-dec-tree_0/harness-020102-16528043457893939074/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-06T07:01:12.158Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-06T07:01:12.158Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-06T07:01:12.158Z] WARNING: All illegal access operations will be denied in a future release [2025-02-06T07:01:15.387Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-06T07:01:16.169Z] GC before operation: completed in 266.812 ms, heap usage 54.874 MB -> 33.738 MB. [2025-02-06T07:01:38.199Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (20306.588 ms) ====== [2025-02-06T07:01:38.199Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-06T07:01:38.199Z] GC before operation: completed in 397.685 ms, heap usage 180.338 MB -> 62.946 MB. [2025-02-06T07:01:43.920Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7481.370 ms) ====== [2025-02-06T07:01:43.920Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-06T07:01:43.920Z] GC before operation: completed in 255.514 ms, heap usage 99.098 MB -> 62.773 MB. [2025-02-06T07:01:50.401Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (5651.858 ms) ====== [2025-02-06T07:01:50.401Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-06T07:01:50.401Z] GC before operation: completed in 474.072 ms, heap usage 109.936 MB -> 63.038 MB. [2025-02-06T07:01:55.756Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (5207.066 ms) ====== [2025-02-06T07:01:55.756Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-06T07:01:55.756Z] GC before operation: completed in 512.246 ms, heap usage 262.610 MB -> 91.013 MB. [2025-02-06T07:02:01.327Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (5236.173 ms) ====== [2025-02-06T07:02:01.327Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-06T07:02:02.153Z] GC before operation: completed in 715.713 ms, heap usage 208.754 MB -> 63.607 MB. [2025-02-06T07:02:06.374Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4527.483 ms) ====== [2025-02-06T07:02:06.374Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-06T07:02:07.065Z] GC before operation: completed in 310.536 ms, heap usage 180.607 MB -> 63.794 MB. [2025-02-06T07:02:11.482Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (4922.736 ms) ====== [2025-02-06T07:02:11.482Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-06T07:02:12.261Z] GC before operation: completed in 324.262 ms, heap usage 218.064 MB -> 64.116 MB. [2025-02-06T07:02:16.499Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (4066.181 ms) ====== [2025-02-06T07:02:16.499Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-06T07:02:16.499Z] GC before operation: completed in 414.995 ms, heap usage 157.134 MB -> 64.153 MB. [2025-02-06T07:02:21.911Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (5186.531 ms) ====== [2025-02-06T07:02:21.911Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-06T07:02:22.678Z] GC before operation: completed in 594.401 ms, heap usage 179.643 MB -> 64.255 MB. [2025-02-06T07:02:28.147Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4990.168 ms) ====== [2025-02-06T07:02:28.147Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-06T07:02:28.147Z] GC before operation: completed in 490.460 ms, heap usage 180.783 MB -> 64.356 MB. [2025-02-06T07:02:31.374Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3549.224 ms) ====== [2025-02-06T07:02:31.374Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-06T07:02:31.374Z] GC before operation: completed in 260.561 ms, heap usage 138.113 MB -> 64.589 MB. [2025-02-06T07:02:35.579Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3727.239 ms) ====== [2025-02-06T07:02:35.579Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-06T07:02:35.579Z] GC before operation: completed in 294.534 ms, heap usage 179.019 MB -> 64.562 MB. [2025-02-06T07:02:40.497Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4575.315 ms) ====== [2025-02-06T07:02:40.497Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-06T07:02:40.497Z] GC before operation: completed in 520.597 ms, heap usage 195.922 MB -> 64.803 MB. [2025-02-06T07:02:44.818Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3950.076 ms) ====== [2025-02-06T07:02:44.818Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-06T07:02:45.489Z] GC before operation: completed in 417.913 ms, heap usage 111.469 MB -> 64.632 MB. [2025-02-06T07:02:48.638Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (3222.258 ms) ====== [2025-02-06T07:02:48.639Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-06T07:02:48.639Z] GC before operation: completed in 297.456 ms, heap usage 156.725 MB -> 64.880 MB. [2025-02-06T07:02:51.930Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3152.525 ms) ====== [2025-02-06T07:02:51.930Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-06T07:02:51.930Z] GC before operation: completed in 393.804 ms, heap usage 221.274 MB -> 65.049 MB. [2025-02-06T07:02:56.217Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4170.945 ms) ====== [2025-02-06T07:02:56.217Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-06T07:02:56.910Z] GC before operation: completed in 573.046 ms, heap usage 227.586 MB -> 65.158 MB. [2025-02-06T07:03:01.297Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (3900.889 ms) ====== [2025-02-06T07:03:01.297Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-06T07:03:01.297Z] GC before operation: completed in 407.540 ms, heap usage 100.545 MB -> 64.976 MB. [2025-02-06T07:03:05.775Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (4189.208 ms) ====== [2025-02-06T07:03:05.775Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-06T07:03:05.775Z] GC before operation: completed in 456.292 ms, heap usage 261.159 MB -> 65.508 MB. [2025-02-06T07:03:10.068Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4119.566 ms) ====== [2025-02-06T07:03:10.068Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-06T07:03:10.746Z] GC before operation: completed in 590.254 ms, heap usage 162.533 MB -> 65.185 MB. [2025-02-06T07:03:14.063Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (3453.833 ms) ====== [2025-02-06T07:03:14.063Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-06T07:03:14.818Z] GC before operation: completed in 373.936 ms, heap usage 98.408 MB -> 65.005 MB. [2025-02-06T07:03:19.528Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (5247.696 ms) ====== [2025-02-06T07:03:19.528Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-06T07:03:20.325Z] GC before operation: completed in 498.403 ms, heap usage 261.166 MB -> 65.641 MB. [2025-02-06T07:03:24.526Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (3717.826 ms) ====== [2025-02-06T07:03:24.526Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-06T07:03:24.526Z] GC before operation: completed in 758.613 ms, heap usage 116.479 MB -> 65.489 MB. [2025-02-06T07:03:28.897Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (4314.017 ms) ====== [2025-02-06T07:03:28.898Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-06T07:03:30.089Z] GC before operation: completed in 373.887 ms, heap usage 156.963 MB -> 65.831 MB. [2025-02-06T07:03:33.390Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (3880.011 ms) ====== [2025-02-06T07:03:33.390Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-06T07:03:34.479Z] GC before operation: completed in 687.295 ms, heap usage 99.341 MB -> 65.865 MB. [2025-02-06T07:03:37.834Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (4130.868 ms) ====== [2025-02-06T07:03:37.835Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-06T07:03:38.503Z] GC before operation: completed in 606.789 ms, heap usage 242.774 MB -> 66.050 MB. [2025-02-06T07:03:41.858Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3389.904 ms) ====== [2025-02-06T07:03:41.858Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-06T07:03:42.532Z] GC before operation: completed in 365.916 ms, heap usage 188.521 MB -> 66.137 MB. [2025-02-06T07:03:46.830Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3769.730 ms) ====== [2025-02-06T07:03:46.830Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-06T07:03:46.830Z] GC before operation: completed in 446.822 ms, heap usage 168.887 MB -> 65.967 MB. [2025-02-06T07:03:51.200Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (4559.273 ms) ====== [2025-02-06T07:03:51.200Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-06T07:03:51.936Z] GC before operation: completed in 329.984 ms, heap usage 129.138 MB -> 66.180 MB. [2025-02-06T07:03:55.556Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3330.395 ms) ====== [2025-02-06T07:03:55.556Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-06T07:03:55.556Z] GC before operation: completed in 354.494 ms, heap usage 165.378 MB -> 66.147 MB. [2025-02-06T07:03:58.767Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3447.796 ms) ====== [2025-02-06T07:03:58.767Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-06T07:03:59.482Z] GC before operation: completed in 476.726 ms, heap usage 99.516 MB -> 66.221 MB. [2025-02-06T07:04:03.564Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3897.351 ms) ====== [2025-02-06T07:04:03.564Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-06T07:04:03.564Z] GC before operation: completed in 442.268 ms, heap usage 224.152 MB -> 66.605 MB. [2025-02-06T07:04:06.673Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3073.669 ms) ====== [2025-02-06T07:04:06.673Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-06T07:04:07.534Z] GC before operation: completed in 492.246 ms, heap usage 198.419 MB -> 66.696 MB. [2025-02-06T07:04:11.751Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (4511.093 ms) ====== [2025-02-06T07:04:11.751Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-06T07:04:11.751Z] GC before operation: completed in 389.517 ms, heap usage 109.707 MB -> 66.498 MB. [2025-02-06T07:04:14.933Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2841.948 ms) ====== [2025-02-06T07:04:14.933Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-06T07:04:15.616Z] GC before operation: completed in 405.415 ms, heap usage 162.665 MB -> 66.614 MB. [2025-02-06T07:04:18.785Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (3347.575 ms) ====== [2025-02-06T07:04:18.785Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-06T07:04:18.785Z] GC before operation: completed in 369.446 ms, heap usage 273.276 MB -> 66.970 MB. [2025-02-06T07:04:22.659Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3193.991 ms) ====== [2025-02-06T07:04:22.659Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-06T07:04:22.659Z] GC before operation: completed in 317.965 ms, heap usage 156.599 MB -> 67.212 MB. [2025-02-06T07:04:26.002Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (3351.131 ms) ====== [2025-02-06T07:04:26.002Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-06T07:04:26.750Z] GC before operation: completed in 532.482 ms, heap usage 234.431 MB -> 67.170 MB. [2025-02-06T07:04:31.039Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4520.847 ms) ====== [2025-02-06T07:04:31.039Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-06T07:04:31.848Z] GC before operation: completed in 662.116 ms, heap usage 216.394 MB -> 67.405 MB. [2025-02-06T07:04:36.163Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (4139.983 ms) ====== [2025-02-06T07:04:37.730Z] ----------------------------------- [2025-02-06T07:04:37.730Z] renaissance-dec-tree_0_PASSED [2025-02-06T07:04:37.730Z] ----------------------------------- [2025-02-06T07:04:37.730Z] [2025-02-06T07:04:37.730Z] TEST TEARDOWN: [2025-02-06T07:04:37.730Z] Nothing to be done for teardown. [2025-02-06T07:04:37.730Z] renaissance-dec-tree_0 Finish Time: Thu Feb 6 02:04:36 2025 Epoch Time (ms): 1738825476973