[2024-11-21T13:00:34.540Z] Running test renaissance-dec-tree_0 ... [2024-11-21T13:00:34.541Z] =============================================== [2024-11-21T13:00:34.541Z] renaissance-dec-tree_0 Start Time: Thu Nov 21 13:00:33 2024 Epoch Time (ms): 1732194033916 [2024-11-21T13:00:34.541Z] variation: NoOptions [2024-11-21T13:00:34.541Z] JVM_OPTIONS: [2024-11-21T13:00:34.541Z] { \ [2024-11-21T13:00:34.541Z] echo ""; echo "TEST SETUP:"; \ [2024-11-21T13:00:34.541Z] echo "Nothing to be done for setup."; \ [2024-11-21T13:00:34.541Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1732191032186/renaissance-dec-tree_0"; \ [2024-11-21T13:00:34.541Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1732191032186/renaissance-dec-tree_0"; \ [2024-11-21T13:00:34.541Z] echo ""; echo "TESTING:"; \ [2024-11-21T13:00:34.541Z] "/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_1732191032186/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-21T13:00:34.541Z] 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_1732191032186/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-21T13:00:34.541Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-21T13:00:34.541Z] echo "Nothing to be done for teardown."; \ [2024-11-21T13:00:34.541Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1732191032186/TestTargetResult"; [2024-11-21T13:00:34.541Z] [2024-11-21T13:00:34.541Z] TEST SETUP: [2024-11-21T13:00:34.541Z] Nothing to be done for setup. [2024-11-21T13:00:34.541Z] [2024-11-21T13:00:34.541Z] TESTING: [2024-11-21T13:00:57.032Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-21T13:01:17.448Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-21T13:01:59.564Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-21T13:01:59.564Z] GC before operation: completed in 505.106 ms, heap usage 89.771 MB -> 35.121 MB. [2024-11-21T13:03:19.674Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (81397.471 ms) ====== [2024-11-21T13:03:19.674Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-21T13:03:19.674Z] GC before operation: completed in 594.398 ms, heap usage 219.821 MB -> 64.605 MB. [2024-11-21T13:03:42.522Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (21838.277 ms) ====== [2024-11-21T13:03:42.522Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-21T13:03:42.522Z] GC before operation: completed in 570.867 ms, heap usage 136.865 MB -> 64.692 MB. [2024-11-21T13:03:59.984Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (19331.684 ms) ====== [2024-11-21T13:03:59.984Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-21T13:04:00.814Z] GC before operation: completed in 882.426 ms, heap usage 351.290 MB -> 92.883 MB. [2024-11-21T13:04:00.814Z] 24/11/21 13:04:00 WARN BlockManager: Asked to remove block rdd_144_1, which does not exist [2024-11-21T13:04:00.814Z] 24/11/21 13:04:00 WARN BlockManager: Asked to remove block rdd_144_2, which does not exist [2024-11-21T13:04:00.814Z] 24/11/21 13:04:00 WARN BlockManager: Asked to remove block rdd_144_0, which does not exist [2024-11-21T13:04:20.645Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (19419.378 ms) ====== [2024-11-21T13:04:20.645Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-21T13:04:20.645Z] GC before operation: completed in 658.850 ms, heap usage 169.577 MB -> 65.591 MB. [2024-11-21T13:04:37.460Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (16206.556 ms) ====== [2024-11-21T13:04:37.460Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-21T13:04:37.460Z] GC before operation: completed in 992.090 ms, heap usage 185.128 MB -> 65.712 MB. [2024-11-21T13:04:51.960Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (14492.585 ms) ====== [2024-11-21T13:04:51.960Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-21T13:04:52.798Z] GC before operation: completed in 863.634 ms, heap usage 243.168 MB -> 65.929 MB. [2024-11-21T13:05:09.781Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (15061.970 ms) ====== [2024-11-21T13:05:09.781Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-21T13:05:09.781Z] GC before operation: completed in 766.759 ms, heap usage 337.192 MB -> 66.115 MB. [2024-11-21T13:05:24.196Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (14498.397 ms) ====== [2024-11-21T13:05:24.196Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-21T13:05:24.196Z] GC before operation: completed in 650.334 ms, heap usage 105.152 MB -> 65.798 MB. [2024-11-21T13:05:38.407Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (13050.281 ms) ====== [2024-11-21T13:05:38.407Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-21T13:05:38.407Z] GC before operation: completed in 662.234 ms, heap usage 188.798 MB -> 66.311 MB. [2024-11-21T13:05:52.448Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (13429.458 ms) ====== [2024-11-21T13:05:52.448Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-21T13:05:52.448Z] GC before operation: completed in 619.293 ms, heap usage 338.330 MB -> 66.611 MB. [2024-11-21T13:06:02.631Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (10889.570 ms) ====== [2024-11-21T13:06:02.631Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-21T13:06:03.420Z] GC before operation: completed in 631.989 ms, heap usage 303.278 MB -> 66.605 MB. [2024-11-21T13:06:17.436Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (12410.553 ms) ====== [2024-11-21T13:06:17.436Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-21T13:06:17.436Z] GC before operation: completed in 706.649 ms, heap usage 212.023 MB -> 66.722 MB. [2024-11-21T13:06:29.555Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (12766.183 ms) ====== [2024-11-21T13:06:29.555Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-21T13:06:30.376Z] GC before operation: completed in 776.479 ms, heap usage 336.354 MB -> 66.842 MB. [2024-11-21T13:06:42.363Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (11189.538 ms) ====== [2024-11-21T13:06:42.363Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-21T13:06:42.363Z] GC before operation: completed in 468.222 ms, heap usage 209.623 MB -> 67.001 MB. [2024-11-21T13:06:50.942Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (9073.207 ms) ====== [2024-11-21T13:06:50.942Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-21T13:06:51.726Z] GC before operation: completed in 704.860 ms, heap usage 319.298 MB -> 67.077 MB. [2024-11-21T13:07:00.139Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (8692.937 ms) ====== [2024-11-21T13:07:00.139Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-21T13:07:00.937Z] GC before operation: completed in 565.476 ms, heap usage 291.036 MB -> 67.352 MB. [2024-11-21T13:07:11.067Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (9113.413 ms) ====== [2024-11-21T13:07:11.067Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-21T13:07:11.067Z] GC before operation: completed in 580.710 ms, heap usage 296.320 MB -> 67.343 MB. [2024-11-21T13:07:19.455Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (9269.634 ms) ====== [2024-11-21T13:07:19.455Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-21T13:07:20.254Z] GC before operation: completed in 736.535 ms, heap usage 293.376 MB -> 67.630 MB. [2024-11-21T13:07:30.332Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (9314.952 ms) ====== [2024-11-21T13:07:30.333Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-21T13:07:30.333Z] GC before operation: completed in 778.886 ms, heap usage 294.982 MB -> 67.583 MB. [2024-11-21T13:07:42.807Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (11043.671 ms) ====== [2024-11-21T13:07:42.807Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-21T13:07:42.807Z] GC before operation: completed in 749.618 ms, heap usage 296.462 MB -> 68.031 MB. [2024-11-21T13:07:51.381Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (9085.037 ms) ====== [2024-11-21T13:07:51.381Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-21T13:07:52.169Z] GC before operation: completed in 656.772 ms, heap usage 268.491 MB -> 67.828 MB. [2024-11-21T13:08:02.197Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (9912.113 ms) ====== [2024-11-21T13:08:02.197Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-21T13:08:03.017Z] GC before operation: completed in 740.646 ms, heap usage 291.041 MB -> 68.018 MB. [2024-11-21T13:08:13.154Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (9339.413 ms) ====== [2024-11-21T13:08:13.154Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-21T13:08:13.154Z] GC before operation: completed in 651.133 ms, heap usage 287.906 MB -> 68.100 MB. [2024-11-21T13:08:20.297Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (7506.944 ms) ====== [2024-11-21T13:08:20.297Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-21T13:08:21.131Z] GC before operation: completed in 561.276 ms, heap usage 299.731 MB -> 84.887 MB. [2024-11-21T13:08:29.941Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (9205.117 ms) ====== [2024-11-21T13:08:29.941Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-21T13:08:30.910Z] GC before operation: completed in 735.945 ms, heap usage 257.917 MB -> 68.443 MB. [2024-11-21T13:08:40.192Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (9459.685 ms) ====== [2024-11-21T13:08:40.192Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-21T13:08:41.006Z] GC before operation: completed in 744.524 ms, heap usage 144.864 MB -> 68.188 MB. [2024-11-21T13:08:51.446Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (10372.583 ms) ====== [2024-11-21T13:08:51.446Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-21T13:08:52.283Z] GC before operation: completed in 756.757 ms, heap usage 131.032 MB -> 68.452 MB. [2024-11-21T13:08:59.600Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (7410.491 ms) ====== [2024-11-21T13:08:59.600Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-21T13:09:00.414Z] GC before operation: completed in 556.409 ms, heap usage 233.594 MB -> 68.689 MB. [2024-11-21T13:09:09.158Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (8851.714 ms) ====== [2024-11-21T13:09:09.158Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-21T13:09:09.974Z] GC before operation: completed in 739.281 ms, heap usage 166.012 MB -> 68.635 MB. [2024-11-21T13:09:18.652Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (8625.732 ms) ====== [2024-11-21T13:09:18.652Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-21T13:09:19.499Z] GC before operation: completed in 694.703 ms, heap usage 191.169 MB -> 68.987 MB. [2024-11-21T13:09:26.709Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (7526.508 ms) ====== [2024-11-21T13:09:26.709Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-21T13:09:27.530Z] GC before operation: completed in 702.000 ms, heap usage 236.316 MB -> 68.849 MB. [2024-11-21T13:09:36.387Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (9253.416 ms) ====== [2024-11-21T13:09:36.387Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-21T13:09:37.234Z] GC before operation: completed in 731.168 ms, heap usage 245.113 MB -> 69.086 MB. [2024-11-21T13:09:45.938Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (8151.067 ms) ====== [2024-11-21T13:09:45.938Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-21T13:09:45.938Z] GC before operation: completed in 748.838 ms, heap usage 265.353 MB -> 69.213 MB. [2024-11-21T13:09:54.733Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (8087.486 ms) ====== [2024-11-21T13:09:54.733Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-21T13:09:54.733Z] GC before operation: completed in 585.630 ms, heap usage 263.193 MB -> 69.330 MB. [2024-11-21T13:10:03.443Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (8452.603 ms) ====== [2024-11-21T13:10:03.443Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-21T13:10:04.411Z] GC before operation: completed in 676.253 ms, heap usage 296.902 MB -> 69.311 MB. [2024-11-21T13:10:13.260Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (8464.651 ms) ====== [2024-11-21T13:10:13.260Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-21T13:10:13.260Z] GC before operation: completed in 689.827 ms, heap usage 269.962 MB -> 69.508 MB. [2024-11-21T13:10:21.935Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (8193.555 ms) ====== [2024-11-21T13:10:21.935Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-21T13:10:21.935Z] GC before operation: completed in 687.619 ms, heap usage 272.160 MB -> 69.554 MB. [2024-11-21T13:10:29.121Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (6948.082 ms) ====== [2024-11-21T13:10:29.121Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-21T13:10:29.952Z] GC before operation: completed in 783.771 ms, heap usage 259.426 MB -> 69.623 MB. [2024-11-21T13:10:40.941Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (10556.851 ms) ====== [2024-11-21T13:10:40.941Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-21T13:10:40.941Z] GC before operation: completed in 816.035 ms, heap usage 247.435 MB -> 69.801 MB. [2024-11-21T13:10:49.723Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (7961.988 ms) ====== [2024-11-21T13:10:51.470Z] ----------------------------------- [2024-11-21T13:10:51.470Z] renaissance-dec-tree_0_PASSED [2024-11-21T13:10:51.470Z] ----------------------------------- [2024-11-21T13:10:51.470Z] [2024-11-21T13:10:51.470Z] TEST TEARDOWN: [2024-11-21T13:10:51.470Z] Nothing to be done for teardown. [2024-11-21T13:10:51.470Z] renaissance-dec-tree_0 Finish Time: Thu Nov 21 13:10:50 2024 Epoch Time (ms): 1732194650558