[2024-09-26T20:53:19.031Z] Running test renaissance-dec-tree_0 ... [2024-09-26T20:53:19.031Z] =============================================== [2024-09-26T20:53:19.031Z] renaissance-dec-tree_0 Start Time: Thu Sep 26 20:53:18 2024 Epoch Time (ms): 1727383998799 [2024-09-26T20:53:19.031Z] variation: NoOptions [2024-09-26T20:53:19.031Z] JVM_OPTIONS: [2024-09-26T20:53:19.031Z] { \ [2024-09-26T20:53:19.031Z] echo ""; echo "TEST SETUP:"; \ [2024-09-26T20:53:19.031Z] echo "Nothing to be done for setup."; \ [2024-09-26T20:53:19.031Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273835137937/renaissance-dec-tree_0"; \ [2024-09-26T20:53:19.031Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273835137937/renaissance-dec-tree_0"; \ [2024-09-26T20:53:19.031Z] echo ""; echo "TESTING:"; \ [2024-09-26T20:53:19.031Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273835137937/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-26T20:53:19.031Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273835137937/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-26T20:53:19.031Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-26T20:53:19.031Z] echo "Nothing to be done for teardown."; \ [2024-09-26T20:53:19.031Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273835137937/TestTargetResult"; [2024-09-26T20:53:19.031Z] [2024-09-26T20:53:19.031Z] TEST SETUP: [2024-09-26T20:53:19.031Z] Nothing to be done for setup. [2024-09-26T20:53:19.031Z] [2024-09-26T20:53:19.031Z] TESTING: [2024-09-26T20:53:24.593Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-26T20:53:28.003Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-09-26T20:53:34.818Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-26T20:53:34.818Z] GC before operation: completed in 188.531 ms, heap usage 50.278 MB -> 21.524 MB. [2024-09-26T20:53:48.536Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (13552.776 ms) ====== [2024-09-26T20:53:48.536Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-26T20:53:48.536Z] GC before operation: completed in 446.389 ms, heap usage 144.261 MB -> 53.699 MB. [2024-09-26T20:53:52.022Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2966.048 ms) ====== [2024-09-26T20:53:52.022Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-26T20:53:52.022Z] GC before operation: completed in 345.804 ms, heap usage 331.991 MB -> 54.205 MB. [2024-09-26T20:53:54.623Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2559.851 ms) ====== [2024-09-26T20:53:54.623Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-26T20:53:55.387Z] GC before operation: completed in 257.085 ms, heap usage 304.614 MB -> 54.842 MB. [2024-09-26T20:53:57.842Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2342.565 ms) ====== [2024-09-26T20:53:57.842Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-26T20:53:57.842Z] GC before operation: completed in 275.509 ms, heap usage 271.189 MB -> 55.279 MB. [2024-09-26T20:54:00.291Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2277.336 ms) ====== [2024-09-26T20:54:00.291Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-26T20:54:00.291Z] GC before operation: completed in 250.808 ms, heap usage 255.969 MB -> 55.518 MB. [2024-09-26T20:54:02.736Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2219.163 ms) ====== [2024-09-26T20:54:02.736Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-26T20:54:02.736Z] GC before operation: completed in 231.439 ms, heap usage 252.670 MB -> 55.858 MB. [2024-09-26T20:54:04.695Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2111.499 ms) ====== [2024-09-26T20:54:04.695Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-26T20:54:05.486Z] GC before operation: completed in 274.496 ms, heap usage 248.943 MB -> 56.051 MB. [2024-09-26T20:54:07.077Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2097.987 ms) ====== [2024-09-26T20:54:07.077Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-26T20:54:07.077Z] GC before operation: completed in 287.495 ms, heap usage 250.797 MB -> 56.072 MB. [2024-09-26T20:54:09.550Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1963.956 ms) ====== [2024-09-26T20:54:09.550Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-26T20:54:09.550Z] GC before operation: completed in 316.597 ms, heap usage 244.766 MB -> 56.364 MB. [2024-09-26T20:54:12.002Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2012.546 ms) ====== [2024-09-26T20:54:12.002Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-26T20:54:12.002Z] GC before operation: completed in 356.521 ms, heap usage 251.250 MB -> 56.356 MB. [2024-09-26T20:54:14.513Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1958.934 ms) ====== [2024-09-26T20:54:14.513Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-26T20:54:14.513Z] GC before operation: completed in 298.151 ms, heap usage 246.687 MB -> 56.867 MB. [2024-09-26T20:54:16.101Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1884.161 ms) ====== [2024-09-26T20:54:16.101Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-26T20:54:16.875Z] GC before operation: completed in 330.098 ms, heap usage 250.235 MB -> 56.787 MB. [2024-09-26T20:54:18.465Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1926.772 ms) ====== [2024-09-26T20:54:18.465Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-26T20:54:18.465Z] GC before operation: completed in 216.386 ms, heap usage 247.609 MB -> 56.931 MB. [2024-09-26T20:54:20.922Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1912.412 ms) ====== [2024-09-26T20:54:20.922Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-26T20:54:20.922Z] GC before operation: completed in 287.437 ms, heap usage 248.972 MB -> 56.993 MB. [2024-09-26T20:54:22.500Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1934.285 ms) ====== [2024-09-26T20:54:22.500Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-26T20:54:23.292Z] GC before operation: completed in 287.077 ms, heap usage 246.921 MB -> 57.268 MB. [2024-09-26T20:54:24.875Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1828.860 ms) ====== [2024-09-26T20:54:24.875Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-26T20:54:24.875Z] GC before operation: completed in 319.197 ms, heap usage 250.296 MB -> 57.457 MB. [2024-09-26T20:54:27.322Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1804.895 ms) ====== [2024-09-26T20:54:27.322Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-26T20:54:27.322Z] GC before operation: completed in 265.567 ms, heap usage 246.473 MB -> 57.504 MB. [2024-09-26T20:54:28.910Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1881.391 ms) ====== [2024-09-26T20:54:28.910Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-26T20:54:29.720Z] GC before operation: completed in 346.282 ms, heap usage 249.489 MB -> 57.734 MB. [2024-09-26T20:54:31.296Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1801.464 ms) ====== [2024-09-26T20:54:31.296Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-26T20:54:31.296Z] GC before operation: completed in 221.615 ms, heap usage 246.025 MB -> 57.716 MB. [2024-09-26T20:54:33.742Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1762.293 ms) ====== [2024-09-26T20:54:33.743Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-26T20:54:33.743Z] GC before operation: completed in 220.265 ms, heap usage 249.665 MB -> 57.981 MB. [2024-09-26T20:54:35.317Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1799.691 ms) ====== [2024-09-26T20:54:35.318Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-26T20:54:35.318Z] GC before operation: completed in 228.913 ms, heap usage 250.713 MB -> 58.120 MB. [2024-09-26T20:54:36.895Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1702.045 ms) ====== [2024-09-26T20:54:36.895Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-26T20:54:37.660Z] GC before operation: completed in 296.437 ms, heap usage 249.862 MB -> 58.101 MB. [2024-09-26T20:54:39.242Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1716.405 ms) ====== [2024-09-26T20:54:39.242Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-26T20:54:39.242Z] GC before operation: completed in 288.130 ms, heap usage 247.774 MB -> 58.238 MB. [2024-09-26T20:54:41.701Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1701.400 ms) ====== [2024-09-26T20:54:41.701Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-26T20:54:41.701Z] GC before operation: completed in 243.969 ms, heap usage 250.706 MB -> 58.368 MB. [2024-09-26T20:54:43.283Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1727.882 ms) ====== [2024-09-26T20:54:43.283Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-26T20:54:43.283Z] GC before operation: completed in 310.192 ms, heap usage 246.930 MB -> 58.685 MB. [2024-09-26T20:54:45.750Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1732.777 ms) ====== [2024-09-26T20:54:45.750Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-26T20:54:45.750Z] GC before operation: completed in 303.641 ms, heap usage 247.114 MB -> 58.680 MB. [2024-09-26T20:54:47.322Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1767.257 ms) ====== [2024-09-26T20:54:47.322Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-26T20:54:47.322Z] GC before operation: completed in 252.033 ms, heap usage 247.656 MB -> 58.819 MB. [2024-09-26T20:54:49.786Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1728.381 ms) ====== [2024-09-26T20:54:49.786Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-26T20:54:49.786Z] GC before operation: completed in 277.042 ms, heap usage 253.269 MB -> 58.951 MB. [2024-09-26T20:54:51.374Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1663.357 ms) ====== [2024-09-26T20:54:51.374Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-26T20:54:51.374Z] GC before operation: completed in 178.781 ms, heap usage 250.257 MB -> 59.229 MB. [2024-09-26T20:54:52.958Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1722.008 ms) ====== [2024-09-26T20:54:52.958Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-26T20:54:53.731Z] GC before operation: completed in 236.473 ms, heap usage 249.748 MB -> 59.344 MB. [2024-09-26T20:54:55.320Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1730.328 ms) ====== [2024-09-26T20:54:55.320Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-26T20:54:55.320Z] GC before operation: completed in 292.282 ms, heap usage 247.892 MB -> 59.329 MB. [2024-09-26T20:54:56.901Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1670.325 ms) ====== [2024-09-26T20:54:56.901Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-26T20:54:57.681Z] GC before operation: completed in 278.311 ms, heap usage 252.518 MB -> 59.616 MB. [2024-09-26T20:54:59.267Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1700.479 ms) ====== [2024-09-26T20:54:59.267Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-26T20:54:59.267Z] GC before operation: completed in 206.277 ms, heap usage 249.366 MB -> 59.744 MB. [2024-09-26T20:55:00.842Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1716.923 ms) ====== [2024-09-26T20:55:00.842Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-26T20:55:01.603Z] GC before operation: completed in 281.482 ms, heap usage 248.612 MB -> 59.729 MB. [2024-09-26T20:55:03.176Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1788.846 ms) ====== [2024-09-26T20:55:03.176Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-26T20:55:03.176Z] GC before operation: completed in 288.321 ms, heap usage 250.286 MB -> 59.848 MB. [2024-09-26T20:55:04.749Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1681.036 ms) ====== [2024-09-26T20:55:04.749Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-26T20:55:05.520Z] GC before operation: completed in 234.474 ms, heap usage 251.210 MB -> 59.981 MB. [2024-09-26T20:55:07.110Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1603.715 ms) ====== [2024-09-26T20:55:07.110Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-26T20:55:07.110Z] GC before operation: completed in 228.178 ms, heap usage 248.638 MB -> 60.263 MB. [2024-09-26T20:55:08.690Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1659.327 ms) ====== [2024-09-26T20:55:08.690Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-26T20:55:08.690Z] GC before operation: completed in 239.317 ms, heap usage 253.339 MB -> 60.244 MB. [2024-09-26T20:55:11.150Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1694.801 ms) ====== [2024-09-26T20:55:11.150Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-26T20:55:11.150Z] GC before operation: completed in 233.196 ms, heap usage 253.371 MB -> 60.529 MB. [2024-09-26T20:55:12.731Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1670.014 ms) ====== [2024-09-26T20:55:13.494Z] ----------------------------------- [2024-09-26T20:55:13.494Z] renaissance-dec-tree_0_PASSED [2024-09-26T20:55:13.494Z] ----------------------------------- [2024-09-26T20:55:13.494Z] [2024-09-26T20:55:13.494Z] TEST TEARDOWN: [2024-09-26T20:55:13.494Z] Nothing to be done for teardown. [2024-09-26T20:55:13.494Z] renaissance-dec-tree_0 Finish Time: Thu Sep 26 20:55:12 2024 Epoch Time (ms): 1727384112767