[2024-11-14T01:01:29.294Z] Running test renaissance-dec-tree_0 ... [2024-11-14T01:01:29.294Z] =============================================== [2024-11-14T01:01:29.294Z] renaissance-dec-tree_0 Start Time: Thu Nov 14 01:01:28 2024 Epoch Time (ms): 1731546088913 [2024-11-14T01:01:29.294Z] variation: NoOptions [2024-11-14T01:01:29.294Z] JVM_OPTIONS: [2024-11-14T01:01:29.294Z] { \ [2024-11-14T01:01:29.294Z] echo ""; echo "TEST SETUP:"; \ [2024-11-14T01:01:29.294Z] echo "Nothing to be done for setup."; \ [2024-11-14T01:01:29.294Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1731543159347/renaissance-dec-tree_0"; \ [2024-11-14T01:01:29.294Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1731543159347/renaissance-dec-tree_0"; \ [2024-11-14T01:01:29.294Z] echo ""; echo "TESTING:"; \ [2024-11-14T01:01:29.294Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk-17.0.14+3/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_1731543159347/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-14T01:01:29.294Z] 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_1731543159347/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-14T01:01:29.294Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-14T01:01:29.294Z] echo "Nothing to be done for teardown."; \ [2024-11-14T01:01:29.294Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1731543159347/TestTargetResult"; [2024-11-14T01:01:29.294Z] [2024-11-14T01:01:29.294Z] TEST SETUP: [2024-11-14T01:01:29.294Z] Nothing to be done for setup. [2024-11-14T01:01:29.294Z] [2024-11-14T01:01:29.294Z] TESTING: [2024-11-14T01:01:51.339Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-14T01:02:05.232Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-14T01:02:36.291Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-14T01:02:36.291Z] GC before operation: completed in 370.816 ms, heap usage 87.717 MB -> 35.383 MB. [2024-11-14T01:03:55.628Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (78170.871 ms) ====== [2024-11-14T01:03:55.628Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-14T01:03:55.628Z] GC before operation: completed in 829.647 ms, heap usage 241.165 MB -> 64.676 MB. [2024-11-14T01:04:18.272Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (24768.743 ms) ====== [2024-11-14T01:04:18.272Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-14T01:04:18.272Z] GC before operation: completed in 680.107 ms, heap usage 111.823 MB -> 64.652 MB. [2024-11-14T01:04:40.827Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (21246.227 ms) ====== [2024-11-14T01:04:40.827Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-14T01:04:40.827Z] GC before operation: completed in 600.833 ms, heap usage 207.567 MB -> 65.481 MB. [2024-11-14T01:05:00.205Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (19685.742 ms) ====== [2024-11-14T01:05:00.205Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-14T01:05:00.205Z] GC before operation: completed in 587.256 ms, heap usage 105.617 MB -> 65.665 MB. [2024-11-14T01:05:22.883Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (20268.168 ms) ====== [2024-11-14T01:05:22.883Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-14T01:05:22.883Z] GC before operation: completed in 631.356 ms, heap usage 400.177 MB -> 66.212 MB. [2024-11-14T01:05:39.536Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (16862.113 ms) ====== [2024-11-14T01:05:39.536Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-14T01:05:39.536Z] GC before operation: completed in 812.734 ms, heap usage 164.555 MB -> 65.750 MB. [2024-11-14T01:05:56.434Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (16784.402 ms) ====== [2024-11-14T01:05:56.434Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-14T01:05:56.434Z] GC before operation: completed in 590.318 ms, heap usage 237.055 MB -> 66.371 MB. [2024-11-14T01:06:13.309Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (15187.374 ms) ====== [2024-11-14T01:06:13.309Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-14T01:06:13.309Z] GC before operation: completed in 762.223 ms, heap usage 331.072 MB -> 66.383 MB. [2024-11-14T01:06:30.069Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (16067.480 ms) ====== [2024-11-14T01:06:30.069Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-14T01:06:30.069Z] GC before operation: completed in 845.761 ms, heap usage 315.390 MB -> 66.464 MB. [2024-11-14T01:06:44.236Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (14986.523 ms) ====== [2024-11-14T01:06:44.236Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-14T01:06:45.036Z] GC before operation: completed in 789.367 ms, heap usage 324.374 MB -> 66.986 MB. [2024-11-14T01:06:59.166Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (14184.858 ms) ====== [2024-11-14T01:06:59.166Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-14T01:06:59.962Z] GC before operation: completed in 713.413 ms, heap usage 312.623 MB -> 66.847 MB. [2024-11-14T01:07:16.819Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (14415.576 ms) ====== [2024-11-14T01:07:16.819Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-14T01:07:16.819Z] GC before operation: completed in 782.963 ms, heap usage 314.943 MB -> 66.807 MB. [2024-11-14T01:07:30.974Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (14509.443 ms) ====== [2024-11-14T01:07:30.974Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-14T01:07:30.974Z] GC before operation: completed in 784.362 ms, heap usage 221.715 MB -> 66.925 MB. [2024-11-14T01:07:47.579Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (16127.418 ms) ====== [2024-11-14T01:07:47.579Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-14T01:07:47.579Z] GC before operation: completed in 813.673 ms, heap usage 316.247 MB -> 67.081 MB. [2024-11-14T01:07:59.540Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (12171.195 ms) ====== [2024-11-14T01:07:59.540Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-14T01:08:00.457Z] GC before operation: completed in 933.481 ms, heap usage 309.622 MB -> 67.513 MB. [2024-11-14T01:08:14.631Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (13668.223 ms) ====== [2024-11-14T01:08:14.631Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-14T01:08:15.404Z] GC before operation: completed in 834.158 ms, heap usage 300.817 MB -> 67.441 MB. [2024-11-14T01:08:29.701Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (13633.706 ms) ====== [2024-11-14T01:08:29.701Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-14T01:08:29.701Z] GC before operation: completed in 778.891 ms, heap usage 304.327 MB -> 67.607 MB. [2024-11-14T01:08:41.651Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (12480.184 ms) ====== [2024-11-14T01:08:41.651Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-14T01:08:43.277Z] GC before operation: completed in 879.406 ms, heap usage 302.505 MB -> 67.712 MB. [2024-11-14T01:08:57.632Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (12731.818 ms) ====== [2024-11-14T01:08:57.632Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-14T01:08:57.632Z] GC before operation: completed in 903.630 ms, heap usage 305.543 MB -> 67.685 MB. [2024-11-14T01:09:09.501Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (12551.743 ms) ====== [2024-11-14T01:09:09.501Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-14T01:09:10.273Z] GC before operation: completed in 877.543 ms, heap usage 303.389 MB -> 67.734 MB. [2024-11-14T01:09:24.433Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (12743.503 ms) ====== [2024-11-14T01:09:24.433Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-14T01:09:24.433Z] GC before operation: completed in 873.434 ms, heap usage 320.165 MB -> 68.216 MB. [2024-11-14T01:09:36.347Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (12777.703 ms) ====== [2024-11-14T01:09:36.347Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-14T01:09:37.155Z] GC before operation: completed in 692.905 ms, heap usage 272.000 MB -> 68.156 MB. [2024-11-14T01:09:48.942Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (10733.579 ms) ====== [2024-11-14T01:09:48.942Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-14T01:09:48.942Z] GC before operation: completed in 680.528 ms, heap usage 298.373 MB -> 68.208 MB. [2024-11-14T01:10:00.888Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (11654.317 ms) ====== [2024-11-14T01:10:00.888Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-14T01:10:00.888Z] GC before operation: completed in 744.563 ms, heap usage 307.372 MB -> 68.792 MB. [2024-11-14T01:10:10.908Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (9669.110 ms) ====== [2024-11-14T01:10:10.908Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-14T01:10:10.908Z] GC before operation: completed in 599.059 ms, heap usage 274.417 MB -> 68.295 MB. [2024-11-14T01:10:20.925Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (9562.441 ms) ====== [2024-11-14T01:10:20.925Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-14T01:10:21.697Z] GC before operation: completed in 605.030 ms, heap usage 203.900 MB -> 68.508 MB. [2024-11-14T01:10:30.237Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (9154.744 ms) ====== [2024-11-14T01:10:30.237Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-14T01:10:31.022Z] GC before operation: completed in 571.691 ms, heap usage 293.316 MB -> 68.865 MB. [2024-11-14T01:10:40.066Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (8364.581 ms) ====== [2024-11-14T01:10:40.066Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-14T01:10:40.066Z] GC before operation: completed in 617.905 ms, heap usage 294.400 MB -> 68.680 MB. [2024-11-14T01:10:50.019Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (9890.938 ms) ====== [2024-11-14T01:10:50.019Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-14T01:10:50.839Z] GC before operation: completed in 653.958 ms, heap usage 145.031 MB -> 68.548 MB. [2024-11-14T01:10:59.306Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (8083.154 ms) ====== [2024-11-14T01:10:59.306Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-14T01:10:59.306Z] GC before operation: completed in 661.739 ms, heap usage 238.651 MB -> 68.900 MB. [2024-11-14T01:11:07.795Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (8726.902 ms) ====== [2024-11-14T01:11:07.795Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-14T01:11:08.590Z] GC before operation: completed in 802.977 ms, heap usage 117.831 MB -> 68.672 MB. [2024-11-14T01:11:18.635Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (8829.935 ms) ====== [2024-11-14T01:11:18.635Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-14T01:11:18.635Z] GC before operation: completed in 569.305 ms, heap usage 312.844 MB -> 69.099 MB. [2024-11-14T01:11:27.041Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (7768.660 ms) ====== [2024-11-14T01:11:27.041Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-14T01:11:27.041Z] GC before operation: completed in 620.525 ms, heap usage 285.849 MB -> 69.174 MB. [2024-11-14T01:11:35.550Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (7838.493 ms) ====== [2024-11-14T01:11:35.550Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-14T01:11:35.550Z] GC before operation: completed in 629.585 ms, heap usage 369.928 MB -> 69.168 MB. [2024-11-14T01:11:43.969Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (8294.304 ms) ====== [2024-11-14T01:11:43.969Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-14T01:11:43.969Z] GC before operation: completed in 731.870 ms, heap usage 260.168 MB -> 69.561 MB. [2024-11-14T01:11:53.954Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (8613.670 ms) ====== [2024-11-14T01:11:53.954Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-14T01:11:53.954Z] GC before operation: completed in 689.265 ms, heap usage 274.709 MB -> 69.512 MB. [2024-11-14T01:12:02.323Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (8293.664 ms) ====== [2024-11-14T01:12:02.323Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-14T01:12:02.323Z] GC before operation: completed in 459.124 ms, heap usage 377.918 MB -> 69.675 MB. [2024-11-14T01:12:12.935Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (9586.141 ms) ====== [2024-11-14T01:12:12.935Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-14T01:12:12.935Z] GC before operation: completed in 850.640 ms, heap usage 262.592 MB -> 69.686 MB. [2024-11-14T01:12:21.387Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (8528.408 ms) ====== [2024-11-14T01:12:21.387Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-14T01:12:22.177Z] GC before operation: completed in 769.642 ms, heap usage 101.460 MB -> 69.522 MB. [2024-11-14T01:12:30.605Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (8585.574 ms) ====== [2024-11-14T01:12:32.210Z] ----------------------------------- [2024-11-14T01:12:32.210Z] renaissance-dec-tree_0_PASSED [2024-11-14T01:12:32.210Z] ----------------------------------- [2024-11-14T01:12:32.210Z] [2024-11-14T01:12:32.210Z] TEST TEARDOWN: [2024-11-14T01:12:32.210Z] Nothing to be done for teardown. [2024-11-14T01:12:32.210Z] renaissance-dec-tree_0 Finish Time: Thu Nov 14 01:12:31 2024 Epoch Time (ms): 1731546751992