[2024-09-06T02:02:03.491Z] Running test renaissance-dec-tree_0 ... [2024-09-06T02:02:03.491Z] =============================================== [2024-09-06T02:02:03.491Z] renaissance-dec-tree_0 Start Time: Fri Sep 6 02:02:02 2024 Epoch Time (ms): 1725588122607 [2024-09-06T02:02:03.491Z] variation: NoOptions [2024-09-06T02:02:03.491Z] JVM_OPTIONS: [2024-09-06T02:02:03.491Z] { \ [2024-09-06T02:02:03.491Z] echo ""; echo "TEST SETUP:"; \ [2024-09-06T02:02:03.491Z] echo "Nothing to be done for setup."; \ [2024-09-06T02:02:03.491Z] mkdir -p "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1725587276451\\renaissance-dec-tree_0"; \ [2024-09-06T02:02:03.491Z] cd "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1725587276451\\renaissance-dec-tree_0"; \ [2024-09-06T02:02:03.491Z] echo ""; echo "TESTING:"; \ [2024-09-06T02:02:03.491Z] "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_1725587276451\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2024-09-06T02:02:03.491Z] 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_1725587276451\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-06T02:02:03.491Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-06T02:02:03.491Z] echo "Nothing to be done for teardown."; \ [2024-09-06T02:02:03.491Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_1725587276451\\TestTargetResult"; [2024-09-06T02:02:03.491Z] [2024-09-06T02:02:03.491Z] TEST SETUP: [2024-09-06T02:02:03.491Z] Nothing to be done for setup. [2024-09-06T02:02:03.491Z] [2024-09-06T02:02:03.491Z] TESTING: [2024-09-06T02:02:14.008Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-06T02:02:15.104Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-06T02:02:18.722Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-06T02:02:18.722Z] GC before operation: completed in 129.167 ms, heap usage 134.930 MB -> 28.391 MB. [2024-09-06T02:02:26.164Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7522.395 ms) ====== [2024-09-06T02:02:26.164Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-06T02:02:26.164Z] GC before operation: completed in 279.840 ms, heap usage 121.037 MB -> 53.775 MB. [2024-09-06T02:02:28.451Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2036.652 ms) ====== [2024-09-06T02:02:28.451Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-06T02:02:28.767Z] GC before operation: completed in 331.711 ms, heap usage 378.267 MB -> 76.782 MB. [2024-09-06T02:02:30.400Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1649.855 ms) ====== [2024-09-06T02:02:30.400Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-06T02:02:30.400Z] GC before operation: completed in 174.925 ms, heap usage 285.068 MB -> 66.661 MB. [2024-09-06T02:02:32.108Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1492.829 ms) ====== [2024-09-06T02:02:32.108Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-06T02:02:32.414Z] GC before operation: completed in 178.413 ms, heap usage 256.534 MB -> 65.961 MB. [2024-09-06T02:02:32.414Z] 24/09/06 02:02:31 WARN BlockManager: Asked to remove block broadcast_50, which does not exist [2024-09-06T02:02:33.500Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1395.306 ms) ====== [2024-09-06T02:02:33.500Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-06T02:02:33.827Z] GC before operation: completed in 183.363 ms, heap usage 232.394 MB -> 65.984 MB. [2024-09-06T02:02:34.982Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1346.777 ms) ====== [2024-09-06T02:02:34.982Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-06T02:02:35.331Z] GC before operation: completed in 220.195 ms, heap usage 241.289 MB -> 56.889 MB. [2024-09-06T02:02:36.908Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1372.506 ms) ====== [2024-09-06T02:02:36.908Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-06T02:02:36.908Z] GC before operation: completed in 164.994 ms, heap usage 219.040 MB -> 66.638 MB. [2024-09-06T02:02:38.013Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1286.824 ms) ====== [2024-09-06T02:02:38.013Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-06T02:02:38.334Z] GC before operation: completed in 215.712 ms, heap usage 237.410 MB -> 72.255 MB. [2024-09-06T02:02:39.935Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1329.215 ms) ====== [2024-09-06T02:02:39.935Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-06T02:02:39.935Z] GC before operation: completed in 172.620 ms, heap usage 229.278 MB -> 66.798 MB. [2024-09-06T02:02:41.053Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1220.310 ms) ====== [2024-09-06T02:02:41.053Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-06T02:02:41.369Z] GC before operation: completed in 198.786 ms, heap usage 233.236 MB -> 72.592 MB. [2024-09-06T02:02:42.511Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1225.961 ms) ====== [2024-09-06T02:02:42.511Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-06T02:02:42.827Z] GC before operation: completed in 198.249 ms, heap usage 228.287 MB -> 72.737 MB. [2024-09-06T02:02:42.827Z] 24/09/06 02:02:42 WARN BlockManager: Asked to remove block rdd_536_0, which does not exist [2024-09-06T02:02:43.915Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1273.653 ms) ====== [2024-09-06T02:02:43.915Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-06T02:02:44.231Z] GC before operation: completed in 183.264 ms, heap usage 233.958 MB -> 67.236 MB. [2024-09-06T02:02:45.317Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1232.554 ms) ====== [2024-09-06T02:02:45.317Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-06T02:02:45.638Z] GC before operation: completed in 205.751 ms, heap usage 228.513 MB -> 72.986 MB. [2024-09-06T02:02:46.733Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1180.374 ms) ====== [2024-09-06T02:02:46.733Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-06T02:02:47.048Z] GC before operation: completed in 191.417 ms, heap usage 235.368 MB -> 78.588 MB. [2024-09-06T02:02:48.147Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1198.100 ms) ====== [2024-09-06T02:02:48.147Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-06T02:02:48.461Z] GC before operation: completed in 174.166 ms, heap usage 244.123 MB -> 73.328 MB. [2024-09-06T02:02:48.461Z] 24/09/06 02:02:48 WARN BlockManager: Asked to remove block rdd_732_2, which does not exist [2024-09-06T02:02:49.546Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1280.277 ms) ====== [2024-09-06T02:02:49.546Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-06T02:02:49.861Z] GC before operation: completed in 208.953 ms, heap usage 240.831 MB -> 57.135 MB. [2024-09-06T02:02:50.960Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1177.842 ms) ====== [2024-09-06T02:02:50.960Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-06T02:02:51.277Z] GC before operation: completed in 186.663 ms, heap usage 219.688 MB -> 57.168 MB. [2024-09-06T02:02:52.367Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1186.798 ms) ====== [2024-09-06T02:02:52.367Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-06T02:02:52.688Z] GC before operation: completed in 172.796 ms, heap usage 222.779 MB -> 73.788 MB. [2024-09-06T02:02:53.782Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1182.979 ms) ====== [2024-09-06T02:02:53.782Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-06T02:02:54.111Z] GC before operation: completed in 197.981 ms, heap usage 237.033 MB -> 73.938 MB. [2024-09-06T02:02:55.199Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1178.446 ms) ====== [2024-09-06T02:02:55.199Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-06T02:02:55.199Z] GC before operation: completed in 216.302 ms, heap usage 239.753 MB -> 74.085 MB. [2024-09-06T02:02:56.787Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1218.503 ms) ====== [2024-09-06T02:02:56.787Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-06T02:02:56.787Z] GC before operation: completed in 167.706 ms, heap usage 239.917 MB -> 68.797 MB. [2024-09-06T02:02:57.929Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1238.790 ms) ====== [2024-09-06T02:02:57.929Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-06T02:02:58.244Z] GC before operation: completed in 174.638 ms, heap usage 231.407 MB -> 74.332 MB. [2024-09-06T02:02:59.336Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1196.579 ms) ====== [2024-09-06T02:02:59.336Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-06T02:02:59.648Z] GC before operation: completed in 165.476 ms, heap usage 231.374 MB -> 80.131 MB. [2024-09-06T02:02:59.648Z] 24/09/06 02:02:59 WARN BlockManager: Asked to remove block rdd_1124_0, which does not exist [2024-09-06T02:03:00.738Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1179.810 ms) ====== [2024-09-06T02:03:00.738Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-06T02:03:00.738Z] GC before operation: completed in 163.417 ms, heap usage 239.939 MB -> 74.601 MB. [2024-09-06T02:03:02.336Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1143.547 ms) ====== [2024-09-06T02:03:02.336Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-06T02:03:02.336Z] GC before operation: completed in 177.970 ms, heap usage 233.061 MB -> 58.235 MB. [2024-09-06T02:03:03.408Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1146.092 ms) ====== [2024-09-06T02:03:03.408Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-06T02:03:03.408Z] GC before operation: completed in 178.255 ms, heap usage 222.016 MB -> 74.870 MB. [2024-09-06T02:03:04.502Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1131.835 ms) ====== [2024-09-06T02:03:04.502Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-06T02:03:04.815Z] GC before operation: completed in 168.432 ms, heap usage 239.933 MB -> 74.987 MB. [2024-09-06T02:03:05.897Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1110.308 ms) ====== [2024-09-06T02:03:05.898Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-06T02:03:06.212Z] GC before operation: completed in 178.659 ms, heap usage 244.993 MB -> 75.126 MB. [2024-09-06T02:03:06.212Z] 24/09/06 02:03:05 WARN BlockManager: Asked to remove block rdd_1369_0, which does not exist [2024-09-06T02:03:07.297Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1123.335 ms) ====== [2024-09-06T02:03:07.297Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-06T02:03:07.297Z] GC before operation: completed in 164.634 ms, heap usage 232.646 MB -> 69.793 MB. [2024-09-06T02:03:08.396Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1146.894 ms) ====== [2024-09-06T02:03:08.396Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-06T02:03:08.709Z] GC before operation: completed in 164.752 ms, heap usage 228.693 MB -> 75.392 MB. [2024-09-06T02:03:09.797Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1190.901 ms) ====== [2024-09-06T02:03:09.797Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-06T02:03:10.113Z] GC before operation: completed in 170.722 ms, heap usage 228.091 MB -> 80.973 MB. [2024-09-06T02:03:11.287Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1193.265 ms) ====== [2024-09-06T02:03:11.287Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-06T02:03:11.287Z] GC before operation: completed in 176.431 ms, heap usage 241.162 MB -> 81.286 MB. [2024-09-06T02:03:11.287Z] 24/09/06 02:03:11 WARN BlockManager: Asked to remove block rdd_1565_1, which does not exist [2024-09-06T02:03:12.667Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1253.239 ms) ====== [2024-09-06T02:03:12.667Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-06T02:03:12.987Z] GC before operation: completed in 199.028 ms, heap usage 253.032 MB -> 75.793 MB. [2024-09-06T02:03:14.081Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1191.474 ms) ====== [2024-09-06T02:03:14.081Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-06T02:03:14.439Z] GC before operation: completed in 179.849 ms, heap usage 248.564 MB -> 75.904 MB. [2024-09-06T02:03:15.529Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1191.610 ms) ====== [2024-09-06T02:03:15.529Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-06T02:03:15.529Z] GC before operation: completed in 203.237 ms, heap usage 245.999 MB -> 81.506 MB. [2024-09-06T02:03:17.113Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1243.717 ms) ====== [2024-09-06T02:03:17.113Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-06T02:03:17.113Z] GC before operation: completed in 191.302 ms, heap usage 237.889 MB -> 76.218 MB. [2024-09-06T02:03:17.113Z] 24/09/06 02:03:16 WARN BlockManager: Asked to remove block broadcast_498, which does not exist [2024-09-06T02:03:18.195Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1147.562 ms) ====== [2024-09-06T02:03:18.195Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-06T02:03:18.537Z] GC before operation: completed in 182.263 ms, heap usage 240.964 MB -> 76.320 MB. [2024-09-06T02:03:19.620Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1146.288 ms) ====== [2024-09-06T02:03:19.620Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-06T02:03:19.620Z] GC before operation: completed in 202.071 ms, heap usage 239.766 MB -> 76.449 MB. [2024-09-06T02:03:20.817Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1168.961 ms) ====== [2024-09-06T02:03:20.817Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-06T02:03:21.133Z] GC before operation: completed in 164.240 ms, heap usage 236.633 MB -> 76.618 MB. [2024-09-06T02:03:22.380Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1233.692 ms) ====== [2024-09-06T02:03:22.685Z] ----------------------------------- [2024-09-06T02:03:22.685Z] renaissance-dec-tree_0_PASSED [2024-09-06T02:03:22.685Z] ----------------------------------- [2024-09-06T02:03:22.685Z] [2024-09-06T02:03:22.685Z] TEST TEARDOWN: [2024-09-06T02:03:22.685Z] Nothing to be done for teardown. [2024-09-06T02:03:22.991Z] renaissance-dec-tree_0 Finish Time: Fri Sep 6 02:03:22 2024 Epoch Time (ms): 1725588202673