[2023-04-19T09:51:14.837Z] Running test renaissance-dec-tree_0 ... [2023-04-19T09:51:14.837Z] =============================================== [2023-04-19T09:51:14.837Z] renaissance-dec-tree_0 Start Time: Wed Apr 19 10:51:14 2023 Epoch Time (ms): 1681897874736 [2023-04-19T09:51:14.838Z] variation: NoOptions [2023-04-19T09:51:14.838Z] JVM_OPTIONS: [2023-04-19T09:51:14.838Z] { \ [2023-04-19T09:51:14.838Z] echo ""; echo "TEST SETUP:"; \ [2023-04-19T09:51:14.838Z] echo "Nothing to be done for setup."; \ [2023-04-19T09:51:14.838Z] mkdir -p "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-dec-tree_0"; \ [2023-04-19T09:51:14.838Z] cd "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-dec-tree_0"; \ [2023-04-19T09:51:14.838Z] echo ""; echo "TESTING:"; \ [2023-04-19T09:51:14.838Z] "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/openjdkbinary/j2sdk-image/bin/java" -jar "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2023-04-19T09:51:14.838Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/..; rm -f -r "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-19T09:51:14.838Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-19T09:51:14.838Z] echo "Nothing to be done for teardown."; \ [2023-04-19T09:51:14.838Z] } 2>&1 | tee -a "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/TestTargetResult"; [2023-04-19T09:51:14.838Z] [2023-04-19T09:51:14.838Z] TEST SETUP: [2023-04-19T09:51:14.838Z] Nothing to be done for setup. [2023-04-19T09:51:14.838Z] [2023-04-19T09:51:14.838Z] TESTING: [2023-04-19T09:51:17.776Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2023-04-19T09:51:18.919Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2023-04-19T09:51:21.864Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2023-04-19T09:51:21.864Z] GC before operation: completed in 138.541 ms, heap usage 56.973 MB -> 24.865 MB. [2023-04-19T09:51:27.752Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (5436.311 ms) ====== [2023-04-19T09:51:27.753Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2023-04-19T09:51:27.753Z] GC before operation: completed in 239.920 ms, heap usage 734.172 MB -> 57.153 MB. [2023-04-19T09:51:28.899Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1481.404 ms) ====== [2023-04-19T09:51:28.899Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2023-04-19T09:51:29.227Z] GC before operation: completed in 251.299 ms, heap usage 625.938 MB -> 56.878 MB. [2023-04-19T09:51:31.478Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1993.272 ms) ====== [2023-04-19T09:51:31.478Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2023-04-19T09:51:31.478Z] GC before operation: completed in 184.285 ms, heap usage 272.284 MB -> 57.029 MB. [2023-04-19T09:51:32.622Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1156.499 ms) ====== [2023-04-19T09:51:32.622Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2023-04-19T09:51:32.622Z] GC before operation: completed in 162.676 ms, heap usage 237.994 MB -> 74.166 MB. [2023-04-19T09:51:33.767Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1128.828 ms) ====== [2023-04-19T09:51:33.767Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2023-04-19T09:51:33.767Z] GC before operation: completed in 166.968 ms, heap usage 258.181 MB -> 68.281 MB. [2023-04-19T09:51:34.913Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1095.940 ms) ====== [2023-04-19T09:51:34.913Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2023-04-19T09:51:35.242Z] GC before operation: completed in 207.944 ms, heap usage 282.699 MB -> 63.117 MB. [2023-04-19T09:51:36.388Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1152.300 ms) ====== [2023-04-19T09:51:36.388Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2023-04-19T09:51:36.388Z] GC before operation: completed in 167.331 ms, heap usage 256.317 MB -> 68.808 MB. [2023-04-19T09:51:37.535Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1069.582 ms) ====== [2023-04-19T09:51:37.535Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2023-04-19T09:51:37.861Z] GC before operation: completed in 171.694 ms, heap usage 248.723 MB -> 69.044 MB. [2023-04-19T09:51:39.001Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1043.132 ms) ====== [2023-04-19T09:51:39.002Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2023-04-19T09:51:39.002Z] GC before operation: completed in 265.081 ms, heap usage 252.450 MB -> 85.861 MB. [2023-04-19T09:51:40.145Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1026.539 ms) ====== [2023-04-19T09:51:40.145Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2023-04-19T09:51:40.145Z] GC before operation: completed in 136.713 ms, heap usage 273.748 MB -> 85.985 MB. [2023-04-19T09:51:40.145Z] 23/04/19 10:51:40 WARN BlockManager: Asked to remove block rdd_487_2, which does not exist [2023-04-19T09:51:40.145Z] 23/04/19 10:51:40 WARN BlockManager: Asked to remove block rdd_487_1, which does not exist [2023-04-19T09:51:41.292Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1021.697 ms) ====== [2023-04-19T09:51:41.292Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2023-04-19T09:51:41.292Z] GC before operation: completed in 178.423 ms, heap usage 258.730 MB -> 86.173 MB. [2023-04-19T09:51:42.623Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1058.735 ms) ====== [2023-04-19T09:51:42.623Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2023-04-19T09:51:42.623Z] GC before operation: completed in 180.974 ms, heap usage 258.262 MB -> 86.321 MB. [2023-04-19T09:51:42.623Z] 23/04/19 10:51:42 WARN BlockManager: Asked to remove block rdd_585_1, which does not exist [2023-04-19T09:51:43.763Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1089.991 ms) ====== [2023-04-19T09:51:43.763Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2023-04-19T09:51:43.763Z] GC before operation: completed in 168.509 ms, heap usage 264.752 MB -> 75.353 MB. [2023-04-19T09:51:44.911Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1008.713 ms) ====== [2023-04-19T09:51:44.911Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2023-04-19T09:51:45.238Z] GC before operation: completed in 165.319 ms, heap usage 263.464 MB -> 81.185 MB. [2023-04-19T09:51:46.383Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1062.633 ms) ====== [2023-04-19T09:51:46.383Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2023-04-19T09:51:46.384Z] GC before operation: completed in 150.872 ms, heap usage 247.917 MB -> 75.815 MB. [2023-04-19T09:51:47.528Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1071.245 ms) ====== [2023-04-19T09:51:47.528Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2023-04-19T09:51:47.528Z] GC before operation: completed in 191.254 ms, heap usage 251.846 MB -> 59.477 MB. [2023-04-19T09:51:48.671Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1109.374 ms) ====== [2023-04-19T09:51:48.672Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2023-04-19T09:51:48.998Z] GC before operation: completed in 187.706 ms, heap usage 223.479 MB -> 59.519 MB. [2023-04-19T09:51:50.139Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1073.113 ms) ====== [2023-04-19T09:51:50.139Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2023-04-19T09:51:50.139Z] GC before operation: completed in 162.277 ms, heap usage 228.128 MB -> 70.645 MB. [2023-04-19T09:51:51.282Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1174.797 ms) ====== [2023-04-19T09:51:51.282Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2023-04-19T09:51:51.607Z] GC before operation: completed in 212.105 ms, heap usage 230.303 MB -> 70.640 MB. [2023-04-19T09:51:52.748Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1196.929 ms) ====== [2023-04-19T09:51:52.748Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2023-04-19T09:51:52.749Z] GC before operation: completed in 215.899 ms, heap usage 221.324 MB -> 76.403 MB. [2023-04-19T09:51:53.894Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1122.568 ms) ====== [2023-04-19T09:51:53.894Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2023-04-19T09:51:54.220Z] GC before operation: completed in 177.808 ms, heap usage 233.025 MB -> 76.738 MB. [2023-04-19T09:51:54.220Z] 23/04/19 10:51:54 WARN BlockManager: Asked to remove block rdd_1026_0, which does not exist [2023-04-19T09:51:55.366Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1151.371 ms) ====== [2023-04-19T09:51:55.366Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2023-04-19T09:51:55.698Z] GC before operation: completed in 209.726 ms, heap usage 241.449 MB -> 76.655 MB. [2023-04-19T09:51:55.698Z] 23/04/19 10:51:55 WARN BlockManager: Asked to remove block rdd_1075_0, which does not exist [2023-04-19T09:51:55.698Z] 23/04/19 10:51:55 WARN BlockManager: Asked to remove block rdd_1075_2, which does not exist [2023-04-19T09:51:56.849Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1162.033 ms) ====== [2023-04-19T09:51:56.849Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2023-04-19T09:51:56.849Z] GC before operation: completed in 171.585 ms, heap usage 233.798 MB -> 82.267 MB. [2023-04-19T09:51:57.996Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1165.560 ms) ====== [2023-04-19T09:51:57.996Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2023-04-19T09:51:58.326Z] GC before operation: completed in 188.754 ms, heap usage 243.284 MB -> 88.004 MB. [2023-04-19T09:51:59.469Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1174.560 ms) ====== [2023-04-19T09:51:59.469Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2023-04-19T09:51:59.469Z] GC before operation: completed in 195.860 ms, heap usage 246.128 MB -> 71.438 MB. [2023-04-19T09:52:00.614Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1087.986 ms) ====== [2023-04-19T09:52:00.614Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2023-04-19T09:52:00.940Z] GC before operation: completed in 150.354 ms, heap usage 225.905 MB -> 88.266 MB. [2023-04-19T09:52:02.078Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1050.108 ms) ====== [2023-04-19T09:52:02.078Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2023-04-19T09:52:02.078Z] GC before operation: completed in 205.092 ms, heap usage 238.921 MB -> 77.306 MB. [2023-04-19T09:52:02.078Z] 23/04/19 10:52:01 WARN BlockManager: Asked to remove block rdd_1320_1, which does not exist [2023-04-19T09:52:03.222Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1060.833 ms) ====== [2023-04-19T09:52:03.222Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2023-04-19T09:52:03.222Z] GC before operation: completed in 162.479 ms, heap usage 233.492 MB -> 77.658 MB. [2023-04-19T09:52:04.363Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1012.862 ms) ====== [2023-04-19T09:52:04.363Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2023-04-19T09:52:04.363Z] GC before operation: completed in 154.880 ms, heap usage 240.544 MB -> 72.129 MB. [2023-04-19T09:52:05.518Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1108.537 ms) ====== [2023-04-19T09:52:05.518Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2023-04-19T09:52:05.844Z] GC before operation: completed in 130.296 ms, heap usage 232.635 MB -> 72.105 MB. [2023-04-19T09:52:06.984Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1093.456 ms) ====== [2023-04-19T09:52:06.985Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2023-04-19T09:52:06.985Z] GC before operation: completed in 152.293 ms, heap usage 229.205 MB -> 83.281 MB. [2023-04-19T09:52:08.127Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1092.771 ms) ====== [2023-04-19T09:52:08.127Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2023-04-19T09:52:08.127Z] GC before operation: completed in 168.382 ms, heap usage 240.638 MB -> 72.564 MB. [2023-04-19T09:52:09.273Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1035.145 ms) ====== [2023-04-19T09:52:09.273Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2023-04-19T09:52:09.602Z] GC before operation: completed in 181.184 ms, heap usage 233.846 MB -> 89.185 MB. [2023-04-19T09:52:10.743Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1045.323 ms) ====== [2023-04-19T09:52:10.743Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2023-04-19T09:52:10.743Z] GC before operation: completed in 168.987 ms, heap usage 240.679 MB -> 89.322 MB. [2023-04-19T09:52:11.889Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1020.050 ms) ====== [2023-04-19T09:52:11.889Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2023-04-19T09:52:11.889Z] GC before operation: completed in 151.335 ms, heap usage 242.188 MB -> 72.936 MB. [2023-04-19T09:52:13.029Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1001.240 ms) ====== [2023-04-19T09:52:13.029Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2023-04-19T09:52:13.029Z] GC before operation: completed in 154.123 ms, heap usage 229.713 MB -> 62.167 MB. [2023-04-19T09:52:14.165Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1025.780 ms) ====== [2023-04-19T09:52:14.165Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2023-04-19T09:52:14.165Z] GC before operation: completed in 170.870 ms, heap usage 211.597 MB -> 89.752 MB. [2023-04-19T09:52:15.299Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1007.831 ms) ====== [2023-04-19T09:52:15.299Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2023-04-19T09:52:15.299Z] GC before operation: completed in 140.162 ms, heap usage 253.728 MB -> 78.594 MB. [2023-04-19T09:52:15.299Z] 23/04/19 10:52:15 WARN BlockManager: Asked to remove block rdd_1859_0, which does not exist [2023-04-19T09:52:15.299Z] 23/04/19 10:52:15 WARN BlockManager: Asked to remove block rdd_1859_2, which does not exist [2023-04-19T09:52:16.432Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1003.238 ms) ====== [2023-04-19T09:52:16.432Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2023-04-19T09:52:16.432Z] GC before operation: completed in 144.927 ms, heap usage 233.283 MB -> 79.092 MB. [2023-04-19T09:52:17.570Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1024.161 ms) ====== [2023-04-19T09:52:17.895Z] ----------------------------------- [2023-04-19T09:52:17.895Z] renaissance-dec-tree_0_PASSED [2023-04-19T09:52:17.895Z] ----------------------------------- [2023-04-19T09:52:17.895Z] [2023-04-19T09:52:17.895Z] TEST TEARDOWN: [2023-04-19T09:52:17.895Z] Nothing to be done for teardown. [2023-04-19T09:52:17.895Z] renaissance-dec-tree_0 Finish Time: Wed Apr 19 10:52:17 2023 Epoch Time (ms): 1681897937840