[2025-02-17T18:11:09.490Z] Running test renaissance-dec-tree_0 ... [2025-02-17T18:11:09.814Z] =============================================== [2025-02-17T18:11:09.814Z] renaissance-dec-tree_0 Start Time: Mon Feb 17 18:11:09 2025 Epoch Time (ms): 1739815869612 [2025-02-17T18:11:09.814Z] variation: NoOptions [2025-02-17T18:11:09.814Z] JVM_OPTIONS: [2025-02-17T18:11:09.814Z] { \ [2025-02-17T18:11:09.814Z] echo ""; echo "TEST SETUP:"; \ [2025-02-17T18:11:09.814Z] echo "Nothing to be done for setup."; \ [2025-02-17T18:11:09.814Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398151574076\\renaissance-dec-tree_0"; \ [2025-02-17T18:11:09.814Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398151574076\\renaissance-dec-tree_0"; \ [2025-02-17T18:11:09.814Z] echo ""; echo "TESTING:"; \ [2025-02-17T18:11:09.814Z] "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_17398151574076\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2025-02-17T18:11:09.814Z] 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_17398151574076\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-17T18:11:09.814Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-17T18:11:09.814Z] echo "Nothing to be done for teardown."; \ [2025-02-17T18:11:09.814Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398151574076\\TestTargetResult"; [2025-02-17T18:11:10.149Z] [2025-02-17T18:11:10.149Z] TEST SETUP: [2025-02-17T18:11:10.149Z] Nothing to be done for setup. [2025-02-17T18:11:10.149Z] [2025-02-17T18:11:10.149Z] TESTING: [2025-02-17T18:11:23.144Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-17T18:11:24.781Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-17T18:11:28.489Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-17T18:11:28.489Z] GC before operation: completed in 67.087 ms, heap usage 90.324 MB -> 35.406 MB. [2025-02-17T18:11:37.520Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8614.645 ms) ====== [2025-02-17T18:11:37.520Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-17T18:11:37.520Z] GC before operation: completed in 89.580 ms, heap usage 263.976 MB -> 64.937 MB. [2025-02-17T18:11:39.284Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2349.115 ms) ====== [2025-02-17T18:11:39.284Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-17T18:11:39.284Z] GC before operation: completed in 68.935 ms, heap usage 134.227 MB -> 65.029 MB. [2025-02-17T18:11:41.628Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2029.208 ms) ====== [2025-02-17T18:11:41.628Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-17T18:11:41.628Z] GC before operation: completed in 78.475 ms, heap usage 220.784 MB -> 65.610 MB. [2025-02-17T18:11:43.336Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1846.488 ms) ====== [2025-02-17T18:11:43.336Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-17T18:11:43.336Z] GC before operation: completed in 74.664 ms, heap usage 207.031 MB -> 65.847 MB. [2025-02-17T18:11:45.093Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1684.322 ms) ====== [2025-02-17T18:11:45.093Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-17T18:11:45.093Z] GC before operation: completed in 73.953 ms, heap usage 299.017 MB -> 77.123 MB. [2025-02-17T18:11:46.755Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1749.553 ms) ====== [2025-02-17T18:11:46.755Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-17T18:11:47.119Z] GC before operation: completed in 86.631 ms, heap usage 374.207 MB -> 77.406 MB. [2025-02-17T18:11:48.783Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1614.843 ms) ====== [2025-02-17T18:11:48.783Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-17T18:11:48.783Z] GC before operation: completed in 80.080 ms, heap usage 245.773 MB -> 83.064 MB. [2025-02-17T18:11:49.969Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1435.143 ms) ====== [2025-02-17T18:11:49.969Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-17T18:11:50.318Z] GC before operation: completed in 81.421 ms, heap usage 450.633 MB -> 83.413 MB. [2025-02-17T18:11:52.033Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1462.534 ms) ====== [2025-02-17T18:11:52.033Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-17T18:11:52.033Z] GC before operation: completed in 78.189 ms, heap usage 178.613 MB -> 66.520 MB. [2025-02-17T18:11:53.173Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1413.901 ms) ====== [2025-02-17T18:11:53.173Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-17T18:11:53.173Z] GC before operation: completed in 82.899 ms, heap usage 326.744 MB -> 78.084 MB. [2025-02-17T18:11:54.864Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1384.301 ms) ====== [2025-02-17T18:11:54.864Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-17T18:11:54.864Z] GC before operation: completed in 81.216 ms, heap usage 202.255 MB -> 78.103 MB. [2025-02-17T18:11:55.999Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1338.613 ms) ====== [2025-02-17T18:11:55.999Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-17T18:11:55.999Z] GC before operation: completed in 85.541 ms, heap usage 183.299 MB -> 77.938 MB. [2025-02-17T18:11:57.629Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1391.733 ms) ====== [2025-02-17T18:11:57.629Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-17T18:11:57.629Z] GC before operation: completed in 83.269 ms, heap usage 143.501 MB -> 83.458 MB. [2025-02-17T18:11:59.276Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1363.031 ms) ====== [2025-02-17T18:11:59.276Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-17T18:11:59.276Z] GC before operation: completed in 94.917 ms, heap usage 381.034 MB -> 89.333 MB. [2025-02-17T18:12:00.407Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1364.663 ms) ====== [2025-02-17T18:12:00.407Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-17T18:12:00.407Z] GC before operation: completed in 90.909 ms, heap usage 347.969 MB -> 83.989 MB. [2025-02-17T18:12:00.407Z] 25/02/17 18:12:00 WARN BlockManager: Asked to remove block broadcast_204, which does not exist [2025-02-17T18:12:02.036Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1368.769 ms) ====== [2025-02-17T18:12:02.036Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-17T18:12:02.036Z] GC before operation: completed in 88.933 ms, heap usage 416.949 MB -> 67.857 MB. [2025-02-17T18:12:03.178Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1297.655 ms) ====== [2025-02-17T18:12:03.178Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-17T18:12:03.503Z] GC before operation: completed in 90.958 ms, heap usage 269.500 MB -> 67.777 MB. [2025-02-17T18:12:04.642Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1337.403 ms) ====== [2025-02-17T18:12:04.642Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-17T18:12:04.642Z] GC before operation: completed in 94.254 ms, heap usage 314.321 MB -> 84.437 MB. [2025-02-17T18:12:06.296Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1444.272 ms) ====== [2025-02-17T18:12:06.296Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-17T18:12:06.296Z] GC before operation: completed in 113.225 ms, heap usage 371.313 MB -> 84.480 MB. [2025-02-17T18:12:07.984Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1491.535 ms) ====== [2025-02-17T18:12:07.985Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-17T18:12:07.985Z] GC before operation: completed in 101.945 ms, heap usage 360.748 MB -> 84.771 MB. [2025-02-17T18:12:07.985Z] 25/02/17 18:12:07 WARN BlockManager: Asked to remove block rdd_977_1, which does not exist [2025-02-17T18:12:07.985Z] 25/02/17 18:12:07 WARN BlockManager: Asked to remove block rdd_977_2, which does not exist [2025-02-17T18:12:09.136Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1313.862 ms) ====== [2025-02-17T18:12:09.136Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-17T18:12:09.464Z] GC before operation: completed in 99.830 ms, heap usage 364.378 MB -> 84.681 MB. [2025-02-17T18:12:10.697Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1370.536 ms) ====== [2025-02-17T18:12:10.698Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-17T18:12:10.698Z] GC before operation: completed in 89.979 ms, heap usage 362.944 MB -> 84.836 MB. [2025-02-17T18:12:12.372Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1340.608 ms) ====== [2025-02-17T18:12:12.372Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-17T18:12:12.372Z] GC before operation: completed in 99.230 ms, heap usage 370.757 MB -> 90.634 MB. [2025-02-17T18:12:13.512Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1274.992 ms) ====== [2025-02-17T18:12:13.512Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-17T18:12:13.512Z] GC before operation: completed in 96.666 ms, heap usage 312.522 MB -> 85.161 MB. [2025-02-17T18:12:15.167Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1302.997 ms) ====== [2025-02-17T18:12:15.167Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-17T18:12:15.167Z] GC before operation: completed in 115.593 ms, heap usage 371.294 MB -> 96.205 MB. [2025-02-17T18:12:16.295Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1322.433 ms) ====== [2025-02-17T18:12:16.295Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-17T18:12:16.295Z] GC before operation: completed in 96.251 ms, heap usage 264.953 MB -> 85.281 MB. [2025-02-17T18:12:17.948Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1379.635 ms) ====== [2025-02-17T18:12:17.948Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-17T18:12:17.948Z] GC before operation: completed in 99.150 ms, heap usage 413.057 MB -> 85.319 MB. [2025-02-17T18:12:19.637Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1335.817 ms) ====== [2025-02-17T18:12:19.637Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-17T18:12:19.637Z] GC before operation: completed in 105.852 ms, heap usage 367.243 MB -> 85.411 MB. [2025-02-17T18:12:20.766Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1343.493 ms) ====== [2025-02-17T18:12:20.766Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-17T18:12:20.766Z] GC before operation: completed in 114.444 ms, heap usage 369.493 MB -> 90.962 MB. [2025-02-17T18:12:22.426Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1279.895 ms) ====== [2025-02-17T18:12:22.426Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-17T18:12:22.426Z] GC before operation: completed in 98.958 ms, heap usage 315.275 MB -> 85.603 MB. [2025-02-17T18:12:23.558Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1238.034 ms) ====== [2025-02-17T18:12:23.558Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-17T18:12:23.558Z] GC before operation: completed in 99.062 ms, heap usage 359.723 MB -> 91.147 MB. [2025-02-17T18:12:24.752Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1313.677 ms) ====== [2025-02-17T18:12:24.752Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-17T18:12:25.071Z] GC before operation: completed in 104.319 ms, heap usage 313.884 MB -> 91.318 MB. [2025-02-17T18:12:26.247Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1372.648 ms) ====== [2025-02-17T18:12:26.247Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-17T18:12:26.591Z] GC before operation: completed in 115.380 ms, heap usage 306.513 MB -> 85.937 MB. [2025-02-17T18:12:27.792Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1363.935 ms) ====== [2025-02-17T18:12:27.792Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-17T18:12:27.792Z] GC before operation: completed in 103.098 ms, heap usage 367.546 MB -> 86.001 MB. [2025-02-17T18:12:29.485Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1414.078 ms) ====== [2025-02-17T18:12:29.485Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-17T18:12:29.485Z] GC before operation: completed in 110.489 ms, heap usage 365.766 MB -> 91.562 MB. [2025-02-17T18:12:31.121Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1370.444 ms) ====== [2025-02-17T18:12:31.121Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-17T18:12:31.121Z] GC before operation: completed in 107.002 ms, heap usage 307.324 MB -> 86.344 MB. [2025-02-17T18:12:32.335Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1395.480 ms) ====== [2025-02-17T18:12:32.335Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-17T18:12:32.335Z] GC before operation: completed in 111.300 ms, heap usage 366.449 MB -> 86.343 MB. [2025-02-17T18:12:32.335Z] 25/02/17 18:12:32 WARN BlockManager: Asked to remove block rdd_1810_0, which does not exist [2025-02-17T18:12:33.964Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1373.231 ms) ====== [2025-02-17T18:12:33.964Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-17T18:12:33.964Z] GC before operation: completed in 108.006 ms, heap usage 337.772 MB -> 86.479 MB. [2025-02-17T18:12:35.126Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1300.995 ms) ====== [2025-02-17T18:12:35.126Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-17T18:12:35.466Z] GC before operation: completed in 122.656 ms, heap usage 347.735 MB -> 86.503 MB. [2025-02-17T18:12:36.603Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1295.920 ms) ====== [2025-02-17T18:12:36.935Z] ----------------------------------- [2025-02-17T18:12:36.935Z] renaissance-dec-tree_0_PASSED [2025-02-17T18:12:36.935Z] ----------------------------------- [2025-02-17T18:12:37.257Z] [2025-02-17T18:12:37.257Z] TEST TEARDOWN: [2025-02-17T18:12:37.257Z] Nothing to be done for teardown. [2025-02-17T18:12:37.257Z] renaissance-dec-tree_0 Finish Time: Mon Feb 17 18:12:37 2025 Epoch Time (ms): 1739815957024