[2024-08-08T00:27:40.785Z] Running test renaissance-dec-tree_0 ... [2024-08-08T00:27:40.785Z] =============================================== [2024-08-08T00:27:40.785Z] renaissance-dec-tree_0 Start Time: Wed Aug 7 19:27:40 2024 Epoch Time (ms): 1723076860222 [2024-08-08T00:27:40.785Z] variation: NoOptions [2024-08-08T00:27:40.785Z] JVM_OPTIONS: [2024-08-08T00:27:40.785Z] { \ [2024-08-08T00:27:40.785Z] echo ""; echo "TEST SETUP:"; \ [2024-08-08T00:27:40.785Z] echo "Nothing to be done for setup."; \ [2024-08-08T00:27:40.785Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17230766079807/renaissance-dec-tree_0"; \ [2024-08-08T00:27:40.785Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17230766079807/renaissance-dec-tree_0"; \ [2024-08-08T00:27:40.785Z] echo ""; echo "TESTING:"; \ [2024-08-08T00:27:40.785Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+2/bin/..//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_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17230766079807/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-08T00:27:40.785Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17230766079807/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-08T00:27:40.785Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-08T00:27:40.785Z] echo "Nothing to be done for teardown."; \ [2024-08-08T00:27:40.785Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17230766079807/TestTargetResult"; [2024-08-08T00:27:40.785Z] [2024-08-08T00:27:40.785Z] TEST SETUP: [2024-08-08T00:27:40.785Z] Nothing to be done for setup. [2024-08-08T00:27:40.785Z] [2024-08-08T00:27:40.785Z] TESTING: [2024-08-08T00:27:43.803Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-08T00:27:45.211Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-08T00:27:48.223Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-08T00:27:48.223Z] GC before operation: completed in 59.903 ms, heap usage 46.876 MB -> 35.801 MB. [2024-08-08T00:27:55.724Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7433.915 ms) ====== [2024-08-08T00:27:55.724Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-08T00:27:55.724Z] GC before operation: completed in 108.849 ms, heap usage 212.604 MB -> 65.179 MB. [2024-08-08T00:27:57.886Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2034.713 ms) ====== [2024-08-08T00:27:57.886Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-08T00:27:57.886Z] GC before operation: completed in 89.392 ms, heap usage 190.805 MB -> 65.557 MB. [2024-08-08T00:28:00.084Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1632.478 ms) ====== [2024-08-08T00:28:00.084Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-08T00:28:00.084Z] GC before operation: completed in 71.261 ms, heap usage 331.990 MB -> 65.983 MB. [2024-08-08T00:28:01.614Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1545.720 ms) ====== [2024-08-08T00:28:01.614Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-08T00:28:01.614Z] GC before operation: completed in 91.150 ms, heap usage 276.814 MB -> 66.215 MB. [2024-08-08T00:28:02.995Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1389.651 ms) ====== [2024-08-08T00:28:02.995Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-08T00:28:02.995Z] GC before operation: completed in 81.740 ms, heap usage 301.918 MB -> 77.606 MB. [2024-08-08T00:28:04.379Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1404.801 ms) ====== [2024-08-08T00:28:04.379Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-08T00:28:04.379Z] GC before operation: completed in 100.314 ms, heap usage 437.270 MB -> 72.323 MB. [2024-08-08T00:28:05.762Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1424.217 ms) ====== [2024-08-08T00:28:05.762Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-08T00:28:05.762Z] GC before operation: completed in 75.224 ms, heap usage 180.892 MB -> 66.460 MB. [2024-08-08T00:28:07.143Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1370.461 ms) ====== [2024-08-08T00:28:07.143Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-08T00:28:07.143Z] GC before operation: completed in 83.230 ms, heap usage 241.009 MB -> 66.996 MB. [2024-08-08T00:28:08.525Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1317.906 ms) ====== [2024-08-08T00:28:08.525Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-08T00:28:08.525Z] GC before operation: completed in 88.170 ms, heap usage 264.098 MB -> 94.639 MB. [2024-08-08T00:28:09.924Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1376.135 ms) ====== [2024-08-08T00:28:09.924Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-08T00:28:09.924Z] GC before operation: completed in 91.133 ms, heap usage 282.883 MB -> 78.247 MB. [2024-08-08T00:28:12.084Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1493.203 ms) ====== [2024-08-08T00:28:12.084Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-08T00:28:12.084Z] GC before operation: completed in 102.165 ms, heap usage 116.201 MB -> 83.505 MB. [2024-08-08T00:28:13.467Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1550.243 ms) ====== [2024-08-08T00:28:13.467Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-08T00:28:13.467Z] GC before operation: completed in 98.197 ms, heap usage 231.262 MB -> 67.336 MB. [2024-08-08T00:28:14.864Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1588.358 ms) ====== [2024-08-08T00:28:14.864Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-08T00:28:14.864Z] GC before operation: completed in 111.686 ms, heap usage 255.941 MB -> 83.989 MB. [2024-08-08T00:28:17.058Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1435.234 ms) ====== [2024-08-08T00:28:17.058Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-08T00:28:17.058Z] GC before operation: completed in 105.040 ms, heap usage 370.986 MB -> 78.553 MB. [2024-08-08T00:28:18.439Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1524.813 ms) ====== [2024-08-08T00:28:18.439Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-08T00:28:18.439Z] GC before operation: completed in 105.547 ms, heap usage 425.336 MB -> 84.516 MB. [2024-08-08T00:28:19.820Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1274.741 ms) ====== [2024-08-08T00:28:19.820Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-08T00:28:19.820Z] GC before operation: completed in 105.908 ms, heap usage 320.308 MB -> 84.466 MB. [2024-08-08T00:28:21.224Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1271.109 ms) ====== [2024-08-08T00:28:21.224Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-08T00:28:21.224Z] GC before operation: completed in 99.057 ms, heap usage 337.584 MB -> 67.989 MB. [2024-08-08T00:28:22.622Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1252.240 ms) ====== [2024-08-08T00:28:22.622Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-08T00:28:22.622Z] GC before operation: completed in 95.654 ms, heap usage 236.039 MB -> 79.201 MB. [2024-08-08T00:28:24.010Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1183.759 ms) ====== [2024-08-08T00:28:24.010Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-08T00:28:24.010Z] GC before operation: completed in 143.343 ms, heap usage 437.464 MB -> 96.019 MB. [2024-08-08T00:28:24.010Z] 24/08/07 19:28:23 WARN BlockManager: Asked to remove block rdd_928_2, which does not exist [2024-08-08T00:28:24.010Z] 24/08/07 19:28:23 WARN BlockManager: Asked to remove block rdd_928_0, which does not exist [2024-08-08T00:28:25.395Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1516.790 ms) ====== [2024-08-08T00:28:25.395Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-08T00:28:25.395Z] GC before operation: completed in 110.816 ms, heap usage 223.134 MB -> 84.905 MB. [2024-08-08T00:28:26.779Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1287.330 ms) ====== [2024-08-08T00:28:26.779Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-08T00:28:26.779Z] GC before operation: completed in 110.333 ms, heap usage 387.880 MB -> 85.142 MB. [2024-08-08T00:28:28.267Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1342.848 ms) ====== [2024-08-08T00:28:28.267Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-08T00:28:28.267Z] GC before operation: completed in 125.755 ms, heap usage 313.320 MB -> 96.238 MB. [2024-08-08T00:28:29.651Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1246.138 ms) ====== [2024-08-08T00:28:29.651Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-08T00:28:29.651Z] GC before operation: completed in 94.059 ms, heap usage 236.321 MB -> 79.557 MB. [2024-08-08T00:28:31.039Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1277.726 ms) ====== [2024-08-08T00:28:31.039Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-08T00:28:31.039Z] GC before operation: completed in 111.062 ms, heap usage 404.891 MB -> 96.355 MB. [2024-08-08T00:28:32.419Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1353.591 ms) ====== [2024-08-08T00:28:32.419Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-08T00:28:32.419Z] GC before operation: completed in 110.069 ms, heap usage 429.108 MB -> 68.936 MB. [2024-08-08T00:28:33.801Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1336.275 ms) ====== [2024-08-08T00:28:33.801Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-08T00:28:33.801Z] GC before operation: completed in 128.493 ms, heap usage 380.303 MB -> 96.457 MB. [2024-08-08T00:28:35.181Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1232.099 ms) ====== [2024-08-08T00:28:35.181Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-08T00:28:35.181Z] GC before operation: completed in 108.398 ms, heap usage 227.393 MB -> 80.087 MB. [2024-08-08T00:28:36.563Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1322.585 ms) ====== [2024-08-08T00:28:36.563Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-08T00:28:36.563Z] GC before operation: completed in 108.976 ms, heap usage 421.021 MB -> 96.707 MB. [2024-08-08T00:28:37.949Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1282.825 ms) ====== [2024-08-08T00:28:37.949Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-08T00:28:37.949Z] GC before operation: completed in 110.947 ms, heap usage 229.797 MB -> 80.477 MB. [2024-08-08T00:28:39.333Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1233.564 ms) ====== [2024-08-08T00:28:39.333Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-08T00:28:39.333Z] GC before operation: completed in 129.136 ms, heap usage 421.366 MB -> 96.923 MB. [2024-08-08T00:28:39.333Z] 24/08/07 19:28:39 WARN BlockManager: Asked to remove block rdd_1467_2, which does not exist [2024-08-08T00:28:39.333Z] 24/08/07 19:28:39 WARN BlockManager: Asked to remove block rdd_1467_1, which does not exist [2024-08-08T00:28:40.852Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1205.039 ms) ====== [2024-08-08T00:28:40.852Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-08T00:28:40.852Z] GC before operation: completed in 117.181 ms, heap usage 214.302 MB -> 91.589 MB. [2024-08-08T00:28:42.234Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1327.874 ms) ====== [2024-08-08T00:28:42.234Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-08T00:28:42.234Z] GC before operation: completed in 111.103 ms, heap usage 291.179 MB -> 91.658 MB. [2024-08-08T00:28:43.622Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1574.214 ms) ====== [2024-08-08T00:28:43.622Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-08T00:28:43.622Z] GC before operation: completed in 92.912 ms, heap usage 295.234 MB -> 69.631 MB. [2024-08-08T00:28:45.016Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1391.827 ms) ====== [2024-08-08T00:28:45.016Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-08T00:28:45.693Z] GC before operation: completed in 114.416 ms, heap usage 238.124 MB -> 97.652 MB. [2024-08-08T00:28:47.076Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1329.406 ms) ====== [2024-08-08T00:28:47.076Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-08T00:28:47.076Z] GC before operation: completed in 115.108 ms, heap usage 275.064 MB -> 91.971 MB. [2024-08-08T00:28:47.076Z] 24/08/07 19:28:46 WARN BlockManager: Asked to remove block broadcast_484_piece0, which does not exist [2024-08-08T00:28:48.457Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1249.013 ms) ====== [2024-08-08T00:28:48.457Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-08T00:28:48.457Z] GC before operation: completed in 94.945 ms, heap usage 321.987 MB -> 69.980 MB. [2024-08-08T00:28:49.122Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1235.862 ms) ====== [2024-08-08T00:28:49.122Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-08T00:28:49.815Z] GC before operation: completed in 104.499 ms, heap usage 217.091 MB -> 98.173 MB. [2024-08-08T00:28:49.815Z] 24/08/07 19:28:49 WARN BlockManager: Asked to remove block rdd_1810_0, which does not exist [2024-08-08T00:28:50.485Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1216.484 ms) ====== [2024-08-08T00:28:50.485Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-08T00:28:51.160Z] GC before operation: completed in 109.958 ms, heap usage 245.274 MB -> 86.775 MB. [2024-08-08T00:28:52.551Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1351.486 ms) ====== [2024-08-08T00:28:52.551Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-08T00:28:52.551Z] GC before operation: completed in 113.230 ms, heap usage 373.153 MB -> 81.123 MB. [2024-08-08T00:28:53.945Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1232.300 ms) ====== [2024-08-08T00:28:53.945Z] ----------------------------------- [2024-08-08T00:28:53.945Z] renaissance-dec-tree_0_PASSED [2024-08-08T00:28:53.945Z] ----------------------------------- [2024-08-08T00:28:53.945Z] [2024-08-08T00:28:53.945Z] TEST TEARDOWN: [2024-08-08T00:28:53.945Z] Nothing to be done for teardown. [2024-08-08T00:28:53.945Z] renaissance-dec-tree_0 Finish Time: Wed Aug 7 19:28:53 2024 Epoch Time (ms): 1723076933679