[2024-08-17T11:33:28.931Z] Running test renaissance-dec-tree_0 ... [2024-08-17T11:33:28.931Z] =============================================== [2024-08-17T11:33:28.931Z] renaissance-dec-tree_0 Start Time: Sat Aug 17 11:33:28 2024 Epoch Time (ms): 1723894408811 [2024-08-17T11:33:28.931Z] variation: NoOptions [2024-08-17T11:33:28.931Z] JVM_OPTIONS: [2024-08-17T11:33:28.931Z] { \ [2024-08-17T11:33:28.931Z] echo ""; echo "TEST SETUP:"; \ [2024-08-17T11:33:28.931Z] echo "Nothing to be done for setup."; \ [2024-08-17T11:33:28.931Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17238936138096/renaissance-dec-tree_0"; \ [2024-08-17T11:33:28.931Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17238936138096/renaissance-dec-tree_0"; \ [2024-08-17T11:33:28.931Z] echo ""; echo "TESTING:"; \ [2024-08-17T11:33:28.931Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/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_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17238936138096/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-17T11:33:28.931Z] 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_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17238936138096/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-17T11:33:28.931Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-17T11:33:28.931Z] echo "Nothing to be done for teardown."; \ [2024-08-17T11:33:28.931Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17238936138096/TestTargetResult"; [2024-08-17T11:33:28.931Z] [2024-08-17T11:33:28.931Z] TEST SETUP: [2024-08-17T11:33:28.931Z] Nothing to be done for setup. [2024-08-17T11:33:28.931Z] [2024-08-17T11:33:28.931Z] TESTING: [2024-08-17T11:33:33.956Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-17T11:33:37.835Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-17T11:33:44.123Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-17T11:33:44.123Z] GC before operation: completed in 87.665 ms, heap usage 45.874 MB -> 35.054 MB. [2024-08-17T11:34:04.586Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (18913.650 ms) ====== [2024-08-17T11:34:04.586Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-17T11:34:04.586Z] GC before operation: completed in 263.026 ms, heap usage 100.403 MB -> 64.454 MB. [2024-08-17T11:34:09.662Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (6043.778 ms) ====== [2024-08-17T11:34:09.662Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-17T11:34:09.662Z] GC before operation: completed in 259.237 ms, heap usage 334.307 MB -> 92.445 MB. [2024-08-17T11:34:14.771Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4212.106 ms) ====== [2024-08-17T11:34:14.771Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-17T11:34:14.771Z] GC before operation: completed in 171.203 ms, heap usage 241.182 MB -> 65.125 MB. [2024-08-17T11:34:18.839Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3947.706 ms) ====== [2024-08-17T11:34:18.839Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-17T11:34:18.839Z] GC before operation: completed in 195.676 ms, heap usage 258.851 MB -> 65.453 MB. [2024-08-17T11:34:22.732Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3881.806 ms) ====== [2024-08-17T11:34:22.732Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-17T11:34:22.732Z] GC before operation: completed in 281.407 ms, heap usage 345.555 MB -> 65.516 MB. [2024-08-17T11:34:26.652Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3496.535 ms) ====== [2024-08-17T11:34:26.652Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-17T11:34:26.652Z] GC before operation: completed in 204.520 ms, heap usage 187.816 MB -> 65.883 MB. [2024-08-17T11:34:29.411Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2914.060 ms) ====== [2024-08-17T11:34:29.411Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-17T11:34:29.411Z] GC before operation: completed in 210.011 ms, heap usage 320.946 MB -> 65.959 MB. [2024-08-17T11:34:32.102Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2690.700 ms) ====== [2024-08-17T11:34:32.102Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-17T11:34:32.102Z] GC before operation: completed in 172.706 ms, heap usage 274.686 MB -> 66.225 MB. [2024-08-17T11:34:34.786Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2560.318 ms) ====== [2024-08-17T11:34:34.786Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-17T11:34:34.786Z] GC before operation: completed in 139.772 ms, heap usage 310.443 MB -> 66.319 MB. [2024-08-17T11:34:37.478Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2565.452 ms) ====== [2024-08-17T11:34:37.478Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-17T11:34:37.478Z] GC before operation: completed in 173.439 ms, heap usage 327.350 MB -> 66.336 MB. [2024-08-17T11:34:40.158Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2340.248 ms) ====== [2024-08-17T11:34:40.158Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-17T11:34:40.158Z] GC before operation: completed in 158.699 ms, heap usage 175.098 MB -> 66.205 MB. [2024-08-17T11:34:42.856Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2656.045 ms) ====== [2024-08-17T11:34:42.856Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-17T11:34:42.856Z] GC before operation: completed in 203.487 ms, heap usage 273.589 MB -> 66.554 MB. [2024-08-17T11:34:45.542Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2332.391 ms) ====== [2024-08-17T11:34:45.542Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-17T11:34:45.542Z] GC before operation: completed in 203.031 ms, heap usage 310.234 MB -> 66.771 MB. [2024-08-17T11:34:48.220Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2514.798 ms) ====== [2024-08-17T11:34:48.220Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-17T11:34:48.220Z] GC before operation: completed in 163.645 ms, heap usage 300.853 MB -> 66.908 MB. [2024-08-17T11:34:50.896Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2124.129 ms) ====== [2024-08-17T11:34:50.896Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-17T11:34:50.896Z] GC before operation: completed in 232.088 ms, heap usage 98.815 MB -> 66.479 MB. [2024-08-17T11:34:53.577Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2394.517 ms) ====== [2024-08-17T11:34:53.578Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-17T11:34:53.578Z] GC before operation: completed in 172.715 ms, heap usage 484.353 MB -> 67.472 MB. [2024-08-17T11:34:55.302Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2271.118 ms) ====== [2024-08-17T11:34:55.302Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-17T11:34:56.147Z] GC before operation: completed in 166.210 ms, heap usage 110.622 MB -> 66.594 MB. [2024-08-17T11:34:58.871Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2778.766 ms) ====== [2024-08-17T11:34:58.871Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-17T11:34:58.871Z] GC before operation: completed in 222.468 ms, heap usage 451.107 MB -> 67.697 MB. [2024-08-17T11:35:01.587Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2802.766 ms) ====== [2024-08-17T11:35:01.587Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-17T11:35:01.587Z] GC before operation: completed in 189.445 ms, heap usage 146.749 MB -> 67.325 MB. [2024-08-17T11:35:04.275Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2769.789 ms) ====== [2024-08-17T11:35:04.275Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-17T11:35:05.129Z] GC before operation: completed in 236.734 ms, heap usage 411.075 MB -> 67.464 MB. [2024-08-17T11:35:07.822Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2887.542 ms) ====== [2024-08-17T11:35:07.822Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-17T11:35:07.822Z] GC before operation: completed in 283.907 ms, heap usage 352.532 MB -> 95.192 MB. [2024-08-17T11:35:07.822Z] 24/08/17 11:35:07 WARN BlockManager: Asked to remove block broadcast_292, which does not exist [2024-08-17T11:35:07.822Z] 24/08/17 11:35:07 WARN BlockManager: Asked to remove block broadcast_288, which does not exist [2024-08-17T11:35:11.531Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3046.023 ms) ====== [2024-08-17T11:35:11.531Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-17T11:35:11.531Z] GC before operation: completed in 257.158 ms, heap usage 316.762 MB -> 95.265 MB. [2024-08-17T11:35:14.227Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2597.177 ms) ====== [2024-08-17T11:35:14.227Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-17T11:35:14.227Z] GC before operation: completed in 194.170 ms, heap usage 317.353 MB -> 67.942 MB. [2024-08-17T11:35:16.239Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2645.401 ms) ====== [2024-08-17T11:35:16.239Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-17T11:35:17.078Z] GC before operation: completed in 272.229 ms, heap usage 303.207 MB -> 67.888 MB. [2024-08-17T11:35:19.775Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2831.361 ms) ====== [2024-08-17T11:35:19.775Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-17T11:35:19.775Z] GC before operation: completed in 277.972 ms, heap usage 272.443 MB -> 68.196 MB. [2024-08-17T11:35:22.481Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2677.523 ms) ====== [2024-08-17T11:35:22.481Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-17T11:35:23.323Z] GC before operation: completed in 309.875 ms, heap usage 174.884 MB -> 68.006 MB. [2024-08-17T11:35:26.011Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2786.391 ms) ====== [2024-08-17T11:35:26.011Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-17T11:35:26.011Z] GC before operation: completed in 274.607 ms, heap usage 209.577 MB -> 68.351 MB. [2024-08-17T11:35:28.707Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2576.761 ms) ====== [2024-08-17T11:35:28.707Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-17T11:35:28.707Z] GC before operation: completed in 286.734 ms, heap usage 258.655 MB -> 68.429 MB. [2024-08-17T11:35:31.399Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2652.371 ms) ====== [2024-08-17T11:35:31.399Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-17T11:35:32.246Z] GC before operation: completed in 222.883 ms, heap usage 120.418 MB -> 68.003 MB. [2024-08-17T11:35:34.947Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2750.668 ms) ====== [2024-08-17T11:35:34.947Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-17T11:35:34.948Z] GC before operation: completed in 244.973 ms, heap usage 232.839 MB -> 68.698 MB. [2024-08-17T11:35:37.691Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2557.240 ms) ====== [2024-08-17T11:35:37.691Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-17T11:35:37.692Z] GC before operation: completed in 218.888 ms, heap usage 288.544 MB -> 68.715 MB. [2024-08-17T11:35:40.413Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2707.177 ms) ====== [2024-08-17T11:35:40.414Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-17T11:35:40.414Z] GC before operation: completed in 238.543 ms, heap usage 251.476 MB -> 68.688 MB. [2024-08-17T11:35:43.099Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2721.604 ms) ====== [2024-08-17T11:35:43.099Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-17T11:35:43.947Z] GC before operation: completed in 309.924 ms, heap usage 279.617 MB -> 68.809 MB. [2024-08-17T11:35:46.619Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2508.633 ms) ====== [2024-08-17T11:35:46.619Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-17T11:35:46.619Z] GC before operation: completed in 298.701 ms, heap usage 261.379 MB -> 68.935 MB. [2024-08-17T11:35:49.330Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2784.008 ms) ====== [2024-08-17T11:35:49.330Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-17T11:35:49.330Z] GC before operation: completed in 335.343 ms, heap usage 352.592 MB -> 69.178 MB. [2024-08-17T11:35:52.039Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2570.098 ms) ====== [2024-08-17T11:35:52.040Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-17T11:35:52.040Z] GC before operation: completed in 268.286 ms, heap usage 130.742 MB -> 68.821 MB. [2024-08-17T11:35:54.767Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2709.742 ms) ====== [2024-08-17T11:35:54.767Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-17T11:35:55.607Z] GC before operation: completed in 241.583 ms, heap usage 403.778 MB -> 69.363 MB. [2024-08-17T11:35:58.319Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2515.752 ms) ====== [2024-08-17T11:35:58.319Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-17T11:35:58.319Z] GC before operation: completed in 287.286 ms, heap usage 271.341 MB -> 69.454 MB. [2024-08-17T11:36:01.069Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2720.063 ms) ====== [2024-08-17T11:36:01.069Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-17T11:36:01.069Z] GC before operation: completed in 335.418 ms, heap usage 256.495 MB -> 69.581 MB. [2024-08-17T11:36:03.763Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2616.227 ms) ====== [2024-08-17T11:36:04.607Z] ----------------------------------- [2024-08-17T11:36:04.607Z] renaissance-dec-tree_0_PASSED [2024-08-17T11:36:04.607Z] ----------------------------------- [2024-08-17T11:36:04.607Z] [2024-08-17T11:36:04.607Z] TEST TEARDOWN: [2024-08-17T11:36:04.607Z] Nothing to be done for teardown. [2024-08-17T11:36:04.607Z] renaissance-dec-tree_0 Finish Time: Sat Aug 17 11:36:03 2024 Epoch Time (ms): 1723894563795