[2024-08-15T06:24:56.927Z] Running test renaissance-dec-tree_0 ... [2024-08-15T06:24:56.927Z] =============================================== [2024-08-15T06:24:56.927Z] renaissance-dec-tree_0 Start Time: Thu Aug 15 06:24:56 2024 Epoch Time (ms): 1723703096708 [2024-08-15T06:24:56.927Z] variation: NoOptions [2024-08-15T06:24:56.927Z] JVM_OPTIONS: [2024-08-15T06:24:56.927Z] { \ [2024-08-15T06:24:56.927Z] echo ""; echo "TEST SETUP:"; \ [2024-08-15T06:24:56.927Z] echo "Nothing to be done for setup."; \ [2024-08-15T06:24:56.927Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17237025032524/renaissance-dec-tree_0"; \ [2024-08-15T06:24:56.927Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17237025032524/renaissance-dec-tree_0"; \ [2024-08-15T06:24:56.927Z] echo ""; echo "TESTING:"; \ [2024-08-15T06:24:56.927Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/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_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17237025032524/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-15T06:24:56.927Z] 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_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17237025032524/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-15T06:24:56.927Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-15T06:24:56.927Z] echo "Nothing to be done for teardown."; \ [2024-08-15T06:24:56.927Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17237025032524/TestTargetResult"; [2024-08-15T06:24:56.927Z] [2024-08-15T06:24:56.927Z] TEST SETUP: [2024-08-15T06:24:56.927Z] Nothing to be done for setup. [2024-08-15T06:24:56.927Z] [2024-08-15T06:24:56.927Z] TESTING: [2024-08-15T06:25:00.664Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-15T06:25:04.406Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-15T06:25:10.632Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-15T06:25:10.632Z] GC before operation: completed in 63.663 ms, heap usage 58.096 MB -> 35.134 MB. [2024-08-15T06:25:25.984Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15564.117 ms) ====== [2024-08-15T06:25:25.984Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-15T06:25:25.984Z] GC before operation: completed in 97.685 ms, heap usage 158.741 MB -> 64.513 MB. [2024-08-15T06:25:30.855Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4806.030 ms) ====== [2024-08-15T06:25:30.855Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-15T06:25:30.855Z] GC before operation: completed in 233.211 ms, heap usage 295.618 MB -> 65.038 MB. [2024-08-15T06:25:34.645Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3688.752 ms) ====== [2024-08-15T06:25:34.645Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-15T06:25:34.645Z] GC before operation: completed in 140.742 ms, heap usage 211.626 MB -> 65.308 MB. [2024-08-15T06:25:37.345Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2875.635 ms) ====== [2024-08-15T06:25:37.345Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-15T06:25:38.196Z] GC before operation: completed in 115.479 ms, heap usage 157.159 MB -> 65.415 MB. [2024-08-15T06:25:40.945Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3309.245 ms) ====== [2024-08-15T06:25:40.945Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-15T06:25:40.945Z] GC before operation: completed in 137.998 ms, heap usage 263.609 MB -> 65.901 MB. [2024-08-15T06:25:43.683Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2737.960 ms) ====== [2024-08-15T06:25:43.683Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-15T06:25:44.544Z] GC before operation: completed in 184.327 ms, heap usage 243.007 MB -> 66.214 MB. [2024-08-15T06:25:48.309Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3864.023 ms) ====== [2024-08-15T06:25:48.309Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-15T06:25:48.309Z] GC before operation: completed in 209.550 ms, heap usage 347.035 MB -> 66.329 MB. [2024-08-15T06:25:52.103Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3876.714 ms) ====== [2024-08-15T06:25:52.103Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-15T06:25:52.103Z] GC before operation: completed in 222.303 ms, heap usage 290.444 MB -> 66.310 MB. [2024-08-15T06:25:56.987Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4022.993 ms) ====== [2024-08-15T06:25:56.987Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-15T06:25:56.987Z] GC before operation: completed in 225.201 ms, heap usage 313.414 MB -> 66.629 MB. [2024-08-15T06:26:00.740Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4073.623 ms) ====== [2024-08-15T06:26:00.740Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-15T06:26:00.740Z] GC before operation: completed in 104.260 ms, heap usage 165.893 MB -> 66.571 MB. [2024-08-15T06:26:04.508Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3139.370 ms) ====== [2024-08-15T06:26:04.508Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-15T06:26:04.508Z] GC before operation: completed in 233.834 ms, heap usage 302.000 MB -> 77.900 MB. [2024-08-15T06:26:07.238Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3034.422 ms) ====== [2024-08-15T06:26:07.238Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-15T06:26:07.238Z] GC before operation: completed in 79.295 ms, heap usage 287.984 MB -> 66.761 MB. [2024-08-15T06:26:08.988Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1339.706 ms) ====== [2024-08-15T06:26:08.988Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-15T06:26:08.988Z] GC before operation: completed in 85.930 ms, heap usage 322.126 MB -> 67.121 MB. [2024-08-15T06:26:09.830Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1416.469 ms) ====== [2024-08-15T06:26:09.830Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-15T06:26:10.671Z] GC before operation: completed in 88.645 ms, heap usage 324.817 MB -> 78.036 MB. [2024-08-15T06:26:11.517Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1356.329 ms) ====== [2024-08-15T06:26:11.517Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-15T06:26:11.517Z] GC before operation: completed in 91.389 ms, heap usage 239.119 MB -> 67.337 MB. [2024-08-15T06:26:13.260Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1283.489 ms) ====== [2024-08-15T06:26:13.260Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-15T06:26:13.260Z] GC before operation: completed in 88.609 ms, heap usage 301.179 MB -> 67.430 MB. [2024-08-15T06:26:14.105Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1365.207 ms) ====== [2024-08-15T06:26:14.105Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-15T06:26:14.958Z] GC before operation: completed in 89.971 ms, heap usage 309.215 MB -> 67.551 MB. [2024-08-15T06:26:15.801Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1322.268 ms) ====== [2024-08-15T06:26:15.801Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-15T06:26:15.801Z] GC before operation: completed in 93.804 ms, heap usage 167.739 MB -> 67.320 MB. [2024-08-15T06:26:17.555Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1291.400 ms) ====== [2024-08-15T06:26:17.555Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-15T06:26:17.555Z] GC before operation: completed in 122.804 ms, heap usage 235.273 MB -> 67.751 MB. [2024-08-15T06:26:19.411Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1644.814 ms) ====== [2024-08-15T06:26:19.411Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-15T06:26:19.411Z] GC before operation: completed in 91.715 ms, heap usage 141.862 MB -> 78.751 MB. [2024-08-15T06:26:20.608Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1416.729 ms) ====== [2024-08-15T06:26:20.608Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-15T06:26:20.608Z] GC before operation: completed in 100.945 ms, heap usage 214.959 MB -> 73.614 MB. [2024-08-15T06:26:23.348Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2161.260 ms) ====== [2024-08-15T06:26:23.348Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-15T06:26:23.348Z] GC before operation: completed in 160.667 ms, heap usage 427.786 MB -> 68.204 MB. [2024-08-15T06:26:25.113Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2315.626 ms) ====== [2024-08-15T06:26:25.113Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-15T06:26:25.113Z] GC before operation: completed in 115.159 ms, heap usage 133.006 MB -> 68.086 MB. [2024-08-15T06:26:27.831Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2381.289 ms) ====== [2024-08-15T06:26:27.832Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-15T06:26:27.832Z] GC before operation: completed in 245.373 ms, heap usage 183.508 MB -> 68.106 MB. [2024-08-15T06:26:30.579Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2783.165 ms) ====== [2024-08-15T06:26:30.579Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-15T06:26:31.442Z] GC before operation: completed in 220.773 ms, heap usage 339.175 MB -> 68.428 MB. [2024-08-15T06:26:34.175Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2961.147 ms) ====== [2024-08-15T06:26:34.175Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-15T06:26:34.175Z] GC before operation: completed in 185.403 ms, heap usage 134.773 MB -> 68.197 MB. [2024-08-15T06:26:37.939Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3171.797 ms) ====== [2024-08-15T06:26:37.939Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-15T06:26:37.939Z] GC before operation: completed in 281.410 ms, heap usage 265.993 MB -> 68.804 MB. [2024-08-15T06:26:40.652Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3027.285 ms) ====== [2024-08-15T06:26:40.652Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-15T06:26:40.652Z] GC before operation: completed in 278.401 ms, heap usage 344.797 MB -> 68.474 MB. [2024-08-15T06:26:44.402Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3156.575 ms) ====== [2024-08-15T06:26:44.402Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-15T06:26:44.402Z] GC before operation: completed in 218.176 ms, heap usage 145.804 MB -> 68.462 MB. [2024-08-15T06:26:47.117Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3069.586 ms) ====== [2024-08-15T06:26:47.117Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-15T06:26:47.964Z] GC before operation: completed in 223.572 ms, heap usage 295.572 MB -> 68.896 MB. [2024-08-15T06:26:50.684Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3093.910 ms) ====== [2024-08-15T06:26:50.684Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-15T06:26:50.684Z] GC before operation: completed in 253.540 ms, heap usage 374.879 MB -> 69.006 MB. [2024-08-15T06:26:54.550Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3353.092 ms) ====== [2024-08-15T06:26:54.550Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-15T06:26:54.550Z] GC before operation: completed in 197.973 ms, heap usage 296.187 MB -> 69.104 MB. [2024-08-15T06:26:56.317Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1843.590 ms) ====== [2024-08-15T06:26:56.317Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-15T06:26:56.317Z] GC before operation: completed in 244.210 ms, heap usage 131.665 MB -> 68.797 MB. [2024-08-15T06:26:59.027Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1888.397 ms) ====== [2024-08-15T06:26:59.027Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-15T06:26:59.027Z] GC before operation: completed in 135.362 ms, heap usage 251.074 MB -> 69.155 MB. [2024-08-15T06:27:00.772Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1803.336 ms) ====== [2024-08-15T06:27:00.772Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-15T06:27:00.772Z] GC before operation: completed in 138.301 ms, heap usage 132.058 MB -> 69.101 MB. [2024-08-15T06:27:02.525Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1506.377 ms) ====== [2024-08-15T06:27:02.525Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-15T06:27:02.525Z] GC before operation: completed in 121.754 ms, heap usage 111.693 MB -> 68.971 MB. [2024-08-15T06:27:04.273Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1784.698 ms) ====== [2024-08-15T06:27:04.273Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-15T06:27:04.273Z] GC before operation: completed in 131.933 ms, heap usage 148.591 MB -> 69.284 MB. [2024-08-15T06:27:06.018Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1521.400 ms) ====== [2024-08-15T06:27:06.018Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-15T06:27:06.018Z] GC before operation: completed in 109.726 ms, heap usage 212.780 MB -> 74.922 MB. [2024-08-15T06:27:07.769Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1728.039 ms) ====== [2024-08-15T06:27:07.769Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-15T06:27:07.769Z] GC before operation: completed in 156.691 ms, heap usage 290.988 MB -> 69.616 MB. [2024-08-15T06:27:09.519Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2086.601 ms) ====== [2024-08-15T06:27:10.367Z] ----------------------------------- [2024-08-15T06:27:10.367Z] renaissance-dec-tree_0_PASSED [2024-08-15T06:27:10.367Z] ----------------------------------- [2024-08-15T06:27:10.367Z] [2024-08-15T06:27:10.368Z] TEST TEARDOWN: [2024-08-15T06:27:10.368Z] Nothing to be done for teardown. [2024-08-15T06:27:10.368Z] renaissance-dec-tree_0 Finish Time: Thu Aug 15 06:27:09 2024 Epoch Time (ms): 1723703229660