[2025-05-29T03:59:06.062Z] Running test renaissance-dec-tree_0 ... [2025-05-29T03:59:06.062Z] =============================================== [2025-05-29T03:59:06.062Z] renaissance-dec-tree_0 Start Time: Thu May 29 03:59:05 2025 Epoch Time (ms): 1748491145840 [2025-05-29T03:59:06.062Z] variation: NoOptions [2025-05-29T03:59:06.062Z] JVM_OPTIONS: [2025-05-29T03:59:06.062Z] { \ [2025-05-29T03:59:06.062Z] echo ""; echo "TEST SETUP:"; \ [2025-05-29T03:59:06.062Z] echo "Nothing to be done for setup."; \ [2025-05-29T03:59:06.062Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17484905661127/renaissance-dec-tree_0"; \ [2025-05-29T03:59:06.062Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17484905661127/renaissance-dec-tree_0"; \ [2025-05-29T03:59:06.062Z] echo ""; echo "TESTING:"; \ [2025-05-29T03:59:06.062Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17484905661127/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-05-29T03:59:06.062Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17484905661127/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-29T03:59:06.062Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-29T03:59:06.062Z] echo "Nothing to be done for teardown."; \ [2025-05-29T03:59:06.062Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17484905661127/TestTargetResult"; [2025-05-29T03:59:06.062Z] [2025-05-29T03:59:06.062Z] TEST SETUP: [2025-05-29T03:59:06.062Z] Nothing to be done for setup. [2025-05-29T03:59:06.062Z] [2025-05-29T03:59:06.062Z] TESTING: [2025-05-29T03:59:10.906Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-05-29T03:59:12.971Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-05-29T03:59:12.971Z] GC before operation: completed in 57.471 ms, heap usage 38.604 MB -> 34.878 MB. [2025-05-29T03:59:23.313Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9248.721 ms) ====== [2025-05-29T03:59:23.313Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-05-29T03:59:23.313Z] GC before operation: completed in 169.611 ms, heap usage 242.502 MB -> 68.265 MB. [2025-05-29T03:59:25.367Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3104.487 ms) ====== [2025-05-29T03:59:25.367Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-05-29T03:59:25.367Z] GC before operation: completed in 90.053 ms, heap usage 103.228 MB -> 68.206 MB. [2025-05-29T03:59:28.416Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2592.060 ms) ====== [2025-05-29T03:59:28.416Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-05-29T03:59:28.416Z] GC before operation: completed in 122.777 ms, heap usage 254.034 MB -> 87.932 MB. [2025-05-29T03:59:30.512Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2118.059 ms) ====== [2025-05-29T03:59:30.512Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-05-29T03:59:30.512Z] GC before operation: completed in 143.201 ms, heap usage 243.384 MB -> 68.850 MB. [2025-05-29T03:59:32.639Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2184.813 ms) ====== [2025-05-29T03:59:32.639Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-05-29T03:59:32.639Z] GC before operation: completed in 121.141 ms, heap usage 193.006 MB -> 69.054 MB. [2025-05-29T03:59:34.699Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1975.800 ms) ====== [2025-05-29T03:59:34.699Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-05-29T03:59:34.699Z] GC before operation: completed in 120.811 ms, heap usage 206.719 MB -> 69.105 MB. [2025-05-29T03:59:37.589Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2141.113 ms) ====== [2025-05-29T03:59:37.589Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-05-29T03:59:37.589Z] GC before operation: completed in 102.023 ms, heap usage 290.212 MB -> 69.304 MB. [2025-05-29T03:59:38.919Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1843.134 ms) ====== [2025-05-29T03:59:38.919Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-05-29T03:59:38.919Z] GC before operation: completed in 111.092 ms, heap usage 260.653 MB -> 97.195 MB. [2025-05-29T03:59:40.979Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2061.500 ms) ====== [2025-05-29T03:59:40.979Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-05-29T03:59:41.616Z] GC before operation: completed in 149.814 ms, heap usage 276.395 MB -> 97.462 MB. [2025-05-29T03:59:41.617Z] 03:59:41.077 WARN [block-manager-storage-async-thread-pool-88] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_125, which does not exist [2025-05-29T03:59:43.694Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1878.445 ms) ====== [2025-05-29T03:59:43.694Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-05-29T03:59:43.694Z] GC before operation: completed in 180.787 ms, heap usage 347.015 MB -> 89.335 MB. [2025-05-29T03:59:45.844Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2158.178 ms) ====== [2025-05-29T03:59:45.844Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-05-29T03:59:45.844Z] GC before operation: completed in 172.954 ms, heap usage 200.361 MB -> 70.109 MB. [2025-05-29T03:59:47.960Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1781.996 ms) ====== [2025-05-29T03:59:47.960Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-05-29T03:59:47.960Z] GC before operation: completed in 131.722 ms, heap usage 342.145 MB -> 89.512 MB. [2025-05-29T03:59:50.072Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1921.459 ms) ====== [2025-05-29T03:59:50.072Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-05-29T03:59:50.072Z] GC before operation: completed in 142.159 ms, heap usage 194.538 MB -> 70.139 MB. [2025-05-29T03:59:51.438Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1690.973 ms) ====== [2025-05-29T03:59:51.438Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-05-29T03:59:51.438Z] GC before operation: completed in 142.440 ms, heap usage 302.777 MB -> 70.680 MB. [2025-05-29T03:59:53.509Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2021.100 ms) ====== [2025-05-29T03:59:53.509Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-05-29T03:59:54.143Z] GC before operation: completed in 179.524 ms, heap usage 165.944 MB -> 70.056 MB. [2025-05-29T03:59:56.212Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2021.128 ms) ====== [2025-05-29T03:59:56.212Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-05-29T03:59:56.212Z] GC before operation: completed in 143.289 ms, heap usage 138.154 MB -> 70.225 MB. [2025-05-29T03:59:57.525Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1753.454 ms) ====== [2025-05-29T03:59:57.525Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-05-29T03:59:58.165Z] GC before operation: completed in 105.488 ms, heap usage 323.441 MB -> 70.697 MB. [2025-05-29T03:59:59.470Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1772.649 ms) ====== [2025-05-29T03:59:59.470Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-05-29T03:59:59.470Z] GC before operation: completed in 127.073 ms, heap usage 240.894 MB -> 70.949 MB. [2025-05-29T04:00:01.520Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2081.356 ms) ====== [2025-05-29T04:00:01.520Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-05-29T04:00:02.168Z] GC before operation: completed in 151.783 ms, heap usage 259.280 MB -> 70.933 MB. [2025-05-29T04:00:04.227Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1984.418 ms) ====== [2025-05-29T04:00:04.227Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-05-29T04:00:04.227Z] GC before operation: completed in 171.865 ms, heap usage 277.764 MB -> 71.176 MB. [2025-05-29T04:00:06.279Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1981.675 ms) ====== [2025-05-29T04:00:06.279Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-05-29T04:00:06.279Z] GC before operation: completed in 117.864 ms, heap usage 165.760 MB -> 70.868 MB. [2025-05-29T04:00:08.331Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1935.064 ms) ====== [2025-05-29T04:00:08.331Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-05-29T04:00:08.331Z] GC before operation: completed in 154.491 ms, heap usage 251.143 MB -> 71.253 MB. [2025-05-29T04:00:10.393Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1838.041 ms) ====== [2025-05-29T04:00:10.393Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-05-29T04:00:10.393Z] GC before operation: completed in 141.930 ms, heap usage 168.366 MB -> 90.224 MB. [2025-05-29T04:00:11.698Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1645.827 ms) ====== [2025-05-29T04:00:11.698Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-05-29T04:00:12.328Z] GC before operation: completed in 123.513 ms, heap usage 137.212 MB -> 98.556 MB. [2025-05-29T04:00:13.654Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1830.099 ms) ====== [2025-05-29T04:00:13.654Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-05-29T04:00:14.289Z] GC before operation: completed in 161.814 ms, heap usage 254.721 MB -> 99.192 MB. [2025-05-29T04:00:15.612Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1737.056 ms) ====== [2025-05-29T04:00:15.612Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-05-29T04:00:16.237Z] GC before operation: completed in 161.704 ms, heap usage 318.506 MB -> 99.358 MB. [2025-05-29T04:00:17.566Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1783.899 ms) ====== [2025-05-29T04:00:17.566Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-05-29T04:00:18.205Z] GC before operation: completed in 139.202 ms, heap usage 238.989 MB -> 71.754 MB. [2025-05-29T04:00:19.541Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1933.737 ms) ====== [2025-05-29T04:00:19.541Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-05-29T04:00:20.189Z] GC before operation: completed in 150.140 ms, heap usage 171.123 MB -> 71.740 MB. [2025-05-29T04:00:21.501Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1662.383 ms) ====== [2025-05-29T04:00:21.501Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-05-29T04:00:21.501Z] GC before operation: completed in 147.223 ms, heap usage 356.057 MB -> 99.595 MB. [2025-05-29T04:00:23.578Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1866.146 ms) ====== [2025-05-29T04:00:23.578Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-05-29T04:00:23.578Z] GC before operation: completed in 183.398 ms, heap usage 232.459 MB -> 72.261 MB. [2025-05-29T04:00:25.657Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1582.109 ms) ====== [2025-05-29T04:00:25.657Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-05-29T04:00:25.657Z] GC before operation: completed in 135.925 ms, heap usage 316.742 MB -> 72.384 MB. [2025-05-29T04:00:27.696Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2112.160 ms) ====== [2025-05-29T04:00:27.696Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-05-29T04:00:27.696Z] GC before operation: completed in 158.101 ms, heap usage 286.202 MB -> 72.326 MB. [2025-05-29T04:00:29.013Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1444.818 ms) ====== [2025-05-29T04:00:29.013Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-05-29T04:00:29.638Z] GC before operation: completed in 103.352 ms, heap usage 318.518 MB -> 72.607 MB. [2025-05-29T04:00:30.949Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1686.629 ms) ====== [2025-05-29T04:00:30.949Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-05-29T04:00:30.949Z] GC before operation: completed in 109.746 ms, heap usage 203.320 MB -> 72.675 MB. [2025-05-29T04:00:33.003Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1832.322 ms) ====== [2025-05-29T04:00:33.003Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-05-29T04:00:33.003Z] GC before operation: completed in 190.055 ms, heap usage 245.105 MB -> 72.813 MB. [2025-05-29T04:00:35.053Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1607.730 ms) ====== [2025-05-29T04:00:35.053Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-05-29T04:00:35.053Z] GC before operation: completed in 108.563 ms, heap usage 123.317 MB -> 72.224 MB. [2025-05-29T04:00:37.130Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1837.139 ms) ====== [2025-05-29T04:00:37.130Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-05-29T04:00:37.130Z] GC before operation: completed in 154.592 ms, heap usage 281.584 MB -> 72.860 MB. [2025-05-29T04:00:38.460Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1741.967 ms) ====== [2025-05-29T04:00:38.460Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-05-29T04:00:39.102Z] GC before operation: completed in 121.640 ms, heap usage 123.757 MB -> 100.003 MB. [2025-05-29T04:00:40.426Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1547.107 ms) ====== [2025-05-29T04:00:40.426Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-05-29T04:00:40.426Z] GC before operation: completed in 171.896 ms, heap usage 252.525 MB -> 73.266 MB. [2025-05-29T04:00:42.548Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1769.635 ms) ====== [2025-05-29T04:00:42.548Z] ----------------------------------- [2025-05-29T04:00:42.548Z] renaissance-dec-tree_0_PASSED [2025-05-29T04:00:42.548Z] ----------------------------------- [2025-05-29T04:00:42.548Z] [2025-05-29T04:00:42.548Z] TEST TEARDOWN: [2025-05-29T04:00:42.548Z] Nothing to be done for teardown. [2025-05-29T04:00:42.548Z] renaissance-dec-tree_0 Finish Time: Thu May 29 04:00:42 2025 Epoch Time (ms): 1748491242194