[2025-02-20T06:59:49.412Z] Running test renaissance-dec-tree_0 ... [2025-02-20T06:59:49.412Z] =============================================== [2025-02-20T06:59:49.412Z] renaissance-dec-tree_0 Start Time: Thu Feb 20 01:59:49 2025 Epoch Time (ms): 1740034789235 [2025-02-20T06:59:49.412Z] variation: NoOptions [2025-02-20T06:59:49.412Z] JVM_OPTIONS: [2025-02-20T06:59:49.412Z] { \ [2025-02-20T06:59:49.412Z] echo ""; echo "TEST SETUP:"; \ [2025-02-20T06:59:49.412Z] echo "Nothing to be done for setup."; \ [2025-02-20T06:59:49.412Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17400342377445/renaissance-dec-tree_0"; \ [2025-02-20T06:59:49.412Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17400342377445/renaissance-dec-tree_0"; \ [2025-02-20T06:59:49.412Z] echo ""; echo "TESTING:"; \ [2025-02-20T06:59:49.412Z] "/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_17400342377445/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-20T06:59:49.412Z] 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_17400342377445/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-20T06:59:49.412Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-20T06:59:49.412Z] echo "Nothing to be done for teardown."; \ [2025-02-20T06:59:49.412Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17400342377445/TestTargetResult"; [2025-02-20T06:59:49.412Z] [2025-02-20T06:59:49.412Z] TEST SETUP: [2025-02-20T06:59:49.412Z] Nothing to be done for setup. [2025-02-20T06:59:49.412Z] [2025-02-20T06:59:49.412Z] TESTING: [2025-02-20T06:59:53.303Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-20T06:59:54.685Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-02-20T06:59:55.365Z] WARNING: An illegal reflective access operation has occurred [2025-02-20T06:59:55.365Z] 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_17400342377445/renaissance-dec-tree_0/harness-015950-9543870773561756936/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-20T06:59:55.365Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-20T06:59:55.365Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-20T06:59:55.365Z] WARNING: All illegal access operations will be denied in a future release [2025-02-20T06:59:57.554Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-20T06:59:57.554Z] GC before operation: completed in 94.244 ms, heap usage 70.854 MB -> 33.744 MB. [2025-02-20T07:00:08.284Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10994.357 ms) ====== [2025-02-20T07:00:08.284Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-20T07:00:08.997Z] GC before operation: completed in 218.395 ms, heap usage 158.601 MB -> 62.554 MB. [2025-02-20T07:00:13.226Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3800.772 ms) ====== [2025-02-20T07:00:13.226Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-20T07:00:13.226Z] GC before operation: completed in 177.303 ms, heap usage 95.633 MB -> 62.791 MB. [2025-02-20T07:00:16.501Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3435.412 ms) ====== [2025-02-20T07:00:16.501Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-20T07:00:16.501Z] GC before operation: completed in 163.038 ms, heap usage 198.112 MB -> 90.772 MB. [2025-02-20T07:00:19.676Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2712.338 ms) ====== [2025-02-20T07:00:19.676Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-20T07:00:19.676Z] GC before operation: completed in 223.736 ms, heap usage 228.747 MB -> 63.408 MB. [2025-02-20T07:00:22.265Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2441.946 ms) ====== [2025-02-20T07:00:22.265Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-20T07:00:22.265Z] GC before operation: completed in 235.528 ms, heap usage 95.047 MB -> 63.570 MB. [2025-02-20T07:00:24.426Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2354.091 ms) ====== [2025-02-20T07:00:24.426Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-20T07:00:24.426Z] GC before operation: completed in 177.455 ms, heap usage 202.541 MB -> 91.389 MB. [2025-02-20T07:00:24.426Z] 25/02/20 02:00:24 WARN BlockManager: Asked to remove block broadcast_82, which does not exist [2025-02-20T07:00:26.813Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2480.082 ms) ====== [2025-02-20T07:00:26.813Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-20T07:00:27.490Z] GC before operation: completed in 196.504 ms, heap usage 176.115 MB -> 63.973 MB. [2025-02-20T07:00:29.668Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2406.594 ms) ====== [2025-02-20T07:00:29.668Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-20T07:00:29.668Z] GC before operation: completed in 223.609 ms, heap usage 102.663 MB -> 64.096 MB. [2025-02-20T07:00:32.679Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2402.585 ms) ====== [2025-02-20T07:00:32.679Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-20T07:00:32.679Z] GC before operation: completed in 220.873 ms, heap usage 182.124 MB -> 64.411 MB. [2025-02-20T07:00:34.907Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2423.041 ms) ====== [2025-02-20T07:00:34.907Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-20T07:00:34.907Z] GC before operation: completed in 195.826 ms, heap usage 125.745 MB -> 64.500 MB. [2025-02-20T07:00:38.037Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2414.644 ms) ====== [2025-02-20T07:00:38.037Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-20T07:00:38.037Z] GC before operation: completed in 242.463 ms, heap usage 215.912 MB -> 83.926 MB. [2025-02-20T07:00:38.037Z] 25/02/20 02:00:37 WARN BlockManager: Asked to remove block broadcast_148, which does not exist [2025-02-20T07:00:40.176Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2354.428 ms) ====== [2025-02-20T07:00:40.176Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-20T07:00:40.176Z] GC before operation: completed in 177.511 ms, heap usage 172.965 MB -> 64.316 MB. [2025-02-20T07:00:42.361Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2106.335 ms) ====== [2025-02-20T07:00:42.361Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-20T07:00:42.361Z] GC before operation: completed in 217.575 ms, heap usage 180.761 MB -> 92.272 MB. [2025-02-20T07:00:44.487Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2135.450 ms) ====== [2025-02-20T07:00:44.487Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-20T07:00:45.165Z] GC before operation: completed in 209.624 ms, heap usage 195.375 MB -> 64.505 MB. [2025-02-20T07:00:47.334Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2303.291 ms) ====== [2025-02-20T07:00:47.334Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-20T07:00:47.334Z] GC before operation: completed in 180.039 ms, heap usage 138.762 MB -> 92.061 MB. [2025-02-20T07:00:49.592Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2260.044 ms) ====== [2025-02-20T07:00:49.592Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-20T07:00:50.247Z] GC before operation: completed in 224.109 ms, heap usage 193.145 MB -> 64.795 MB. [2025-02-20T07:00:52.468Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2087.370 ms) ====== [2025-02-20T07:00:52.468Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-20T07:00:52.468Z] GC before operation: completed in 224.478 ms, heap usage 99.261 MB -> 92.192 MB. [2025-02-20T07:00:54.586Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2126.107 ms) ====== [2025-02-20T07:00:54.586Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-20T07:00:54.586Z] GC before operation: completed in 254.371 ms, heap usage 231.902 MB -> 65.254 MB. [2025-02-20T07:00:56.794Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2089.613 ms) ====== [2025-02-20T07:00:56.794Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-20T07:00:56.794Z] GC before operation: completed in 237.229 ms, heap usage 182.520 MB -> 65.498 MB. [2025-02-20T07:00:58.956Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2205.728 ms) ====== [2025-02-20T07:00:58.956Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-20T07:00:59.606Z] GC before operation: completed in 184.100 ms, heap usage 167.501 MB -> 65.495 MB. [2025-02-20T07:01:01.145Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1979.393 ms) ====== [2025-02-20T07:01:01.145Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-20T07:01:01.839Z] GC before operation: completed in 169.270 ms, heap usage 183.680 MB -> 85.001 MB. [2025-02-20T07:01:03.255Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2028.145 ms) ====== [2025-02-20T07:01:03.255Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-20T07:01:03.929Z] GC before operation: completed in 187.828 ms, heap usage 268.553 MB -> 65.795 MB. [2025-02-20T07:01:05.306Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1877.570 ms) ====== [2025-02-20T07:01:05.306Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-20T07:01:05.968Z] GC before operation: completed in 174.692 ms, heap usage 166.343 MB -> 66.146 MB. [2025-02-20T07:01:07.455Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1813.765 ms) ====== [2025-02-20T07:01:07.455Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-20T07:01:08.111Z] GC before operation: completed in 200.409 ms, heap usage 138.691 MB -> 93.437 MB. [2025-02-20T07:01:09.942Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2030.739 ms) ====== [2025-02-20T07:01:09.942Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-20T07:01:09.942Z] GC before operation: completed in 193.699 ms, heap usage 191.125 MB -> 85.393 MB. [2025-02-20T07:01:12.117Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1804.661 ms) ====== [2025-02-20T07:01:12.117Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-20T07:01:12.117Z] GC before operation: completed in 194.079 ms, heap usage 132.879 MB -> 65.747 MB. [2025-02-20T07:01:13.518Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1791.332 ms) ====== [2025-02-20T07:01:13.518Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-20T07:01:14.220Z] GC before operation: completed in 334.163 ms, heap usage 186.344 MB -> 66.107 MB. [2025-02-20T07:01:16.376Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2063.813 ms) ====== [2025-02-20T07:01:16.376Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-20T07:01:16.376Z] GC before operation: completed in 223.303 ms, heap usage 155.804 MB -> 66.230 MB. [2025-02-20T07:01:18.599Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2111.553 ms) ====== [2025-02-20T07:01:18.599Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-20T07:01:18.599Z] GC before operation: completed in 252.943 ms, heap usage 186.958 MB -> 93.783 MB. [2025-02-20T07:01:21.691Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2446.739 ms) ====== [2025-02-20T07:01:21.691Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-20T07:01:21.691Z] GC before operation: completed in 237.495 ms, heap usage 113.894 MB -> 66.131 MB. [2025-02-20T07:01:23.846Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2097.142 ms) ====== [2025-02-20T07:01:23.846Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-20T07:01:23.846Z] GC before operation: completed in 246.267 ms, heap usage 154.219 MB -> 66.234 MB. [2025-02-20T07:01:25.981Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2184.866 ms) ====== [2025-02-20T07:01:25.981Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-20T07:01:25.981Z] GC before operation: completed in 200.311 ms, heap usage 155.958 MB -> 66.487 MB. [2025-02-20T07:01:28.217Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2107.853 ms) ====== [2025-02-20T07:01:28.217Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-20T07:01:28.217Z] GC before operation: completed in 217.595 ms, heap usage 140.099 MB -> 94.287 MB. [2025-02-20T07:01:30.357Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2070.080 ms) ====== [2025-02-20T07:01:30.357Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-20T07:01:31.012Z] GC before operation: completed in 251.029 ms, heap usage 214.758 MB -> 86.246 MB. [2025-02-20T07:01:33.137Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1996.242 ms) ====== [2025-02-20T07:01:33.137Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-20T07:01:33.137Z] GC before operation: completed in 250.538 ms, heap usage 148.320 MB -> 94.465 MB. [2025-02-20T07:01:35.283Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1946.922 ms) ====== [2025-02-20T07:01:35.283Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-20T07:01:35.283Z] GC before operation: completed in 224.975 ms, heap usage 158.612 MB -> 66.832 MB. [2025-02-20T07:01:37.420Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1915.635 ms) ====== [2025-02-20T07:01:37.420Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-20T07:01:37.420Z] GC before operation: completed in 215.058 ms, heap usage 232.587 MB -> 67.217 MB. [2025-02-20T07:01:39.622Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2078.728 ms) ====== [2025-02-20T07:01:39.622Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-20T07:01:39.622Z] GC before operation: completed in 245.959 ms, heap usage 164.354 MB -> 86.398 MB. [2025-02-20T07:01:41.837Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2042.149 ms) ====== [2025-02-20T07:01:41.837Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-20T07:01:41.837Z] GC before operation: completed in 223.479 ms, heap usage 240.709 MB -> 67.249 MB. [2025-02-20T07:01:43.997Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1915.606 ms) ====== [2025-02-20T07:01:44.633Z] ----------------------------------- [2025-02-20T07:01:44.633Z] renaissance-dec-tree_0_PASSED [2025-02-20T07:01:44.633Z] ----------------------------------- [2025-02-20T07:01:44.633Z] [2025-02-20T07:01:44.633Z] TEST TEARDOWN: [2025-02-20T07:01:44.633Z] Nothing to be done for teardown. [2025-02-20T07:01:44.633Z] renaissance-dec-tree_0 Finish Time: Thu Feb 20 02:01:43 2025 Epoch Time (ms): 1740034903974