[2024-10-29T22:27:47.758Z] Running test renaissance-dec-tree_0 ... [2024-10-29T22:27:47.758Z] =============================================== [2024-10-29T22:27:47.758Z] renaissance-dec-tree_0 Start Time: Tue Oct 29 17:27:47 2024 Epoch Time (ms): 1730240867511 [2024-10-29T22:27:47.758Z] variation: NoOptions [2024-10-29T22:27:47.758Z] JVM_OPTIONS: [2024-10-29T22:27:47.758Z] { \ [2024-10-29T22:27:47.758Z] echo ""; echo "TEST SETUP:"; \ [2024-10-29T22:27:47.758Z] echo "Nothing to be done for setup."; \ [2024-10-29T22:27:47.758Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-dec-tree_0"; \ [2024-10-29T22:27:47.758Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-dec-tree_0"; \ [2024-10-29T22:27:47.758Z] echo ""; echo "TESTING:"; \ [2024-10-29T22:27:47.759Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk8u442-b01/bin/..//bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-29T22:27:47.759Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-29T22:27:47.759Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-29T22:27:47.759Z] echo "Nothing to be done for teardown."; \ [2024-10-29T22:27:47.759Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/TestTargetResult"; [2024-10-29T22:27:47.759Z] [2024-10-29T22:27:47.759Z] TEST SETUP: [2024-10-29T22:27:47.759Z] Nothing to be done for setup. [2024-10-29T22:27:47.759Z] [2024-10-29T22:27:47.759Z] TESTING: [2024-10-29T22:27:50.847Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-29T22:27:53.068Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-10-29T22:27:56.162Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-29T22:27:56.848Z] GC before operation: completed in 165.298 ms, heap usage 154.261 MB -> 32.729 MB. [2024-10-29T22:28:04.499Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7772.910 ms) ====== [2024-10-29T22:28:04.499Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-29T22:28:04.499Z] GC before operation: completed in 321.072 ms, heap usage 364.957 MB -> 56.461 MB. [2024-10-29T22:28:06.733Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1923.696 ms) ====== [2024-10-29T22:28:06.733Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-29T22:28:06.733Z] GC before operation: completed in 333.607 ms, heap usage 399.546 MB -> 56.917 MB. [2024-10-29T22:28:09.409Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1584.427 ms) ====== [2024-10-29T22:28:09.409Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-29T22:28:09.409Z] GC before operation: completed in 237.571 ms, heap usage 306.733 MB -> 78.780 MB. [2024-10-29T22:28:10.095Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1601.532 ms) ====== [2024-10-29T22:28:10.095Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-29T22:28:10.783Z] GC before operation: completed in 251.262 ms, heap usage 325.214 MB -> 57.030 MB. [2024-10-29T22:28:12.211Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1419.975 ms) ====== [2024-10-29T22:28:12.211Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-29T22:28:12.211Z] GC before operation: completed in 177.466 ms, heap usage 286.485 MB -> 68.159 MB. [2024-10-29T22:28:13.635Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1320.075 ms) ====== [2024-10-29T22:28:13.635Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-29T22:28:13.635Z] GC before operation: completed in 209.667 ms, heap usage 296.470 MB -> 74.220 MB. [2024-10-29T22:28:15.060Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1334.550 ms) ====== [2024-10-29T22:28:15.060Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-29T22:28:15.060Z] GC before operation: completed in 199.680 ms, heap usage 291.892 MB -> 68.676 MB. [2024-10-29T22:28:16.487Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1443.392 ms) ====== [2024-10-29T22:28:16.487Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-29T22:28:17.174Z] GC before operation: completed in 266.223 ms, heap usage 293.639 MB -> 68.970 MB. [2024-10-29T22:28:18.601Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1253.877 ms) ====== [2024-10-29T22:28:18.601Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-29T22:28:18.601Z] GC before operation: completed in 229.443 ms, heap usage 281.970 MB -> 69.112 MB. [2024-10-29T22:28:20.029Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1370.110 ms) ====== [2024-10-29T22:28:20.029Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-29T22:28:20.029Z] GC before operation: completed in 287.596 ms, heap usage 284.283 MB -> 74.723 MB. [2024-10-29T22:28:21.451Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1228.591 ms) ====== [2024-10-29T22:28:21.451Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-29T22:28:21.451Z] GC before operation: completed in 225.937 ms, heap usage 289.460 MB -> 86.003 MB. [2024-10-29T22:28:22.874Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1207.262 ms) ====== [2024-10-29T22:28:22.874Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-29T22:28:22.875Z] GC before operation: completed in 248.319 ms, heap usage 325.474 MB -> 86.152 MB. [2024-10-29T22:28:24.329Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1279.140 ms) ====== [2024-10-29T22:28:24.329Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-29T22:28:24.329Z] GC before operation: completed in 236.708 ms, heap usage 323.111 MB -> 86.301 MB. [2024-10-29T22:28:25.765Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1415.749 ms) ====== [2024-10-29T22:28:25.765Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-29T22:28:26.453Z] GC before operation: completed in 245.824 ms, heap usage 341.127 MB -> 80.827 MB. [2024-10-29T22:28:27.140Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1158.914 ms) ====== [2024-10-29T22:28:27.140Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-29T22:28:27.847Z] GC before operation: completed in 244.049 ms, heap usage 326.765 MB -> 86.605 MB. [2024-10-29T22:28:29.276Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1468.991 ms) ====== [2024-10-29T22:28:29.276Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-29T22:28:29.276Z] GC before operation: completed in 263.403 ms, heap usage 344.936 MB -> 59.333 MB. [2024-10-29T22:28:30.699Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1262.388 ms) ====== [2024-10-29T22:28:30.699Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-29T22:28:30.699Z] GC before operation: completed in 257.333 ms, heap usage 316.437 MB -> 59.365 MB. [2024-10-29T22:28:32.123Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1286.880 ms) ====== [2024-10-29T22:28:32.123Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-29T22:28:32.123Z] GC before operation: completed in 236.131 ms, heap usage 304.072 MB -> 59.598 MB. [2024-10-29T22:28:33.577Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1229.972 ms) ====== [2024-10-29T22:28:33.577Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-29T22:28:33.577Z] GC before operation: completed in 207.680 ms, heap usage 288.621 MB -> 70.534 MB. [2024-10-29T22:28:35.003Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1347.135 ms) ====== [2024-10-29T22:28:35.003Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-29T22:28:35.690Z] GC before operation: completed in 194.678 ms, heap usage 285.370 MB -> 76.300 MB. [2024-10-29T22:28:36.389Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1252.086 ms) ====== [2024-10-29T22:28:36.389Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-29T22:28:37.089Z] GC before operation: completed in 229.572 ms, heap usage 291.084 MB -> 76.593 MB. [2024-10-29T22:28:37.818Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1247.787 ms) ====== [2024-10-29T22:28:37.818Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-29T22:28:38.505Z] GC before operation: completed in 230.640 ms, heap usage 300.028 MB -> 87.650 MB. [2024-10-29T22:28:39.930Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1211.649 ms) ====== [2024-10-29T22:28:39.930Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-29T22:28:39.930Z] GC before operation: completed in 225.629 ms, heap usage 313.887 MB -> 71.078 MB. [2024-10-29T22:28:41.353Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1425.013 ms) ====== [2024-10-29T22:28:41.353Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-29T22:28:41.353Z] GC before operation: completed in 207.690 ms, heap usage 300.070 MB -> 87.897 MB. [2024-10-29T22:28:42.775Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1141.670 ms) ====== [2024-10-29T22:28:42.775Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-29T22:28:42.775Z] GC before operation: completed in 231.016 ms, heap usage 316.797 MB -> 60.429 MB. [2024-10-29T22:28:44.205Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1253.471 ms) ====== [2024-10-29T22:28:44.205Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-29T22:28:44.205Z] GC before operation: completed in 205.216 ms, heap usage 294.280 MB -> 77.058 MB. [2024-10-29T22:28:45.659Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1352.655 ms) ====== [2024-10-29T22:28:45.659Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-29T22:28:45.659Z] GC before operation: completed in 270.404 ms, heap usage 304.869 MB -> 88.298 MB. [2024-10-29T22:28:45.659Z] 24/10/29 17:28:45 WARN BlockManager: Asked to remove block broadcast_372_piece0, which does not exist [2024-10-29T22:28:47.081Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1353.818 ms) ====== [2024-10-29T22:28:47.081Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-29T22:28:47.769Z] GC before operation: completed in 257.715 ms, heap usage 330.665 MB -> 71.901 MB. [2024-10-29T22:28:49.196Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1343.354 ms) ====== [2024-10-29T22:28:49.196Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-29T22:28:49.196Z] GC before operation: completed in 261.364 ms, heap usage 308.803 MB -> 72.035 MB. [2024-10-29T22:28:50.618Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1389.555 ms) ====== [2024-10-29T22:28:50.619Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-29T22:28:50.619Z] GC before operation: completed in 227.683 ms, heap usage 296.974 MB -> 88.702 MB. [2024-10-29T22:28:52.042Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1243.860 ms) ====== [2024-10-29T22:28:52.042Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-29T22:28:52.042Z] GC before operation: completed in 233.956 ms, heap usage 303.381 MB -> 72.529 MB. [2024-10-29T22:28:53.490Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1440.824 ms) ====== [2024-10-29T22:28:53.490Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-29T22:28:54.176Z] GC before operation: completed in 245.705 ms, heap usage 301.640 MB -> 61.365 MB. [2024-10-29T22:28:54.862Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1197.828 ms) ====== [2024-10-29T22:28:54.862Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-29T22:28:55.551Z] GC before operation: completed in 172.295 ms, heap usage 280.887 MB -> 61.500 MB. [2024-10-29T22:28:56.243Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1174.440 ms) ====== [2024-10-29T22:28:56.243Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-29T22:28:56.931Z] GC before operation: completed in 209.997 ms, heap usage 274.894 MB -> 89.238 MB. [2024-10-29T22:28:56.931Z] 24/10/29 17:28:56 WARN BlockManager: Asked to remove block rdd_1663_0, which does not exist [2024-10-29T22:28:56.932Z] 24/10/29 17:28:56 WARN BlockManager: Asked to remove block rdd_1663_2, which does not exist [2024-10-29T22:28:58.353Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1367.108 ms) ====== [2024-10-29T22:28:58.353Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-29T22:28:58.353Z] GC before operation: completed in 218.200 ms, heap usage 306.566 MB -> 83.750 MB. [2024-10-29T22:28:59.781Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1278.014 ms) ====== [2024-10-29T22:28:59.781Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-29T22:28:59.781Z] GC before operation: completed in 255.391 ms, heap usage 317.453 MB -> 62.078 MB. [2024-10-29T22:29:01.221Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1134.801 ms) ====== [2024-10-29T22:29:01.221Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-29T22:29:01.221Z] GC before operation: completed in 228.646 ms, heap usage 300.330 MB -> 62.230 MB. [2024-10-29T22:29:02.713Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1338.020 ms) ====== [2024-10-29T22:29:02.713Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-29T22:29:02.713Z] GC before operation: completed in 214.792 ms, heap usage 290.923 MB -> 89.778 MB. [2024-10-29T22:29:02.713Z] 24/10/29 17:29:02 WARN BlockManager: Asked to remove block broadcast_526_piece0, which does not exist [2024-10-29T22:29:04.134Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1212.323 ms) ====== [2024-10-29T22:29:04.135Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-29T22:29:04.135Z] GC before operation: completed in 199.023 ms, heap usage 316.509 MB -> 89.908 MB. [2024-10-29T22:29:05.559Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1168.691 ms) ====== [2024-10-29T22:29:05.559Z] ----------------------------------- [2024-10-29T22:29:05.559Z] renaissance-dec-tree_0_PASSED [2024-10-29T22:29:05.559Z] ----------------------------------- [2024-10-29T22:29:05.559Z] [2024-10-29T22:29:05.559Z] TEST TEARDOWN: [2024-10-29T22:29:05.559Z] Nothing to be done for teardown. [2024-10-29T22:29:05.559Z] renaissance-dec-tree_0 Finish Time: Tue Oct 29 17:29:05 2024 Epoch Time (ms): 1730240945347