[2023-04-19T09:12:24.930Z] Running test renaissance-dec-tree_0 ... [2023-04-19T09:12:24.930Z] =============================================== [2023-04-19T09:12:24.930Z] renaissance-dec-tree_0 Start Time: Wed Apr 19 09:12:24 2023 Epoch Time (ms): 1681895544907 [2023-04-19T09:12:24.930Z] variation: NoOptions [2023-04-19T09:12:24.930Z] JVM_OPTIONS: [2023-04-19T09:12:24.930Z] { \ [2023-04-19T09:12:24.930Z] echo ""; echo "TEST SETUP:"; \ [2023-04-19T09:12:24.930Z] echo "Nothing to be done for setup."; \ [2023-04-19T09:12:24.930Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_16818952196808/renaissance-dec-tree_0"; \ [2023-04-19T09:12:24.930Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_16818952196808/renaissance-dec-tree_0"; \ [2023-04-19T09:12:24.930Z] echo ""; echo "TESTING:"; \ [2023-04-19T09:12:24.930Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/openjdkbinary/j2sdk-image/jdk8u372-b07/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_16818952196808/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2023-04-19T09:12:24.930Z] 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_16818952196808/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-19T09:12:24.930Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-19T09:12:24.930Z] echo "Nothing to be done for teardown."; \ [2023-04-19T09:12:24.930Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_16818952196808/TestTargetResult"; [2023-04-19T09:12:24.930Z] [2023-04-19T09:12:24.930Z] TEST SETUP: [2023-04-19T09:12:24.930Z] Nothing to be done for setup. [2023-04-19T09:12:24.930Z] [2023-04-19T09:12:24.930Z] TESTING: [2023-04-19T09:12:27.372Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2023-04-19T09:12:28.134Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2023-04-19T09:12:30.442Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2023-04-19T09:12:30.442Z] GC before operation: completed in 81.000 ms, heap usage 137.769 MB -> 29.878 MB. [2023-04-19T09:12:35.283Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (4721.724 ms) ====== [2023-04-19T09:12:35.283Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2023-04-19T09:12:35.283Z] GC before operation: completed in 155.148 ms, heap usage 186.239 MB -> 54.943 MB. [2023-04-19T09:12:36.013Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1148.057 ms) ====== [2023-04-19T09:12:36.013Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2023-04-19T09:12:36.354Z] GC before operation: completed in 177.694 ms, heap usage 350.809 MB -> 55.472 MB. [2023-04-19T09:12:37.536Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (988.608 ms) ====== [2023-04-19T09:12:37.536Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2023-04-19T09:12:37.536Z] GC before operation: completed in 108.472 ms, heap usage 289.820 MB -> 55.628 MB. [2023-04-19T09:12:38.272Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (834.515 ms) ====== [2023-04-19T09:12:38.272Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2023-04-19T09:12:38.272Z] GC before operation: completed in 99.368 ms, heap usage 268.692 MB -> 56.039 MB. [2023-04-19T09:12:39.002Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (797.758 ms) ====== [2023-04-19T09:12:39.002Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2023-04-19T09:12:39.342Z] GC before operation: completed in 83.784 ms, heap usage 251.840 MB -> 78.158 MB. [2023-04-19T09:12:40.075Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (801.606 ms) ====== [2023-04-19T09:12:40.075Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2023-04-19T09:12:40.075Z] GC before operation: completed in 101.597 ms, heap usage 328.880 MB -> 56.859 MB. [2023-04-19T09:12:40.807Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (818.213 ms) ====== [2023-04-19T09:12:40.807Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2023-04-19T09:12:41.147Z] GC before operation: completed in 132.093 ms, heap usage 309.482 MB -> 56.872 MB. [2023-04-19T09:12:41.878Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (791.356 ms) ====== [2023-04-19T09:12:41.878Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2023-04-19T09:12:41.878Z] GC before operation: completed in 145.736 ms, heap usage 278.178 MB -> 79.029 MB. [2023-04-19T09:12:43.070Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (919.483 ms) ====== [2023-04-19T09:12:43.070Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2023-04-19T09:12:43.070Z] GC before operation: completed in 114.627 ms, heap usage 287.908 MB -> 68.331 MB. [2023-04-19T09:12:43.804Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (846.232 ms) ====== [2023-04-19T09:12:43.804Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2023-04-19T09:12:44.144Z] GC before operation: completed in 115.938 ms, heap usage 288.054 MB -> 73.680 MB. [2023-04-19T09:12:44.878Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (925.166 ms) ====== [2023-04-19T09:12:44.878Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2023-04-19T09:12:45.220Z] GC before operation: completed in 143.528 ms, heap usage 280.086 MB -> 84.968 MB. [2023-04-19T09:12:45.953Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (985.588 ms) ====== [2023-04-19T09:12:45.953Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2023-04-19T09:12:46.296Z] GC before operation: completed in 130.074 ms, heap usage 313.108 MB -> 57.496 MB. [2023-04-19T09:12:47.028Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (926.683 ms) ====== [2023-04-19T09:12:47.028Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2023-04-19T09:12:47.367Z] GC before operation: completed in 130.547 ms, heap usage 281.582 MB -> 85.271 MB. [2023-04-19T09:12:48.100Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (971.505 ms) ====== [2023-04-19T09:12:48.100Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2023-04-19T09:12:48.444Z] GC before operation: completed in 132.014 ms, heap usage 310.254 MB -> 57.950 MB. [2023-04-19T09:12:49.627Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (973.494 ms) ====== [2023-04-19T09:12:49.627Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2023-04-19T09:12:49.627Z] GC before operation: completed in 116.308 ms, heap usage 285.148 MB -> 58.092 MB. [2023-04-19T09:12:50.366Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (972.522 ms) ====== [2023-04-19T09:12:50.366Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2023-04-19T09:12:50.708Z] GC before operation: completed in 144.252 ms, heap usage 278.946 MB -> 58.280 MB. [2023-04-19T09:12:51.444Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (962.073 ms) ====== [2023-04-19T09:12:51.444Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2023-04-19T09:12:51.785Z] GC before operation: completed in 148.675 ms, heap usage 269.236 MB -> 58.439 MB. [2023-04-19T09:12:52.522Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (983.232 ms) ====== [2023-04-19T09:12:52.522Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2023-04-19T09:12:52.867Z] GC before operation: completed in 153.237 ms, heap usage 263.111 MB -> 58.514 MB. [2023-04-19T09:12:53.723Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (935.375 ms) ====== [2023-04-19T09:12:53.723Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2023-04-19T09:12:53.723Z] GC before operation: completed in 114.206 ms, heap usage 263.316 MB -> 74.994 MB. [2023-04-19T09:12:54.906Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (965.726 ms) ====== [2023-04-19T09:12:54.906Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2023-04-19T09:12:54.906Z] GC before operation: completed in 137.575 ms, heap usage 279.621 MB -> 58.826 MB. [2023-04-19T09:12:56.090Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1033.862 ms) ====== [2023-04-19T09:12:56.090Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2023-04-19T09:12:56.090Z] GC before operation: completed in 164.872 ms, heap usage 263.136 MB -> 58.962 MB. [2023-04-19T09:12:57.277Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (994.592 ms) ====== [2023-04-19T09:12:57.277Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2023-04-19T09:12:57.277Z] GC before operation: completed in 164.030 ms, heap usage 269.346 MB -> 59.110 MB. [2023-04-19T09:12:58.465Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1016.503 ms) ====== [2023-04-19T09:12:58.465Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2023-04-19T09:12:58.465Z] GC before operation: completed in 137.196 ms, heap usage 264.150 MB -> 70.396 MB. [2023-04-19T09:12:59.661Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1066.204 ms) ====== [2023-04-19T09:12:59.661Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2023-04-19T09:12:59.661Z] GC before operation: completed in 159.269 ms, heap usage 270.389 MB -> 59.285 MB. [2023-04-19T09:13:01.370Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1293.427 ms) ====== [2023-04-19T09:13:01.370Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2023-04-19T09:13:01.370Z] GC before operation: completed in 130.107 ms, heap usage 269.630 MB -> 59.805 MB. [2023-04-19T09:13:02.102Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (872.450 ms) ====== [2023-04-19T09:13:02.102Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2023-04-19T09:13:02.102Z] GC before operation: completed in 129.927 ms, heap usage 255.346 MB -> 59.526 MB. [2023-04-19T09:13:03.292Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (943.635 ms) ====== [2023-04-19T09:13:03.292Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2023-04-19T09:13:03.292Z] GC before operation: completed in 141.703 ms, heap usage 259.279 MB -> 87.291 MB. [2023-04-19T09:13:04.477Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (998.642 ms) ====== [2023-04-19T09:13:04.477Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2023-04-19T09:13:04.477Z] GC before operation: completed in 120.776 ms, heap usage 307.571 MB -> 59.820 MB. [2023-04-19T09:13:05.217Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (965.800 ms) ====== [2023-04-19T09:13:05.217Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2023-04-19T09:13:05.559Z] GC before operation: completed in 113.033 ms, heap usage 275.379 MB -> 81.962 MB. [2023-04-19T09:13:06.297Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (964.179 ms) ====== [2023-04-19T09:13:06.298Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2023-04-19T09:13:06.640Z] GC before operation: completed in 126.211 ms, heap usage 302.440 MB -> 60.085 MB. [2023-04-19T09:13:07.376Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (924.906 ms) ====== [2023-04-19T09:13:07.376Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2023-04-19T09:13:07.718Z] GC before operation: completed in 127.338 ms, heap usage 274.114 MB -> 60.368 MB. [2023-04-19T09:13:08.455Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (770.542 ms) ====== [2023-04-19T09:13:08.455Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2023-04-19T09:13:08.455Z] GC before operation: completed in 125.637 ms, heap usage 270.592 MB -> 60.354 MB. [2023-04-19T09:13:09.647Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (960.707 ms) ====== [2023-04-19T09:13:09.647Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2023-04-19T09:13:09.647Z] GC before operation: completed in 110.513 ms, heap usage 261.683 MB -> 76.938 MB. [2023-04-19T09:13:10.384Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (945.840 ms) ====== [2023-04-19T09:13:10.384Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2023-04-19T09:13:10.727Z] GC before operation: completed in 176.255 ms, heap usage 285.886 MB -> 61.471 MB. [2023-04-19T09:13:11.913Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (970.132 ms) ====== [2023-04-19T09:13:11.913Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2023-04-19T09:13:11.913Z] GC before operation: completed in 134.374 ms, heap usage 264.635 MB -> 60.729 MB. [2023-04-19T09:13:12.650Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (939.240 ms) ====== [2023-04-19T09:13:12.650Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2023-04-19T09:13:12.993Z] GC before operation: completed in 138.618 ms, heap usage 265.727 MB -> 88.464 MB. [2023-04-19T09:13:13.730Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (954.235 ms) ====== [2023-04-19T09:13:13.730Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2023-04-19T09:13:14.075Z] GC before operation: completed in 157.445 ms, heap usage 299.449 MB -> 77.492 MB. [2023-04-19T09:13:14.075Z] 23/04/19 09:13:13 WARN BlockManager: Asked to remove block broadcast_512_piece0, which does not exist [2023-04-19T09:13:15.264Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1054.004 ms) ====== [2023-04-19T09:13:15.264Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2023-04-19T09:13:15.264Z] GC before operation: completed in 172.613 ms, heap usage 293.962 MB -> 77.849 MB. [2023-04-19T09:13:15.264Z] 23/04/19 09:13:15 WARN BlockManager: Asked to remove block rdd_1859_2, which does not exist [2023-04-19T09:13:16.450Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1016.616 ms) ====== [2023-04-19T09:13:16.450Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2023-04-19T09:13:16.450Z] GC before operation: completed in 161.385 ms, heap usage 293.660 MB -> 61.261 MB. [2023-04-19T09:13:17.639Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1025.533 ms) ====== [2023-04-19T09:13:17.639Z] ----------------------------------- [2023-04-19T09:13:17.639Z] renaissance-dec-tree_0_PASSED [2023-04-19T09:13:17.639Z] ----------------------------------- [2023-04-19T09:13:17.639Z] [2023-04-19T09:13:17.639Z] TEST TEARDOWN: [2023-04-19T09:13:17.639Z] Nothing to be done for teardown. [2023-04-19T09:13:17.639Z] renaissance-dec-tree_0 Finish Time: Wed Apr 19 09:13:17 2023 Epoch Time (ms): 1681895597455