[2024-08-02T00:04:43.721Z] Running test renaissance-dec-tree_0 ... [2024-08-02T00:04:43.721Z] =============================================== [2024-08-02T00:04:43.721Z] renaissance-dec-tree_0 Start Time: Fri Aug 2 00:04:43 2024 Epoch Time (ms): 1722557083200 [2024-08-02T00:04:43.721Z] variation: NoOptions [2024-08-02T00:04:44.044Z] JVM_OPTIONS: [2024-08-02T00:04:44.045Z] { \ [2024-08-02T00:04:44.045Z] echo ""; echo "TEST SETUP:"; \ [2024-08-02T00:04:44.045Z] echo "Nothing to be done for setup."; \ [2024-08-02T00:04:44.045Z] mkdir -p "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17225562359755\\renaissance-dec-tree_0"; \ [2024-08-02T00:04:44.045Z] cd "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17225562359755\\renaissance-dec-tree_0"; \ [2024-08-02T00:04:44.045Z] echo ""; echo "TESTING:"; \ [2024-08-02T00:04:44.045Z] "c:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/jdkbinary/j2sdk-image\\bin\\java" -jar "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17225562359755\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2024-08-02T00:04:44.045Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17225562359755\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-02T00:04:44.045Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-02T00:04:44.045Z] echo "Nothing to be done for teardown."; \ [2024-08-02T00:04:44.045Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17225562359755\\TestTargetResult"; [2024-08-02T00:04:44.045Z] [2024-08-02T00:04:44.045Z] TEST SETUP: [2024-08-02T00:04:44.045Z] Nothing to be done for setup. [2024-08-02T00:04:44.045Z] [2024-08-02T00:04:44.045Z] TESTING: [2024-08-02T00:04:54.628Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-02T00:04:56.253Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-02T00:04:59.904Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-02T00:04:59.904Z] GC before operation: completed in 178.405 ms, heap usage 127.977 MB -> 28.763 MB. [2024-08-02T00:05:08.814Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8170.132 ms) ====== [2024-08-02T00:05:08.814Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-02T00:05:08.814Z] GC before operation: completed in 310.928 ms, heap usage 280.401 MB -> 55.623 MB. [2024-08-02T00:05:10.113Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1999.734 ms) ====== [2024-08-02T00:05:10.113Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-02T00:05:10.436Z] GC before operation: completed in 293.917 ms, heap usage 418.469 MB -> 82.182 MB. [2024-08-02T00:05:12.056Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1616.399 ms) ====== [2024-08-02T00:05:12.056Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-02T00:05:12.368Z] GC before operation: completed in 181.244 ms, heap usage 340.855 MB -> 65.751 MB. [2024-08-02T00:05:13.983Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1456.520 ms) ====== [2024-08-02T00:05:13.983Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-02T00:05:13.983Z] GC before operation: completed in 203.178 ms, heap usage 296.856 MB -> 65.831 MB. [2024-08-02T00:05:15.640Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1403.314 ms) ====== [2024-08-02T00:05:15.640Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-02T00:05:15.640Z] GC before operation: completed in 152.473 ms, heap usage 286.676 MB -> 66.054 MB. [2024-08-02T00:05:16.799Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1391.295 ms) ====== [2024-08-02T00:05:16.799Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-02T00:05:17.125Z] GC before operation: completed in 166.913 ms, heap usage 270.999 MB -> 57.472 MB. [2024-08-02T00:05:18.734Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1379.378 ms) ====== [2024-08-02T00:05:18.734Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-02T00:05:18.735Z] GC before operation: completed in 193.687 ms, heap usage 250.631 MB -> 66.668 MB. [2024-08-02T00:05:20.358Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1323.624 ms) ====== [2024-08-02T00:05:20.358Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-02T00:05:20.358Z] GC before operation: completed in 219.361 ms, heap usage 258.593 MB -> 66.852 MB. [2024-08-02T00:05:21.467Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1302.751 ms) ====== [2024-08-02T00:05:21.467Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-02T00:05:21.776Z] GC before operation: completed in 209.549 ms, heap usage 254.455 MB -> 72.467 MB. [2024-08-02T00:05:23.362Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1315.632 ms) ====== [2024-08-02T00:05:23.362Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-02T00:05:23.362Z] GC before operation: completed in 205.487 ms, heap usage 261.947 MB -> 66.962 MB. [2024-08-02T00:05:24.503Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1244.914 ms) ====== [2024-08-02T00:05:24.503Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-02T00:05:24.812Z] GC before operation: completed in 210.587 ms, heap usage 253.083 MB -> 72.774 MB. [2024-08-02T00:05:25.955Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1241.680 ms) ====== [2024-08-02T00:05:25.955Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-02T00:05:26.278Z] GC before operation: completed in 214.623 ms, heap usage 266.065 MB -> 72.972 MB. [2024-08-02T00:05:27.378Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1211.544 ms) ====== [2024-08-02T00:05:27.378Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-02T00:05:27.695Z] GC before operation: completed in 217.038 ms, heap usage 263.879 MB -> 73.093 MB. [2024-08-02T00:05:28.807Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1176.779 ms) ====== [2024-08-02T00:05:28.807Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-02T00:05:28.807Z] GC before operation: completed in 186.990 ms, heap usage 266.258 MB -> 78.670 MB. [2024-08-02T00:05:30.415Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1242.272 ms) ====== [2024-08-02T00:05:30.415Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-02T00:05:30.415Z] GC before operation: completed in 195.119 ms, heap usage 274.730 MB -> 73.398 MB. [2024-08-02T00:05:31.521Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1196.355 ms) ====== [2024-08-02T00:05:31.521Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-02T00:05:31.842Z] GC before operation: completed in 192.490 ms, heap usage 271.570 MB -> 57.198 MB. [2024-08-02T00:05:33.019Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1203.070 ms) ====== [2024-08-02T00:05:33.019Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-02T00:05:33.347Z] GC before operation: completed in 252.897 ms, heap usage 252.471 MB -> 57.239 MB. [2024-08-02T00:05:34.446Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1292.056 ms) ====== [2024-08-02T00:05:34.446Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-02T00:05:34.771Z] GC before operation: completed in 267.987 ms, heap usage 252.580 MB -> 68.216 MB. [2024-08-02T00:05:35.931Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1219.026 ms) ====== [2024-08-02T00:05:35.931Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-02T00:05:36.252Z] GC before operation: completed in 196.272 ms, heap usage 262.398 MB -> 73.969 MB. [2024-08-02T00:05:37.351Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1159.081 ms) ====== [2024-08-02T00:05:37.351Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-02T00:05:37.674Z] GC before operation: completed in 162.525 ms, heap usage 260.683 MB -> 74.140 MB. [2024-08-02T00:05:38.789Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1136.332 ms) ====== [2024-08-02T00:05:38.789Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-02T00:05:38.789Z] GC before operation: completed in 216.641 ms, heap usage 272.557 MB -> 74.263 MB. [2024-08-02T00:05:40.388Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1149.089 ms) ====== [2024-08-02T00:05:40.388Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-02T00:05:40.388Z] GC before operation: completed in 192.846 ms, heap usage 265.451 MB -> 74.385 MB. [2024-08-02T00:05:41.486Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1191.915 ms) ====== [2024-08-02T00:05:41.486Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-02T00:05:41.828Z] GC before operation: completed in 212.040 ms, heap usage 269.039 MB -> 69.088 MB. [2024-08-02T00:05:42.927Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1182.498 ms) ====== [2024-08-02T00:05:42.927Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-02T00:05:42.927Z] GC before operation: completed in 204.749 ms, heap usage 261.091 MB -> 74.652 MB. [2024-08-02T00:05:44.546Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1152.581 ms) ====== [2024-08-02T00:05:44.546Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-02T00:05:44.546Z] GC before operation: completed in 188.937 ms, heap usage 261.165 MB -> 74.975 MB. [2024-08-02T00:05:45.648Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1191.394 ms) ====== [2024-08-02T00:05:45.648Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-02T00:05:45.648Z] GC before operation: completed in 208.742 ms, heap usage 265.231 MB -> 74.922 MB. [2024-08-02T00:05:46.920Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1210.246 ms) ====== [2024-08-02T00:05:46.920Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-02T00:05:47.247Z] GC before operation: completed in 191.349 ms, heap usage 264.217 MB -> 75.060 MB. [2024-08-02T00:05:48.470Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1350.723 ms) ====== [2024-08-02T00:05:48.470Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-02T00:05:48.799Z] GC before operation: completed in 181.092 ms, heap usage 267.712 MB -> 75.177 MB. [2024-08-02T00:05:49.904Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1189.697 ms) ====== [2024-08-02T00:05:49.904Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-02T00:05:50.231Z] GC before operation: completed in 199.985 ms, heap usage 268.969 MB -> 80.940 MB. [2024-08-02T00:05:51.333Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1135.900 ms) ====== [2024-08-02T00:05:51.333Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-02T00:05:51.333Z] GC before operation: completed in 177.971 ms, heap usage 275.302 MB -> 69.825 MB. [2024-08-02T00:05:52.501Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1164.360 ms) ====== [2024-08-02T00:05:52.501Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-02T00:05:52.821Z] GC before operation: completed in 187.390 ms, heap usage 264.518 MB -> 81.022 MB. [2024-08-02T00:05:53.920Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1121.627 ms) ====== [2024-08-02T00:05:53.920Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-02T00:05:54.239Z] GC before operation: completed in 190.152 ms, heap usage 274.020 MB -> 81.340 MB. [2024-08-02T00:05:55.420Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1154.464 ms) ====== [2024-08-02T00:05:55.420Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-02T00:05:55.420Z] GC before operation: completed in 167.521 ms, heap usage 282.094 MB -> 75.843 MB. [2024-08-02T00:05:56.521Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1192.158 ms) ====== [2024-08-02T00:05:56.521Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-02T00:05:56.870Z] GC before operation: completed in 239.192 ms, heap usage 290.342 MB -> 75.981 MB. [2024-08-02T00:05:58.068Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1266.403 ms) ====== [2024-08-02T00:05:58.068Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-02T00:05:58.387Z] GC before operation: completed in 215.263 ms, heap usage 270.940 MB -> 81.537 MB. [2024-08-02T00:05:59.482Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1135.782 ms) ====== [2024-08-02T00:05:59.482Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-02T00:05:59.800Z] GC before operation: completed in 202.648 ms, heap usage 275.505 MB -> 76.416 MB. [2024-08-02T00:06:00.907Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1160.146 ms) ====== [2024-08-02T00:06:00.907Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-02T00:06:00.907Z] GC before operation: completed in 196.443 ms, heap usage 270.039 MB -> 76.375 MB. [2024-08-02T00:06:00.907Z] 24/08/02 00:06:00 WARN BlockManager: Asked to remove block rdd_1810_0, which does not exist [2024-08-02T00:06:02.054Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1162.794 ms) ====== [2024-08-02T00:06:02.054Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-02T00:06:02.388Z] GC before operation: completed in 218.774 ms, heap usage 267.751 MB -> 76.505 MB. [2024-08-02T00:06:03.502Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1138.632 ms) ====== [2024-08-02T00:06:03.502Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-02T00:06:03.823Z] GC before operation: completed in 175.386 ms, heap usage 268.316 MB -> 71.237 MB. [2024-08-02T00:06:04.911Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1242.756 ms) ====== [2024-08-02T00:06:05.233Z] ----------------------------------- [2024-08-02T00:06:05.233Z] renaissance-dec-tree_0_PASSED [2024-08-02T00:06:05.233Z] ----------------------------------- [2024-08-02T00:06:05.541Z] [2024-08-02T00:06:05.541Z] TEST TEARDOWN: [2024-08-02T00:06:05.541Z] Nothing to be done for teardown. [2024-08-02T00:06:05.541Z] renaissance-dec-tree_0 Finish Time: Fri Aug 2 00:06:05 2024 Epoch Time (ms): 1722557165416