[2024-09-25T22:59:07.154Z] Running test renaissance-dec-tree_0 ... [2024-09-25T22:59:07.154Z] =============================================== [2024-09-25T22:59:07.154Z] renaissance-dec-tree_0 Start Time: Wed Sep 25 22:59:06 2024 Epoch Time (ms): 1727305146209 [2024-09-25T22:59:07.154Z] variation: NoOptions [2024-09-25T22:59:07.154Z] JVM_OPTIONS: [2024-09-25T22:59:07.154Z] { \ [2024-09-25T22:59:07.154Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T22:59:07.154Z] echo "Nothing to be done for setup."; \ [2024-09-25T22:59:07.154Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17273047013474/renaissance-dec-tree_0"; \ [2024-09-25T22:59:07.154Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17273047013474/renaissance-dec-tree_0"; \ [2024-09-25T22:59:07.154Z] echo ""; echo "TESTING:"; \ [2024-09-25T22:59:07.154Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17273047013474/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-25T22:59:07.154Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17273047013474/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T22:59:07.154Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T22:59:07.154Z] echo "Nothing to be done for teardown."; \ [2024-09-25T22:59:07.154Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17273047013474/TestTargetResult"; [2024-09-25T22:59:07.154Z] [2024-09-25T22:59:07.154Z] TEST SETUP: [2024-09-25T22:59:07.154Z] Nothing to be done for setup. [2024-09-25T22:59:07.154Z] [2024-09-25T22:59:07.154Z] TESTING: [2024-09-25T22:59:10.113Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-25T22:59:11.064Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-25T22:59:14.093Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-25T22:59:14.093Z] GC before operation: completed in 61.621 ms, heap usage 88.899 MB -> 35.215 MB. [2024-09-25T22:59:22.089Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6815.030 ms) ====== [2024-09-25T22:59:22.089Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-25T22:59:22.089Z] GC before operation: completed in 72.400 ms, heap usage 267.161 MB -> 86.568 MB. [2024-09-25T22:59:23.021Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2125.594 ms) ====== [2024-09-25T22:59:23.021Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-25T22:59:23.021Z] GC before operation: completed in 88.723 ms, heap usage 347.176 MB -> 87.259 MB. [2024-09-25T22:59:24.934Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1769.363 ms) ====== [2024-09-25T22:59:24.934Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-25T22:59:24.934Z] GC before operation: completed in 69.818 ms, heap usage 283.328 MB -> 65.546 MB. [2024-09-25T22:59:26.847Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1640.681 ms) ====== [2024-09-25T22:59:26.847Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-25T22:59:26.847Z] GC before operation: completed in 88.656 ms, heap usage 310.222 MB -> 65.759 MB. [2024-09-25T22:59:28.765Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1656.633 ms) ====== [2024-09-25T22:59:28.765Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-25T22:59:28.765Z] GC before operation: completed in 73.899 ms, heap usage 131.521 MB -> 65.691 MB. [2024-09-25T22:59:30.673Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1612.987 ms) ====== [2024-09-25T22:59:30.673Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-25T22:59:30.673Z] GC before operation: completed in 81.733 ms, heap usage 296.585 MB -> 66.442 MB. [2024-09-25T22:59:31.608Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1588.605 ms) ====== [2024-09-25T22:59:31.608Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-25T22:59:32.537Z] GC before operation: completed in 72.214 ms, heap usage 129.466 MB -> 66.002 MB. [2024-09-25T22:59:33.467Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1530.709 ms) ====== [2024-09-25T22:59:33.467Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-25T22:59:33.467Z] GC before operation: completed in 75.515 ms, heap usage 282.938 MB -> 66.573 MB. [2024-09-25T22:59:35.374Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1505.393 ms) ====== [2024-09-25T22:59:35.374Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-25T22:59:35.374Z] GC before operation: completed in 85.139 ms, heap usage 144.178 MB -> 66.262 MB. [2024-09-25T22:59:37.283Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1506.657 ms) ====== [2024-09-25T22:59:37.283Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-25T22:59:37.283Z] GC before operation: completed in 79.305 ms, heap usage 269.713 MB -> 66.857 MB. [2024-09-25T22:59:38.219Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1514.154 ms) ====== [2024-09-25T22:59:38.219Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-25T22:59:38.219Z] GC before operation: completed in 80.505 ms, heap usage 316.187 MB -> 66.778 MB. [2024-09-25T22:59:40.127Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1504.374 ms) ====== [2024-09-25T22:59:40.127Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-25T22:59:40.127Z] GC before operation: completed in 87.269 ms, heap usage 227.306 MB -> 78.183 MB. [2024-09-25T22:59:41.071Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1473.461 ms) ====== [2024-09-25T22:59:41.071Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-25T22:59:42.004Z] GC before operation: completed in 83.088 ms, heap usage 205.580 MB -> 77.937 MB. [2024-09-25T22:59:42.936Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1523.132 ms) ====== [2024-09-25T22:59:42.936Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-25T22:59:42.936Z] GC before operation: completed in 91.349 ms, heap usage 174.180 MB -> 66.829 MB. [2024-09-25T22:59:46.548Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1505.645 ms) ====== [2024-09-25T22:59:46.548Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-25T22:59:46.548Z] GC before operation: completed in 93.006 ms, heap usage 294.917 MB -> 83.937 MB. [2024-09-25T22:59:48.464Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3344.947 ms) ====== [2024-09-25T22:59:48.464Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-25T22:59:48.464Z] GC before operation: completed in 92.897 ms, heap usage 277.209 MB -> 67.577 MB. [2024-09-25T22:59:49.394Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1465.638 ms) ====== [2024-09-25T22:59:49.394Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-25T22:59:49.394Z] GC before operation: completed in 84.595 ms, heap usage 223.492 MB -> 67.543 MB. [2024-09-25T22:59:51.306Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1455.041 ms) ====== [2024-09-25T22:59:51.306Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-25T22:59:51.306Z] GC before operation: completed in 103.437 ms, heap usage 297.321 MB -> 73.276 MB. [2024-09-25T22:59:53.220Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1507.353 ms) ====== [2024-09-25T22:59:53.220Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-25T22:59:53.220Z] GC before operation: completed in 113.609 ms, heap usage 227.881 MB -> 67.750 MB. [2024-09-25T22:59:54.151Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1464.475 ms) ====== [2024-09-25T22:59:54.151Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-25T22:59:54.151Z] GC before operation: completed in 124.078 ms, heap usage 309.647 MB -> 78.960 MB. [2024-09-25T22:59:56.065Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1475.142 ms) ====== [2024-09-25T22:59:56.065Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-25T22:59:56.065Z] GC before operation: completed in 98.748 ms, heap usage 144.007 MB -> 67.671 MB. [2024-09-25T22:59:57.997Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1475.971 ms) ====== [2024-09-25T22:59:57.997Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-25T22:59:57.997Z] GC before operation: completed in 102.461 ms, heap usage 212.752 MB -> 68.237 MB. [2024-09-25T22:59:58.933Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1468.262 ms) ====== [2024-09-25T22:59:58.933Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-25T22:59:58.933Z] GC before operation: completed in 102.552 ms, heap usage 287.325 MB -> 68.169 MB. [2024-09-25T23:00:00.847Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1451.375 ms) ====== [2024-09-25T23:00:00.847Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-25T23:00:00.847Z] GC before operation: completed in 96.542 ms, heap usage 294.175 MB -> 68.703 MB. [2024-09-25T23:00:02.770Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1447.849 ms) ====== [2024-09-25T23:00:02.770Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-25T23:00:02.770Z] GC before operation: completed in 101.551 ms, heap usage 301.872 MB -> 68.742 MB. [2024-09-25T23:00:03.699Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1455.110 ms) ====== [2024-09-25T23:00:03.699Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-25T23:00:03.699Z] GC before operation: completed in 96.504 ms, heap usage 291.320 MB -> 79.788 MB. [2024-09-25T23:00:05.404Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1465.553 ms) ====== [2024-09-25T23:00:05.404Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-25T23:00:05.404Z] GC before operation: completed in 96.774 ms, heap usage 122.413 MB -> 79.330 MB. [2024-09-25T23:00:07.311Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1494.802 ms) ====== [2024-09-25T23:00:07.311Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-25T23:00:07.311Z] GC before operation: completed in 90.246 ms, heap usage 338.408 MB -> 69.088 MB. [2024-09-25T23:00:08.241Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1483.477 ms) ====== [2024-09-25T23:00:08.241Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-25T23:00:08.241Z] GC before operation: completed in 88.978 ms, heap usage 211.169 MB -> 68.958 MB. [2024-09-25T23:00:10.153Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1443.545 ms) ====== [2024-09-25T23:00:10.153Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-25T23:00:10.153Z] GC before operation: completed in 101.747 ms, heap usage 286.555 MB -> 69.080 MB. [2024-09-25T23:00:12.065Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1475.192 ms) ====== [2024-09-25T23:00:12.065Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-25T23:00:12.065Z] GC before operation: completed in 95.339 ms, heap usage 277.955 MB -> 91.168 MB. [2024-09-25T23:00:12.997Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1428.333 ms) ====== [2024-09-25T23:00:12.997Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-25T23:00:12.997Z] GC before operation: completed in 92.937 ms, heap usage 341.160 MB -> 80.335 MB. [2024-09-25T23:00:15.068Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1428.558 ms) ====== [2024-09-25T23:00:15.068Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-25T23:00:15.068Z] GC before operation: completed in 91.382 ms, heap usage 177.585 MB -> 80.007 MB. [2024-09-25T23:00:15.998Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1419.441 ms) ====== [2024-09-25T23:00:15.998Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-25T23:00:15.998Z] GC before operation: completed in 96.256 ms, heap usage 444.972 MB -> 69.661 MB. [2024-09-25T23:00:17.907Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1422.340 ms) ====== [2024-09-25T23:00:17.907Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-25T23:00:17.907Z] GC before operation: completed in 97.731 ms, heap usage 332.320 MB -> 91.638 MB. [2024-09-25T23:00:19.835Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1420.643 ms) ====== [2024-09-25T23:00:19.835Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-25T23:00:19.835Z] GC before operation: completed in 94.956 ms, heap usage 336.037 MB -> 69.525 MB. [2024-09-25T23:00:20.763Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1469.380 ms) ====== [2024-09-25T23:00:20.763Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-25T23:00:20.763Z] GC before operation: completed in 96.844 ms, heap usage 187.417 MB -> 86.120 MB. [2024-09-25T23:00:22.672Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1424.843 ms) ====== [2024-09-25T23:00:22.672Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-25T23:00:22.672Z] GC before operation: completed in 104.707 ms, heap usage 245.356 MB -> 86.512 MB. [2024-09-25T23:00:23.603Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1402.513 ms) ====== [2024-09-25T23:00:23.603Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-25T23:00:23.603Z] GC before operation: completed in 102.408 ms, heap usage 245.466 MB -> 81.087 MB. [2024-09-25T23:00:25.513Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1409.053 ms) ====== [2024-09-25T23:00:25.513Z] ----------------------------------- [2024-09-25T23:00:25.513Z] renaissance-dec-tree_0_PASSED [2024-09-25T23:00:25.513Z] ----------------------------------- [2024-09-25T23:00:25.513Z] [2024-09-25T23:00:25.513Z] TEST TEARDOWN: [2024-09-25T23:00:25.513Z] Nothing to be done for teardown. [2024-09-25T23:00:25.513Z] renaissance-dec-tree_0 Finish Time: Wed Sep 25 23:00:25 2024 Epoch Time (ms): 1727305225097