[2024-08-16T21:19:06.359Z] Running test renaissance-dec-tree_0 ... [2024-08-16T21:19:06.359Z] =============================================== [2024-08-16T21:19:06.359Z] renaissance-dec-tree_0 Start Time: Fri Aug 16 16:19:06 2024 Epoch Time (ms): 1723843146310 [2024-08-16T21:19:07.038Z] variation: NoOptions [2024-08-16T21:19:07.038Z] JVM_OPTIONS: [2024-08-16T21:19:07.038Z] { \ [2024-08-16T21:19:07.038Z] echo ""; echo "TEST SETUP:"; \ [2024-08-16T21:19:07.038Z] echo "Nothing to be done for setup."; \ [2024-08-16T21:19:07.038Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17238428998059/renaissance-dec-tree_0"; \ [2024-08-16T21:19:07.038Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17238428998059/renaissance-dec-tree_0"; \ [2024-08-16T21:19:07.038Z] echo ""; echo "TESTING:"; \ [2024-08-16T21:19:07.038Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+3/bin/..//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_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17238428998059/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-16T21:19:07.038Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17238428998059/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-16T21:19:07.038Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-16T21:19:07.038Z] echo "Nothing to be done for teardown."; \ [2024-08-16T21:19:07.038Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17238428998059/TestTargetResult"; [2024-08-16T21:19:07.038Z] [2024-08-16T21:19:07.038Z] TEST SETUP: [2024-08-16T21:19:07.038Z] Nothing to be done for setup. [2024-08-16T21:19:07.038Z] [2024-08-16T21:19:07.038Z] TESTING: [2024-08-16T21:19:09.234Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-16T21:19:11.436Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-16T21:19:14.485Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-16T21:19:14.485Z] GC before operation: completed in 88.458 ms, heap usage 90.305 MB -> 35.687 MB. [2024-08-16T21:19:22.085Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7471.231 ms) ====== [2024-08-16T21:19:22.085Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-16T21:19:22.085Z] GC before operation: completed in 71.925 ms, heap usage 232.414 MB -> 65.349 MB. [2024-08-16T21:19:23.503Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1819.171 ms) ====== [2024-08-16T21:19:23.503Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-16T21:19:23.503Z] GC before operation: completed in 88.023 ms, heap usage 159.861 MB -> 65.331 MB. [2024-08-16T21:19:25.702Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1562.873 ms) ====== [2024-08-16T21:19:25.702Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-16T21:19:25.702Z] GC before operation: completed in 67.343 ms, heap usage 217.698 MB -> 65.891 MB. [2024-08-16T21:19:27.117Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1387.544 ms) ====== [2024-08-16T21:19:27.118Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-16T21:19:27.118Z] GC before operation: completed in 78.375 ms, heap usage 323.477 MB -> 66.623 MB. [2024-08-16T21:19:28.530Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1412.102 ms) ====== [2024-08-16T21:19:28.530Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-16T21:19:28.530Z] GC before operation: completed in 75.641 ms, heap usage 290.987 MB -> 66.526 MB. [2024-08-16T21:19:29.936Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1469.382 ms) ====== [2024-08-16T21:19:29.936Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-16T21:19:29.936Z] GC before operation: completed in 84.370 ms, heap usage 304.602 MB -> 77.484 MB. [2024-08-16T21:19:31.348Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1449.977 ms) ====== [2024-08-16T21:19:31.348Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-16T21:19:31.348Z] GC before operation: completed in 92.226 ms, heap usage 427.301 MB -> 78.131 MB. [2024-08-16T21:19:32.757Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1355.969 ms) ====== [2024-08-16T21:19:32.757Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-16T21:19:32.757Z] GC before operation: completed in 97.579 ms, heap usage 420.223 MB -> 78.286 MB. [2024-08-16T21:19:34.166Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1558.917 ms) ====== [2024-08-16T21:19:34.167Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-16T21:19:34.848Z] GC before operation: completed in 110.481 ms, heap usage 426.236 MB -> 89.346 MB. [2024-08-16T21:19:36.254Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1670.216 ms) ====== [2024-08-16T21:19:36.255Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-16T21:19:36.255Z] GC before operation: completed in 98.752 ms, heap usage 309.052 MB -> 94.856 MB. [2024-08-16T21:19:37.660Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1321.867 ms) ====== [2024-08-16T21:19:37.660Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-16T21:19:37.660Z] GC before operation: completed in 1.053 ms, heap usage 278.336 MB -> 278.336 MB. [2024-08-16T21:19:39.070Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1259.015 ms) ====== [2024-08-16T21:19:39.070Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-16T21:19:39.070Z] GC before operation: completed in 91.954 ms, heap usage 246.279 MB -> 83.952 MB. [2024-08-16T21:19:40.482Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1394.322 ms) ====== [2024-08-16T21:19:40.482Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-16T21:19:40.482Z] GC before operation: completed in 103.824 ms, heap usage 418.524 MB -> 83.895 MB. [2024-08-16T21:19:41.891Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1305.203 ms) ====== [2024-08-16T21:19:41.892Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-16T21:19:41.892Z] GC before operation: completed in 110.898 ms, heap usage 363.791 MB -> 89.663 MB. [2024-08-16T21:19:43.302Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1366.657 ms) ====== [2024-08-16T21:19:43.302Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-16T21:19:43.303Z] GC before operation: completed in 93.447 ms, heap usage 291.154 MB -> 95.491 MB. [2024-08-16T21:19:44.711Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1345.947 ms) ====== [2024-08-16T21:19:44.711Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-16T21:19:44.711Z] GC before operation: completed in 90.942 ms, heap usage 269.232 MB -> 67.978 MB. [2024-08-16T21:19:46.118Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1254.823 ms) ====== [2024-08-16T21:19:46.118Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-16T21:19:46.118Z] GC before operation: completed in 103.860 ms, heap usage 382.751 MB -> 84.560 MB. [2024-08-16T21:19:47.526Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1290.100 ms) ====== [2024-08-16T21:19:47.526Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-16T21:19:47.526Z] GC before operation: completed in 120.825 ms, heap usage 330.431 MB -> 84.847 MB. [2024-08-16T21:19:49.724Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1682.265 ms) ====== [2024-08-16T21:19:49.724Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-16T21:19:49.724Z] GC before operation: completed in 103.309 ms, heap usage 334.924 MB -> 95.954 MB. [2024-08-16T21:19:49.724Z] 24/08/16 16:19:49 WARN BlockManager: Asked to remove block rdd_928_2, which does not exist [2024-08-16T21:19:50.410Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1229.357 ms) ====== [2024-08-16T21:19:50.410Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-16T21:19:50.410Z] GC before operation: completed in 114.214 ms, heap usage 251.893 MB -> 90.506 MB. [2024-08-16T21:19:51.820Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1382.189 ms) ====== [2024-08-16T21:19:51.820Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-16T21:19:52.501Z] GC before operation: completed in 88.443 ms, heap usage 334.553 MB -> 68.449 MB. [2024-08-16T21:19:53.909Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1526.808 ms) ====== [2024-08-16T21:19:53.909Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-16T21:19:53.909Z] GC before operation: completed in 102.709 ms, heap usage 263.032 MB -> 68.520 MB. [2024-08-16T21:19:55.316Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1614.267 ms) ====== [2024-08-16T21:19:55.316Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-16T21:19:55.316Z] GC before operation: completed in 123.469 ms, heap usage 267.458 MB -> 90.858 MB. [2024-08-16T21:19:56.730Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1309.003 ms) ====== [2024-08-16T21:19:56.730Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-16T21:19:56.730Z] GC before operation: completed in 103.359 ms, heap usage 311.217 MB -> 74.340 MB. [2024-08-16T21:19:58.148Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1258.745 ms) ====== [2024-08-16T21:19:58.148Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-16T21:19:58.148Z] GC before operation: completed in 119.494 ms, heap usage 190.461 MB -> 79.756 MB. [2024-08-16T21:19:59.557Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1230.171 ms) ====== [2024-08-16T21:19:59.557Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-16T21:19:59.557Z] GC before operation: completed in 105.724 ms, heap usage 431.613 MB -> 90.971 MB. [2024-08-16T21:20:01.072Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1292.965 ms) ====== [2024-08-16T21:20:01.072Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-16T21:20:01.072Z] GC before operation: completed in 110.758 ms, heap usage 287.574 MB -> 96.743 MB. [2024-08-16T21:20:02.478Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1299.732 ms) ====== [2024-08-16T21:20:02.478Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-16T21:20:02.478Z] GC before operation: completed in 102.084 ms, heap usage 264.331 MB -> 74.730 MB. [2024-08-16T21:20:03.881Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1319.408 ms) ====== [2024-08-16T21:20:03.881Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-16T21:20:03.881Z] GC before operation: completed in 102.026 ms, heap usage 208.729 MB -> 91.455 MB. [2024-08-16T21:20:05.287Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1231.007 ms) ====== [2024-08-16T21:20:05.287Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-16T21:20:05.287Z] GC before operation: completed in 111.011 ms, heap usage 322.725 MB -> 91.566 MB. [2024-08-16T21:20:06.727Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1370.514 ms) ====== [2024-08-16T21:20:06.727Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-16T21:20:06.727Z] GC before operation: completed in 122.500 ms, heap usage 297.987 MB -> 80.767 MB. [2024-08-16T21:20:08.131Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1297.565 ms) ====== [2024-08-16T21:20:08.131Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-16T21:20:08.131Z] GC before operation: completed in 117.615 ms, heap usage 434.425 MB -> 97.227 MB. [2024-08-16T21:20:08.131Z] 24/08/16 16:20:07 WARN BlockManager: Asked to remove block rdd_1565_1, which does not exist [2024-08-16T21:20:08.131Z] 24/08/16 16:20:07 WARN BlockManager: Asked to remove block rdd_1565_2, which does not exist [2024-08-16T21:20:09.542Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1297.360 ms) ====== [2024-08-16T21:20:09.542Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-16T21:20:09.542Z] GC before operation: completed in 109.096 ms, heap usage 232.820 MB -> 86.176 MB. [2024-08-16T21:20:10.954Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1276.860 ms) ====== [2024-08-16T21:20:10.954Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-16T21:20:10.954Z] GC before operation: completed in 124.951 ms, heap usage 354.009 MB -> 97.308 MB. [2024-08-16T21:20:12.359Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1344.942 ms) ====== [2024-08-16T21:20:12.359Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-16T21:20:12.359Z] GC before operation: completed in 105.732 ms, heap usage 256.517 MB -> 69.883 MB. [2024-08-16T21:20:13.780Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1382.856 ms) ====== [2024-08-16T21:20:13.780Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-16T21:20:13.780Z] GC before operation: completed in 108.932 ms, heap usage 355.374 MB -> 97.594 MB. [2024-08-16T21:20:15.188Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1326.704 ms) ====== [2024-08-16T21:20:15.188Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-16T21:20:15.188Z] GC before operation: completed in 119.054 ms, heap usage 247.922 MB -> 70.507 MB. [2024-08-16T21:20:16.598Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1331.586 ms) ====== [2024-08-16T21:20:16.598Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-16T21:20:16.598Z] GC before operation: completed in 125.871 ms, heap usage 343.260 MB -> 97.795 MB. [2024-08-16T21:20:18.796Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1613.753 ms) ====== [2024-08-16T21:20:18.796Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-16T21:20:18.796Z] GC before operation: completed in 114.201 ms, heap usage 246.487 MB -> 81.551 MB. [2024-08-16T21:20:20.205Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1346.941 ms) ====== [2024-08-16T21:20:20.206Z] ----------------------------------- [2024-08-16T21:20:20.206Z] renaissance-dec-tree_0_PASSED [2024-08-16T21:20:20.206Z] ----------------------------------- [2024-08-16T21:20:20.206Z] [2024-08-16T21:20:20.206Z] TEST TEARDOWN: [2024-08-16T21:20:20.206Z] Nothing to be done for teardown. [2024-08-16T21:20:20.206Z] renaissance-dec-tree_0 Finish Time: Fri Aug 16 16:20:20 2024 Epoch Time (ms): 1723843220044