[2023-04-20T01:55:47.522Z] Running test renaissance-dec-tree_0 ... [2023-04-20T01:55:47.522Z] =============================================== [2023-04-20T01:55:47.522Z] renaissance-dec-tree_0 Start Time: Thu Apr 20 02:06:34 2023 Epoch Time (ms): 1681956394882 [2023-04-20T01:55:47.522Z] variation: NoOptions [2023-04-20T01:55:47.522Z] JVM_OPTIONS: [2023-04-20T01:55:47.522Z] { \ [2023-04-20T01:55:47.522Z] echo ""; echo "TEST SETUP:"; \ [2023-04-20T01:55:47.522Z] echo "Nothing to be done for setup."; \ [2023-04-20T01:55:47.522Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_16819559301834/renaissance-dec-tree_0"; \ [2023-04-20T01:55:47.522Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_16819559301834/renaissance-dec-tree_0"; \ [2023-04-20T01:55:47.522Z] echo ""; echo "TESTING:"; \ [2023-04-20T01:55:47.522Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/openjdkbinary/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_16819559301834/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2023-04-20T01:55:47.522Z] 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_16819559301834/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-20T01:55:47.522Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-20T01:55:47.522Z] echo "Nothing to be done for teardown."; \ [2023-04-20T01:55:47.522Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_16819559301834/TestTargetResult"; [2023-04-20T01:55:47.522Z] [2023-04-20T01:55:47.522Z] TEST SETUP: [2023-04-20T01:55:47.522Z] Nothing to be done for setup. [2023-04-20T01:55:47.522Z] [2023-04-20T01:55:47.522Z] TESTING: [2023-04-20T01:55:51.943Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2023-04-20T01:55:55.335Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2023-04-20T01:56:02.143Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2023-04-20T01:56:02.903Z] GC before operation: completed in 372.874 ms, heap usage 84.781 MB -> 26.370 MB. [2023-04-20T01:56:16.569Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (13134.947 ms) ====== [2023-04-20T01:56:16.569Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2023-04-20T01:56:16.569Z] GC before operation: completed in 328.421 ms, heap usage 211.469 MB -> 54.199 MB. [2023-04-20T01:56:19.016Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2844.695 ms) ====== [2023-04-20T01:56:19.016Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2023-04-20T01:56:19.016Z] GC before operation: completed in 356.768 ms, heap usage 316.551 MB -> 54.354 MB. [2023-04-20T01:56:21.467Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2441.658 ms) ====== [2023-04-20T01:56:21.467Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2023-04-20T01:56:22.227Z] GC before operation: completed in 272.141 ms, heap usage 283.857 MB -> 54.897 MB. [2023-04-20T01:56:24.677Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2306.140 ms) ====== [2023-04-20T01:56:24.677Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2023-04-20T01:56:24.677Z] GC before operation: completed in 230.625 ms, heap usage 256.608 MB -> 55.331 MB. [2023-04-20T01:56:27.122Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2214.502 ms) ====== [2023-04-20T01:56:27.122Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2023-04-20T01:56:27.122Z] GC before operation: completed in 220.668 ms, heap usage 254.128 MB -> 55.579 MB. [2023-04-20T01:56:29.574Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2139.126 ms) ====== [2023-04-20T01:56:29.574Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2023-04-20T01:56:29.574Z] GC before operation: completed in 249.517 ms, heap usage 252.993 MB -> 55.826 MB. [2023-04-20T01:56:31.152Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2054.022 ms) ====== [2023-04-20T01:56:31.152Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2023-04-20T01:56:31.914Z] GC before operation: completed in 278.944 ms, heap usage 249.373 MB -> 56.050 MB. [2023-04-20T01:56:33.489Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1980.986 ms) ====== [2023-04-20T01:56:33.489Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2023-04-20T01:56:34.285Z] GC before operation: completed in 296.805 ms, heap usage 245.884 MB -> 56.215 MB. [2023-04-20T01:56:35.872Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1921.714 ms) ====== [2023-04-20T01:56:35.872Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2023-04-20T01:56:35.872Z] GC before operation: completed in 280.888 ms, heap usage 243.760 MB -> 56.359 MB. [2023-04-20T01:56:38.346Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1889.027 ms) ====== [2023-04-20T01:56:38.347Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2023-04-20T01:56:38.347Z] GC before operation: completed in 247.245 ms, heap usage 249.603 MB -> 56.776 MB. [2023-04-20T01:56:39.924Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1866.222 ms) ====== [2023-04-20T01:56:39.925Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2023-04-20T01:56:40.694Z] GC before operation: completed in 262.660 ms, heap usage 246.994 MB -> 56.685 MB. [2023-04-20T01:56:42.272Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1806.641 ms) ====== [2023-04-20T01:56:42.272Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2023-04-20T01:56:42.272Z] GC before operation: completed in 253.471 ms, heap usage 249.288 MB -> 56.845 MB. [2023-04-20T01:56:44.729Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1827.273 ms) ====== [2023-04-20T01:56:44.729Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2023-04-20T01:56:44.729Z] GC before operation: completed in 238.317 ms, heap usage 244.586 MB -> 56.992 MB. [2023-04-20T01:56:46.305Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1787.488 ms) ====== [2023-04-20T01:56:46.305Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2023-04-20T01:56:46.305Z] GC before operation: completed in 247.560 ms, heap usage 247.610 MB -> 57.134 MB. [2023-04-20T01:56:48.751Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1834.720 ms) ====== [2023-04-20T01:56:48.751Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2023-04-20T01:56:48.751Z] GC before operation: completed in 270.395 ms, heap usage 242.784 MB -> 57.277 MB. [2023-04-20T01:56:50.339Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1769.922 ms) ====== [2023-04-20T01:56:50.339Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2023-04-20T01:56:51.106Z] GC before operation: completed in 229.131 ms, heap usage 249.771 MB -> 57.451 MB. [2023-04-20T01:56:52.692Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1710.411 ms) ====== [2023-04-20T01:56:52.692Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2023-04-20T01:56:52.692Z] GC before operation: completed in 295.678 ms, heap usage 247.629 MB -> 57.641 MB. [2023-04-20T01:56:54.275Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1701.466 ms) ====== [2023-04-20T01:56:54.275Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2023-04-20T01:56:55.046Z] GC before operation: completed in 268.821 ms, heap usage 247.954 MB -> 57.724 MB. [2023-04-20T01:56:56.627Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1675.277 ms) ====== [2023-04-20T01:56:56.627Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2023-04-20T01:56:56.627Z] GC before operation: completed in 271.110 ms, heap usage 245.070 MB -> 57.862 MB. [2023-04-20T01:56:58.201Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1731.884 ms) ====== [2023-04-20T01:56:58.201Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2023-04-20T01:56:58.964Z] GC before operation: completed in 196.185 ms, heap usage 249.398 MB -> 58.063 MB. [2023-04-20T01:57:00.553Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1780.173 ms) ====== [2023-04-20T01:57:00.553Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2023-04-20T01:57:00.553Z] GC before operation: completed in 318.205 ms, heap usage 246.042 MB -> 58.333 MB. [2023-04-20T01:57:02.137Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1737.343 ms) ====== [2023-04-20T01:57:02.137Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2023-04-20T01:57:02.903Z] GC before operation: completed in 169.022 ms, heap usage 251.148 MB -> 58.250 MB. [2023-04-20T01:57:04.495Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1666.428 ms) ====== [2023-04-20T01:57:04.495Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2023-04-20T01:57:04.495Z] GC before operation: completed in 207.363 ms, heap usage 247.520 MB -> 58.233 MB. [2023-04-20T01:57:06.067Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1706.730 ms) ====== [2023-04-20T01:57:06.068Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2023-04-20T01:57:06.830Z] GC before operation: completed in 284.305 ms, heap usage 247.982 MB -> 58.518 MB. [2023-04-20T01:57:08.405Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1653.418 ms) ====== [2023-04-20T01:57:08.405Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2023-04-20T01:57:08.405Z] GC before operation: completed in 236.615 ms, heap usage 248.200 MB -> 58.662 MB. [2023-04-20T01:57:09.986Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1657.925 ms) ====== [2023-04-20T01:57:09.986Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2023-04-20T01:57:09.986Z] GC before operation: completed in 288.137 ms, heap usage 247.784 MB -> 58.777 MB. [2023-04-20T01:57:12.443Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1730.260 ms) ====== [2023-04-20T01:57:12.443Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2023-04-20T01:57:12.443Z] GC before operation: completed in 319.191 ms, heap usage 245.664 MB -> 58.962 MB. [2023-04-20T01:57:14.017Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1648.951 ms) ====== [2023-04-20T01:57:14.017Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2023-04-20T01:57:14.017Z] GC before operation: completed in 302.430 ms, heap usage 249.395 MB -> 59.091 MB. [2023-04-20T01:57:16.473Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1720.686 ms) ====== [2023-04-20T01:57:16.473Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2023-04-20T01:57:16.473Z] GC before operation: completed in 250.598 ms, heap usage 244.372 MB -> 59.084 MB. [2023-04-20T01:57:18.051Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1622.915 ms) ====== [2023-04-20T01:57:18.052Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2023-04-20T01:57:18.052Z] GC before operation: completed in 246.032 ms, heap usage 249.809 MB -> 59.212 MB. [2023-04-20T01:57:19.626Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1779.666 ms) ====== [2023-04-20T01:57:19.626Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2023-04-20T01:57:20.391Z] GC before operation: completed in 224.638 ms, heap usage 251.639 MB -> 59.327 MB. [2023-04-20T01:57:21.973Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1699.647 ms) ====== [2023-04-20T01:57:21.973Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2023-04-20T01:57:21.973Z] GC before operation: completed in 317.331 ms, heap usage 247.923 MB -> 59.459 MB. [2023-04-20T01:57:23.563Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1651.353 ms) ====== [2023-04-20T01:57:23.563Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2023-04-20T01:57:24.333Z] GC before operation: completed in 197.730 ms, heap usage 244.096 MB -> 59.739 MB. [2023-04-20T01:57:25.908Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1692.026 ms) ====== [2023-04-20T01:57:25.908Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2023-04-20T01:57:25.908Z] GC before operation: completed in 245.894 ms, heap usage 250.127 MB -> 87.327 MB. [2023-04-20T01:57:27.483Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1691.295 ms) ====== [2023-04-20T01:57:27.483Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2023-04-20T01:57:28.246Z] GC before operation: completed in 285.447 ms, heap usage 289.378 MB -> 59.860 MB. [2023-04-20T01:57:29.825Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1666.758 ms) ====== [2023-04-20T01:57:29.825Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2023-04-20T01:57:29.825Z] GC before operation: completed in 272.052 ms, heap usage 252.582 MB -> 59.975 MB. [2023-04-20T01:57:31.403Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1696.020 ms) ====== [2023-04-20T01:57:31.403Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2023-04-20T01:57:32.165Z] GC before operation: completed in 259.756 ms, heap usage 250.379 MB -> 60.256 MB. [2023-04-20T01:57:33.740Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1688.025 ms) ====== [2023-04-20T01:57:33.740Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2023-04-20T01:57:33.740Z] GC before operation: completed in 278.619 ms, heap usage 248.191 MB -> 60.241 MB. [2023-04-20T01:57:35.319Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1621.453 ms) ====== [2023-04-20T01:57:35.319Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2023-04-20T01:57:35.319Z] GC before operation: completed in 224.855 ms, heap usage 248.783 MB -> 60.371 MB. [2023-04-20T01:57:37.775Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1658.945 ms) ====== [2023-04-20T01:57:37.775Z] ----------------------------------- [2023-04-20T01:57:37.775Z] renaissance-dec-tree_0_PASSED [2023-04-20T01:57:37.775Z] ----------------------------------- [2023-04-20T01:57:37.775Z] [2023-04-20T01:57:37.775Z] TEST TEARDOWN: [2023-04-20T01:57:37.775Z] Nothing to be done for teardown. [2023-04-20T01:57:37.775Z] renaissance-dec-tree_0 Finish Time: Thu Apr 20 02:08:25 2023 Epoch Time (ms): 1681956505615