[2025-01-11T08:26:31.085Z] Running test renaissance-dec-tree_0 ... [2025-01-11T08:26:31.085Z] =============================================== [2025-01-11T08:26:31.085Z] renaissance-dec-tree_0 Start Time: Sat Jan 11 08:26:30 2025 Epoch Time (ms): 1736583990616 [2025-01-11T08:26:31.085Z] variation: NoOptions [2025-01-11T08:26:31.085Z] JVM_OPTIONS: [2025-01-11T08:26:31.085Z] { \ [2025-01-11T08:26:31.085Z] echo ""; echo "TEST SETUP:"; \ [2025-01-11T08:26:31.085Z] echo "Nothing to be done for setup."; \ [2025-01-11T08:26:31.085Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17365824671824/renaissance-dec-tree_0"; \ [2025-01-11T08:26:31.086Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17365824671824/renaissance-dec-tree_0"; \ [2025-01-11T08:26:31.086Z] echo ""; echo "TESTING:"; \ [2025-01-11T08:26:31.086Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/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_riscv64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17365824671824/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-01-11T08:26:31.086Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17365824671824/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-11T08:26:31.086Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-11T08:26:31.086Z] echo "Nothing to be done for teardown."; \ [2025-01-11T08:26:31.086Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17365824671824/TestTargetResult"; [2025-01-11T08:26:31.086Z] [2025-01-11T08:26:31.086Z] TEST SETUP: [2025-01-11T08:26:31.086Z] Nothing to be done for setup. [2025-01-11T08:26:31.086Z] [2025-01-11T08:26:31.086Z] TESTING: [2025-01-11T08:26:43.576Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-11T08:26:51.140Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-01-11T08:27:08.867Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-01-11T08:27:08.867Z] GC before operation: completed in 257.246 ms, heap usage 53.934 MB -> 36.851 MB. [2025-01-11T08:27:51.048Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (41102.233 ms) ====== [2025-01-11T08:27:51.048Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-01-11T08:27:51.048Z] GC before operation: completed in 478.043 ms, heap usage 286.552 MB -> 68.416 MB. [2025-01-11T08:28:02.431Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (12158.610 ms) ====== [2025-01-11T08:28:02.431Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-01-11T08:28:02.431Z] GC before operation: completed in 515.936 ms, heap usage 286.411 MB -> 68.780 MB. [2025-01-11T08:28:12.436Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (10672.731 ms) ====== [2025-01-11T08:28:12.437Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-01-11T08:28:12.437Z] GC before operation: completed in 503.035 ms, heap usage 314.592 MB -> 69.141 MB. [2025-01-11T08:28:22.366Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (8925.292 ms) ====== [2025-01-11T08:28:22.366Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-01-11T08:28:22.366Z] GC before operation: completed in 535.089 ms, heap usage 125.309 MB -> 68.751 MB. [2025-01-11T08:28:30.605Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8364.032 ms) ====== [2025-01-11T08:28:30.605Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-01-11T08:28:30.605Z] GC before operation: completed in 573.799 ms, heap usage 121.169 MB -> 68.957 MB. [2025-01-11T08:28:40.547Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (8385.308 ms) ====== [2025-01-11T08:28:40.547Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-01-11T08:28:40.547Z] GC before operation: completed in 618.718 ms, heap usage 462.201 MB -> 69.931 MB. [2025-01-11T08:28:47.542Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (7806.288 ms) ====== [2025-01-11T08:28:47.542Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-01-11T08:28:48.396Z] GC before operation: completed in 671.371 ms, heap usage 350.712 MB -> 69.921 MB. [2025-01-11T08:28:56.037Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (7277.447 ms) ====== [2025-01-11T08:28:56.037Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-01-11T08:28:56.721Z] GC before operation: completed in 672.172 ms, heap usage 213.085 MB -> 70.050 MB. [2025-01-11T08:29:04.565Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (7797.015 ms) ====== [2025-01-11T08:29:04.565Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-01-11T08:29:05.361Z] GC before operation: completed in 756.930 ms, heap usage 370.188 MB -> 70.028 MB. [2025-01-11T08:29:14.054Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (8447.395 ms) ====== [2025-01-11T08:29:14.054Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-01-11T08:29:14.054Z] GC before operation: completed in 755.911 ms, heap usage 338.389 MB -> 70.186 MB. [2025-01-11T08:29:22.050Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (7312.128 ms) ====== [2025-01-11T08:29:22.050Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-01-11T08:29:22.050Z] GC before operation: completed in 747.519 ms, heap usage 218.991 MB -> 70.477 MB. [2025-01-11T08:29:29.720Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (6817.399 ms) ====== [2025-01-11T08:29:29.720Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-01-11T08:29:29.720Z] GC before operation: completed in 766.231 ms, heap usage 310.661 MB -> 70.498 MB. [2025-01-11T08:29:36.471Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (6791.937 ms) ====== [2025-01-11T08:29:36.471Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-01-11T08:29:37.327Z] GC before operation: completed in 839.271 ms, heap usage 351.991 MB -> 70.461 MB. [2025-01-11T08:29:44.632Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (6768.460 ms) ====== [2025-01-11T08:29:44.632Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-01-11T08:29:45.245Z] GC before operation: completed in 783.984 ms, heap usage 142.181 MB -> 70.284 MB. [2025-01-11T08:29:52.164Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (6578.246 ms) ====== [2025-01-11T08:29:52.164Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-01-11T08:29:52.164Z] GC before operation: completed in 788.068 ms, heap usage 473.314 MB -> 71.038 MB. [2025-01-11T08:29:59.406Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (6746.592 ms) ====== [2025-01-11T08:29:59.406Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-01-11T08:30:00.179Z] GC before operation: completed in 865.238 ms, heap usage 356.489 MB -> 70.994 MB. [2025-01-11T08:30:07.046Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (6542.992 ms) ====== [2025-01-11T08:30:07.046Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-01-11T08:30:08.024Z] GC before operation: completed in 869.372 ms, heap usage 296.704 MB -> 71.240 MB. [2025-01-11T08:30:14.031Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (6440.398 ms) ====== [2025-01-11T08:30:14.031Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-01-11T08:30:14.894Z] GC before operation: completed in 932.613 ms, heap usage 313.123 MB -> 71.302 MB. [2025-01-11T08:30:22.146Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (6501.717 ms) ====== [2025-01-11T08:30:22.146Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-01-11T08:30:22.146Z] GC before operation: completed in 880.026 ms, heap usage 309.598 MB -> 71.416 MB. [2025-01-11T08:30:30.093Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (7112.306 ms) ====== [2025-01-11T08:30:30.094Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-01-11T08:30:30.094Z] GC before operation: completed in 935.964 ms, heap usage 315.427 MB -> 71.428 MB. [2025-01-11T08:30:37.078Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (7123.126 ms) ====== [2025-01-11T08:30:37.078Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-01-11T08:30:38.522Z] GC before operation: completed in 963.303 ms, heap usage 305.235 MB -> 71.602 MB. [2025-01-11T08:30:45.846Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (7153.788 ms) ====== [2025-01-11T08:30:45.846Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-01-11T08:30:46.642Z] GC before operation: completed in 934.847 ms, heap usage 299.422 MB -> 71.615 MB. [2025-01-11T08:30:53.660Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (6604.067 ms) ====== [2025-01-11T08:30:53.660Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-01-11T08:30:53.660Z] GC before operation: completed in 936.430 ms, heap usage 199.835 MB -> 71.820 MB. [2025-01-11T08:31:01.169Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (6572.808 ms) ====== [2025-01-11T08:31:01.169Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-01-11T08:31:01.169Z] GC before operation: completed in 943.270 ms, heap usage 408.913 MB -> 71.822 MB. [2025-01-11T08:31:08.140Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (6347.941 ms) ====== [2025-01-11T08:31:08.140Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-01-11T08:31:09.103Z] GC before operation: completed in 980.444 ms, heap usage 299.826 MB -> 72.040 MB. [2025-01-11T08:31:15.463Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (6508.275 ms) ====== [2025-01-11T08:31:15.463Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-01-11T08:31:16.266Z] GC before operation: completed in 1006.093 ms, heap usage 309.520 MB -> 72.040 MB. [2025-01-11T08:31:23.193Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (6299.781 ms) ====== [2025-01-11T08:31:23.193Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-01-11T08:31:24.249Z] GC before operation: completed in 952.678 ms, heap usage 268.326 MB -> 71.995 MB. [2025-01-11T08:31:30.577Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (6176.357 ms) ====== [2025-01-11T08:31:30.577Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-01-11T08:31:30.577Z] GC before operation: completed in 952.887 ms, heap usage 272.390 MB -> 72.128 MB. [2025-01-11T08:31:37.116Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (6152.069 ms) ====== [2025-01-11T08:31:37.116Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-01-11T08:31:38.101Z] GC before operation: completed in 997.950 ms, heap usage 304.097 MB -> 72.339 MB. [2025-01-11T08:31:44.598Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (5997.325 ms) ====== [2025-01-11T08:31:44.598Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-01-11T08:31:44.598Z] GC before operation: completed in 974.197 ms, heap usage 271.565 MB -> 72.293 MB. [2025-01-11T08:31:51.020Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (6199.004 ms) ====== [2025-01-11T08:31:51.020Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-01-11T08:31:51.887Z] GC before operation: completed in 1028.413 ms, heap usage 290.389 MB -> 72.391 MB. [2025-01-11T08:31:58.209Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (6409.669 ms) ====== [2025-01-11T08:31:58.209Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-01-11T08:32:00.181Z] GC before operation: completed in 1092.504 ms, heap usage 268.115 MB -> 72.685 MB. [2025-01-11T08:32:06.969Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (6722.811 ms) ====== [2025-01-11T08:32:06.969Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-01-11T08:32:07.991Z] GC before operation: completed in 1044.535 ms, heap usage 228.676 MB -> 72.666 MB. [2025-01-11T08:32:14.759Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (6510.047 ms) ====== [2025-01-11T08:32:14.759Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-01-11T08:32:14.759Z] GC before operation: completed in 1009.825 ms, heap usage 248.283 MB -> 72.931 MB. [2025-01-11T08:32:21.342Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (6409.933 ms) ====== [2025-01-11T08:32:21.342Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-01-11T08:32:22.410Z] GC before operation: completed in 1092.956 ms, heap usage 255.832 MB -> 72.908 MB. [2025-01-11T08:32:28.920Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (6531.981 ms) ====== [2025-01-11T08:32:28.920Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-01-11T08:32:29.877Z] GC before operation: completed in 1159.102 ms, heap usage 259.879 MB -> 73.172 MB. [2025-01-11T08:32:36.371Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6231.126 ms) ====== [2025-01-11T08:32:36.372Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-01-11T08:32:37.706Z] GC before operation: completed in 1126.615 ms, heap usage 252.527 MB -> 73.085 MB. [2025-01-11T08:32:44.256Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (6124.636 ms) ====== [2025-01-11T08:32:44.256Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-01-11T08:32:45.042Z] GC before operation: completed in 1047.772 ms, heap usage 254.393 MB -> 73.372 MB. [2025-01-11T08:32:51.570Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (6089.893 ms) ====== [2025-01-11T08:32:51.570Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-01-11T08:32:51.570Z] GC before operation: completed in 1058.745 ms, heap usage 270.435 MB -> 73.237 MB. [2025-01-11T08:32:58.086Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (6212.605 ms) ====== [2025-01-11T08:32:59.242Z] ----------------------------------- [2025-01-11T08:32:59.242Z] renaissance-dec-tree_0_PASSED [2025-01-11T08:32:59.242Z] ----------------------------------- [2025-01-11T08:32:59.242Z] [2025-01-11T08:32:59.242Z] TEST TEARDOWN: [2025-01-11T08:32:59.242Z] Nothing to be done for teardown. [2025-01-11T08:32:59.242Z] renaissance-dec-tree_0 Finish Time: Sat Jan 11 08:32:59 2025 Epoch Time (ms): 1736584379176