[2024-09-05T21:01:49.911Z] Running test renaissance-dec-tree_0 ... [2024-09-05T21:01:49.911Z] =============================================== [2024-09-05T21:01:49.911Z] renaissance-dec-tree_0 Start Time: Thu Sep 5 21:01:49 2024 Epoch Time (ms): 1725570109669 [2024-09-05T21:01:49.911Z] variation: NoOptions [2024-09-05T21:01:49.911Z] JVM_OPTIONS: [2024-09-05T21:01:49.911Z] { \ [2024-09-05T21:01:49.911Z] echo ""; echo "TEST SETUP:"; \ [2024-09-05T21:01:49.911Z] echo "Nothing to be done for setup."; \ [2024-09-05T21:01:49.911Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17255696153005/renaissance-dec-tree_0"; \ [2024-09-05T21:01:49.911Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17255696153005/renaissance-dec-tree_0"; \ [2024-09-05T21:01:49.911Z] echo ""; echo "TESTING:"; \ [2024-09-05T21:01:49.911Z] "/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_17255696153005/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-05T21:01:49.912Z] 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_17255696153005/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-05T21:01:49.912Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-05T21:01:49.912Z] echo "Nothing to be done for teardown."; \ [2024-09-05T21:01:49.912Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17255696153005/TestTargetResult"; [2024-09-05T21:01:49.912Z] [2024-09-05T21:01:49.912Z] TEST SETUP: [2024-09-05T21:01:49.912Z] Nothing to be done for setup. [2024-09-05T21:01:49.912Z] [2024-09-05T21:01:49.912Z] TESTING: [2024-09-05T21:01:55.406Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-05T21:01:58.764Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-09-05T21:02:05.498Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-05T21:02:05.498Z] GC before operation: completed in 270.164 ms, heap usage 91.453 MB -> 26.308 MB. [2024-09-05T21:02:19.071Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (13321.223 ms) ====== [2024-09-05T21:02:19.071Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-05T21:02:19.071Z] GC before operation: completed in 428.694 ms, heap usage 155.074 MB -> 53.897 MB. [2024-09-05T21:02:22.425Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2993.218 ms) ====== [2024-09-05T21:02:22.426Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-05T21:02:22.426Z] GC before operation: completed in 347.490 ms, heap usage 83.260 MB -> 54.489 MB. [2024-09-05T21:02:24.853Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2451.230 ms) ====== [2024-09-05T21:02:24.853Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-05T21:02:25.610Z] GC before operation: completed in 250.455 ms, heap usage 324.869 MB -> 55.051 MB. [2024-09-05T21:02:28.080Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2326.481 ms) ====== [2024-09-05T21:02:28.080Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-05T21:02:28.080Z] GC before operation: completed in 281.256 ms, heap usage 290.850 MB -> 55.174 MB. [2024-09-05T21:02:30.495Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2236.690 ms) ====== [2024-09-05T21:02:30.495Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-05T21:02:30.495Z] GC before operation: completed in 236.248 ms, heap usage 247.692 MB -> 55.565 MB. [2024-09-05T21:02:32.910Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2110.647 ms) ====== [2024-09-05T21:02:32.910Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-05T21:02:32.910Z] GC before operation: completed in 233.074 ms, heap usage 246.849 MB -> 55.805 MB. [2024-09-05T21:02:35.362Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2160.196 ms) ====== [2024-09-05T21:02:35.362Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-05T21:02:35.362Z] GC before operation: completed in 279.280 ms, heap usage 242.342 MB -> 55.876 MB. [2024-09-05T21:02:36.928Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1979.780 ms) ====== [2024-09-05T21:02:36.928Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-05T21:02:37.681Z] GC before operation: completed in 247.576 ms, heap usage 245.458 MB -> 56.050 MB. [2024-09-05T21:02:39.248Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1928.953 ms) ====== [2024-09-05T21:02:39.248Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-05T21:02:39.248Z] GC before operation: completed in 236.935 ms, heap usage 239.940 MB -> 56.342 MB. [2024-09-05T21:02:41.664Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2022.777 ms) ====== [2024-09-05T21:02:41.664Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-05T21:02:41.664Z] GC before operation: completed in 281.658 ms, heap usage 249.768 MB -> 56.545 MB. [2024-09-05T21:02:44.085Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1887.120 ms) ====== [2024-09-05T21:02:44.085Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-05T21:02:44.085Z] GC before operation: completed in 277.119 ms, heap usage 242.300 MB -> 56.757 MB. [2024-09-05T21:02:45.647Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1869.353 ms) ====== [2024-09-05T21:02:45.647Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-05T21:02:46.399Z] GC before operation: completed in 295.839 ms, heap usage 246.296 MB -> 56.840 MB. [2024-09-05T21:02:47.952Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1860.747 ms) ====== [2024-09-05T21:02:47.952Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-05T21:02:48.704Z] GC before operation: completed in 307.262 ms, heap usage 245.272 MB -> 56.830 MB. [2024-09-05T21:02:50.264Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1769.221 ms) ====== [2024-09-05T21:02:50.264Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-05T21:02:50.264Z] GC before operation: completed in 270.138 ms, heap usage 245.658 MB -> 57.138 MB. [2024-09-05T21:02:52.691Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1775.910 ms) ====== [2024-09-05T21:02:52.691Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-05T21:02:52.691Z] GC before operation: completed in 279.127 ms, heap usage 241.354 MB -> 57.280 MB. [2024-09-05T21:02:54.243Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1784.572 ms) ====== [2024-09-05T21:02:54.243Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-05T21:02:54.243Z] GC before operation: completed in 269.810 ms, heap usage 247.832 MB -> 57.453 MB. [2024-09-05T21:02:56.672Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1739.099 ms) ====== [2024-09-05T21:02:56.672Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-05T21:02:56.672Z] GC before operation: completed in 262.301 ms, heap usage 248.302 MB -> 57.644 MB. [2024-09-05T21:02:58.223Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1749.815 ms) ====== [2024-09-05T21:02:58.223Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-05T21:02:58.223Z] GC before operation: completed in 245.161 ms, heap usage 247.570 MB -> 57.721 MB. [2024-09-05T21:03:00.637Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1817.216 ms) ====== [2024-09-05T21:03:00.637Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-05T21:03:00.637Z] GC before operation: completed in 234.251 ms, heap usage 247.011 MB -> 57.859 MB. [2024-09-05T21:03:02.195Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1758.465 ms) ====== [2024-09-05T21:03:02.195Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-05T21:03:02.948Z] GC before operation: completed in 243.246 ms, heap usage 246.093 MB -> 58.208 MB. [2024-09-05T21:03:04.499Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1830.212 ms) ====== [2024-09-05T21:03:04.499Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-05T21:03:04.499Z] GC before operation: completed in 195.663 ms, heap usage 246.359 MB -> 58.107 MB. [2024-09-05T21:03:06.909Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1776.787 ms) ====== [2024-09-05T21:03:06.909Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-05T21:03:06.909Z] GC before operation: completed in 256.817 ms, heap usage 244.783 MB -> 58.096 MB. [2024-09-05T21:03:08.462Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1713.490 ms) ====== [2024-09-05T21:03:08.462Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-05T21:03:08.462Z] GC before operation: completed in 240.529 ms, heap usage 245.761 MB -> 58.635 MB. [2024-09-05T21:03:10.889Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1750.781 ms) ====== [2024-09-05T21:03:10.889Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-05T21:03:10.889Z] GC before operation: completed in 219.677 ms, heap usage 248.196 MB -> 58.368 MB. [2024-09-05T21:03:12.448Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1712.884 ms) ====== [2024-09-05T21:03:12.448Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-05T21:03:12.448Z] GC before operation: completed in 237.612 ms, heap usage 245.487 MB -> 58.654 MB. [2024-09-05T21:03:14.005Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1721.233 ms) ====== [2024-09-05T21:03:14.005Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-05T21:03:14.755Z] GC before operation: completed in 286.385 ms, heap usage 251.972 MB -> 58.680 MB. [2024-09-05T21:03:16.318Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1665.433 ms) ====== [2024-09-05T21:03:16.318Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-05T21:03:16.318Z] GC before operation: completed in 228.201 ms, heap usage 245.707 MB -> 58.963 MB. [2024-09-05T21:03:17.871Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1661.160 ms) ====== [2024-09-05T21:03:17.871Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-05T21:03:18.630Z] GC before operation: completed in 293.561 ms, heap usage 247.725 MB -> 58.948 MB. [2024-09-05T21:03:20.196Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1617.662 ms) ====== [2024-09-05T21:03:20.196Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-05T21:03:20.196Z] GC before operation: completed in 1.399 ms, heap usage 246.907 MB -> 246.925 MB. [2024-09-05T21:03:21.753Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1674.473 ms) ====== [2024-09-05T21:03:21.753Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-05T21:03:21.753Z] GC before operation: completed in 263.646 ms, heap usage 248.759 MB -> 59.841 MB. [2024-09-05T21:03:24.186Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1698.219 ms) ====== [2024-09-05T21:03:24.186Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-05T21:03:24.186Z] GC before operation: completed in 241.825 ms, heap usage 246.653 MB -> 59.335 MB. [2024-09-05T21:03:25.740Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1642.156 ms) ====== [2024-09-05T21:03:25.740Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-05T21:03:25.740Z] GC before operation: completed in 262.470 ms, heap usage 245.200 MB -> 59.615 MB. [2024-09-05T21:03:27.299Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1762.248 ms) ====== [2024-09-05T21:03:27.299Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-05T21:03:28.052Z] GC before operation: completed in 245.639 ms, heap usage 247.445 MB -> 59.744 MB. [2024-09-05T21:03:29.611Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1649.038 ms) ====== [2024-09-05T21:03:29.611Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-05T21:03:29.611Z] GC before operation: completed in 274.182 ms, heap usage 249.147 MB -> 59.875 MB. [2024-09-05T21:03:32.034Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1762.119 ms) ====== [2024-09-05T21:03:32.034Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-05T21:03:32.034Z] GC before operation: completed in 231.669 ms, heap usage 242.470 MB -> 60.018 MB. [2024-09-05T21:03:33.594Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1640.828 ms) ====== [2024-09-05T21:03:33.594Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-05T21:03:33.594Z] GC before operation: completed in 264.228 ms, heap usage 250.585 MB -> 59.983 MB. [2024-09-05T21:03:35.163Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1648.028 ms) ====== [2024-09-05T21:03:35.163Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-05T21:03:35.917Z] GC before operation: completed in 299.389 ms, heap usage 246.255 MB -> 60.263 MB. [2024-09-05T21:03:37.643Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1679.189 ms) ====== [2024-09-05T21:03:37.643Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-05T21:03:37.643Z] GC before operation: completed in 241.098 ms, heap usage 251.086 MB -> 60.393 MB. [2024-09-05T21:03:39.207Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1725.158 ms) ====== [2024-09-05T21:03:39.207Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-05T21:03:39.207Z] GC before operation: completed in 249.988 ms, heap usage 247.901 MB -> 60.517 MB. [2024-09-05T21:03:41.653Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1714.950 ms) ====== [2024-09-05T21:03:41.653Z] ----------------------------------- [2024-09-05T21:03:41.653Z] renaissance-dec-tree_0_PASSED [2024-09-05T21:03:41.653Z] ----------------------------------- [2024-09-05T21:03:41.653Z] [2024-09-05T21:03:41.653Z] TEST TEARDOWN: [2024-09-05T21:03:41.653Z] Nothing to be done for teardown. [2024-09-05T21:03:41.653Z] renaissance-dec-tree_0 Finish Time: Thu Sep 5 21:03:41 2024 Epoch Time (ms): 1725570221480