[2024-11-28T02:43:50.115Z] Running test renaissance-dec-tree_0 ... [2024-11-28T02:43:50.115Z] =============================================== [2024-11-28T02:43:50.115Z] renaissance-dec-tree_0 Start Time: Thu Nov 28 02:43:49 2024 Epoch Time (ms): 1732761829908 [2024-11-28T02:43:50.115Z] variation: NoOptions [2024-11-28T02:43:50.115Z] JVM_OPTIONS: [2024-11-28T02:43:50.115Z] { \ [2024-11-28T02:43:50.115Z] echo ""; echo "TEST SETUP:"; \ [2024-11-28T02:43:50.115Z] echo "Nothing to be done for setup."; \ [2024-11-28T02:43:50.115Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17327592569882/renaissance-dec-tree_0"; \ [2024-11-28T02:43:50.115Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17327592569882/renaissance-dec-tree_0"; \ [2024-11-28T02:43:50.115Z] echo ""; echo "TESTING:"; \ [2024-11-28T02:43:50.115Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/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 "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17327592569882/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-28T02:43:50.115Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17327592569882/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-28T02:43:50.115Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-28T02:43:50.115Z] echo "Nothing to be done for teardown."; \ [2024-11-28T02:43:50.115Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17327592569882/TestTargetResult"; [2024-11-28T02:43:50.115Z] [2024-11-28T02:43:50.115Z] TEST SETUP: [2024-11-28T02:43:50.115Z] Nothing to be done for setup. [2024-11-28T02:43:50.115Z] [2024-11-28T02:43:50.115Z] TESTING: [2024-11-28T02:44:05.024Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-28T02:44:21.722Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-28T02:44:47.999Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-28T02:44:47.999Z] GC before operation: completed in 332.131 ms, heap usage 60.089 MB -> 35.139 MB. [2024-11-28T02:46:08.725Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (77284.693 ms) ====== [2024-11-28T02:46:08.725Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-28T02:46:08.725Z] GC before operation: completed in 792.580 ms, heap usage 178.039 MB -> 64.536 MB. [2024-11-28T02:46:29.427Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (25077.393 ms) ====== [2024-11-28T02:46:29.427Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-28T02:46:29.427Z] GC before operation: completed in 638.604 ms, heap usage 255.172 MB -> 64.794 MB. [2024-11-28T02:46:49.634Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (19777.065 ms) ====== [2024-11-28T02:46:49.634Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-28T02:46:49.634Z] GC before operation: completed in 640.842 ms, heap usage 131.976 MB -> 65.088 MB. [2024-11-28T02:47:10.547Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (18885.501 ms) ====== [2024-11-28T02:47:10.547Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-28T02:47:10.547Z] GC before operation: completed in 859.718 ms, heap usage 227.466 MB -> 65.452 MB. [2024-11-28T02:47:29.010Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (20065.498 ms) ====== [2024-11-28T02:47:29.010Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-28T02:47:29.977Z] GC before operation: completed in 821.873 ms, heap usage 274.166 MB -> 65.486 MB. [2024-11-28T02:47:50.756Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (18236.954 ms) ====== [2024-11-28T02:47:50.756Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-28T02:47:50.756Z] GC before operation: completed in 871.432 ms, heap usage 206.063 MB -> 65.742 MB. [2024-11-28T02:48:06.707Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (17317.338 ms) ====== [2024-11-28T02:48:06.707Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-28T02:48:07.632Z] GC before operation: completed in 616.290 ms, heap usage 120.081 MB -> 65.512 MB. [2024-11-28T02:48:23.180Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (15921.443 ms) ====== [2024-11-28T02:48:23.180Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-28T02:48:24.099Z] GC before operation: completed in 639.838 ms, heap usage 251.056 MB -> 66.184 MB. [2024-11-28T02:48:37.386Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (13926.742 ms) ====== [2024-11-28T02:48:37.386Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-28T02:48:38.309Z] GC before operation: completed in 664.111 ms, heap usage 247.586 MB -> 66.267 MB. [2024-11-28T02:48:51.591Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (13350.102 ms) ====== [2024-11-28T02:48:51.592Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-28T02:48:52.499Z] GC before operation: completed in 708.739 ms, heap usage 334.931 MB -> 66.293 MB. [2024-11-28T02:49:05.578Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (13344.396 ms) ====== [2024-11-28T02:49:05.578Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-28T02:49:06.485Z] GC before operation: completed in 770.803 ms, heap usage 316.497 MB -> 66.520 MB. [2024-11-28T02:49:22.335Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (14461.331 ms) ====== [2024-11-28T02:49:22.335Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-28T02:49:22.335Z] GC before operation: completed in 737.907 ms, heap usage 207.515 MB -> 66.667 MB. [2024-11-28T02:49:35.595Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (13858.578 ms) ====== [2024-11-28T02:49:35.595Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-28T02:49:36.521Z] GC before operation: completed in 756.437 ms, heap usage 334.879 MB -> 66.625 MB. [2024-11-28T02:49:49.519Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (11749.490 ms) ====== [2024-11-28T02:49:49.519Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-28T02:49:49.519Z] GC before operation: completed in 857.403 ms, heap usage 313.400 MB -> 66.695 MB. [2024-11-28T02:50:02.708Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (12972.334 ms) ====== [2024-11-28T02:50:02.708Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-28T02:50:02.708Z] GC before operation: completed in 803.938 ms, heap usage 301.674 MB -> 66.860 MB. [2024-11-28T02:50:13.878Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (11285.718 ms) ====== [2024-11-28T02:50:13.878Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-28T02:50:14.791Z] GC before operation: completed in 1000.688 ms, heap usage 308.113 MB -> 67.142 MB. [2024-11-28T02:50:26.052Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (10892.108 ms) ====== [2024-11-28T02:50:26.052Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-28T02:50:26.975Z] GC before operation: completed in 723.287 ms, heap usage 318.399 MB -> 67.280 MB. [2024-11-28T02:50:38.082Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (10359.856 ms) ====== [2024-11-28T02:50:38.082Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-28T02:50:38.082Z] GC before operation: completed in 838.226 ms, heap usage 312.430 MB -> 67.473 MB. [2024-11-28T02:50:50.237Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (12119.029 ms) ====== [2024-11-28T02:50:50.237Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-28T02:50:51.162Z] GC before operation: completed in 737.027 ms, heap usage 193.630 MB -> 67.492 MB. [2024-11-28T02:51:02.587Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (11718.221 ms) ====== [2024-11-28T02:51:02.587Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-28T02:51:03.523Z] GC before operation: completed in 941.040 ms, heap usage 295.104 MB -> 67.468 MB. [2024-11-28T02:51:15.085Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (11835.618 ms) ====== [2024-11-28T02:51:15.085Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-28T02:51:16.030Z] GC before operation: completed in 713.861 ms, heap usage 311.340 MB -> 67.738 MB. [2024-11-28T02:51:25.565Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (9724.979 ms) ====== [2024-11-28T02:51:25.565Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-28T02:51:26.499Z] GC before operation: completed in 751.360 ms, heap usage 305.297 MB -> 67.876 MB. [2024-11-28T02:51:37.741Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (11051.052 ms) ====== [2024-11-28T02:51:37.741Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-28T02:51:38.685Z] GC before operation: completed in 739.538 ms, heap usage 290.304 MB -> 67.936 MB. [2024-11-28T02:51:48.076Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (9986.268 ms) ====== [2024-11-28T02:51:48.076Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-28T02:51:49.002Z] GC before operation: completed in 811.936 ms, heap usage 295.339 MB -> 68.078 MB. [2024-11-28T02:52:00.908Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (10550.320 ms) ====== [2024-11-28T02:52:00.908Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-28T02:52:00.908Z] GC before operation: completed in 762.988 ms, heap usage 293.620 MB -> 68.150 MB. [2024-11-28T02:52:10.397Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (9081.874 ms) ====== [2024-11-28T02:52:10.397Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-28T02:52:10.397Z] GC before operation: completed in 791.047 ms, heap usage 158.276 MB -> 67.805 MB. [2024-11-28T02:52:21.558Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (10218.400 ms) ====== [2024-11-28T02:52:21.558Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-28T02:52:21.558Z] GC before operation: completed in 755.135 ms, heap usage 197.981 MB -> 68.375 MB. [2024-11-28T02:52:29.357Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (8444.044 ms) ====== [2024-11-28T02:52:29.357Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-28T02:52:30.266Z] GC before operation: completed in 755.320 ms, heap usage 275.739 MB -> 68.246 MB. [2024-11-28T02:52:41.344Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (10149.461 ms) ====== [2024-11-28T02:52:41.344Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-28T02:52:41.344Z] GC before operation: completed in 779.170 ms, heap usage 306.116 MB -> 68.366 MB. [2024-11-28T02:52:52.523Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (9782.992 ms) ====== [2024-11-28T02:52:52.523Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-28T02:52:52.523Z] GC before operation: completed in 757.367 ms, heap usage 200.506 MB -> 68.419 MB. [2024-11-28T02:53:03.854Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (10937.582 ms) ====== [2024-11-28T02:53:03.854Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-28T02:53:03.854Z] GC before operation: completed in 694.296 ms, heap usage 286.063 MB -> 68.696 MB. [2024-11-28T02:53:13.342Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (8800.317 ms) ====== [2024-11-28T02:53:13.342Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-28T02:53:13.342Z] GC before operation: completed in 784.236 ms, heap usage 290.431 MB -> 68.930 MB. [2024-11-28T02:53:23.288Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (9589.136 ms) ====== [2024-11-28T02:53:23.288Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-28T02:53:23.288Z] GC before operation: completed in 766.067 ms, heap usage 286.376 MB -> 68.907 MB. [2024-11-28T02:53:32.663Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (8478.582 ms) ====== [2024-11-28T02:53:32.663Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-28T02:53:32.663Z] GC before operation: completed in 735.486 ms, heap usage 285.122 MB -> 69.064 MB. [2024-11-28T02:53:43.739Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (9631.188 ms) ====== [2024-11-28T02:53:43.739Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-28T02:53:43.739Z] GC before operation: completed in 863.201 ms, heap usage 272.358 MB -> 68.985 MB. [2024-11-28T02:53:53.122Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (9647.786 ms) ====== [2024-11-28T02:53:53.122Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-28T02:53:54.020Z] GC before operation: completed in 814.802 ms, heap usage 292.428 MB -> 69.591 MB. [2024-11-28T02:54:03.360Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (9796.177 ms) ====== [2024-11-28T02:54:03.360Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-28T02:54:04.266Z] GC before operation: completed in 724.791 ms, heap usage 285.273 MB -> 69.454 MB. [2024-11-28T02:54:13.669Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (9458.369 ms) ====== [2024-11-28T02:54:13.669Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-28T02:54:14.574Z] GC before operation: completed in 791.498 ms, heap usage 168.660 MB -> 69.128 MB. [2024-11-28T02:54:23.996Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (9371.893 ms) ====== [2024-11-28T02:54:23.996Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-28T02:54:24.901Z] GC before operation: completed in 749.553 ms, heap usage 194.730 MB -> 91.246 MB. [2024-11-28T02:54:34.247Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (9938.386 ms) ====== [2024-11-28T02:54:35.931Z] ----------------------------------- [2024-11-28T02:54:35.931Z] renaissance-dec-tree_0_PASSED [2024-11-28T02:54:35.931Z] ----------------------------------- [2024-11-28T02:54:35.931Z] [2024-11-28T02:54:35.931Z] TEST TEARDOWN: [2024-11-28T02:54:35.931Z] Nothing to be done for teardown. [2024-11-28T02:54:36.748Z] renaissance-dec-tree_0 Finish Time: Thu Nov 28 02:54:35 2024 Epoch Time (ms): 1732762475927