[2024-10-02T21:19:53.143Z] Running test renaissance-dec-tree_0 ... [2024-10-02T21:19:53.143Z] =============================================== [2024-10-02T21:19:53.143Z] renaissance-dec-tree_0 Start Time: Wed Oct 2 21:19:52 2024 Epoch Time (ms): 1727903992508 [2024-10-02T21:19:53.143Z] variation: NoOptions [2024-10-02T21:19:53.143Z] JVM_OPTIONS: [2024-10-02T21:19:53.143Z] { \ [2024-10-02T21:19:53.143Z] echo ""; echo "TEST SETUP:"; \ [2024-10-02T21:19:53.143Z] echo "Nothing to be done for setup."; \ [2024-10-02T21:19:53.143Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17279026359048/renaissance-dec-tree_0"; \ [2024-10-02T21:19:53.143Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17279026359048/renaissance-dec-tree_0"; \ [2024-10-02T21:19:53.143Z] echo ""; echo "TESTING:"; \ [2024-10-02T21:19:53.143Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/jdkbinary/j2sdk-image/bin/java" --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.util=ALL-UNNAMED --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.base/java.lang.invoke=ALL-UNNAMED -jar "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17279026359048/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-02T21:19:53.143Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17279026359048/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-02T21:19:53.143Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-02T21:19:53.143Z] echo "Nothing to be done for teardown."; \ [2024-10-02T21:19:53.143Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17279026359048/TestTargetResult"; [2024-10-02T21:19:53.143Z] [2024-10-02T21:19:53.143Z] TEST SETUP: [2024-10-02T21:19:53.143Z] Nothing to be done for setup. [2024-10-02T21:19:53.143Z] [2024-10-02T21:19:53.143Z] TESTING: [2024-10-02T21:20:01.338Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-02T21:20:09.518Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-10-02T21:20:20.964Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-02T21:20:20.964Z] GC before operation: completed in 144.604 ms, heap usage 89.710 MB -> 35.116 MB. [2024-10-02T21:20:56.669Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (35602.429 ms) ====== [2024-10-02T21:20:56.669Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-02T21:20:56.670Z] GC before operation: completed in 472.621 ms, heap usage 216.371 MB -> 64.765 MB. [2024-10-02T21:21:08.331Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (10393.268 ms) ====== [2024-10-02T21:21:08.331Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-02T21:21:08.331Z] GC before operation: completed in 268.574 ms, heap usage 137.346 MB -> 64.677 MB. [2024-10-02T21:21:16.739Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (8954.860 ms) ====== [2024-10-02T21:21:16.739Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-02T21:21:16.739Z] GC before operation: completed in 412.743 ms, heap usage 273.769 MB -> 65.240 MB. [2024-10-02T21:21:26.658Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9839.725 ms) ====== [2024-10-02T21:21:26.658Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-02T21:21:27.412Z] GC before operation: completed in 346.783 ms, heap usage 226.462 MB -> 65.622 MB. [2024-10-02T21:21:35.705Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8129.409 ms) ====== [2024-10-02T21:21:35.705Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-02T21:21:35.705Z] GC before operation: completed in 273.367 ms, heap usage 109.607 MB -> 65.533 MB. [2024-10-02T21:21:44.455Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (8612.833 ms) ====== [2024-10-02T21:21:44.455Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-02T21:21:44.455Z] GC before operation: completed in 366.076 ms, heap usage 250.852 MB -> 66.078 MB. [2024-10-02T21:21:51.289Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6491.097 ms) ====== [2024-10-02T21:21:51.289Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-02T21:21:51.289Z] GC before operation: completed in 303.212 ms, heap usage 223.846 MB -> 66.304 MB. [2024-10-02T21:21:56.933Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (5318.191 ms) ====== [2024-10-02T21:21:56.933Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-02T21:21:56.933Z] GC before operation: completed in 379.427 ms, heap usage 335.095 MB -> 66.659 MB. [2024-10-02T21:22:02.446Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (5421.697 ms) ====== [2024-10-02T21:22:02.446Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-02T21:22:02.446Z] GC before operation: completed in 306.968 ms, heap usage 185.256 MB -> 88.287 MB. [2024-10-02T21:22:09.237Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6334.550 ms) ====== [2024-10-02T21:22:09.237Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-02T21:22:09.237Z] GC before operation: completed in 334.560 ms, heap usage 435.672 MB -> 66.688 MB. [2024-10-02T21:22:14.689Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4731.486 ms) ====== [2024-10-02T21:22:14.689Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-02T21:22:14.689Z] GC before operation: completed in 329.798 ms, heap usage 216.764 MB -> 67.366 MB. [2024-10-02T21:22:23.010Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (8016.436 ms) ====== [2024-10-02T21:22:23.010Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-02T21:22:23.010Z] GC before operation: completed in 514.793 ms, heap usage 326.693 MB -> 66.891 MB. [2024-10-02T21:22:29.701Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (6244.969 ms) ====== [2024-10-02T21:22:29.701Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-02T21:22:29.701Z] GC before operation: completed in 417.306 ms, heap usage 311.693 MB -> 67.039 MB. [2024-10-02T21:22:35.687Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (5529.543 ms) ====== [2024-10-02T21:22:35.687Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-02T21:22:35.687Z] GC before operation: completed in 279.573 ms, heap usage 297.549 MB -> 67.611 MB. [2024-10-02T21:22:41.308Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5747.755 ms) ====== [2024-10-02T21:22:41.308Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-02T21:22:41.308Z] GC before operation: completed in 421.266 ms, heap usage 317.422 MB -> 67.247 MB. [2024-10-02T21:22:46.806Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (5219.000 ms) ====== [2024-10-02T21:22:46.806Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-02T21:22:46.806Z] GC before operation: completed in 372.036 ms, heap usage 129.851 MB -> 67.147 MB. [2024-10-02T21:22:52.329Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (5057.450 ms) ====== [2024-10-02T21:22:52.329Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-02T21:22:52.329Z] GC before operation: completed in 316.180 ms, heap usage 210.466 MB -> 67.544 MB. [2024-10-02T21:22:58.076Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (5213.258 ms) ====== [2024-10-02T21:22:58.076Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-02T21:22:58.076Z] GC before operation: completed in 580.655 ms, heap usage 305.791 MB -> 67.649 MB. [2024-10-02T21:23:04.809Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5915.506 ms) ====== [2024-10-02T21:23:04.809Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-02T21:23:04.809Z] GC before operation: completed in 461.472 ms, heap usage 167.720 MB -> 67.316 MB. [2024-10-02T21:23:11.612Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (6165.675 ms) ====== [2024-10-02T21:23:11.612Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-02T21:23:11.612Z] GC before operation: completed in 449.338 ms, heap usage 173.172 MB -> 67.549 MB. [2024-10-02T21:23:17.176Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (5257.978 ms) ====== [2024-10-02T21:23:17.176Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-02T21:23:17.176Z] GC before operation: completed in 211.704 ms, heap usage 356.710 MB -> 84.073 MB. [2024-10-02T21:23:21.563Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (4917.226 ms) ====== [2024-10-02T21:23:21.564Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-02T21:23:22.330Z] GC before operation: completed in 317.570 ms, heap usage 277.399 MB -> 68.039 MB. [2024-10-02T21:23:27.224Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (4829.629 ms) ====== [2024-10-02T21:23:27.224Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-02T21:23:27.224Z] GC before operation: completed in 384.916 ms, heap usage 303.145 MB -> 68.028 MB. [2024-10-02T21:23:32.777Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (5711.475 ms) ====== [2024-10-02T21:23:32.777Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-02T21:23:33.548Z] GC before operation: completed in 462.355 ms, heap usage 262.691 MB -> 68.039 MB. [2024-10-02T21:23:39.104Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (5573.705 ms) ====== [2024-10-02T21:23:39.104Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-02T21:23:39.104Z] GC before operation: completed in 425.881 ms, heap usage 126.587 MB -> 67.971 MB. [2024-10-02T21:23:44.676Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (5395.178 ms) ====== [2024-10-02T21:23:44.676Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-02T21:23:45.432Z] GC before operation: completed in 385.931 ms, heap usage 458.062 MB -> 68.648 MB. [2024-10-02T21:23:49.840Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4726.306 ms) ====== [2024-10-02T21:23:49.840Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-02T21:23:50.586Z] GC before operation: completed in 346.730 ms, heap usage 262.212 MB -> 96.070 MB. [2024-10-02T21:23:50.586Z] 24/10/02 21:23:49 WARN BlockManager: Asked to remove block broadcast_376, which does not exist [2024-10-02T21:23:55.018Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4178.341 ms) ====== [2024-10-02T21:23:55.018Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-02T21:23:55.018Z] GC before operation: completed in 411.681 ms, heap usage 328.510 MB -> 68.710 MB. [2024-10-02T21:23:59.476Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (4222.492 ms) ====== [2024-10-02T21:23:59.476Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-02T21:23:59.476Z] GC before operation: completed in 307.457 ms, heap usage 273.180 MB -> 68.829 MB. [2024-10-02T21:24:03.902Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (4444.605 ms) ====== [2024-10-02T21:24:03.902Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-02T21:24:04.682Z] GC before operation: completed in 460.970 ms, heap usage 276.113 MB -> 68.886 MB. [2024-10-02T21:24:09.083Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4702.777 ms) ====== [2024-10-02T21:24:09.083Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-02T21:24:09.854Z] GC before operation: completed in 432.495 ms, heap usage 186.950 MB -> 69.011 MB. [2024-10-02T21:24:14.298Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (5113.556 ms) ====== [2024-10-02T21:24:14.298Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-02T21:24:15.077Z] GC before operation: completed in 373.475 ms, heap usage 170.683 MB -> 68.806 MB. [2024-10-02T21:24:19.982Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (5126.462 ms) ====== [2024-10-02T21:24:19.982Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-02T21:24:20.748Z] GC before operation: completed in 390.441 ms, heap usage 231.974 MB -> 80.423 MB. [2024-10-02T21:24:24.117Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (3882.988 ms) ====== [2024-10-02T21:24:24.117Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-02T21:24:24.877Z] GC before operation: completed in 326.806 ms, heap usage 144.097 MB -> 68.906 MB. [2024-10-02T21:24:29.318Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (4909.795 ms) ====== [2024-10-02T21:24:29.318Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-02T21:24:30.086Z] GC before operation: completed in 378.628 ms, heap usage 246.821 MB -> 69.524 MB. [2024-10-02T21:24:35.644Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4987.036 ms) ====== [2024-10-02T21:24:35.644Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-02T21:24:35.644Z] GC before operation: completed in 468.156 ms, heap usage 363.766 MB -> 69.335 MB. [2024-10-02T21:24:41.238Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (5343.167 ms) ====== [2024-10-02T21:24:41.238Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-02T21:24:41.238Z] GC before operation: completed in 455.741 ms, heap usage 240.915 MB -> 69.671 MB. [2024-10-02T21:24:45.645Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4604.780 ms) ====== [2024-10-02T21:24:45.645Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-02T21:24:46.398Z] GC before operation: completed in 413.475 ms, heap usage 267.043 MB -> 69.635 MB. [2024-10-02T21:24:51.916Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (5796.499 ms) ====== [2024-10-02T21:24:51.916Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-02T21:24:52.676Z] GC before operation: completed in 608.656 ms, heap usage 279.561 MB -> 69.767 MB. [2024-10-02T21:24:58.218Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5054.454 ms) ====== [2024-10-02T21:24:58.981Z] ----------------------------------- [2024-10-02T21:24:58.981Z] renaissance-dec-tree_0_PASSED [2024-10-02T21:24:58.981Z] ----------------------------------- [2024-10-02T21:24:58.981Z] [2024-10-02T21:24:58.981Z] TEST TEARDOWN: [2024-10-02T21:24:58.981Z] Nothing to be done for teardown. [2024-10-02T21:24:58.981Z] renaissance-dec-tree_0 Finish Time: Wed Oct 2 21:24:58 2024 Epoch Time (ms): 1727904298357