[2024-09-25T20:42:26.302Z] Running test renaissance-dec-tree_0 ... [2024-09-25T20:42:26.302Z] =============================================== [2024-09-25T20:42:26.302Z] renaissance-dec-tree_0 Start Time: Wed Sep 25 20:42:25 2024 Epoch Time (ms): 1727296945498 [2024-09-25T20:42:26.302Z] variation: NoOptions [2024-09-25T20:42:26.302Z] JVM_OPTIONS: [2024-09-25T20:42:26.302Z] { \ [2024-09-25T20:42:26.302Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T20:42:26.302Z] echo "Nothing to be done for setup."; \ [2024-09-25T20:42:26.302Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17272966738568/renaissance-dec-tree_0"; \ [2024-09-25T20:42:26.302Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17272966738568/renaissance-dec-tree_0"; \ [2024-09-25T20:42:26.302Z] echo ""; echo "TESTING:"; \ [2024-09-25T20:42:26.302Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17272966738568/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-25T20:42:26.302Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17272966738568/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T20:42:26.302Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T20:42:26.302Z] echo "Nothing to be done for teardown."; \ [2024-09-25T20:42:26.302Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17272966738568/TestTargetResult"; [2024-09-25T20:42:26.302Z] [2024-09-25T20:42:26.302Z] TEST SETUP: [2024-09-25T20:42:26.302Z] Nothing to be done for setup. [2024-09-25T20:42:26.302Z] [2024-09-25T20:42:26.302Z] TESTING: [2024-09-25T20:42:29.286Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-25T20:42:33.386Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-09-25T20:42:40.093Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-25T20:42:40.093Z] GC before operation: completed in 68.244 ms, heap usage 83.809 MB -> 37.229 MB. [2024-09-25T20:42:48.162Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8984.289 ms) ====== [2024-09-25T20:42:48.162Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-25T20:42:48.162Z] GC before operation: completed in 113.339 ms, heap usage 120.741 MB -> 68.540 MB. [2024-09-25T20:42:51.145Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2236.354 ms) ====== [2024-09-25T20:42:51.145Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-25T20:42:51.145Z] GC before operation: completed in 122.133 ms, heap usage 333.798 MB -> 69.615 MB. [2024-09-25T20:42:52.084Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1612.148 ms) ====== [2024-09-25T20:42:52.084Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-25T20:42:53.030Z] GC before operation: completed in 112.483 ms, heap usage 244.233 MB -> 69.552 MB. [2024-09-25T20:42:53.972Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1706.248 ms) ====== [2024-09-25T20:42:53.972Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-25T20:42:55.152Z] GC before operation: completed in 130.465 ms, heap usage 183.973 MB -> 69.539 MB. [2024-09-25T20:42:56.095Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1686.718 ms) ====== [2024-09-25T20:42:56.095Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-25T20:42:56.095Z] GC before operation: completed in 135.046 ms, heap usage 176.923 MB -> 80.631 MB. [2024-09-25T20:42:58.030Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1738.686 ms) ====== [2024-09-25T20:42:58.030Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-25T20:42:58.030Z] GC before operation: completed in 168.149 ms, heap usage 374.413 MB -> 81.334 MB. [2024-09-25T20:42:59.963Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1902.168 ms) ====== [2024-09-25T20:42:59.963Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-25T20:42:59.963Z] GC before operation: completed in 140.760 ms, heap usage 317.822 MB -> 70.428 MB. [2024-09-25T20:43:02.942Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2150.691 ms) ====== [2024-09-25T20:43:02.942Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-25T20:43:02.942Z] GC before operation: completed in 146.320 ms, heap usage 171.515 MB -> 70.197 MB. [2024-09-25T20:43:03.889Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1564.481 ms) ====== [2024-09-25T20:43:03.889Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-25T20:43:04.845Z] GC before operation: completed in 290.715 ms, heap usage 455.808 MB -> 70.778 MB. [2024-09-25T20:43:05.785Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1588.618 ms) ====== [2024-09-25T20:43:05.785Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-25T20:43:05.785Z] GC before operation: completed in 147.926 ms, heap usage 105.248 MB -> 70.804 MB. [2024-09-25T20:43:07.717Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1990.247 ms) ====== [2024-09-25T20:43:07.717Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-25T20:43:08.657Z] GC before operation: completed in 163.042 ms, heap usage 349.874 MB -> 87.313 MB. [2024-09-25T20:43:09.597Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1460.295 ms) ====== [2024-09-25T20:43:09.598Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-25T20:43:09.598Z] GC before operation: completed in 163.444 ms, heap usage 318.606 MB -> 70.901 MB. [2024-09-25T20:43:11.527Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1372.728 ms) ====== [2024-09-25T20:43:11.527Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-25T20:43:11.527Z] GC before operation: completed in 168.264 ms, heap usage 445.047 MB -> 71.414 MB. [2024-09-25T20:43:13.610Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1801.435 ms) ====== [2024-09-25T20:43:13.610Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-25T20:43:13.610Z] GC before operation: completed in 158.263 ms, heap usage 443.156 MB -> 71.550 MB. [2024-09-25T20:43:14.553Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1446.995 ms) ====== [2024-09-25T20:43:14.553Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-25T20:43:14.553Z] GC before operation: completed in 163.622 ms, heap usage 427.421 MB -> 71.581 MB. [2024-09-25T20:43:16.496Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1329.718 ms) ====== [2024-09-25T20:43:16.496Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-25T20:43:16.496Z] GC before operation: completed in 164.195 ms, heap usage 429.552 MB -> 71.588 MB. [2024-09-25T20:43:18.434Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1563.053 ms) ====== [2024-09-25T20:43:18.434Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-25T20:43:18.434Z] GC before operation: completed in 170.649 ms, heap usage 427.791 MB -> 71.574 MB. [2024-09-25T20:43:20.372Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1694.589 ms) ====== [2024-09-25T20:43:20.372Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-25T20:43:20.372Z] GC before operation: completed in 167.272 ms, heap usage 257.965 MB -> 71.691 MB. [2024-09-25T20:43:21.323Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1302.447 ms) ====== [2024-09-25T20:43:21.323Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-25T20:43:21.323Z] GC before operation: completed in 154.898 ms, heap usage 114.331 MB -> 71.255 MB. [2024-09-25T20:43:23.263Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1389.365 ms) ====== [2024-09-25T20:43:23.263Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-25T20:43:23.263Z] GC before operation: completed in 170.216 ms, heap usage 351.072 MB -> 71.928 MB. [2024-09-25T20:43:25.201Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1673.029 ms) ====== [2024-09-25T20:43:25.201Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-25T20:43:25.201Z] GC before operation: completed in 168.707 ms, heap usage 430.614 MB -> 72.081 MB. [2024-09-25T20:43:27.141Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1833.438 ms) ====== [2024-09-25T20:43:27.141Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-25T20:43:27.141Z] GC before operation: completed in 184.771 ms, heap usage 434.695 MB -> 72.217 MB. [2024-09-25T20:43:29.073Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2117.900 ms) ====== [2024-09-25T20:43:29.073Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-25T20:43:29.073Z] GC before operation: completed in 191.948 ms, heap usage 428.377 MB -> 72.175 MB. [2024-09-25T20:43:31.007Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2082.307 ms) ====== [2024-09-25T20:43:31.007Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-25T20:43:31.947Z] GC before operation: completed in 181.855 ms, heap usage 134.025 MB -> 72.099 MB. [2024-09-25T20:43:32.888Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1604.603 ms) ====== [2024-09-25T20:43:32.888Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-25T20:43:32.888Z] GC before operation: completed in 176.842 ms, heap usage 385.659 MB -> 72.521 MB. [2024-09-25T20:43:34.823Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1268.087 ms) ====== [2024-09-25T20:43:34.823Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-25T20:43:34.823Z] GC before operation: completed in 172.293 ms, heap usage 268.887 MB -> 72.497 MB. [2024-09-25T20:43:36.754Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1479.320 ms) ====== [2024-09-25T20:43:36.754Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-25T20:43:36.754Z] GC before operation: completed in 173.757 ms, heap usage 116.727 MB -> 72.199 MB. [2024-09-25T20:43:37.698Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1486.745 ms) ====== [2024-09-25T20:43:37.698Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-25T20:43:37.698Z] GC before operation: completed in 171.598 ms, heap usage 325.665 MB -> 72.630 MB. [2024-09-25T20:43:39.634Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1551.734 ms) ====== [2024-09-25T20:43:39.634Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-25T20:43:39.634Z] GC before operation: completed in 187.513 ms, heap usage 242.261 MB -> 94.750 MB. [2024-09-25T20:43:41.574Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1842.884 ms) ====== [2024-09-25T20:43:41.574Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-25T20:43:41.574Z] GC before operation: completed in 201.216 ms, heap usage 249.587 MB -> 72.874 MB. [2024-09-25T20:43:43.507Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1855.798 ms) ====== [2024-09-25T20:43:43.507Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-25T20:43:43.507Z] GC before operation: completed in 184.215 ms, heap usage 271.049 MB -> 94.784 MB. [2024-09-25T20:43:45.442Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1872.052 ms) ====== [2024-09-25T20:43:45.442Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-25T20:43:46.384Z] GC before operation: completed in 183.606 ms, heap usage 269.211 MB -> 73.131 MB. [2024-09-25T20:43:47.330Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1460.543 ms) ====== [2024-09-25T20:43:47.330Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-25T20:43:47.330Z] GC before operation: completed in 184.015 ms, heap usage 451.449 MB -> 73.448 MB. [2024-09-25T20:43:49.266Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1675.598 ms) ====== [2024-09-25T20:43:49.266Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-25T20:43:49.266Z] GC before operation: completed in 200.157 ms, heap usage 245.939 MB -> 89.689 MB. [2024-09-25T20:43:51.197Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1733.392 ms) ====== [2024-09-25T20:43:51.197Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-25T20:43:51.197Z] GC before operation: completed in 179.513 ms, heap usage 308.638 MB -> 73.395 MB. [2024-09-25T20:43:53.140Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1274.412 ms) ====== [2024-09-25T20:43:53.140Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-25T20:43:53.140Z] GC before operation: completed in 207.160 ms, heap usage 247.785 MB -> 73.535 MB. [2024-09-25T20:43:54.083Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1173.800 ms) ====== [2024-09-25T20:43:54.083Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-25T20:43:54.083Z] GC before operation: completed in 220.500 ms, heap usage 184.960 MB -> 84.283 MB. [2024-09-25T20:43:56.045Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1822.763 ms) ====== [2024-09-25T20:43:56.045Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-25T20:43:56.045Z] GC before operation: completed in 238.702 ms, heap usage 433.960 MB -> 90.222 MB. [2024-09-25T20:43:57.988Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1662.367 ms) ====== [2024-09-25T20:43:57.988Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-25T20:43:57.988Z] GC before operation: completed in 285.558 ms, heap usage 445.848 MB -> 73.841 MB. [2024-09-25T20:43:59.937Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1645.410 ms) ====== [2024-09-25T20:44:00.883Z] ----------------------------------- [2024-09-25T20:44:00.883Z] renaissance-dec-tree_0_PASSED [2024-09-25T20:44:00.883Z] ----------------------------------- [2024-09-25T20:44:00.883Z] [2024-09-25T20:44:00.883Z] TEST TEARDOWN: [2024-09-25T20:44:00.883Z] Nothing to be done for teardown. [2024-09-25T20:44:00.883Z] renaissance-dec-tree_0 Finish Time: Wed Sep 25 20:44:00 2024 Epoch Time (ms): 1727297040057