[2024-11-14T23:29:22.576Z] Running test renaissance-dec-tree_0 ... [2024-11-14T23:29:22.576Z] =============================================== [2024-11-14T23:29:22.576Z] renaissance-dec-tree_0 Start Time: Thu Nov 14 23:29:21 2024 Epoch Time (ms): 1731626961937 [2024-11-14T23:29:22.576Z] variation: NoOptions [2024-11-14T23:29:22.576Z] JVM_OPTIONS: [2024-11-14T23:29:22.576Z] { \ [2024-11-14T23:29:22.576Z] echo ""; echo "TEST SETUP:"; \ [2024-11-14T23:29:22.576Z] echo "Nothing to be done for setup."; \ [2024-11-14T23:29:22.576Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17316245524245/renaissance-dec-tree_0"; \ [2024-11-14T23:29:22.576Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17316245524245/renaissance-dec-tree_0"; \ [2024-11-14T23:29:22.576Z] echo ""; echo "TESTING:"; \ [2024-11-14T23:29:22.576Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17316245524245/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-14T23:29:22.576Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17316245524245/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-14T23:29:22.576Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-14T23:29:22.576Z] echo "Nothing to be done for teardown."; \ [2024-11-14T23:29:22.576Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17316245524245/TestTargetResult"; [2024-11-14T23:29:22.576Z] [2024-11-14T23:29:22.576Z] TEST SETUP: [2024-11-14T23:29:22.576Z] Nothing to be done for setup. [2024-11-14T23:29:22.576Z] [2024-11-14T23:29:22.576Z] TESTING: [2024-11-14T23:29:36.889Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-14T23:29:49.812Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-14T23:29:55.647Z] WARNING: An illegal reflective access operation has occurred [2024-11-14T23:29:55.647Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17316245524245/renaissance-dec-tree_0/harness-232925-3686171828148553453/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-11-14T23:29:55.647Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-11-14T23:29:55.647Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-11-14T23:29:55.647Z] WARNING: All illegal access operations will be denied in a future release [2024-11-14T23:30:12.330Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-14T23:30:12.330Z] GC before operation: completed in 376.940 ms, heap usage 61.223 MB -> 33.805 MB. [2024-11-14T23:31:32.718Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (74340.811 ms) ====== [2024-11-14T23:31:32.718Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-14T23:31:32.718Z] GC before operation: completed in 860.629 ms, heap usage 165.879 MB -> 63.810 MB. [2024-11-14T23:31:49.641Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (23297.450 ms) ====== [2024-11-14T23:31:49.641Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-14T23:31:50.478Z] GC before operation: completed in 885.394 ms, heap usage 119.152 MB -> 63.974 MB. [2024-11-14T23:32:13.355Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (20862.653 ms) ====== [2024-11-14T23:32:13.355Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-14T23:32:13.355Z] GC before operation: completed in 674.579 ms, heap usage 99.147 MB -> 64.094 MB. [2024-11-14T23:32:32.790Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (18410.392 ms) ====== [2024-11-14T23:32:32.790Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-14T23:32:32.790Z] GC before operation: completed in 682.994 ms, heap usage 133.214 MB -> 64.423 MB. [2024-11-14T23:32:49.453Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (16321.932 ms) ====== [2024-11-14T23:32:49.454Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-14T23:32:49.454Z] GC before operation: completed in 681.216 ms, heap usage 147.138 MB -> 64.816 MB. [2024-11-14T23:33:03.802Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (14605.072 ms) ====== [2024-11-14T23:33:03.802Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-14T23:33:03.802Z] GC before operation: completed in 729.384 ms, heap usage 158.753 MB -> 64.875 MB. [2024-11-14T23:33:17.976Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (13826.821 ms) ====== [2024-11-14T23:33:17.976Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-14T23:33:18.764Z] GC before operation: completed in 785.167 ms, heap usage 186.702 MB -> 65.213 MB. [2024-11-14T23:33:33.090Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (13604.506 ms) ====== [2024-11-14T23:33:33.090Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-14T23:33:33.090Z] GC before operation: completed in 812.888 ms, heap usage 160.587 MB -> 65.142 MB. [2024-11-14T23:33:45.155Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (11679.722 ms) ====== [2024-11-14T23:33:45.155Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-14T23:33:45.155Z] GC before operation: completed in 810.170 ms, heap usage 256.367 MB -> 65.283 MB. [2024-11-14T23:33:57.432Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (11521.263 ms) ====== [2024-11-14T23:33:57.432Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-14T23:33:57.432Z] GC before operation: completed in 875.026 ms, heap usage 189.728 MB -> 65.392 MB. [2024-11-14T23:34:09.381Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (11428.071 ms) ====== [2024-11-14T23:34:09.381Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-14T23:34:10.163Z] GC before operation: completed in 571.650 ms, heap usage 195.648 MB -> 65.673 MB. [2024-11-14T23:34:18.555Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (8766.758 ms) ====== [2024-11-14T23:34:18.555Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-14T23:34:19.329Z] GC before operation: completed in 789.775 ms, heap usage 251.739 MB -> 65.607 MB. [2024-11-14T23:34:31.425Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (11596.523 ms) ====== [2024-11-14T23:34:31.425Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-14T23:34:32.198Z] GC before operation: completed in 1004.599 ms, heap usage 147.353 MB -> 65.428 MB. [2024-11-14T23:34:42.412Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (9924.136 ms) ====== [2024-11-14T23:34:42.412Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-14T23:34:43.212Z] GC before operation: completed in 1152.981 ms, heap usage 170.282 MB -> 65.557 MB. [2024-11-14T23:34:51.748Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (9012.104 ms) ====== [2024-11-14T23:34:51.748Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-14T23:34:52.563Z] GC before operation: completed in 762.418 ms, heap usage 219.121 MB -> 66.079 MB. [2024-11-14T23:35:03.377Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (10468.581 ms) ====== [2024-11-14T23:35:03.377Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-14T23:35:04.170Z] GC before operation: completed in 996.915 ms, heap usage 100.348 MB -> 66.020 MB. [2024-11-14T23:35:14.318Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (9562.885 ms) ====== [2024-11-14T23:35:14.318Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-14T23:35:15.089Z] GC before operation: completed in 816.432 ms, heap usage 213.472 MB -> 66.376 MB. [2024-11-14T23:35:22.149Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (7537.199 ms) ====== [2024-11-14T23:35:22.149Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-14T23:35:22.947Z] GC before operation: completed in 797.557 ms, heap usage 207.032 MB -> 66.296 MB. [2024-11-14T23:35:33.121Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (9535.389 ms) ====== [2024-11-14T23:35:33.121Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-14T23:35:33.898Z] GC before operation: completed in 881.217 ms, heap usage 103.943 MB -> 66.262 MB. [2024-11-14T23:35:42.337Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (8570.244 ms) ====== [2024-11-14T23:35:42.337Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-14T23:35:43.139Z] GC before operation: completed in 739.317 ms, heap usage 154.504 MB -> 66.377 MB. [2024-11-14T23:35:50.130Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (7196.342 ms) ====== [2024-11-14T23:35:50.130Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-14T23:35:50.906Z] GC before operation: completed in 641.187 ms, heap usage 173.608 MB -> 66.475 MB. [2024-11-14T23:35:59.399Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (8135.439 ms) ====== [2024-11-14T23:35:59.399Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-14T23:35:59.399Z] GC before operation: completed in 760.552 ms, heap usage 189.953 MB -> 66.944 MB. [2024-11-14T23:36:07.881Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (8316.849 ms) ====== [2024-11-14T23:36:07.881Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-14T23:36:08.677Z] GC before operation: completed in 740.702 ms, heap usage 108.415 MB -> 66.384 MB. [2024-11-14T23:36:15.716Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (7287.754 ms) ====== [2024-11-14T23:36:15.716Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-14T23:36:16.522Z] GC before operation: completed in 911.075 ms, heap usage 171.632 MB -> 66.835 MB. [2024-11-14T23:36:25.129Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (7665.980 ms) ====== [2024-11-14T23:36:25.129Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-14T23:36:25.129Z] GC before operation: completed in 806.829 ms, heap usage 188.350 MB -> 67.169 MB. [2024-11-14T23:36:33.650Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (8295.615 ms) ====== [2024-11-14T23:36:33.650Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-14T23:36:34.433Z] GC before operation: completed in 901.198 ms, heap usage 236.108 MB -> 67.081 MB. [2024-11-14T23:36:42.966Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (8625.792 ms) ====== [2024-11-14T23:36:42.966Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-14T23:36:43.767Z] GC before operation: completed in 844.117 ms, heap usage 231.000 MB -> 67.182 MB. [2024-11-14T23:36:51.446Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (7189.275 ms) ====== [2024-11-14T23:36:51.446Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-14T23:36:52.231Z] GC before operation: completed in 667.732 ms, heap usage 246.768 MB -> 67.361 MB. [2024-11-14T23:36:59.313Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (7178.007 ms) ====== [2024-11-14T23:36:59.313Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-14T23:37:00.114Z] GC before operation: completed in 696.110 ms, heap usage 217.765 MB -> 67.524 MB. [2024-11-14T23:37:10.257Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (10476.151 ms) ====== [2024-11-14T23:37:10.257Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-14T23:37:11.071Z] GC before operation: completed in 840.255 ms, heap usage 295.354 MB -> 67.473 MB. [2024-11-14T23:37:25.003Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (13061.116 ms) ====== [2024-11-14T23:37:25.003Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-14T23:37:25.003Z] GC before operation: completed in 783.301 ms, heap usage 129.327 MB -> 67.791 MB. [2024-11-14T23:37:32.718Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (7555.613 ms) ====== [2024-11-14T23:37:32.718Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-14T23:37:33.499Z] GC before operation: completed in 706.354 ms, heap usage 111.724 MB -> 67.284 MB. [2024-11-14T23:37:40.402Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (6423.443 ms) ====== [2024-11-14T23:37:40.402Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-14T23:37:40.402Z] GC before operation: completed in 623.533 ms, heap usage 183.805 MB -> 67.918 MB. [2024-11-14T23:37:47.427Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (7284.513 ms) ====== [2024-11-14T23:37:47.427Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-14T23:37:48.218Z] GC before operation: completed in 899.363 ms, heap usage 253.183 MB -> 67.899 MB. [2024-11-14T23:37:58.210Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (8911.487 ms) ====== [2024-11-14T23:37:58.210Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-14T23:37:58.210Z] GC before operation: completed in 967.657 ms, heap usage 164.280 MB -> 67.864 MB. [2024-11-14T23:38:06.568Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (8062.698 ms) ====== [2024-11-14T23:38:06.568Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-14T23:38:07.362Z] GC before operation: completed in 1006.583 ms, heap usage 218.045 MB -> 68.223 MB. [2024-11-14T23:38:14.312Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6985.218 ms) ====== [2024-11-14T23:38:14.312Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-14T23:38:15.088Z] GC before operation: completed in 764.136 ms, heap usage 213.652 MB -> 68.337 MB. [2024-11-14T23:38:22.068Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (7097.747 ms) ====== [2024-11-14T23:38:22.068Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-14T23:38:22.854Z] GC before operation: completed in 789.289 ms, heap usage 163.094 MB -> 68.156 MB. [2024-11-14T23:38:31.274Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (7624.343 ms) ====== [2024-11-14T23:38:31.275Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-14T23:38:32.066Z] GC before operation: completed in 1189.484 ms, heap usage 100.741 MB -> 68.083 MB. [2024-11-14T23:38:39.657Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (7721.860 ms) ====== [2024-11-14T23:38:41.281Z] ----------------------------------- [2024-11-14T23:38:41.281Z] renaissance-dec-tree_0_PASSED [2024-11-14T23:38:41.281Z] ----------------------------------- [2024-11-14T23:38:41.281Z] [2024-11-14T23:38:41.281Z] TEST TEARDOWN: [2024-11-14T23:38:41.281Z] Nothing to be done for teardown. [2024-11-14T23:38:41.281Z] renaissance-dec-tree_0 Finish Time: Thu Nov 14 23:38:40 2024 Epoch Time (ms): 1731627520552