[2024-09-05T22:19:22.060Z] Running test renaissance-dec-tree_0 ... [2024-09-05T22:19:22.060Z] =============================================== [2024-09-05T22:19:22.060Z] renaissance-dec-tree_0 Start Time: Thu Sep 5 22:19:21 2024 Epoch Time (ms): 1725574761483 [2024-09-05T22:19:22.060Z] variation: NoOptions [2024-09-05T22:19:22.060Z] JVM_OPTIONS: [2024-09-05T22:19:22.060Z] { \ [2024-09-05T22:19:22.060Z] echo ""; echo "TEST SETUP:"; \ [2024-09-05T22:19:22.060Z] echo "Nothing to be done for setup."; \ [2024-09-05T22:19:22.060Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17255742407341/renaissance-dec-tree_0"; \ [2024-09-05T22:19:22.060Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17255742407341/renaissance-dec-tree_0"; \ [2024-09-05T22:19:22.060Z] echo ""; echo "TESTING:"; \ [2024-09-05T22:19:22.060Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17255742407341/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-05T22:19:22.060Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17255742407341/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-05T22:19:22.060Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-05T22:19:22.060Z] echo "Nothing to be done for teardown."; \ [2024-09-05T22:19:22.060Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17255742407341/TestTargetResult"; [2024-09-05T22:19:22.060Z] [2024-09-05T22:19:22.060Z] TEST SETUP: [2024-09-05T22:19:22.060Z] Nothing to be done for setup. [2024-09-05T22:19:22.060Z] [2024-09-05T22:19:22.060Z] TESTING: [2024-09-05T22:19:26.199Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-05T22:19:28.088Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-05T22:19:33.909Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-05T22:19:33.909Z] GC before operation: completed in 162.534 ms, heap usage 116.083 MB -> 27.369 MB. [2024-09-05T22:19:45.135Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11693.008 ms) ====== [2024-09-05T22:19:45.135Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-05T22:19:45.135Z] GC before operation: completed in 391.217 ms, heap usage 221.018 MB -> 54.148 MB. [2024-09-05T22:19:48.057Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2790.855 ms) ====== [2024-09-05T22:19:48.057Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-05T22:19:48.057Z] GC before operation: completed in 278.811 ms, heap usage 312.689 MB -> 54.291 MB. [2024-09-05T22:19:49.952Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2359.179 ms) ====== [2024-09-05T22:19:49.952Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-05T22:19:50.871Z] GC before operation: completed in 231.476 ms, heap usage 280.165 MB -> 66.052 MB. [2024-09-05T22:19:52.767Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2170.919 ms) ====== [2024-09-05T22:19:52.767Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-05T22:19:52.767Z] GC before operation: completed in 206.436 ms, heap usage 271.826 MB -> 54.936 MB. [2024-09-05T22:19:54.659Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2087.923 ms) ====== [2024-09-05T22:19:54.659Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-05T22:19:55.581Z] GC before operation: completed in 189.464 ms, heap usage 253.136 MB -> 55.359 MB. [2024-09-05T22:19:57.472Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2032.357 ms) ====== [2024-09-05T22:19:57.472Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-05T22:19:57.472Z] GC before operation: completed in 241.673 ms, heap usage 251.700 MB -> 55.765 MB. [2024-09-05T22:19:59.360Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1968.462 ms) ====== [2024-09-05T22:19:59.360Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-05T22:19:59.360Z] GC before operation: completed in 240.398 ms, heap usage 246.190 MB -> 55.675 MB. [2024-09-05T22:20:01.248Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1968.907 ms) ====== [2024-09-05T22:20:01.248Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-05T22:20:02.167Z] GC before operation: completed in 229.331 ms, heap usage 249.362 MB -> 56.173 MB. [2024-09-05T22:20:04.156Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1937.694 ms) ====== [2024-09-05T22:20:04.156Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-05T22:20:04.156Z] GC before operation: completed in 237.230 ms, heap usage 249.205 MB -> 56.316 MB. [2024-09-05T22:20:06.044Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1897.076 ms) ====== [2024-09-05T22:20:06.044Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-05T22:20:06.044Z] GC before operation: completed in 224.298 ms, heap usage 246.254 MB -> 56.462 MB. [2024-09-05T22:20:07.943Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1838.230 ms) ====== [2024-09-05T22:20:07.943Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-05T22:20:07.943Z] GC before operation: completed in 201.880 ms, heap usage 247.161 MB -> 56.456 MB. [2024-09-05T22:20:09.941Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1791.188 ms) ====== [2024-09-05T22:20:09.941Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-05T22:20:09.941Z] GC before operation: completed in 239.177 ms, heap usage 243.765 MB -> 56.743 MB. [2024-09-05T22:20:11.834Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1784.673 ms) ====== [2024-09-05T22:20:11.834Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-05T22:20:11.834Z] GC before operation: completed in 215.218 ms, heap usage 246.925 MB -> 56.895 MB. [2024-09-05T22:20:13.724Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1733.971 ms) ====== [2024-09-05T22:20:13.724Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-05T22:20:14.645Z] GC before operation: completed in 203.640 ms, heap usage 244.628 MB -> 56.721 MB. [2024-09-05T22:20:15.567Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1757.588 ms) ====== [2024-09-05T22:20:15.567Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-05T22:20:16.489Z] GC before operation: completed in 243.153 ms, heap usage 242.250 MB -> 57.182 MB. [2024-09-05T22:20:18.379Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1723.832 ms) ====== [2024-09-05T22:20:18.379Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-05T22:20:18.379Z] GC before operation: completed in 209.291 ms, heap usage 243.897 MB -> 57.378 MB. [2024-09-05T22:20:20.270Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1701.779 ms) ====== [2024-09-05T22:20:20.270Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-05T22:20:20.270Z] GC before operation: completed in 224.980 ms, heap usage 244.659 MB -> 57.377 MB. [2024-09-05T22:20:22.161Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1722.908 ms) ====== [2024-09-05T22:20:22.161Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-05T22:20:22.161Z] GC before operation: completed in 199.383 ms, heap usage 243.765 MB -> 57.632 MB. [2024-09-05T22:20:24.053Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1724.778 ms) ====== [2024-09-05T22:20:24.053Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-05T22:20:24.053Z] GC before operation: completed in 197.833 ms, heap usage 250.387 MB -> 57.621 MB. [2024-09-05T22:20:25.943Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1674.801 ms) ====== [2024-09-05T22:20:25.943Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-05T22:20:25.943Z] GC before operation: completed in 191.535 ms, heap usage 244.574 MB -> 57.750 MB. [2024-09-05T22:20:27.911Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1675.032 ms) ====== [2024-09-05T22:20:27.911Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-05T22:20:27.911Z] GC before operation: completed in 222.425 ms, heap usage 248.163 MB -> 58.037 MB. [2024-09-05T22:20:29.800Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1672.567 ms) ====== [2024-09-05T22:20:29.800Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-05T22:20:29.800Z] GC before operation: completed in 190.630 ms, heap usage 242.963 MB -> 58.007 MB. [2024-09-05T22:20:31.692Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1640.819 ms) ====== [2024-09-05T22:20:31.692Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-05T22:20:31.692Z] GC before operation: completed in 231.994 ms, heap usage 248.159 MB -> 58.292 MB. [2024-09-05T22:20:32.613Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1646.347 ms) ====== [2024-09-05T22:20:32.613Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-05T22:20:33.533Z] GC before operation: completed in 180.498 ms, heap usage 245.006 MB -> 58.272 MB. [2024-09-05T22:20:34.453Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1647.060 ms) ====== [2024-09-05T22:20:34.453Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-05T22:20:35.372Z] GC before operation: completed in 213.573 ms, heap usage 246.738 MB -> 58.554 MB. [2024-09-05T22:20:36.293Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1633.436 ms) ====== [2024-09-05T22:20:36.293Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-05T22:20:37.214Z] GC before operation: completed in 185.403 ms, heap usage 239.945 MB -> 58.537 MB. [2024-09-05T22:20:38.133Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1615.316 ms) ====== [2024-09-05T22:20:38.133Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-05T22:20:39.056Z] GC before operation: completed in 217.977 ms, heap usage 249.533 MB -> 58.814 MB. [2024-09-05T22:20:39.976Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1625.802 ms) ====== [2024-09-05T22:20:39.976Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-05T22:20:40.896Z] GC before operation: completed in 210.378 ms, heap usage 245.773 MB -> 58.675 MB. [2024-09-05T22:20:41.816Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1619.792 ms) ====== [2024-09-05T22:20:41.816Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-05T22:20:42.905Z] GC before operation: completed in 176.669 ms, heap usage 243.813 MB -> 59.129 MB. [2024-09-05T22:20:43.825Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1617.018 ms) ====== [2024-09-05T22:20:43.825Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-05T22:20:43.825Z] GC before operation: completed in 213.595 ms, heap usage 248.803 MB -> 59.259 MB. [2024-09-05T22:20:45.717Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1640.618 ms) ====== [2024-09-05T22:20:45.717Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-05T22:20:45.717Z] GC before operation: completed in 207.908 ms, heap usage 249.116 MB -> 59.392 MB. [2024-09-05T22:20:47.607Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1600.225 ms) ====== [2024-09-05T22:20:47.607Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-05T22:20:47.607Z] GC before operation: completed in 217.455 ms, heap usage 247.397 MB -> 81.537 MB. [2024-09-05T22:20:49.497Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1629.682 ms) ====== [2024-09-05T22:20:49.497Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-05T22:20:49.497Z] GC before operation: completed in 258.547 ms, heap usage 274.838 MB -> 59.494 MB. [2024-09-05T22:20:51.387Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1634.150 ms) ====== [2024-09-05T22:20:51.387Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-05T22:20:51.387Z] GC before operation: completed in 190.817 ms, heap usage 255.741 MB -> 59.812 MB. [2024-09-05T22:20:53.280Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1597.576 ms) ====== [2024-09-05T22:20:53.280Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-05T22:20:53.280Z] GC before operation: completed in 196.918 ms, heap usage 251.582 MB -> 59.909 MB. [2024-09-05T22:20:55.171Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1568.213 ms) ====== [2024-09-05T22:20:55.171Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-05T22:20:55.171Z] GC before operation: completed in 176.764 ms, heap usage 247.863 MB -> 59.890 MB. [2024-09-05T22:20:57.059Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1601.094 ms) ====== [2024-09-05T22:20:57.059Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-05T22:20:57.059Z] GC before operation: completed in 185.715 ms, heap usage 246.235 MB -> 60.004 MB. [2024-09-05T22:20:58.955Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1639.025 ms) ====== [2024-09-05T22:20:58.955Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-05T22:20:58.955Z] GC before operation: completed in 190.158 ms, heap usage 244.256 MB -> 60.143 MB. [2024-09-05T22:21:00.847Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1611.867 ms) ====== [2024-09-05T22:21:00.847Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-05T22:21:00.847Z] GC before operation: completed in 190.584 ms, heap usage 252.239 MB -> 60.420 MB. [2024-09-05T22:21:01.766Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1596.084 ms) ====== [2024-09-05T22:21:02.685Z] ----------------------------------- [2024-09-05T22:21:02.685Z] renaissance-dec-tree_0_PASSED [2024-09-05T22:21:02.685Z] ----------------------------------- [2024-09-05T22:21:02.685Z] [2024-09-05T22:21:02.685Z] TEST TEARDOWN: [2024-09-05T22:21:02.685Z] Nothing to be done for teardown. [2024-09-05T22:21:02.685Z] renaissance-dec-tree_0 Finish Time: Thu Sep 5 22:21:01 2024 Epoch Time (ms): 1725574861893