[2024-09-26T22:27:42.954Z] Running test renaissance-dec-tree_0 ... [2024-09-26T22:27:42.954Z] =============================================== [2024-09-26T22:27:42.954Z] renaissance-dec-tree_0 Start Time: Thu Sep 26 22:27:42 2024 Epoch Time (ms): 1727389662139 [2024-09-26T22:27:42.954Z] variation: NoOptions [2024-09-26T22:27:42.954Z] JVM_OPTIONS: [2024-09-26T22:27:42.954Z] { \ [2024-09-26T22:27:42.954Z] echo ""; echo "TEST SETUP:"; \ [2024-09-26T22:27:42.954Z] echo "Nothing to be done for setup."; \ [2024-09-26T22:27:42.954Z] mkdir -p "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273888269187\\renaissance-dec-tree_0"; \ [2024-09-26T22:27:42.954Z] cd "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273888269187\\renaissance-dec-tree_0"; \ [2024-09-26T22:27:42.954Z] echo ""; echo "TESTING:"; \ [2024-09-26T22:27:42.954Z] "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_17273888269187\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2024-09-26T22:27:42.954Z] 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_17273888269187\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-26T22:27:42.954Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-26T22:27:42.954Z] echo "Nothing to be done for teardown."; \ [2024-09-26T22:27:42.954Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273888269187\\TestTargetResult"; [2024-09-26T22:27:42.954Z] [2024-09-26T22:27:42.954Z] TEST SETUP: [2024-09-26T22:27:42.954Z] Nothing to be done for setup. [2024-09-26T22:27:42.954Z] [2024-09-26T22:27:42.954Z] TESTING: [2024-09-26T22:27:53.502Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-26T22:27:54.178Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-26T22:27:57.809Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-26T22:27:57.809Z] GC before operation: completed in 164.838 ms, heap usage 120.874 MB -> 28.238 MB. [2024-09-26T22:28:06.799Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7960.449 ms) ====== [2024-09-26T22:28:06.800Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-26T22:28:06.800Z] GC before operation: completed in 475.211 ms, heap usage 269.937 MB -> 54.150 MB. [2024-09-26T22:28:07.957Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2079.934 ms) ====== [2024-09-26T22:28:07.957Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-26T22:28:08.289Z] GC before operation: completed in 291.042 ms, heap usage 256.973 MB -> 68.109 MB. [2024-09-26T22:28:09.978Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1649.790 ms) ====== [2024-09-26T22:28:09.978Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-26T22:28:09.978Z] GC before operation: completed in 176.637 ms, heap usage 243.021 MB -> 54.719 MB. [2024-09-26T22:28:11.567Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1528.396 ms) ====== [2024-09-26T22:28:11.567Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-26T22:28:11.936Z] GC before operation: completed in 233.519 ms, heap usage 252.804 MB -> 65.730 MB. [2024-09-26T22:28:13.041Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1374.502 ms) ====== [2024-09-26T22:28:13.041Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-26T22:28:13.362Z] GC before operation: completed in 170.865 ms, heap usage 265.310 MB -> 55.111 MB. [2024-09-26T22:28:14.948Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1455.227 ms) ====== [2024-09-26T22:28:14.948Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-26T22:28:14.948Z] GC before operation: completed in 194.130 ms, heap usage 263.899 MB -> 55.379 MB. [2024-09-26T22:28:16.531Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1398.047 ms) ====== [2024-09-26T22:28:16.531Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-26T22:28:16.531Z] GC before operation: completed in 184.264 ms, heap usage 244.712 MB -> 72.108 MB. [2024-09-26T22:28:18.138Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1295.598 ms) ====== [2024-09-26T22:28:18.138Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-26T22:28:18.138Z] GC before operation: completed in 219.283 ms, heap usage 263.539 MB -> 66.791 MB. [2024-09-26T22:28:19.724Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1357.560 ms) ====== [2024-09-26T22:28:19.724Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-26T22:28:19.724Z] GC before operation: completed in 165.043 ms, heap usage 253.905 MB -> 66.938 MB. [2024-09-26T22:28:20.872Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1286.305 ms) ====== [2024-09-26T22:28:20.872Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-26T22:28:21.188Z] GC before operation: completed in 225.559 ms, heap usage 257.747 MB -> 72.539 MB. [2024-09-26T22:28:22.275Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1245.832 ms) ====== [2024-09-26T22:28:22.275Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-26T22:28:22.593Z] GC before operation: completed in 206.995 ms, heap usage 254.195 MB -> 72.717 MB. [2024-09-26T22:28:22.593Z] 24/09/26 22:28:22 WARN BlockManager: Asked to remove block rdd_536_0, which does not exist [2024-09-26T22:28:24.166Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1287.400 ms) ====== [2024-09-26T22:28:24.166Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-26T22:28:24.166Z] GC before operation: completed in 218.734 ms, heap usage 263.816 MB -> 67.220 MB. [2024-09-26T22:28:24.166Z] 24/09/26 22:28:23 WARN BlockManager: Asked to remove block rdd_585_1, which does not exist [2024-09-26T22:28:25.252Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1203.952 ms) ====== [2024-09-26T22:28:25.253Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-26T22:28:25.570Z] GC before operation: completed in 199.921 ms, heap usage 255.002 MB -> 72.996 MB. [2024-09-26T22:28:26.659Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1208.722 ms) ====== [2024-09-26T22:28:26.659Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-26T22:28:26.978Z] GC before operation: completed in 179.082 ms, heap usage 265.215 MB -> 78.591 MB. [2024-09-26T22:28:28.092Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1167.761 ms) ====== [2024-09-26T22:28:28.092Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-26T22:28:28.092Z] GC before operation: completed in 167.349 ms, heap usage 273.088 MB -> 73.324 MB. [2024-09-26T22:28:29.672Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1189.211 ms) ====== [2024-09-26T22:28:29.672Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-26T22:28:29.672Z] GC before operation: completed in 217.280 ms, heap usage 270.276 MB -> 57.131 MB. [2024-09-26T22:28:30.789Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1180.327 ms) ====== [2024-09-26T22:28:30.790Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-26T22:28:31.104Z] GC before operation: completed in 198.965 ms, heap usage 252.647 MB -> 57.196 MB. [2024-09-26T22:28:32.232Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1178.568 ms) ====== [2024-09-26T22:28:32.232Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-26T22:28:32.556Z] GC before operation: completed in 231.283 ms, heap usage 246.541 MB -> 73.816 MB. [2024-09-26T22:28:33.646Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1178.997 ms) ====== [2024-09-26T22:28:33.646Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-26T22:28:33.987Z] GC before operation: completed in 201.504 ms, heap usage 262.974 MB -> 73.917 MB. [2024-09-26T22:28:35.079Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1196.344 ms) ====== [2024-09-26T22:28:35.079Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-26T22:28:35.079Z] GC before operation: completed in 187.877 ms, heap usage 265.236 MB -> 79.679 MB. [2024-09-26T22:28:36.652Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1184.654 ms) ====== [2024-09-26T22:28:36.652Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-26T22:28:36.652Z] GC before operation: completed in 157.945 ms, heap usage 277.519 MB -> 74.222 MB. [2024-09-26T22:28:36.652Z] 24/09/26 22:28:36 WARN BlockManager: Asked to remove block rdd_1026_2, which does not exist [2024-09-26T22:28:37.748Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1173.725 ms) ====== [2024-09-26T22:28:37.748Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-26T22:28:37.748Z] GC before operation: completed in 178.957 ms, heap usage 269.594 MB -> 74.550 MB. [2024-09-26T22:28:39.329Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1194.872 ms) ====== [2024-09-26T22:28:39.329Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-26T22:28:39.329Z] GC before operation: completed in 166.151 ms, heap usage 265.861 MB -> 80.134 MB. [2024-09-26T22:28:39.329Z] 24/09/26 22:28:39 WARN BlockManager: Asked to remove block rdd_1124_0, which does not exist [2024-09-26T22:28:40.475Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1263.075 ms) ====== [2024-09-26T22:28:40.475Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-26T22:28:40.829Z] GC before operation: completed in 183.587 ms, heap usage 275.133 MB -> 74.612 MB. [2024-09-26T22:28:41.918Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1206.440 ms) ====== [2024-09-26T22:28:41.918Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-26T22:28:41.918Z] GC before operation: completed in 159.001 ms, heap usage 268.322 MB -> 74.757 MB. [2024-09-26T22:28:43.507Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1140.281 ms) ====== [2024-09-26T22:28:43.507Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-26T22:28:43.507Z] GC before operation: completed in 176.796 ms, heap usage 265.284 MB -> 80.301 MB. [2024-09-26T22:28:44.594Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1212.156 ms) ====== [2024-09-26T22:28:44.594Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-26T22:28:44.945Z] GC before operation: completed in 183.563 ms, heap usage 272.390 MB -> 58.491 MB. [2024-09-26T22:28:46.048Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1274.542 ms) ====== [2024-09-26T22:28:46.048Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-26T22:28:46.361Z] GC before operation: completed in 169.910 ms, heap usage 259.130 MB -> 75.139 MB. [2024-09-26T22:28:47.452Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1148.446 ms) ====== [2024-09-26T22:28:47.452Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-26T22:28:47.452Z] GC before operation: completed in 195.389 ms, heap usage 264.609 MB -> 80.928 MB. [2024-09-26T22:28:48.563Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1127.925 ms) ====== [2024-09-26T22:28:48.563Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-26T22:28:48.883Z] GC before operation: completed in 198.598 ms, heap usage 278.140 MB -> 80.846 MB. [2024-09-26T22:28:49.971Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1117.068 ms) ====== [2024-09-26T22:28:49.971Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-26T22:28:50.287Z] GC before operation: completed in 176.555 ms, heap usage 277.755 MB -> 80.979 MB. [2024-09-26T22:28:51.371Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1166.610 ms) ====== [2024-09-26T22:28:51.371Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-26T22:28:51.688Z] GC before operation: completed in 180.004 ms, heap usage 283.646 MB -> 75.865 MB. [2024-09-26T22:28:52.776Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1170.603 ms) ====== [2024-09-26T22:28:52.776Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-26T22:28:52.776Z] GC before operation: completed in 158.744 ms, heap usage 276.381 MB -> 75.775 MB. [2024-09-26T22:28:52.776Z] 24/09/26 22:28:52 WARN BlockManager: Asked to remove block broadcast_456_piece0, which does not exist [2024-09-26T22:28:53.877Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1120.189 ms) ====== [2024-09-26T22:28:53.877Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-26T22:28:54.195Z] GC before operation: completed in 208.362 ms, heap usage 279.949 MB -> 75.909 MB. [2024-09-26T22:28:55.281Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1166.432 ms) ====== [2024-09-26T22:28:55.281Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-26T22:28:55.597Z] GC before operation: completed in 173.089 ms, heap usage 259.954 MB -> 76.091 MB. [2024-09-26T22:28:56.778Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1167.020 ms) ====== [2024-09-26T22:28:56.778Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-26T22:28:56.778Z] GC before operation: completed in 188.846 ms, heap usage 263.737 MB -> 76.220 MB. [2024-09-26T22:28:57.886Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1126.919 ms) ====== [2024-09-26T22:28:57.886Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-26T22:28:58.204Z] GC before operation: completed in 198.361 ms, heap usage 263.940 MB -> 76.326 MB. [2024-09-26T22:28:59.294Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1150.108 ms) ====== [2024-09-26T22:28:59.294Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-26T22:28:59.622Z] GC before operation: completed in 168.538 ms, heap usage 264.130 MB -> 76.456 MB. [2024-09-26T22:29:00.711Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1163.252 ms) ====== [2024-09-26T22:29:00.711Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-26T22:29:01.030Z] GC before operation: completed in 196.965 ms, heap usage 263.735 MB -> 82.233 MB. [2024-09-26T22:29:01.030Z] 24/09/26 22:29:00 WARN BlockManager: Asked to remove block broadcast_540, which does not exist [2024-09-26T22:29:02.185Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1275.053 ms) ====== [2024-09-26T22:29:02.502Z] ----------------------------------- [2024-09-26T22:29:02.502Z] renaissance-dec-tree_0_PASSED [2024-09-26T22:29:02.502Z] ----------------------------------- [2024-09-26T22:29:02.805Z] [2024-09-26T22:29:02.805Z] TEST TEARDOWN: [2024-09-26T22:29:02.805Z] Nothing to be done for teardown. [2024-09-26T22:29:02.805Z] renaissance-dec-tree_0 Finish Time: Thu Sep 26 22:29:02 2024 Epoch Time (ms): 1727389742609