[2024-11-08T15:49:10.168Z] Running test renaissance-dec-tree_0 ... [2024-11-08T15:49:10.168Z] =============================================== [2024-11-08T15:49:10.168Z] renaissance-dec-tree_0 Start Time: Fri Nov 8 09:49:09 2024 Epoch Time (ms): 1731080949919 [2024-11-08T15:49:10.168Z] variation: NoOptions [2024-11-08T15:49:10.169Z] JVM_OPTIONS: [2024-11-08T15:49:10.169Z] { \ [2024-11-08T15:49:10.169Z] echo ""; echo "TEST SETUP:"; \ [2024-11-08T15:49:10.169Z] echo "Nothing to be done for setup."; \ [2024-11-08T15:49:10.169Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17310806949971/renaissance-dec-tree_0"; \ [2024-11-08T15:49:10.169Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17310806949971/renaissance-dec-tree_0"; \ [2024-11-08T15:49:10.169Z] echo ""; echo "TESTING:"; \ [2024-11-08T15:49:10.169Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk-17.0.14+2/bin/..//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_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17310806949971/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-08T15:49:10.169Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17310806949971/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-08T15:49:10.169Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-08T15:49:10.169Z] echo "Nothing to be done for teardown."; \ [2024-11-08T15:49:10.169Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17310806949971/TestTargetResult"; [2024-11-08T15:49:10.169Z] [2024-11-08T15:49:10.169Z] TEST SETUP: [2024-11-08T15:49:10.169Z] Nothing to be done for setup. [2024-11-08T15:49:10.169Z] [2024-11-08T15:49:10.169Z] TESTING: [2024-11-08T15:49:13.238Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-08T15:49:14.642Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-11-08T15:49:17.803Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-08T15:49:17.803Z] GC before operation: completed in 58.156 ms, heap usage 89.890 MB -> 35.681 MB. [2024-11-08T15:49:24.091Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6710.462 ms) ====== [2024-11-08T15:49:24.091Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-08T15:49:24.770Z] GC before operation: completed in 124.738 ms, heap usage 332.426 MB -> 76.312 MB. [2024-11-08T15:49:27.030Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2084.330 ms) ====== [2024-11-08T15:49:27.030Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-08T15:49:27.030Z] GC before operation: completed in 65.660 ms, heap usage 120.773 MB -> 64.890 MB. [2024-11-08T15:49:28.441Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1676.555 ms) ====== [2024-11-08T15:49:28.442Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-08T15:49:28.442Z] GC before operation: completed in 93.116 ms, heap usage 238.518 MB -> 65.849 MB. [2024-11-08T15:49:29.853Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1368.696 ms) ====== [2024-11-08T15:49:29.853Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-08T15:49:29.853Z] GC before operation: completed in 90.188 ms, heap usage 298.494 MB -> 76.840 MB. [2024-11-08T15:49:31.285Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1381.532 ms) ====== [2024-11-08T15:49:31.285Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-08T15:49:31.285Z] GC before operation: completed in 120.017 ms, heap usage 125.661 MB -> 65.593 MB. [2024-11-08T15:49:32.690Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1435.900 ms) ====== [2024-11-08T15:49:32.690Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-08T15:49:32.690Z] GC before operation: completed in 105.835 ms, heap usage 151.759 MB -> 66.069 MB. [2024-11-08T15:49:34.096Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1473.586 ms) ====== [2024-11-08T15:49:34.096Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-08T15:49:34.775Z] GC before operation: completed in 97.277 ms, heap usage 184.812 MB -> 77.798 MB. [2024-11-08T15:49:36.184Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1504.116 ms) ====== [2024-11-08T15:49:36.184Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-08T15:49:36.184Z] GC before operation: completed in 102.045 ms, heap usage 410.682 MB -> 83.229 MB. [2024-11-08T15:49:36.184Z] 24/11/08 09:49:35 WARN BlockManager: Asked to remove block rdd_389_0, which does not exist [2024-11-08T15:49:37.591Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1408.520 ms) ====== [2024-11-08T15:49:37.591Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-08T15:49:37.591Z] GC before operation: completed in 120.977 ms, heap usage 365.510 MB -> 94.399 MB. [2024-11-08T15:49:38.999Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1356.176 ms) ====== [2024-11-08T15:49:38.999Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-08T15:49:38.999Z] GC before operation: completed in 97.738 ms, heap usage 232.474 MB -> 83.534 MB. [2024-11-08T15:49:38.999Z] 24/11/08 09:49:38 WARN BlockManager: Asked to remove block rdd_487_1, which does not exist [2024-11-08T15:49:40.406Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1356.411 ms) ====== [2024-11-08T15:49:40.406Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-08T15:49:40.407Z] GC before operation: completed in 98.129 ms, heap usage 387.917 MB -> 83.696 MB. [2024-11-08T15:49:41.836Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1346.682 ms) ====== [2024-11-08T15:49:41.836Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-08T15:49:41.836Z] GC before operation: completed in 101.750 ms, heap usage 235.451 MB -> 67.529 MB. [2024-11-08T15:49:43.242Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1305.960 ms) ====== [2024-11-08T15:49:43.242Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-08T15:49:43.242Z] GC before operation: completed in 95.856 ms, heap usage 268.089 MB -> 95.102 MB. [2024-11-08T15:49:43.242Z] 24/11/08 09:49:42 WARN BlockManager: Asked to remove block broadcast_176_piece0, which does not exist [2024-11-08T15:49:44.652Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1382.743 ms) ====== [2024-11-08T15:49:44.652Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-08T15:49:44.652Z] GC before operation: completed in 83.879 ms, heap usage 286.158 MB -> 67.430 MB. [2024-11-08T15:49:46.074Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1540.038 ms) ====== [2024-11-08T15:49:46.074Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-08T15:49:46.753Z] GC before operation: completed in 101.221 ms, heap usage 293.467 MB -> 84.094 MB. [2024-11-08T15:49:48.160Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1572.231 ms) ====== [2024-11-08T15:49:48.160Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-08T15:49:48.160Z] GC before operation: completed in 84.227 ms, heap usage 361.433 MB -> 67.874 MB. [2024-11-08T15:49:49.568Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1351.496 ms) ====== [2024-11-08T15:49:49.568Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-08T15:49:49.568Z] GC before operation: completed in 109.290 ms, heap usage 265.620 MB -> 67.837 MB. [2024-11-08T15:49:50.974Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1239.982 ms) ====== [2024-11-08T15:49:50.974Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-08T15:49:50.974Z] GC before operation: completed in 105.807 ms, heap usage 247.862 MB -> 79.184 MB. [2024-11-08T15:49:52.382Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1321.613 ms) ====== [2024-11-08T15:49:52.382Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-08T15:49:52.382Z] GC before operation: completed in 315.013 ms, heap usage 438.870 MB -> 95.812 MB. [2024-11-08T15:49:53.795Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1302.900 ms) ====== [2024-11-08T15:49:53.795Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-08T15:49:53.795Z] GC before operation: completed in 102.222 ms, heap usage 203.423 MB -> 95.826 MB. [2024-11-08T15:49:55.309Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1477.015 ms) ====== [2024-11-08T15:49:55.309Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-08T15:49:55.309Z] GC before operation: completed in 93.503 ms, heap usage 255.715 MB -> 79.154 MB. [2024-11-08T15:49:56.720Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1278.661 ms) ====== [2024-11-08T15:49:56.720Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-08T15:49:56.720Z] GC before operation: completed in 96.961 ms, heap usage 126.196 MB -> 73.320 MB. [2024-11-08T15:49:56.720Z] 24/11/08 09:49:56 WARN BlockManager: Asked to remove block broadcast_302_piece0, which does not exist [2024-11-08T15:49:58.128Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1309.697 ms) ====== [2024-11-08T15:49:58.128Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-08T15:49:58.128Z] GC before operation: completed in 110.887 ms, heap usage 341.422 MB -> 90.636 MB. [2024-11-08T15:49:59.535Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1387.161 ms) ====== [2024-11-08T15:49:59.536Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-08T15:49:59.536Z] GC before operation: completed in 108.643 ms, heap usage 294.246 MB -> 96.386 MB. [2024-11-08T15:50:00.944Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1404.762 ms) ====== [2024-11-08T15:50:00.944Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-08T15:50:01.620Z] GC before operation: completed in 110.870 ms, heap usage 259.888 MB -> 96.549 MB. [2024-11-08T15:50:03.028Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1322.359 ms) ====== [2024-11-08T15:50:03.029Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-08T15:50:03.029Z] GC before operation: completed in 103.477 ms, heap usage 276.271 MB -> 96.755 MB. [2024-11-08T15:50:04.434Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1480.750 ms) ====== [2024-11-08T15:50:04.434Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-08T15:50:04.434Z] GC before operation: completed in 109.271 ms, heap usage 267.084 MB -> 79.675 MB. [2024-11-08T15:50:05.869Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1287.146 ms) ====== [2024-11-08T15:50:05.869Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-08T15:50:05.869Z] GC before operation: completed in 112.338 ms, heap usage 447.741 MB -> 96.703 MB. [2024-11-08T15:50:05.869Z] 24/11/08 09:50:05 WARN BlockManager: Asked to remove block broadcast_386, which does not exist [2024-11-08T15:50:05.869Z] 24/11/08 09:50:05 WARN BlockManager: Asked to remove block broadcast_386_piece0, which does not exist [2024-11-08T15:50:07.097Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1293.424 ms) ====== [2024-11-08T15:50:07.097Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-08T15:50:07.097Z] GC before operation: completed in 103.737 ms, heap usage 219.909 MB -> 68.970 MB. [2024-11-08T15:50:08.516Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1269.100 ms) ====== [2024-11-08T15:50:08.516Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-08T15:50:08.516Z] GC before operation: completed in 112.244 ms, heap usage 226.037 MB -> 85.375 MB. [2024-11-08T15:50:08.516Z] 24/11/08 09:50:08 WARN BlockManager: Asked to remove block rdd_1467_1, which does not exist [2024-11-08T15:50:09.920Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1221.421 ms) ====== [2024-11-08T15:50:09.920Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-08T15:50:09.920Z] GC before operation: completed in 119.155 ms, heap usage 363.477 MB -> 91.139 MB. [2024-11-08T15:50:11.354Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1305.972 ms) ====== [2024-11-08T15:50:11.354Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-08T15:50:11.354Z] GC before operation: completed in 116.570 ms, heap usage 280.726 MB -> 80.390 MB. [2024-11-08T15:50:12.761Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1213.763 ms) ====== [2024-11-08T15:50:12.761Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-08T15:50:12.761Z] GC before operation: completed in 114.112 ms, heap usage 414.061 MB -> 80.496 MB. [2024-11-08T15:50:14.163Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1249.787 ms) ====== [2024-11-08T15:50:14.163Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-08T15:50:14.163Z] GC before operation: completed in 109.653 ms, heap usage 363.245 MB -> 69.511 MB. [2024-11-08T15:50:15.566Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1279.656 ms) ====== [2024-11-08T15:50:15.566Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-08T15:50:15.566Z] GC before operation: completed in 97.083 ms, heap usage 203.015 MB -> 92.001 MB. [2024-11-08T15:50:16.968Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1412.315 ms) ====== [2024-11-08T15:50:16.969Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-08T15:50:16.969Z] GC before operation: completed in 95.518 ms, heap usage 304.888 MB -> 69.727 MB. [2024-11-08T15:50:18.373Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1251.150 ms) ====== [2024-11-08T15:50:18.373Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-08T15:50:18.373Z] GC before operation: completed in 111.233 ms, heap usage 231.906 MB -> 86.333 MB. [2024-11-08T15:50:19.806Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1126.981 ms) ====== [2024-11-08T15:50:19.806Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-08T15:50:19.806Z] GC before operation: completed in 97.866 ms, heap usage 348.509 MB -> 86.603 MB. [2024-11-08T15:50:20.483Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1221.676 ms) ====== [2024-11-08T15:50:20.483Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-08T15:50:21.249Z] GC before operation: completed in 109.475 ms, heap usage 317.815 MB -> 86.638 MB. [2024-11-08T15:50:21.929Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1346.162 ms) ====== [2024-11-08T15:50:22.607Z] ----------------------------------- [2024-11-08T15:50:22.607Z] renaissance-dec-tree_0_PASSED [2024-11-08T15:50:22.607Z] ----------------------------------- [2024-11-08T15:50:22.607Z] [2024-11-08T15:50:22.607Z] TEST TEARDOWN: [2024-11-08T15:50:22.607Z] Nothing to be done for teardown. [2024-11-08T15:50:22.607Z] renaissance-dec-tree_0 Finish Time: Fri Nov 8 09:50:22 2024 Epoch Time (ms): 1731081022322