[2024-11-28T07:32:42.312Z] Running test renaissance-dec-tree_0 ... [2024-11-28T07:32:42.640Z] =============================================== [2024-11-28T07:32:42.640Z] renaissance-dec-tree_0 Start Time: Thu Nov 28 07:32:42 2024 Epoch Time (ms): 1732779162513 [2024-11-28T07:32:42.967Z] variation: NoOptions [2024-11-28T07:32:42.967Z] JVM_OPTIONS: [2024-11-28T07:32:42.967Z] { \ [2024-11-28T07:32:42.967Z] echo ""; echo "TEST SETUP:"; \ [2024-11-28T07:32:42.967Z] echo "Nothing to be done for setup."; \ [2024-11-28T07:32:42.967Z] mkdir -p "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17327785319577\\renaissance-dec-tree_0"; \ [2024-11-28T07:32:42.967Z] cd "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17327785319577\\renaissance-dec-tree_0"; \ [2024-11-28T07:32:42.967Z] echo ""; echo "TESTING:"; \ [2024-11-28T07:32:42.967Z] "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_17327785319577\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2024-11-28T07:32:42.967Z] 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_17327785319577\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-28T07:32:42.967Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-28T07:32:42.967Z] echo "Nothing to be done for teardown."; \ [2024-11-28T07:32:42.967Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17327785319577\\TestTargetResult"; [2024-11-28T07:32:42.967Z] [2024-11-28T07:32:42.967Z] TEST SETUP: [2024-11-28T07:32:42.967Z] Nothing to be done for setup. [2024-11-28T07:32:42.967Z] [2024-11-28T07:32:42.967Z] TESTING: [2024-11-28T07:32:53.676Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-28T07:32:55.893Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-28T07:32:58.793Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-28T07:32:58.793Z] GC before operation: completed in 51.868 ms, heap usage 89.560 MB -> 35.400 MB. [2024-11-28T07:33:06.214Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7468.755 ms) ====== [2024-11-28T07:33:06.214Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-28T07:33:06.214Z] GC before operation: completed in 70.434 ms, heap usage 233.063 MB -> 64.861 MB. [2024-11-28T07:33:08.660Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2287.668 ms) ====== [2024-11-28T07:33:08.660Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-28T07:33:08.660Z] GC before operation: completed in 65.655 ms, heap usage 109.625 MB -> 64.752 MB. [2024-11-28T07:33:10.454Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1810.070 ms) ====== [2024-11-28T07:33:10.454Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-28T07:33:10.454Z] GC before operation: completed in 66.302 ms, heap usage 164.681 MB -> 65.354 MB. [2024-11-28T07:33:12.213Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1653.418 ms) ====== [2024-11-28T07:33:12.213Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-28T07:33:12.213Z] GC before operation: completed in 64.945 ms, heap usage 347.002 MB -> 76.962 MB. [2024-11-28T07:33:13.473Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1546.982 ms) ====== [2024-11-28T07:33:13.473Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-28T07:33:13.834Z] GC before operation: completed in 69.435 ms, heap usage 291.935 MB -> 77.104 MB. [2024-11-28T07:33:15.104Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1440.883 ms) ====== [2024-11-28T07:33:15.104Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-28T07:33:15.104Z] GC before operation: completed in 67.819 ms, heap usage 248.908 MB -> 77.388 MB. [2024-11-28T07:33:16.759Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1433.136 ms) ====== [2024-11-28T07:33:16.759Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-28T07:33:16.759Z] GC before operation: completed in 68.664 ms, heap usage 213.059 MB -> 77.425 MB. [2024-11-28T07:33:17.936Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1386.361 ms) ====== [2024-11-28T07:33:17.936Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-28T07:33:18.272Z] GC before operation: completed in 76.672 ms, heap usage 216.353 MB -> 77.956 MB. [2024-11-28T07:33:19.936Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1468.283 ms) ====== [2024-11-28T07:33:19.936Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-28T07:33:19.936Z] GC before operation: completed in 75.461 ms, heap usage 204.596 MB -> 78.047 MB. [2024-11-28T07:33:21.088Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1355.534 ms) ====== [2024-11-28T07:33:21.088Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-28T07:33:21.088Z] GC before operation: completed in 74.894 ms, heap usage 185.755 MB -> 72.258 MB. [2024-11-28T07:33:22.270Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1279.832 ms) ====== [2024-11-28T07:33:22.270Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-28T07:33:22.606Z] GC before operation: completed in 72.398 ms, heap usage 265.492 MB -> 66.977 MB. [2024-11-28T07:33:23.741Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1308.716 ms) ====== [2024-11-28T07:33:23.741Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-28T07:33:23.741Z] GC before operation: completed in 74.832 ms, heap usage 316.939 MB -> 78.275 MB. [2024-11-28T07:33:25.370Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1272.628 ms) ====== [2024-11-28T07:33:25.370Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-28T07:33:25.370Z] GC before operation: completed in 77.030 ms, heap usage 208.463 MB -> 83.857 MB. [2024-11-28T07:33:26.495Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1304.948 ms) ====== [2024-11-28T07:33:26.495Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-28T07:33:26.495Z] GC before operation: completed in 79.304 ms, heap usage 438.811 MB -> 78.737 MB. [2024-11-28T07:33:28.136Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1302.147 ms) ====== [2024-11-28T07:33:28.136Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-28T07:33:28.136Z] GC before operation: completed in 78.490 ms, heap usage 226.028 MB -> 84.007 MB. [2024-11-28T07:33:29.283Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1290.988 ms) ====== [2024-11-28T07:33:29.283Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-28T07:33:29.283Z] GC before operation: completed in 80.876 ms, heap usage 429.210 MB -> 67.850 MB. [2024-11-28T07:33:30.486Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1274.685 ms) ====== [2024-11-28T07:33:30.486Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-28T07:33:30.821Z] GC before operation: completed in 77.875 ms, heap usage 304.523 MB -> 67.820 MB. [2024-11-28T07:33:31.941Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1221.437 ms) ====== [2024-11-28T07:33:31.941Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-28T07:33:31.941Z] GC before operation: completed in 81.471 ms, heap usage 284.560 MB -> 84.700 MB. [2024-11-28T07:33:33.135Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1256.476 ms) ====== [2024-11-28T07:33:33.135Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-28T07:33:33.496Z] GC before operation: completed in 85.483 ms, heap usage 398.954 MB -> 84.533 MB. [2024-11-28T07:33:34.656Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1213.448 ms) ====== [2024-11-28T07:33:34.656Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-28T07:33:34.656Z] GC before operation: completed in 88.268 ms, heap usage 413.196 MB -> 90.075 MB. [2024-11-28T07:33:35.809Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1263.003 ms) ====== [2024-11-28T07:33:35.809Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-28T07:33:36.136Z] GC before operation: completed in 85.397 ms, heap usage 351.015 MB -> 84.746 MB. [2024-11-28T07:33:37.268Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1252.542 ms) ====== [2024-11-28T07:33:37.269Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-28T07:33:37.269Z] GC before operation: completed in 89.852 ms, heap usage 413.758 MB -> 84.816 MB. [2024-11-28T07:33:38.978Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1279.740 ms) ====== [2024-11-28T07:33:38.978Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-28T07:33:38.978Z] GC before operation: completed in 87.996 ms, heap usage 399.591 MB -> 90.562 MB. [2024-11-28T07:33:40.105Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1278.750 ms) ====== [2024-11-28T07:33:40.106Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-28T07:33:40.106Z] GC before operation: completed in 88.545 ms, heap usage 331.591 MB -> 84.956 MB. [2024-11-28T07:33:41.318Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1220.208 ms) ====== [2024-11-28T07:33:41.318Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-28T07:33:41.318Z] GC before operation: completed in 86.273 ms, heap usage 423.395 MB -> 85.155 MB. [2024-11-28T07:33:42.547Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1289.369 ms) ====== [2024-11-28T07:33:42.547Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-28T07:33:42.883Z] GC before operation: completed in 88.360 ms, heap usage 419.866 MB -> 90.698 MB. [2024-11-28T07:33:44.007Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1228.328 ms) ====== [2024-11-28T07:33:44.007Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-28T07:33:44.007Z] GC before operation: completed in 87.707 ms, heap usage 344.463 MB -> 85.378 MB. [2024-11-28T07:33:45.167Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1210.918 ms) ====== [2024-11-28T07:33:45.167Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-28T07:33:45.486Z] GC before operation: completed in 90.809 ms, heap usage 414.002 MB -> 85.457 MB. [2024-11-28T07:33:46.613Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1149.660 ms) ====== [2024-11-28T07:33:46.613Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-28T07:33:46.613Z] GC before operation: completed in 90.489 ms, heap usage 395.499 MB -> 90.976 MB. [2024-11-28T07:33:47.779Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1241.312 ms) ====== [2024-11-28T07:33:47.779Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-28T07:33:48.113Z] GC before operation: completed in 91.907 ms, heap usage 345.396 MB -> 91.238 MB. [2024-11-28T07:33:49.239Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1257.499 ms) ====== [2024-11-28T07:33:49.239Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-28T07:33:49.239Z] GC before operation: completed in 92.142 ms, heap usage 329.186 MB -> 91.135 MB. [2024-11-28T07:33:50.429Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1248.851 ms) ====== [2024-11-28T07:33:50.429Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-28T07:33:50.763Z] GC before operation: completed in 92.706 ms, heap usage 332.402 MB -> 85.590 MB. [2024-11-28T07:33:51.891Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1235.480 ms) ====== [2024-11-28T07:33:51.891Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-28T07:33:51.891Z] GC before operation: completed in 91.164 ms, heap usage 379.435 MB -> 85.880 MB. [2024-11-28T07:33:53.037Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1161.102 ms) ====== [2024-11-28T07:33:53.038Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-28T07:33:53.374Z] GC before operation: completed in 92.693 ms, heap usage 376.977 MB -> 86.023 MB. [2024-11-28T07:33:54.550Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1193.336 ms) ====== [2024-11-28T07:33:54.550Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-28T07:33:54.550Z] GC before operation: completed in 90.847 ms, heap usage 391.696 MB -> 86.188 MB. [2024-11-28T07:33:55.903Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1460.328 ms) ====== [2024-11-28T07:33:55.903Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-28T07:33:55.903Z] GC before operation: completed in 93.267 ms, heap usage 380.093 MB -> 86.453 MB. [2024-11-28T07:33:57.534Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1173.868 ms) ====== [2024-11-28T07:33:57.534Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-28T07:33:57.534Z] GC before operation: completed in 94.895 ms, heap usage 364.866 MB -> 86.290 MB. [2024-11-28T07:33:58.663Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1224.867 ms) ====== [2024-11-28T07:33:58.663Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-28T07:33:58.663Z] GC before operation: completed in 96.398 ms, heap usage 364.540 MB -> 86.364 MB. [2024-11-28T07:33:59.915Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1268.895 ms) ====== [2024-11-28T07:33:59.915Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-28T07:33:59.915Z] GC before operation: completed in 96.465 ms, heap usage 378.142 MB -> 92.150 MB. [2024-11-28T07:34:01.529Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1230.161 ms) ====== [2024-11-28T07:34:01.529Z] ----------------------------------- [2024-11-28T07:34:01.529Z] renaissance-dec-tree_0_PASSED [2024-11-28T07:34:01.529Z] ----------------------------------- [2024-11-28T07:34:01.529Z] [2024-11-28T07:34:01.529Z] TEST TEARDOWN: [2024-11-28T07:34:01.529Z] Nothing to be done for teardown. [2024-11-28T07:34:01.855Z] renaissance-dec-tree_0 Finish Time: Thu Nov 28 07:34:01 2024 Epoch Time (ms): 1732779241568