[2024-08-01T05:29:05.779Z] Running test renaissance-dec-tree_0 ... [2024-08-01T05:29:05.779Z] =============================================== [2024-08-01T05:29:05.779Z] renaissance-dec-tree_0 Start Time: Thu Aug 1 05:29:05 2024 Epoch Time (ms): 1722490145372 [2024-08-01T05:29:05.779Z] variation: NoOptions [2024-08-01T05:29:05.779Z] JVM_OPTIONS: [2024-08-01T05:29:05.779Z] { \ [2024-08-01T05:29:05.779Z] echo ""; echo "TEST SETUP:"; \ [2024-08-01T05:29:05.779Z] echo "Nothing to be done for setup."; \ [2024-08-01T05:29:05.779Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17224897626000/renaissance-dec-tree_0"; \ [2024-08-01T05:29:05.779Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17224897626000/renaissance-dec-tree_0"; \ [2024-08-01T05:29:05.779Z] echo ""; echo "TESTING:"; \ [2024-08-01T05:29:05.779Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/jdkbinary/j2sdk-image/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_ppc64_aix_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17224897626000/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-01T05:29:05.779Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17224897626000/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-01T05:29:05.779Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-01T05:29:05.779Z] echo "Nothing to be done for teardown."; \ [2024-08-01T05:29:05.779Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17224897626000/TestTargetResult"; [2024-08-01T05:29:05.779Z] [2024-08-01T05:29:05.779Z] TEST SETUP: [2024-08-01T05:29:05.779Z] Nothing to be done for setup. [2024-08-01T05:29:05.779Z] [2024-08-01T05:29:05.779Z] TESTING: [2024-08-01T05:29:10.212Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-01T05:29:12.669Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-08-01T05:29:16.074Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-01T05:29:16.074Z] GC before operation: completed in 89.548 ms, heap usage 39.543 MB -> 34.967 MB. [2024-08-01T05:29:24.327Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7627.262 ms) ====== [2024-08-01T05:29:24.327Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-01T05:29:24.327Z] GC before operation: completed in 100.947 ms, heap usage 258.993 MB -> 66.709 MB. [2024-08-01T05:29:25.914Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2025.746 ms) ====== [2024-08-01T05:29:25.914Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-01T05:29:25.914Z] GC before operation: completed in 85.889 ms, heap usage 223.347 MB -> 66.984 MB. [2024-08-01T05:29:27.495Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1615.004 ms) ====== [2024-08-01T05:29:27.495Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-01T05:29:27.495Z] GC before operation: completed in 85.776 ms, heap usage 217.521 MB -> 67.418 MB. [2024-08-01T05:29:29.082Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1589.593 ms) ====== [2024-08-01T05:29:29.082Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-01T05:29:29.082Z] GC before operation: completed in 84.819 ms, heap usage 358.145 MB -> 78.611 MB. [2024-08-01T05:29:30.668Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1559.088 ms) ====== [2024-08-01T05:29:30.668Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-01T05:29:31.439Z] GC before operation: completed in 96.134 ms, heap usage 380.229 MB -> 68.106 MB. [2024-08-01T05:29:33.027Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1541.753 ms) ====== [2024-08-01T05:29:33.027Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-01T05:29:33.027Z] GC before operation: completed in 90.829 ms, heap usage 373.805 MB -> 68.063 MB. [2024-08-01T05:29:34.616Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1518.362 ms) ====== [2024-08-01T05:29:34.616Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-01T05:29:34.616Z] GC before operation: completed in 106.470 ms, heap usage 378.372 MB -> 79.169 MB. [2024-08-01T05:29:36.200Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1488.358 ms) ====== [2024-08-01T05:29:36.200Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-01T05:29:36.200Z] GC before operation: completed in 101.269 ms, heap usage 317.911 MB -> 79.272 MB. [2024-08-01T05:29:37.781Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1490.979 ms) ====== [2024-08-01T05:29:37.781Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-01T05:29:37.781Z] GC before operation: completed in 99.574 ms, heap usage 211.792 MB -> 79.635 MB. [2024-08-01T05:29:39.360Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1457.341 ms) ====== [2024-08-01T05:29:39.360Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-01T05:29:39.360Z] GC before operation: completed in 107.209 ms, heap usage 222.183 MB -> 68.463 MB. [2024-08-01T05:29:40.954Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1463.573 ms) ====== [2024-08-01T05:29:40.954Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-01T05:29:40.954Z] GC before operation: completed in 111.519 ms, heap usage 307.920 MB -> 68.939 MB. [2024-08-01T05:29:42.547Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1472.174 ms) ====== [2024-08-01T05:29:42.547Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-01T05:29:42.547Z] GC before operation: completed in 101.738 ms, heap usage 108.420 MB -> 68.176 MB. [2024-08-01T05:29:43.344Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1482.062 ms) ====== [2024-08-01T05:29:43.344Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-01T05:29:44.110Z] GC before operation: completed in 109.447 ms, heap usage 377.886 MB -> 68.845 MB. [2024-08-01T05:29:45.689Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1458.747 ms) ====== [2024-08-01T05:29:45.689Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-01T05:29:45.689Z] GC before operation: completed in 115.034 ms, heap usage 422.853 MB -> 80.082 MB. [2024-08-01T05:29:46.463Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1433.925 ms) ====== [2024-08-01T05:29:46.463Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-01T05:29:47.229Z] GC before operation: completed in 108.737 ms, heap usage 355.940 MB -> 69.052 MB. [2024-08-01T05:29:48.812Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1452.591 ms) ====== [2024-08-01T05:29:48.812Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-01T05:29:48.812Z] GC before operation: completed in 111.183 ms, heap usage 370.318 MB -> 69.375 MB. [2024-08-01T05:29:49.579Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1421.961 ms) ====== [2024-08-01T05:29:49.579Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-01T05:29:50.506Z] GC before operation: completed in 113.618 ms, heap usage 304.910 MB -> 69.329 MB. [2024-08-01T05:29:51.274Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1415.182 ms) ====== [2024-08-01T05:29:51.274Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-01T05:29:51.274Z] GC before operation: completed in 114.591 ms, heap usage 345.041 MB -> 86.141 MB. [2024-08-01T05:29:53.139Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1448.995 ms) ====== [2024-08-01T05:29:53.139Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-01T05:29:53.139Z] GC before operation: completed in 120.471 ms, heap usage 238.526 MB -> 69.536 MB. [2024-08-01T05:29:54.725Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1401.084 ms) ====== [2024-08-01T05:29:54.725Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-01T05:29:54.725Z] GC before operation: completed in 112.464 ms, heap usage 350.271 MB -> 80.919 MB. [2024-08-01T05:29:56.309Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1415.199 ms) ====== [2024-08-01T05:29:56.309Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-01T05:29:56.309Z] GC before operation: completed in 108.108 ms, heap usage 311.304 MB -> 69.861 MB. [2024-08-01T05:29:57.890Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1448.670 ms) ====== [2024-08-01T05:29:57.890Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-01T05:29:57.890Z] GC before operation: completed in 119.566 ms, heap usage 392.287 MB -> 69.967 MB. [2024-08-01T05:29:59.481Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1447.025 ms) ====== [2024-08-01T05:29:59.481Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-01T05:29:59.481Z] GC before operation: completed in 118.112 ms, heap usage 138.620 MB -> 69.780 MB. [2024-08-01T05:30:01.072Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1402.131 ms) ====== [2024-08-01T05:30:01.072Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-01T05:30:01.072Z] GC before operation: completed in 119.430 ms, heap usage 239.630 MB -> 75.581 MB. [2024-08-01T05:30:02.655Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1423.629 ms) ====== [2024-08-01T05:30:02.655Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-01T05:30:02.655Z] GC before operation: completed in 130.707 ms, heap usage 261.783 MB -> 70.308 MB. [2024-08-01T05:30:04.237Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1434.350 ms) ====== [2024-08-01T05:30:04.237Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-01T05:30:04.237Z] GC before operation: completed in 115.944 ms, heap usage 352.755 MB -> 81.515 MB. [2024-08-01T05:30:05.006Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1422.218 ms) ====== [2024-08-01T05:30:05.006Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-01T05:30:05.773Z] GC before operation: completed in 115.526 ms, heap usage 276.282 MB -> 81.211 MB. [2024-08-01T05:30:06.547Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1422.648 ms) ====== [2024-08-01T05:30:06.547Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-01T05:30:07.312Z] GC before operation: completed in 114.354 ms, heap usage 221.773 MB -> 75.962 MB. [2024-08-01T05:30:08.079Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1409.452 ms) ====== [2024-08-01T05:30:08.079Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-01T05:30:08.843Z] GC before operation: completed in 126.803 ms, heap usage 214.626 MB -> 81.759 MB. [2024-08-01T05:30:09.607Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1407.455 ms) ====== [2024-08-01T05:30:09.607Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-01T05:30:10.372Z] GC before operation: completed in 113.946 ms, heap usage 132.138 MB -> 80.925 MB. [2024-08-01T05:30:11.154Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1445.340 ms) ====== [2024-08-01T05:30:11.154Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-01T05:30:11.918Z] GC before operation: completed in 124.175 ms, heap usage 294.405 MB -> 81.983 MB. [2024-08-01T05:30:13.449Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1417.544 ms) ====== [2024-08-01T05:30:13.449Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-01T05:30:13.449Z] GC before operation: completed in 126.519 ms, heap usage 385.701 MB -> 70.794 MB. [2024-08-01T05:30:14.233Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1400.795 ms) ====== [2024-08-01T05:30:14.233Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-01T05:30:15.003Z] GC before operation: completed in 123.481 ms, heap usage 320.227 MB -> 81.784 MB. [2024-08-01T05:30:15.778Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1379.190 ms) ====== [2024-08-01T05:30:15.778Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-01T05:30:16.544Z] GC before operation: completed in 123.254 ms, heap usage 370.251 MB -> 76.587 MB. [2024-08-01T05:30:17.311Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1412.853 ms) ====== [2024-08-01T05:30:17.311Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-01T05:30:18.076Z] GC before operation: completed in 121.230 ms, heap usage 434.878 MB -> 82.031 MB. [2024-08-01T05:30:18.843Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1387.524 ms) ====== [2024-08-01T05:30:18.843Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-01T05:30:19.610Z] GC before operation: completed in 141.314 ms, heap usage 346.018 MB -> 87.721 MB. [2024-08-01T05:30:20.418Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1419.095 ms) ====== [2024-08-01T05:30:20.418Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-01T05:30:21.182Z] GC before operation: completed in 133.078 ms, heap usage 294.783 MB -> 82.343 MB. [2024-08-01T05:30:21.959Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1405.783 ms) ====== [2024-08-01T05:30:21.959Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-01T05:30:22.724Z] GC before operation: completed in 132.901 ms, heap usage 493.290 MB -> 88.100 MB. [2024-08-01T05:30:23.492Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1371.871 ms) ====== [2024-08-01T05:30:23.492Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-01T05:30:24.432Z] GC before operation: completed in 132.551 ms, heap usage 499.356 MB -> 82.602 MB. [2024-08-01T05:30:25.213Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1416.332 ms) ====== [2024-08-01T05:30:25.977Z] ----------------------------------- [2024-08-01T05:30:25.977Z] renaissance-dec-tree_0_PASSED [2024-08-01T05:30:25.977Z] ----------------------------------- [2024-08-01T05:30:25.977Z] [2024-08-01T05:30:25.977Z] TEST TEARDOWN: [2024-08-01T05:30:25.977Z] Nothing to be done for teardown. [2024-08-01T05:30:25.977Z] renaissance-dec-tree_0 Finish Time: Thu Aug 1 05:30:25 2024 Epoch Time (ms): 1722490225159