[2024-11-14T03:02:37.139Z] Running test renaissance-dec-tree_0 ... [2024-11-14T03:02:37.139Z] =============================================== [2024-11-14T03:02:37.139Z] renaissance-dec-tree_0 Start Time: Wed Nov 13 22:02:36 2024 Epoch Time (ms): 1731553356532 [2024-11-14T03:02:37.139Z] variation: NoOptions [2024-11-14T03:02:37.139Z] JVM_OPTIONS: [2024-11-14T03:02:37.139Z] { \ [2024-11-14T03:02:37.139Z] echo ""; echo "TEST SETUP:"; \ [2024-11-14T03:02:37.139Z] echo "Nothing to be done for setup."; \ [2024-11-14T03:02:37.139Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17315529037184/renaissance-dec-tree_0"; \ [2024-11-14T03:02:37.139Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17315529037184/renaissance-dec-tree_0"; \ [2024-11-14T03:02:37.139Z] echo ""; echo "TESTING:"; \ [2024-11-14T03:02:37.139Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17315529037184/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-14T03:02:37.139Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17315529037184/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-14T03:02:37.139Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-14T03:02:37.139Z] echo "Nothing to be done for teardown."; \ [2024-11-14T03:02:37.139Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17315529037184/TestTargetResult"; [2024-11-14T03:02:37.139Z] [2024-11-14T03:02:37.139Z] TEST SETUP: [2024-11-14T03:02:37.139Z] Nothing to be done for setup. [2024-11-14T03:02:37.139Z] [2024-11-14T03:02:37.139Z] TESTING: [2024-11-14T03:02:39.200Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-14T03:02:40.551Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-11-14T03:02:43.468Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-14T03:02:43.468Z] GC before operation: completed in 46.521 ms, heap usage 48.572 MB -> 35.087 MB. [2024-11-14T03:02:50.881Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7944.618 ms) ====== [2024-11-14T03:02:50.881Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-14T03:02:51.551Z] GC before operation: completed in 125.140 ms, heap usage 252.542 MB -> 63.695 MB. [2024-11-14T03:02:54.508Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2921.283 ms) ====== [2024-11-14T03:02:54.508Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-14T03:02:54.508Z] GC before operation: completed in 110.905 ms, heap usage 136.715 MB -> 63.976 MB. [2024-11-14T03:02:56.592Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2148.485 ms) ====== [2024-11-14T03:02:56.592Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-14T03:02:56.592Z] GC before operation: completed in 121.737 ms, heap usage 225.421 MB -> 91.835 MB. [2024-11-14T03:02:58.753Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2207.776 ms) ====== [2024-11-14T03:02:58.753Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-14T03:02:58.753Z] GC before operation: completed in 110.756 ms, heap usage 178.242 MB -> 64.120 MB. [2024-11-14T03:03:00.842Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1931.090 ms) ====== [2024-11-14T03:03:00.842Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-14T03:03:00.842Z] GC before operation: completed in 98.023 ms, heap usage 231.109 MB -> 64.680 MB. [2024-11-14T03:03:03.002Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2064.624 ms) ====== [2024-11-14T03:03:03.002Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-14T03:03:03.003Z] GC before operation: completed in 114.825 ms, heap usage 297.034 MB -> 64.731 MB. [2024-11-14T03:03:05.130Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1817.724 ms) ====== [2024-11-14T03:03:05.131Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-14T03:03:05.131Z] GC before operation: completed in 95.167 ms, heap usage 134.670 MB -> 64.638 MB. [2024-11-14T03:03:07.254Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1746.546 ms) ====== [2024-11-14T03:03:07.254Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-14T03:03:07.254Z] GC before operation: completed in 87.342 ms, heap usage 282.306 MB -> 65.280 MB. [2024-11-14T03:03:08.617Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1973.039 ms) ====== [2024-11-14T03:03:08.617Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-14T03:03:09.250Z] GC before operation: completed in 97.474 ms, heap usage 236.232 MB -> 65.259 MB. [2024-11-14T03:03:11.333Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2216.789 ms) ====== [2024-11-14T03:03:11.333Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-14T03:03:11.333Z] GC before operation: completed in 95.540 ms, heap usage 184.913 MB -> 73.922 MB. [2024-11-14T03:03:13.440Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1764.852 ms) ====== [2024-11-14T03:03:13.440Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-14T03:03:13.440Z] GC before operation: completed in 97.549 ms, heap usage 185.593 MB -> 65.448 MB. [2024-11-14T03:03:14.834Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1840.822 ms) ====== [2024-11-14T03:03:14.834Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-14T03:03:14.834Z] GC before operation: completed in 132.945 ms, heap usage 280.673 MB -> 93.230 MB. [2024-11-14T03:03:16.954Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1873.898 ms) ====== [2024-11-14T03:03:16.954Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-14T03:03:16.954Z] GC before operation: completed in 124.501 ms, heap usage 280.158 MB -> 84.833 MB. [2024-11-14T03:03:19.119Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1785.808 ms) ====== [2024-11-14T03:03:19.119Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-14T03:03:19.119Z] GC before operation: completed in 113.333 ms, heap usage 203.833 MB -> 93.622 MB. [2024-11-14T03:03:21.213Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1872.439 ms) ====== [2024-11-14T03:03:21.213Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-14T03:03:21.213Z] GC before operation: completed in 122.003 ms, heap usage 151.038 MB -> 66.038 MB. [2024-11-14T03:03:21.213Z] 24/11/13 22:03:20 WARN BlockManager: Asked to remove block broadcast_204_piece0, which does not exist [2024-11-14T03:03:21.213Z] 24/11/13 22:03:20 WARN BlockManager: Asked to remove block broadcast_204, which does not exist [2024-11-14T03:03:23.330Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1951.112 ms) ====== [2024-11-14T03:03:23.331Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-14T03:03:23.331Z] GC before operation: completed in 113.285 ms, heap usage 96.213 MB -> 65.513 MB. [2024-11-14T03:03:24.711Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1677.617 ms) ====== [2024-11-14T03:03:24.711Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-14T03:03:24.711Z] GC before operation: completed in 91.889 ms, heap usage 248.193 MB -> 66.135 MB. [2024-11-14T03:03:26.780Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1655.754 ms) ====== [2024-11-14T03:03:26.780Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-14T03:03:26.780Z] GC before operation: completed in 119.071 ms, heap usage 235.329 MB -> 93.922 MB. [2024-11-14T03:03:28.138Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1580.951 ms) ====== [2024-11-14T03:03:28.138Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-14T03:03:28.138Z] GC before operation: completed in 125.266 ms, heap usage 128.929 MB -> 66.047 MB. [2024-11-14T03:03:30.209Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1615.775 ms) ====== [2024-11-14T03:03:30.209Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-14T03:03:30.209Z] GC before operation: completed in 117.140 ms, heap usage 295.062 MB -> 66.471 MB. [2024-11-14T03:03:31.570Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1788.417 ms) ====== [2024-11-14T03:03:31.570Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-14T03:03:32.211Z] GC before operation: completed in 126.249 ms, heap usage 283.077 MB -> 86.083 MB. [2024-11-14T03:03:33.556Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1621.628 ms) ====== [2024-11-14T03:03:33.556Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-14T03:03:33.556Z] GC before operation: completed in 137.248 ms, heap usage 200.405 MB -> 86.155 MB. [2024-11-14T03:03:35.670Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1820.645 ms) ====== [2024-11-14T03:03:35.670Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-14T03:03:35.670Z] GC before operation: completed in 148.023 ms, heap usage 126.250 MB -> 94.319 MB. [2024-11-14T03:03:37.777Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1907.414 ms) ====== [2024-11-14T03:03:37.777Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-14T03:03:37.777Z] GC before operation: completed in 113.005 ms, heap usage 130.312 MB -> 66.749 MB. [2024-11-14T03:03:39.916Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1793.656 ms) ====== [2024-11-14T03:03:39.916Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-14T03:03:39.916Z] GC before operation: completed in 174.932 ms, heap usage 325.640 MB -> 94.633 MB. [2024-11-14T03:03:42.068Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2044.925 ms) ====== [2024-11-14T03:03:42.068Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-14T03:03:42.068Z] GC before operation: completed in 135.872 ms, heap usage 261.788 MB -> 67.251 MB. [2024-11-14T03:03:43.458Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1797.759 ms) ====== [2024-11-14T03:03:43.458Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-14T03:03:44.138Z] GC before operation: completed in 149.095 ms, heap usage 280.452 MB -> 67.205 MB. [2024-11-14T03:03:46.250Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2055.100 ms) ====== [2024-11-14T03:03:46.251Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-14T03:03:46.251Z] GC before operation: completed in 128.020 ms, heap usage 142.007 MB -> 67.180 MB. [2024-11-14T03:03:47.603Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1732.483 ms) ====== [2024-11-14T03:03:47.603Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-14T03:03:47.603Z] GC before operation: completed in 150.180 ms, heap usage 309.704 MB -> 67.533 MB. [2024-11-14T03:03:50.051Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1906.795 ms) ====== [2024-11-14T03:03:50.051Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-14T03:03:50.051Z] GC before operation: completed in 148.174 ms, heap usage 140.672 MB -> 67.608 MB. [2024-11-14T03:03:52.201Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1794.068 ms) ====== [2024-11-14T03:03:52.201Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-14T03:03:52.201Z] GC before operation: completed in 152.100 ms, heap usage 324.810 MB -> 95.032 MB. [2024-11-14T03:03:53.601Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1772.857 ms) ====== [2024-11-14T03:03:53.601Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-14T03:03:53.601Z] GC before operation: completed in 116.247 ms, heap usage 245.539 MB -> 67.884 MB. [2024-11-14T03:03:55.803Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1806.253 ms) ====== [2024-11-14T03:03:55.803Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-14T03:03:55.803Z] GC before operation: completed in 152.671 ms, heap usage 141.716 MB -> 67.676 MB. [2024-11-14T03:03:57.973Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1772.484 ms) ====== [2024-11-14T03:03:57.973Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-14T03:03:57.973Z] GC before operation: completed in 131.424 ms, heap usage 276.738 MB -> 68.101 MB. [2024-11-14T03:03:59.291Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1540.837 ms) ====== [2024-11-14T03:03:59.291Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-14T03:03:59.291Z] GC before operation: completed in 129.387 ms, heap usage 156.524 MB -> 67.772 MB. [2024-11-14T03:04:01.422Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1757.216 ms) ====== [2024-11-14T03:04:01.422Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-14T03:04:01.422Z] GC before operation: completed in 162.913 ms, heap usage 323.689 MB -> 87.615 MB. [2024-11-14T03:04:03.537Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1865.915 ms) ====== [2024-11-14T03:04:03.537Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-14T03:04:03.537Z] GC before operation: completed in 179.046 ms, heap usage 170.574 MB -> 68.340 MB. [2024-11-14T03:04:04.914Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1803.614 ms) ====== [2024-11-14T03:04:04.914Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-14T03:04:04.914Z] GC before operation: completed in 131.645 ms, heap usage 175.281 MB -> 68.246 MB. [2024-11-14T03:04:07.057Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1691.963 ms) ====== [2024-11-14T03:04:07.057Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-14T03:04:07.057Z] GC before operation: completed in 116.194 ms, heap usage 143.600 MB -> 68.247 MB. [2024-11-14T03:04:08.421Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1653.850 ms) ====== [2024-11-14T03:04:09.082Z] ----------------------------------- [2024-11-14T03:04:09.082Z] renaissance-dec-tree_0_PASSED [2024-11-14T03:04:09.082Z] ----------------------------------- [2024-11-14T03:04:09.082Z] [2024-11-14T03:04:09.082Z] TEST TEARDOWN: [2024-11-14T03:04:09.083Z] Nothing to be done for teardown. [2024-11-14T03:04:09.083Z] renaissance-dec-tree_0 Finish Time: Wed Nov 13 22:04:08 2024 Epoch Time (ms): 1731553448654