[2024-08-16T19:23:19.122Z] Running test renaissance-dec-tree_0 ... [2024-08-16T19:23:19.432Z] =============================================== [2024-08-16T19:23:19.742Z] renaissance-dec-tree_0 Start Time: Fri Aug 16 19:23:19 2024 Epoch Time (ms): 1723836199334 [2024-08-16T19:23:20.063Z] variation: NoOptions [2024-08-16T19:23:20.063Z] JVM_OPTIONS: [2024-08-16T19:23:20.063Z] { \ [2024-08-16T19:23:20.063Z] echo ""; echo "TEST SETUP:"; \ [2024-08-16T19:23:20.063Z] echo "Nothing to be done for setup."; \ [2024-08-16T19:23:20.063Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17238356015779\\renaissance-dec-tree_0"; \ [2024-08-16T19:23:20.063Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17238356015779\\renaissance-dec-tree_0"; \ [2024-08-16T19:23:20.063Z] echo ""; echo "TESTING:"; \ [2024-08-16T19:23:20.063Z] "c:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/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 "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17238356015779\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2024-08-16T19:23:20.063Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17238356015779\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-16T19:23:20.063Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-16T19:23:20.063Z] echo "Nothing to be done for teardown."; \ [2024-08-16T19:23:20.063Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17238356015779\\TestTargetResult"; [2024-08-16T19:23:20.063Z] [2024-08-16T19:23:20.063Z] TEST SETUP: [2024-08-16T19:23:20.063Z] Nothing to be done for setup. [2024-08-16T19:23:20.063Z] [2024-08-16T19:23:20.063Z] TESTING: [2024-08-16T19:23:30.692Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-16T19:23:31.805Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-16T19:23:34.741Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-16T19:23:34.741Z] GC before operation: completed in 49.738 ms, heap usage 90.692 MB -> 35.315 MB. [2024-08-16T19:23:42.200Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7196.447 ms) ====== [2024-08-16T19:23:42.200Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-16T19:23:42.200Z] GC before operation: completed in 64.055 ms, heap usage 180.064 MB -> 92.402 MB. [2024-08-16T19:23:44.082Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2089.857 ms) ====== [2024-08-16T19:23:44.082Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-16T19:23:44.082Z] GC before operation: completed in 75.651 ms, heap usage 409.814 MB -> 65.254 MB. [2024-08-16T19:23:45.914Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1858.057 ms) ====== [2024-08-16T19:23:45.914Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-16T19:23:45.914Z] GC before operation: completed in 68.313 ms, heap usage 185.362 MB -> 65.576 MB. [2024-08-16T19:23:47.601Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1629.887 ms) ====== [2024-08-16T19:23:47.601Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-16T19:23:47.601Z] GC before operation: completed in 64.240 ms, heap usage 119.604 MB -> 65.291 MB. [2024-08-16T19:23:49.193Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1460.526 ms) ====== [2024-08-16T19:23:49.193Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-16T19:23:49.193Z] GC before operation: completed in 68.846 ms, heap usage 330.032 MB -> 77.088 MB. [2024-08-16T19:23:50.921Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1389.197 ms) ====== [2024-08-16T19:23:50.921Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-16T19:23:50.921Z] GC before operation: completed in 68.412 ms, heap usage 236.521 MB -> 77.399 MB. [2024-08-16T19:23:52.036Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1393.890 ms) ====== [2024-08-16T19:23:52.036Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-16T19:23:52.036Z] GC before operation: completed in 70.884 ms, heap usage 204.723 MB -> 77.394 MB. [2024-08-16T19:23:53.661Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1480.470 ms) ====== [2024-08-16T19:23:53.661Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-16T19:23:53.661Z] GC before operation: completed in 72.314 ms, heap usage 206.892 MB -> 77.694 MB. [2024-08-16T19:23:55.306Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1348.441 ms) ====== [2024-08-16T19:23:55.306Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-16T19:23:55.306Z] GC before operation: completed in 73.055 ms, heap usage 205.104 MB -> 77.845 MB. [2024-08-16T19:23:56.416Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1319.800 ms) ====== [2024-08-16T19:23:56.416Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-16T19:23:56.416Z] GC before operation: completed in 75.686 ms, heap usage 205.631 MB -> 83.650 MB. [2024-08-16T19:23:58.181Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1355.524 ms) ====== [2024-08-16T19:23:58.181Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-16T19:23:58.181Z] GC before operation: completed in 77.139 ms, heap usage 460.416 MB -> 83.948 MB. [2024-08-16T19:23:59.287Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1235.656 ms) ====== [2024-08-16T19:23:59.287Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-16T19:23:59.287Z] GC before operation: completed in 75.642 ms, heap usage 187.374 MB -> 83.568 MB. [2024-08-16T19:24:00.415Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1285.864 ms) ====== [2024-08-16T19:24:00.415Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-16T19:24:00.734Z] GC before operation: completed in 82.087 ms, heap usage 435.054 MB -> 83.785 MB. [2024-08-16T19:24:01.844Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1225.263 ms) ====== [2024-08-16T19:24:01.844Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-16T19:24:01.844Z] GC before operation: completed in 77.224 ms, heap usage 131.463 MB -> 77.618 MB. [2024-08-16T19:24:03.452Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1305.731 ms) ====== [2024-08-16T19:24:03.452Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-16T19:24:03.452Z] GC before operation: completed in 83.799 ms, heap usage 348.121 MB -> 83.948 MB. [2024-08-16T19:24:04.557Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1289.755 ms) ====== [2024-08-16T19:24:04.557Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-16T19:24:04.557Z] GC before operation: completed in 80.219 ms, heap usage 425.549 MB -> 67.782 MB. [2024-08-16T19:24:06.174Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1166.946 ms) ====== [2024-08-16T19:24:06.174Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-16T19:24:06.174Z] GC before operation: completed in 80.818 ms, heap usage 304.909 MB -> 67.724 MB. [2024-08-16T19:24:07.316Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1188.411 ms) ====== [2024-08-16T19:24:07.316Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-16T19:24:07.316Z] GC before operation: completed in 84.844 ms, heap usage 298.622 MB -> 84.388 MB. [2024-08-16T19:24:08.416Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1163.827 ms) ====== [2024-08-16T19:24:08.416Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-16T19:24:08.417Z] GC before operation: completed in 85.608 ms, heap usage 414.520 MB -> 84.512 MB. [2024-08-16T19:24:09.561Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1231.702 ms) ====== [2024-08-16T19:24:09.561Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-16T19:24:09.871Z] GC before operation: completed in 81.662 ms, heap usage 122.839 MB -> 73.366 MB. [2024-08-16T19:24:11.043Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1272.540 ms) ====== [2024-08-16T19:24:11.043Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-16T19:24:11.043Z] GC before operation: completed in 88.814 ms, heap usage 403.318 MB -> 84.801 MB. [2024-08-16T19:24:12.319Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1306.099 ms) ====== [2024-08-16T19:24:12.319Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-16T19:24:12.664Z] GC before operation: completed in 85.655 ms, heap usage 396.887 MB -> 84.861 MB. [2024-08-16T19:24:13.770Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1219.678 ms) ====== [2024-08-16T19:24:13.771Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-16T19:24:13.771Z] GC before operation: completed in 85.966 ms, heap usage 399.948 MB -> 90.376 MB. [2024-08-16T19:24:14.900Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1169.118 ms) ====== [2024-08-16T19:24:14.900Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-16T19:24:15.222Z] GC before operation: completed in 85.890 ms, heap usage 347.255 MB -> 85.037 MB. [2024-08-16T19:24:15.222Z] 24/08/16 19:24:14 WARN BlockManager: Asked to remove block rdd_1173_2, which does not exist [2024-08-16T19:24:16.324Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1144.159 ms) ====== [2024-08-16T19:24:16.324Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-16T19:24:16.324Z] GC before operation: completed in 90.390 ms, heap usage 399.927 MB -> 85.172 MB. [2024-08-16T19:24:17.448Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1224.706 ms) ====== [2024-08-16T19:24:17.448Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-16T19:24:17.785Z] GC before operation: completed in 92.577 ms, heap usage 397.423 MB -> 85.307 MB. [2024-08-16T19:24:17.785Z] 24/08/16 19:24:17 WARN BlockManager: Asked to remove block rdd_1271_0, which does not exist [2024-08-16T19:24:17.785Z] 24/08/16 19:24:17 WARN BlockManager: Asked to remove block rdd_1271_2, which does not exist [2024-08-16T19:24:18.887Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1159.645 ms) ====== [2024-08-16T19:24:18.887Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-16T19:24:18.887Z] GC before operation: completed in 86.404 ms, heap usage 379.489 MB -> 85.387 MB. [2024-08-16T19:24:19.992Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1149.549 ms) ====== [2024-08-16T19:24:19.992Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-16T19:24:19.992Z] GC before operation: completed in 88.041 ms, heap usage 395.478 MB -> 85.490 MB. [2024-08-16T19:24:21.645Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1194.915 ms) ====== [2024-08-16T19:24:21.645Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-16T19:24:21.645Z] GC before operation: completed in 91.458 ms, heap usage 394.920 MB -> 91.026 MB. [2024-08-16T19:24:22.746Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1226.675 ms) ====== [2024-08-16T19:24:22.746Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-16T19:24:22.746Z] GC before operation: completed in 88.075 ms, heap usage 328.626 MB -> 85.630 MB. [2024-08-16T19:24:23.862Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1177.045 ms) ====== [2024-08-16T19:24:23.862Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-16T19:24:23.862Z] GC before operation: completed in 98.719 ms, heap usage 420.057 MB -> 91.163 MB. [2024-08-16T19:24:25.461Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1189.939 ms) ====== [2024-08-16T19:24:25.461Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-16T19:24:25.461Z] GC before operation: completed in 91.635 ms, heap usage 338.473 MB -> 91.518 MB. [2024-08-16T19:24:26.587Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1129.768 ms) ====== [2024-08-16T19:24:26.587Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-16T19:24:26.587Z] GC before operation: completed in 91.122 ms, heap usage 325.315 MB -> 85.955 MB. [2024-08-16T19:24:27.694Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1144.507 ms) ====== [2024-08-16T19:24:27.694Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-16T19:24:27.694Z] GC before operation: completed in 91.006 ms, heap usage 372.403 MB -> 86.047 MB. [2024-08-16T19:24:27.694Z] 24/08/16 19:24:27 WARN BlockManager: Asked to remove block rdd_1663_2, which does not exist [2024-08-16T19:24:28.872Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1181.517 ms) ====== [2024-08-16T19:24:28.872Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-16T19:24:28.872Z] GC before operation: completed in 92.632 ms, heap usage 400.323 MB -> 91.598 MB. [2024-08-16T19:24:30.546Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1290.633 ms) ====== [2024-08-16T19:24:30.546Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-16T19:24:30.546Z] GC before operation: completed in 97.804 ms, heap usage 149.917 MB -> 86.003 MB. [2024-08-16T19:24:31.637Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1156.690 ms) ====== [2024-08-16T19:24:31.637Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-16T19:24:31.637Z] GC before operation: completed in 93.424 ms, heap usage 185.588 MB -> 86.095 MB. [2024-08-16T19:24:33.245Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1268.925 ms) ====== [2024-08-16T19:24:33.245Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-16T19:24:33.245Z] GC before operation: completed in 92.184 ms, heap usage 379.380 MB -> 86.446 MB. [2024-08-16T19:24:34.371Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1167.374 ms) ====== [2024-08-16T19:24:34.371Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-16T19:24:34.371Z] GC before operation: completed in 94.140 ms, heap usage 386.418 MB -> 86.748 MB. [2024-08-16T19:24:35.472Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1129.253 ms) ====== [2024-08-16T19:24:35.781Z] ----------------------------------- [2024-08-16T19:24:35.781Z] renaissance-dec-tree_0_PASSED [2024-08-16T19:24:35.781Z] ----------------------------------- [2024-08-16T19:24:35.781Z] [2024-08-16T19:24:35.781Z] TEST TEARDOWN: [2024-08-16T19:24:35.781Z] Nothing to be done for teardown. [2024-08-16T19:24:36.100Z] renaissance-dec-tree_0 Finish Time: Fri Aug 16 19:24:35 2024 Epoch Time (ms): 1723836275770