[2025-03-04T22:58:54.083Z] Running test renaissance-dec-tree_0 ... [2025-03-04T22:58:54.083Z] =============================================== [2025-03-04T22:58:54.083Z] renaissance-dec-tree_0 Start Time: Tue Mar 4 22:58:54 2025 Epoch Time (ms): 1741129134031 [2025-03-04T22:58:54.418Z] variation: NoOptions [2025-03-04T22:58:54.418Z] JVM_OPTIONS: [2025-03-04T22:58:54.418Z] { \ [2025-03-04T22:58:54.418Z] echo ""; echo "TEST SETUP:"; \ [2025-03-04T22:58:54.418Z] echo "Nothing to be done for setup."; \ [2025-03-04T22:58:54.418Z] mkdir -p "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17411281626605\\renaissance-dec-tree_0"; \ [2025-03-04T22:58:54.418Z] cd "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17411281626605\\renaissance-dec-tree_0"; \ [2025-03-04T22:58:54.418Z] echo ""; echo "TESTING:"; \ [2025-03-04T22:58:54.418Z] "c:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/jdkbinary/j2sdk-image\\bin\\java" -jar "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17411281626605\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2025-03-04T22:58:54.418Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17411281626605\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-04T22:58:54.418Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-04T22:58:54.418Z] echo "Nothing to be done for teardown."; \ [2025-03-04T22:58:54.418Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17411281626605\\TestTargetResult"; [2025-03-04T22:58:54.418Z] [2025-03-04T22:58:54.418Z] TEST SETUP: [2025-03-04T22:58:54.418Z] Nothing to be done for setup. [2025-03-04T22:58:54.418Z] [2025-03-04T22:58:54.418Z] TESTING: [2025-03-04T22:59:07.408Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-04T22:59:09.651Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-03-04T22:59:13.383Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-03-04T22:59:13.725Z] GC before operation: completed in 186.868 ms, heap usage 133.010 MB -> 28.358 MB. [2025-03-04T22:59:22.926Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8587.683 ms) ====== [2025-03-04T22:59:22.926Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-03-04T22:59:22.926Z] GC before operation: completed in 408.382 ms, heap usage 313.551 MB -> 82.767 MB. [2025-03-04T22:59:25.199Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2373.189 ms) ====== [2025-03-04T22:59:25.199Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-03-04T22:59:25.551Z] GC before operation: completed in 405.217 ms, heap usage 405.827 MB -> 82.662 MB. [2025-03-04T22:59:27.270Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1976.330 ms) ====== [2025-03-04T22:59:27.270Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-03-04T22:59:27.610Z] GC before operation: completed in 246.631 ms, heap usage 331.698 MB -> 54.677 MB. [2025-03-04T22:59:29.295Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1686.882 ms) ====== [2025-03-04T22:59:29.295Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-03-04T22:59:29.672Z] GC before operation: completed in 207.500 ms, heap usage 271.216 MB -> 55.430 MB. [2025-03-04T22:59:31.509Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1711.669 ms) ====== [2025-03-04T22:59:31.509Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-03-04T22:59:31.509Z] GC before operation: completed in 170.156 ms, heap usage 264.030 MB -> 66.230 MB. [2025-03-04T22:59:32.902Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1610.030 ms) ====== [2025-03-04T22:59:32.902Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-03-04T22:59:33.237Z] GC before operation: completed in 196.343 ms, heap usage 280.354 MB -> 55.390 MB. [2025-03-04T22:59:35.066Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1526.313 ms) ====== [2025-03-04T22:59:35.066Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-03-04T22:59:35.066Z] GC before operation: completed in 184.537 ms, heap usage 247.161 MB -> 66.696 MB. [2025-03-04T22:59:36.889Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1623.915 ms) ====== [2025-03-04T22:59:36.889Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-03-04T22:59:36.889Z] GC before operation: completed in 256.530 ms, heap usage 254.130 MB -> 55.964 MB. [2025-03-04T22:59:38.144Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1485.108 ms) ====== [2025-03-04T22:59:38.144Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-03-04T22:59:38.517Z] GC before operation: completed in 241.874 ms, heap usage 246.726 MB -> 67.215 MB. [2025-03-04T22:59:40.154Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1499.011 ms) ====== [2025-03-04T22:59:40.154Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-03-04T22:59:40.154Z] GC before operation: completed in 231.578 ms, heap usage 257.617 MB -> 67.182 MB. [2025-03-04T22:59:41.792Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1446.370 ms) ====== [2025-03-04T22:59:41.792Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-03-04T22:59:42.123Z] GC before operation: completed in 246.925 ms, heap usage 246.569 MB -> 72.938 MB. [2025-03-04T22:59:42.123Z] 25/03/04 22:59:41 WARN BlockManager: Asked to remove block broadcast_148, which does not exist [2025-03-04T22:59:43.363Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1480.460 ms) ====== [2025-03-04T22:59:43.363Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-03-04T22:59:43.726Z] GC before operation: completed in 240.224 ms, heap usage 262.741 MB -> 72.922 MB. [2025-03-04T22:59:44.958Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1411.700 ms) ====== [2025-03-04T22:59:44.958Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-03-04T22:59:45.301Z] GC before operation: completed in 238.490 ms, heap usage 263.182 MB -> 73.257 MB. [2025-03-04T22:59:46.620Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1442.081 ms) ====== [2025-03-04T22:59:46.620Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-03-04T22:59:46.956Z] GC before operation: completed in 203.155 ms, heap usage 260.095 MB -> 67.754 MB. [2025-03-04T22:59:46.956Z] 25/03/04 22:59:46 WARN BlockManager: Asked to remove block broadcast_190_piece0, which does not exist [2025-03-04T22:59:48.277Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1434.853 ms) ====== [2025-03-04T22:59:48.277Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-03-04T22:59:48.616Z] GC before operation: completed in 230.950 ms, heap usage 263.594 MB -> 73.347 MB. [2025-03-04T22:59:50.374Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1427.852 ms) ====== [2025-03-04T22:59:50.374Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-03-04T22:59:50.374Z] GC before operation: completed in 249.570 ms, heap usage 255.830 MB -> 57.148 MB. [2025-03-04T22:59:52.040Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1428.098 ms) ====== [2025-03-04T22:59:52.040Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-03-04T22:59:52.040Z] GC before operation: completed in 257.659 ms, heap usage 245.111 MB -> 57.187 MB. [2025-03-04T22:59:53.328Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1427.025 ms) ====== [2025-03-04T22:59:53.328Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-03-04T22:59:53.657Z] GC before operation: completed in 253.639 ms, heap usage 249.655 MB -> 68.416 MB. [2025-03-04T22:59:55.365Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1382.791 ms) ====== [2025-03-04T22:59:55.365Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-03-04T22:59:55.365Z] GC before operation: completed in 215.841 ms, heap usage 260.742 MB -> 68.516 MB. [2025-03-04T22:59:56.573Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1390.333 ms) ====== [2025-03-04T22:59:56.573Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-03-04T22:59:56.922Z] GC before operation: completed in 208.425 ms, heap usage 251.739 MB -> 74.123 MB. [2025-03-04T22:59:58.643Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1354.069 ms) ====== [2025-03-04T22:59:58.643Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-03-04T22:59:58.643Z] GC before operation: completed in 211.384 ms, heap usage 264.868 MB -> 68.609 MB. [2025-03-04T22:59:59.859Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1412.613 ms) ====== [2025-03-04T22:59:59.859Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-03-04T23:00:00.198Z] GC before operation: completed in 219.899 ms, heap usage 252.503 MB -> 74.351 MB. [2025-03-04T23:00:01.397Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1354.289 ms) ====== [2025-03-04T23:00:01.397Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-03-04T23:00:01.761Z] GC before operation: completed in 244.260 ms, heap usage 261.378 MB -> 57.985 MB. [2025-03-04T23:00:02.987Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1396.699 ms) ====== [2025-03-04T23:00:02.987Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-03-04T23:00:03.333Z] GC before operation: completed in 205.592 ms, heap usage 249.477 MB -> 74.621 MB. [2025-03-04T23:00:04.643Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1404.253 ms) ====== [2025-03-04T23:00:04.643Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-03-04T23:00:04.977Z] GC before operation: completed in 217.143 ms, heap usage 264.141 MB -> 69.368 MB. [2025-03-04T23:00:06.215Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1346.333 ms) ====== [2025-03-04T23:00:06.215Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-03-04T23:00:06.548Z] GC before operation: completed in 242.496 ms, heap usage 259.339 MB -> 74.912 MB. [2025-03-04T23:00:08.257Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1433.313 ms) ====== [2025-03-04T23:00:08.257Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-03-04T23:00:08.257Z] GC before operation: completed in 226.722 ms, heap usage 265.575 MB -> 58.531 MB. [2025-03-04T23:00:09.997Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1558.748 ms) ====== [2025-03-04T23:00:09.997Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-03-04T23:00:09.997Z] GC before operation: completed in 231.566 ms, heap usage 265.986 MB -> 69.949 MB. [2025-03-04T23:00:11.216Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1395.867 ms) ====== [2025-03-04T23:00:11.216Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-03-04T23:00:11.573Z] GC before operation: completed in 212.915 ms, heap usage 253.324 MB -> 69.895 MB. [2025-03-04T23:00:13.227Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1315.724 ms) ====== [2025-03-04T23:00:13.227Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-03-04T23:00:13.228Z] GC before operation: completed in 176.303 ms, heap usage 246.615 MB -> 75.427 MB. [2025-03-04T23:00:13.228Z] 25/03/04 23:00:12 WARN BlockManager: Asked to remove block rdd_1467_1, which does not exist [2025-03-04T23:00:14.392Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1308.111 ms) ====== [2025-03-04T23:00:14.392Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-03-04T23:00:14.744Z] GC before operation: completed in 216.923 ms, heap usage 258.541 MB -> 81.009 MB. [2025-03-04T23:00:15.868Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1361.987 ms) ====== [2025-03-04T23:00:15.868Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-03-04T23:00:16.206Z] GC before operation: completed in 212.230 ms, heap usage 273.835 MB -> 81.328 MB. [2025-03-04T23:00:17.383Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1357.774 ms) ====== [2025-03-04T23:00:17.383Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-03-04T23:00:17.768Z] GC before operation: completed in 221.886 ms, heap usage 280.214 MB -> 75.812 MB. [2025-03-04T23:00:19.480Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1349.362 ms) ====== [2025-03-04T23:00:19.480Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-03-04T23:00:19.480Z] GC before operation: completed in 226.553 ms, heap usage 273.502 MB -> 59.440 MB. [2025-03-04T23:00:20.671Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1364.515 ms) ====== [2025-03-04T23:00:20.671Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-03-04T23:00:21.029Z] GC before operation: completed in 197.826 ms, heap usage 254.456 MB -> 70.889 MB. [2025-03-04T23:00:22.157Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1309.831 ms) ====== [2025-03-04T23:00:22.157Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-03-04T23:00:22.566Z] GC before operation: completed in 219.868 ms, heap usage 259.788 MB -> 76.458 MB. [2025-03-04T23:00:23.749Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1339.357 ms) ====== [2025-03-04T23:00:23.749Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-03-04T23:00:24.096Z] GC before operation: completed in 207.328 ms, heap usage 266.066 MB -> 76.374 MB. [2025-03-04T23:00:24.096Z] 25/03/04 23:00:23 WARN BlockManager: Asked to remove block rdd_1810_0, which does not exist [2025-03-04T23:00:25.233Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1309.570 ms) ====== [2025-03-04T23:00:25.233Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-03-04T23:00:25.564Z] GC before operation: completed in 208.324 ms, heap usage 262.176 MB -> 76.505 MB. [2025-03-04T23:00:25.564Z] 25/03/04 23:00:25 WARN BlockManager: Asked to remove block rdd_1859_0, which does not exist [2025-03-04T23:00:25.564Z] 25/03/04 23:00:25 WARN BlockManager: Asked to remove block rdd_1859_2, which does not exist [2025-03-04T23:00:26.736Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1324.497 ms) ====== [2025-03-04T23:00:26.736Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-03-04T23:00:27.076Z] GC before operation: completed in 192.997 ms, heap usage 266.895 MB -> 71.662 MB. [2025-03-04T23:00:28.358Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1440.986 ms) ====== [2025-03-04T23:00:28.688Z] ----------------------------------- [2025-03-04T23:00:28.688Z] renaissance-dec-tree_0_PASSED [2025-03-04T23:00:28.688Z] ----------------------------------- [2025-03-04T23:00:29.005Z] [2025-03-04T23:00:29.005Z] TEST TEARDOWN: [2025-03-04T23:00:29.005Z] Nothing to be done for teardown. [2025-03-04T23:00:29.005Z] renaissance-dec-tree_0 Finish Time: Tue Mar 4 23:00:28 2025 Epoch Time (ms): 1741129228940