[2024-08-10T08:47:04.195Z] Running test renaissance-dec-tree_0 ... [2024-08-10T08:47:04.195Z] =============================================== [2024-08-10T08:47:04.195Z] renaissance-dec-tree_0 Start Time: Sat Aug 10 08:47:03 2024 Epoch Time (ms): 1723279623797 [2024-08-10T08:47:04.195Z] variation: NoOptions [2024-08-10T08:47:04.195Z] JVM_OPTIONS: [2024-08-10T08:47:04.195Z] { \ [2024-08-10T08:47:04.195Z] echo ""; echo "TEST SETUP:"; \ [2024-08-10T08:47:04.195Z] echo "Nothing to be done for setup."; \ [2024-08-10T08:47:04.195Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17232792367671/renaissance-dec-tree_0"; \ [2024-08-10T08:47:04.195Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17232792367671/renaissance-dec-tree_0"; \ [2024-08-10T08:47:04.195Z] echo ""; echo "TESTING:"; \ [2024-08-10T08:47:04.195Z] "/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_17232792367671/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-10T08:47:04.195Z] 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_17232792367671/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-10T08:47:04.195Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-10T08:47:04.195Z] echo "Nothing to be done for teardown."; \ [2024-08-10T08:47:04.195Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17232792367671/TestTargetResult"; [2024-08-10T08:47:04.195Z] [2024-08-10T08:47:04.195Z] TEST SETUP: [2024-08-10T08:47:04.195Z] Nothing to be done for setup. [2024-08-10T08:47:04.195Z] [2024-08-10T08:47:04.195Z] TESTING: [2024-08-10T08:47:08.650Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-10T08:47:11.128Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-08-10T08:47:14.549Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-10T08:47:14.549Z] GC before operation: completed in 61.183 ms, heap usage 90.594 MB -> 34.938 MB. [2024-08-10T08:47:22.838Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7449.345 ms) ====== [2024-08-10T08:47:22.838Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-10T08:47:22.838Z] GC before operation: completed in 89.431 ms, heap usage 251.779 MB -> 66.521 MB. [2024-08-10T08:47:24.423Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1892.682 ms) ====== [2024-08-10T08:47:24.423Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-10T08:47:24.423Z] GC before operation: completed in 84.199 ms, heap usage 240.310 MB -> 77.855 MB. [2024-08-10T08:47:26.006Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1639.494 ms) ====== [2024-08-10T08:47:26.006Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-10T08:47:26.006Z] GC before operation: completed in 88.116 ms, heap usage 312.718 MB -> 78.283 MB. [2024-08-10T08:47:27.592Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1587.484 ms) ====== [2024-08-10T08:47:27.592Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-10T08:47:27.592Z] GC before operation: completed in 88.530 ms, heap usage 395.069 MB -> 67.262 MB. [2024-08-10T08:47:29.179Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1578.740 ms) ====== [2024-08-10T08:47:29.179Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-10T08:47:29.179Z] GC before operation: completed in 92.517 ms, heap usage 211.732 MB -> 67.500 MB. [2024-08-10T08:47:30.767Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1577.845 ms) ====== [2024-08-10T08:47:30.767Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-10T08:47:30.767Z] GC before operation: completed in 101.822 ms, heap usage 348.584 MB -> 67.832 MB. [2024-08-10T08:47:32.353Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1523.348 ms) ====== [2024-08-10T08:47:32.353Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-10T08:47:32.353Z] GC before operation: completed in 106.523 ms, heap usage 345.460 MB -> 95.531 MB. [2024-08-10T08:47:33.938Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1492.922 ms) ====== [2024-08-10T08:47:33.938Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-10T08:47:33.938Z] GC before operation: completed in 102.704 ms, heap usage 287.457 MB -> 79.158 MB. [2024-08-10T08:47:35.525Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1494.456 ms) ====== [2024-08-10T08:47:35.525Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-10T08:47:35.525Z] GC before operation: completed in 97.741 ms, heap usage 320.529 MB -> 68.306 MB. [2024-08-10T08:47:37.114Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1475.579 ms) ====== [2024-08-10T08:47:37.114Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-10T08:47:37.114Z] GC before operation: completed in 105.302 ms, heap usage 282.573 MB -> 73.828 MB. [2024-08-10T08:47:38.705Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1465.336 ms) ====== [2024-08-10T08:47:38.705Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-10T08:47:38.705Z] GC before operation: completed in 98.712 ms, heap usage 286.132 MB -> 68.512 MB. [2024-08-10T08:47:40.291Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1462.136 ms) ====== [2024-08-10T08:47:40.291Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-10T08:47:40.291Z] GC before operation: completed in 100.198 ms, heap usage 212.861 MB -> 79.839 MB. [2024-08-10T08:47:41.879Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1459.696 ms) ====== [2024-08-10T08:47:41.879Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-10T08:47:41.879Z] GC before operation: completed in 108.676 ms, heap usage 218.262 MB -> 69.014 MB. [2024-08-10T08:47:43.477Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1451.641 ms) ====== [2024-08-10T08:47:43.477Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-10T08:47:43.477Z] GC before operation: completed in 116.956 ms, heap usage 257.399 MB -> 79.626 MB. [2024-08-10T08:47:45.066Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1436.686 ms) ====== [2024-08-10T08:47:45.066Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-10T08:47:45.066Z] GC before operation: completed in 117.169 ms, heap usage 222.920 MB -> 68.837 MB. [2024-08-10T08:47:46.650Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1437.648 ms) ====== [2024-08-10T08:47:46.650Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-10T08:47:46.650Z] GC before operation: completed in 122.788 ms, heap usage 347.755 MB -> 69.154 MB. [2024-08-10T08:47:48.234Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1444.683 ms) ====== [2024-08-10T08:47:48.234Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-10T08:47:48.234Z] GC before operation: completed in 112.729 ms, heap usage 236.952 MB -> 69.237 MB. [2024-08-10T08:47:49.820Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1420.221 ms) ====== [2024-08-10T08:47:49.820Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-10T08:47:49.820Z] GC before operation: completed in 118.797 ms, heap usage 301.247 MB -> 85.731 MB. [2024-08-10T08:47:51.414Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1458.854 ms) ====== [2024-08-10T08:47:51.414Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-10T08:47:51.414Z] GC before operation: completed in 112.750 ms, heap usage 174.306 MB -> 74.573 MB. [2024-08-10T08:47:53.007Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1423.360 ms) ====== [2024-08-10T08:47:53.007Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-10T08:47:53.007Z] GC before operation: completed in 125.834 ms, heap usage 491.767 MB -> 75.423 MB. [2024-08-10T08:47:54.598Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1444.576 ms) ====== [2024-08-10T08:47:54.598Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-10T08:47:54.598Z] GC before operation: completed in 120.982 ms, heap usage 245.185 MB -> 69.730 MB. [2024-08-10T08:47:56.181Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1438.215 ms) ====== [2024-08-10T08:47:56.181Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-10T08:47:56.181Z] GC before operation: completed in 120.887 ms, heap usage 351.245 MB -> 75.173 MB. [2024-08-10T08:47:57.776Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1412.341 ms) ====== [2024-08-10T08:47:57.776Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-10T08:47:57.776Z] GC before operation: completed in 124.401 ms, heap usage 352.615 MB -> 69.713 MB. [2024-08-10T08:47:59.362Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1406.574 ms) ====== [2024-08-10T08:47:59.362Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-10T08:47:59.362Z] GC before operation: completed in 138.781 ms, heap usage 393.964 MB -> 86.277 MB. [2024-08-10T08:48:00.959Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1411.518 ms) ====== [2024-08-10T08:48:00.959Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-10T08:48:00.959Z] GC before operation: completed in 127.361 ms, heap usage 505.402 MB -> 80.997 MB. [2024-08-10T08:48:02.547Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1424.909 ms) ====== [2024-08-10T08:48:02.547Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-10T08:48:02.547Z] GC before operation: completed in 119.002 ms, heap usage 184.497 MB -> 86.426 MB. [2024-08-10T08:48:03.328Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1449.027 ms) ====== [2024-08-10T08:48:03.328Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-10T08:48:04.103Z] GC before operation: completed in 121.023 ms, heap usage 418.601 MB -> 70.270 MB. [2024-08-10T08:48:05.688Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1476.785 ms) ====== [2024-08-10T08:48:05.688Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-10T08:48:05.688Z] GC before operation: completed in 123.802 ms, heap usage 385.004 MB -> 70.183 MB. [2024-08-10T08:48:06.467Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1417.676 ms) ====== [2024-08-10T08:48:06.467Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-10T08:48:07.234Z] GC before operation: completed in 122.249 ms, heap usage 259.738 MB -> 92.320 MB. [2024-08-10T08:48:08.011Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1407.800 ms) ====== [2024-08-10T08:48:08.012Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-10T08:48:08.780Z] GC before operation: completed in 128.711 ms, heap usage 275.723 MB -> 81.434 MB. [2024-08-10T08:48:09.563Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1392.589 ms) ====== [2024-08-10T08:48:09.563Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-10T08:48:10.330Z] GC before operation: completed in 126.819 ms, heap usage 514.504 MB -> 81.749 MB. [2024-08-10T08:48:11.098Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1434.334 ms) ====== [2024-08-10T08:48:11.098Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-10T08:48:11.872Z] GC before operation: completed in 129.459 ms, heap usage 350.285 MB -> 81.673 MB. [2024-08-10T08:48:12.641Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1426.393 ms) ====== [2024-08-10T08:48:12.641Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-10T08:48:13.409Z] GC before operation: completed in 129.661 ms, heap usage 165.611 MB -> 70.370 MB. [2024-08-10T08:48:14.189Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1419.476 ms) ====== [2024-08-10T08:48:14.189Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-10T08:48:14.958Z] GC before operation: completed in 133.809 ms, heap usage 325.384 MB -> 87.271 MB. [2024-08-10T08:48:16.542Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1437.924 ms) ====== [2024-08-10T08:48:16.542Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-10T08:48:16.542Z] GC before operation: completed in 127.385 ms, heap usage 297.193 MB -> 92.673 MB. [2024-08-10T08:48:17.319Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1392.916 ms) ====== [2024-08-10T08:48:17.319Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-10T08:48:18.087Z] GC before operation: completed in 130.156 ms, heap usage 359.237 MB -> 76.796 MB. [2024-08-10T08:48:18.865Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1405.351 ms) ====== [2024-08-10T08:48:18.865Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-10T08:48:19.633Z] GC before operation: completed in 141.614 ms, heap usage 470.153 MB -> 82.320 MB. [2024-08-10T08:48:20.400Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1385.127 ms) ====== [2024-08-10T08:48:20.400Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-10T08:48:21.169Z] GC before operation: completed in 135.739 ms, heap usage 483.686 MB -> 87.864 MB. [2024-08-10T08:48:21.951Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1427.679 ms) ====== [2024-08-10T08:48:21.951Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-10T08:48:22.718Z] GC before operation: completed in 134.751 ms, heap usage 127.172 MB -> 82.042 MB. [2024-08-10T08:48:23.679Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1426.164 ms) ====== [2024-08-10T08:48:24.606Z] ----------------------------------- [2024-08-10T08:48:24.606Z] renaissance-dec-tree_0_PASSED [2024-08-10T08:48:24.606Z] ----------------------------------- [2024-08-10T08:48:24.606Z] [2024-08-10T08:48:24.606Z] TEST TEARDOWN: [2024-08-10T08:48:24.606Z] Nothing to be done for teardown. [2024-08-10T08:48:24.606Z] renaissance-dec-tree_0 Finish Time: Sat Aug 10 08:48:23 2024 Epoch Time (ms): 1723279703712