[2024-11-08T18:15:50.288Z] Running test renaissance-dec-tree_0 ... [2024-11-08T18:15:50.288Z] =============================================== [2024-11-08T18:15:50.288Z] renaissance-dec-tree_0 Start Time: Fri Nov 8 18:15:50 2024 Epoch Time (ms): 1731089750240 [2024-11-08T18:15:50.612Z] variation: NoOptions [2024-11-08T18:15:50.612Z] JVM_OPTIONS: [2024-11-08T18:15:50.612Z] { \ [2024-11-08T18:15:50.612Z] echo ""; echo "TEST SETUP:"; \ [2024-11-08T18:15:50.612Z] echo "Nothing to be done for setup."; \ [2024-11-08T18:15:50.612Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17310891697444\\renaissance-dec-tree_0"; \ [2024-11-08T18:15:50.612Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17310891697444\\renaissance-dec-tree_0"; \ [2024-11-08T18:15:50.612Z] echo ""; echo "TESTING:"; \ [2024-11-08T18:15:50.612Z] "c:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17310891697444\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2024-11-08T18:15:50.612Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17310891697444\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-08T18:15:50.613Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-08T18:15:50.613Z] echo "Nothing to be done for teardown."; \ [2024-11-08T18:15:50.613Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17310891697444\\TestTargetResult"; [2024-11-08T18:15:50.613Z] [2024-11-08T18:15:50.613Z] TEST SETUP: [2024-11-08T18:15:50.613Z] Nothing to be done for setup. [2024-11-08T18:15:50.613Z] [2024-11-08T18:15:50.613Z] TESTING: [2024-11-08T18:16:01.231Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-08T18:16:01.917Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-08T18:16:04.782Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-08T18:16:04.782Z] GC before operation: completed in 46.446 ms, heap usage 59.101 MB -> 35.265 MB. [2024-11-08T18:16:12.024Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7391.600 ms) ====== [2024-11-08T18:16:12.024Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-08T18:16:12.024Z] GC before operation: completed in 67.985 ms, heap usage 252.889 MB -> 86.915 MB. [2024-11-08T18:16:14.399Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2194.059 ms) ====== [2024-11-08T18:16:14.399Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-08T18:16:14.399Z] GC before operation: completed in 75.500 ms, heap usage 217.377 MB -> 76.173 MB. [2024-11-08T18:16:16.660Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1899.018 ms) ====== [2024-11-08T18:16:16.660Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-08T18:16:16.660Z] GC before operation: completed in 61.005 ms, heap usage 145.345 MB -> 65.095 MB. [2024-11-08T18:16:18.331Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1629.661 ms) ====== [2024-11-08T18:16:18.331Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-08T18:16:18.331Z] GC before operation: completed in 69.946 ms, heap usage 99.051 MB -> 65.071 MB. [2024-11-08T18:16:19.968Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1586.788 ms) ====== [2024-11-08T18:16:19.968Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-08T18:16:19.968Z] GC before operation: completed in 67.749 ms, heap usage 221.105 MB -> 76.939 MB. [2024-11-08T18:16:21.163Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1432.746 ms) ====== [2024-11-08T18:16:21.163Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-08T18:16:21.163Z] GC before operation: completed in 65.441 ms, heap usage 227.236 MB -> 66.193 MB. [2024-11-08T18:16:22.827Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1454.355 ms) ====== [2024-11-08T18:16:22.827Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-08T18:16:22.827Z] GC before operation: completed in 74.951 ms, heap usage 333.978 MB -> 82.779 MB. [2024-11-08T18:16:24.032Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1364.097 ms) ====== [2024-11-08T18:16:24.032Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-08T18:16:24.371Z] GC before operation: completed in 73.463 ms, heap usage 181.500 MB -> 76.992 MB. [2024-11-08T18:16:25.517Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1416.301 ms) ====== [2024-11-08T18:16:25.517Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-08T18:16:25.842Z] GC before operation: completed in 74.007 ms, heap usage 193.518 MB -> 77.566 MB. [2024-11-08T18:16:27.000Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1282.304 ms) ====== [2024-11-08T18:16:27.000Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-08T18:16:27.000Z] GC before operation: completed in 74.279 ms, heap usage 217.486 MB -> 83.113 MB. [2024-11-08T18:16:28.600Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1331.751 ms) ====== [2024-11-08T18:16:28.600Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-08T18:16:28.600Z] GC before operation: completed in 73.849 ms, heap usage 127.110 MB -> 77.447 MB. [2024-11-08T18:16:29.826Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1321.968 ms) ====== [2024-11-08T18:16:29.826Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-08T18:16:29.826Z] GC before operation: completed in 79.857 ms, heap usage 367.001 MB -> 83.438 MB. [2024-11-08T18:16:31.439Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1295.231 ms) ====== [2024-11-08T18:16:31.439Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-08T18:16:31.439Z] GC before operation: completed in 81.231 ms, heap usage 422.875 MB -> 83.520 MB. [2024-11-08T18:16:32.547Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1280.421 ms) ====== [2024-11-08T18:16:32.547Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-08T18:16:32.547Z] GC before operation: completed in 81.187 ms, heap usage 144.962 MB -> 77.732 MB. [2024-11-08T18:16:34.146Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1358.456 ms) ====== [2024-11-08T18:16:34.146Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-08T18:16:34.146Z] GC before operation: completed in 82.876 ms, heap usage 445.952 MB -> 83.929 MB. [2024-11-08T18:16:35.257Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1230.631 ms) ====== [2024-11-08T18:16:35.257Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-08T18:16:35.257Z] GC before operation: completed in 78.602 ms, heap usage 162.641 MB -> 67.258 MB. [2024-11-08T18:16:36.853Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1224.045 ms) ====== [2024-11-08T18:16:36.853Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-08T18:16:36.853Z] GC before operation: completed in 80.848 ms, heap usage 281.832 MB -> 67.550 MB. [2024-11-08T18:16:37.956Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1188.723 ms) ====== [2024-11-08T18:16:37.956Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-08T18:16:37.956Z] GC before operation: completed in 80.651 ms, heap usage 298.659 MB -> 84.239 MB. [2024-11-08T18:16:39.069Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1205.465 ms) ====== [2024-11-08T18:16:39.069Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-08T18:16:39.391Z] GC before operation: completed in 84.806 ms, heap usage 422.149 MB -> 84.290 MB. [2024-11-08T18:16:40.536Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1213.075 ms) ====== [2024-11-08T18:16:40.537Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-08T18:16:40.537Z] GC before operation: completed in 89.605 ms, heap usage 134.762 MB -> 83.915 MB. [2024-11-08T18:16:42.180Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1280.712 ms) ====== [2024-11-08T18:16:42.180Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-08T18:16:42.180Z] GC before operation: completed in 82.443 ms, heap usage 326.203 MB -> 84.509 MB. [2024-11-08T18:16:43.284Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1264.038 ms) ====== [2024-11-08T18:16:43.284Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-08T18:16:43.284Z] GC before operation: completed in 84.280 ms, heap usage 419.704 MB -> 84.622 MB. [2024-11-08T18:16:44.392Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1189.648 ms) ====== [2024-11-08T18:16:44.392Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-08T18:16:44.392Z] GC before operation: completed in 84.251 ms, heap usage 129.987 MB -> 78.653 MB. [2024-11-08T18:16:44.392Z] 24/11/08 18:16:44 WARN BlockManager: Asked to remove block rdd_1124_0, which does not exist [2024-11-08T18:16:46.057Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1201.011 ms) ====== [2024-11-08T18:16:46.057Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-08T18:16:46.057Z] GC before operation: completed in 85.367 ms, heap usage 345.928 MB -> 84.764 MB. [2024-11-08T18:16:47.159Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1219.232 ms) ====== [2024-11-08T18:16:47.160Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-08T18:16:47.160Z] GC before operation: completed in 88.368 ms, heap usage 382.207 MB -> 85.074 MB. [2024-11-08T18:16:48.265Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1176.476 ms) ====== [2024-11-08T18:16:48.265Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-08T18:16:48.265Z] GC before operation: completed in 91.538 ms, heap usage 383.307 MB -> 84.905 MB. [2024-11-08T18:16:49.865Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1231.585 ms) ====== [2024-11-08T18:16:49.865Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-08T18:16:49.865Z] GC before operation: completed in 87.615 ms, heap usage 395.952 MB -> 85.030 MB. [2024-11-08T18:16:50.972Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1179.818 ms) ====== [2024-11-08T18:16:50.972Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-08T18:16:50.972Z] GC before operation: completed in 87.151 ms, heap usage 374.627 MB -> 85.156 MB. [2024-11-08T18:16:52.091Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1148.604 ms) ====== [2024-11-08T18:16:52.091Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-08T18:16:52.091Z] GC before operation: completed in 88.901 ms, heap usage 382.175 MB -> 90.759 MB. [2024-11-08T18:16:52.091Z] 24/11/08 18:16:52 WARN BlockManager: Asked to remove block broadcast_400, which does not exist [2024-11-08T18:16:53.248Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1144.327 ms) ====== [2024-11-08T18:16:53.248Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-08T18:16:53.567Z] GC before operation: completed in 91.504 ms, heap usage 324.078 MB -> 85.396 MB. [2024-11-08T18:16:54.673Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1117.335 ms) ====== [2024-11-08T18:16:54.673Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-08T18:16:54.673Z] GC before operation: completed in 89.360 ms, heap usage 395.160 MB -> 90.935 MB. [2024-11-08T18:16:55.825Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1242.731 ms) ====== [2024-11-08T18:16:55.825Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-08T18:16:56.139Z] GC before operation: completed in 105.571 ms, heap usage 333.368 MB -> 91.252 MB. [2024-11-08T18:16:57.248Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1204.674 ms) ====== [2024-11-08T18:16:57.248Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-08T18:16:57.248Z] GC before operation: completed in 92.207 ms, heap usage 339.481 MB -> 85.652 MB. [2024-11-08T18:16:58.378Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1185.768 ms) ====== [2024-11-08T18:16:58.378Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-08T18:16:58.721Z] GC before operation: completed in 90.850 ms, heap usage 385.127 MB -> 85.711 MB. [2024-11-08T18:16:59.895Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1228.988 ms) ====== [2024-11-08T18:16:59.895Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-08T18:16:59.895Z] GC before operation: completed in 92.641 ms, heap usage 382.525 MB -> 91.285 MB. [2024-11-08T18:17:01.115Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1303.027 ms) ====== [2024-11-08T18:17:01.115Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-08T18:17:01.433Z] GC before operation: completed in 93.853 ms, heap usage 341.566 MB -> 85.984 MB. [2024-11-08T18:17:02.548Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1225.840 ms) ====== [2024-11-08T18:17:02.548Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-08T18:17:02.548Z] GC before operation: completed in 93.563 ms, heap usage 360.275 MB -> 86.059 MB. [2024-11-08T18:17:02.548Z] 24/11/08 18:17:02 WARN BlockManager: Asked to remove block rdd_1810_0, which does not exist [2024-11-08T18:17:03.690Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1183.421 ms) ====== [2024-11-08T18:17:03.690Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-08T18:17:04.024Z] GC before operation: completed in 92.510 ms, heap usage 370.984 MB -> 86.147 MB. [2024-11-08T18:17:05.125Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1165.555 ms) ====== [2024-11-08T18:17:05.125Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-08T18:17:05.125Z] GC before operation: completed in 91.538 ms, heap usage 353.381 MB -> 80.853 MB. [2024-11-08T18:17:06.232Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1197.012 ms) ====== [2024-11-08T18:17:06.554Z] ----------------------------------- [2024-11-08T18:17:06.554Z] renaissance-dec-tree_0_PASSED [2024-11-08T18:17:06.554Z] ----------------------------------- [2024-11-08T18:17:06.863Z] [2024-11-08T18:17:06.864Z] TEST TEARDOWN: [2024-11-08T18:17:06.864Z] Nothing to be done for teardown. [2024-11-08T18:17:06.864Z] renaissance-dec-tree_0 Finish Time: Fri Nov 8 18:17:06 2024 Epoch Time (ms): 1731089826732