[2024-08-23T21:18:32.575Z] Running test renaissance-dec-tree_0 ... [2024-08-23T21:18:32.575Z] =============================================== [2024-08-23T21:18:32.575Z] renaissance-dec-tree_0 Start Time: Fri Aug 23 21:18:32 2024 Epoch Time (ms): 1724447912270 [2024-08-23T21:18:32.575Z] variation: NoOptions [2024-08-23T21:18:32.575Z] JVM_OPTIONS: [2024-08-23T21:18:32.575Z] { \ [2024-08-23T21:18:32.575Z] echo ""; echo "TEST SETUP:"; \ [2024-08-23T21:18:32.575Z] echo "Nothing to be done for setup."; \ [2024-08-23T21:18:32.575Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17244476067135/renaissance-dec-tree_0"; \ [2024-08-23T21:18:32.575Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17244476067135/renaissance-dec-tree_0"; \ [2024-08-23T21:18:32.575Z] echo ""; echo "TESTING:"; \ [2024-08-23T21:18:32.575Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17244476067135/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-23T21:18:32.575Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17244476067135/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-23T21:18:32.575Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-23T21:18:32.575Z] echo "Nothing to be done for teardown."; \ [2024-08-23T21:18:32.575Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17244476067135/TestTargetResult"; [2024-08-23T21:18:32.575Z] [2024-08-23T21:18:32.575Z] TEST SETUP: [2024-08-23T21:18:32.575Z] Nothing to be done for setup. [2024-08-23T21:18:32.575Z] [2024-08-23T21:18:32.575Z] TESTING: [2024-08-23T21:18:36.732Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-23T21:18:39.710Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-23T21:18:40.649Z] WARNING: An illegal reflective access operation has occurred [2024-08-23T21:18:40.649Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17244476067135/renaissance-dec-tree_0/harness-211833-3571236515279143953/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-23T21:18:40.649Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-23T21:18:40.649Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-23T21:18:40.649Z] WARNING: All illegal access operations will be denied in a future release [2024-08-23T21:18:44.748Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-23T21:18:44.748Z] GC before operation: completed in 61.838 ms, heap usage 80.896 MB -> 34.323 MB. [2024-08-23T21:18:56.208Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10984.331 ms) ====== [2024-08-23T21:18:56.208Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-23T21:18:56.208Z] GC before operation: completed in 136.356 ms, heap usage 270.964 MB -> 64.393 MB. [2024-08-23T21:18:58.138Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2205.484 ms) ====== [2024-08-23T21:18:58.138Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-23T21:18:58.138Z] GC before operation: completed in 142.129 ms, heap usage 214.281 MB -> 64.711 MB. [2024-08-23T21:19:00.070Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2004.409 ms) ====== [2024-08-23T21:19:00.070Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-23T21:19:00.070Z] GC before operation: completed in 133.871 ms, heap usage 138.741 MB -> 64.551 MB. [2024-08-23T21:19:02.001Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1805.763 ms) ====== [2024-08-23T21:19:02.001Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-23T21:19:02.001Z] GC before operation: completed in 131.336 ms, heap usage 111.474 MB -> 64.661 MB. [2024-08-23T21:19:03.931Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1691.663 ms) ====== [2024-08-23T21:19:03.931Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-23T21:19:03.931Z] GC before operation: completed in 139.498 ms, heap usage 130.099 MB -> 65.145 MB. [2024-08-23T21:19:06.557Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1619.323 ms) ====== [2024-08-23T21:19:06.557Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-23T21:19:06.557Z] GC before operation: completed in 146.297 ms, heap usage 127.372 MB -> 65.363 MB. [2024-08-23T21:19:07.519Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1577.160 ms) ====== [2024-08-23T21:19:07.519Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-23T21:19:07.519Z] GC before operation: completed in 153.906 ms, heap usage 98.908 MB -> 65.140 MB. [2024-08-23T21:19:08.459Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1557.232 ms) ====== [2024-08-23T21:19:08.459Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-23T21:19:09.398Z] GC before operation: completed in 153.733 ms, heap usage 163.795 MB -> 65.542 MB. [2024-08-23T21:19:10.338Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1556.333 ms) ====== [2024-08-23T21:19:10.338Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-23T21:19:10.338Z] GC before operation: completed in 163.342 ms, heap usage 224.971 MB -> 65.930 MB. [2024-08-23T21:19:12.271Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1505.912 ms) ====== [2024-08-23T21:19:12.271Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-23T21:19:12.271Z] GC before operation: completed in 179.979 ms, heap usage 208.408 MB -> 66.028 MB. [2024-08-23T21:19:14.201Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1604.276 ms) ====== [2024-08-23T21:19:14.201Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-23T21:19:14.201Z] GC before operation: completed in 165.145 ms, heap usage 193.763 MB -> 66.128 MB. [2024-08-23T21:19:16.129Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1433.155 ms) ====== [2024-08-23T21:19:16.129Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-23T21:19:16.129Z] GC before operation: completed in 164.909 ms, heap usage 183.004 MB -> 66.234 MB. [2024-08-23T21:19:17.068Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1447.855 ms) ====== [2024-08-23T21:19:17.068Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-23T21:19:17.068Z] GC before operation: completed in 167.880 ms, heap usage 146.673 MB -> 66.054 MB. [2024-08-23T21:19:18.999Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1420.866 ms) ====== [2024-08-23T21:19:18.999Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-23T21:19:18.999Z] GC before operation: completed in 170.680 ms, heap usage 189.881 MB -> 66.459 MB. [2024-08-23T21:19:20.960Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1474.421 ms) ====== [2024-08-23T21:19:20.960Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-23T21:19:20.960Z] GC before operation: completed in 179.351 ms, heap usage 157.243 MB -> 66.302 MB. [2024-08-23T21:19:21.922Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1420.496 ms) ====== [2024-08-23T21:19:21.922Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-23T21:19:21.922Z] GC before operation: completed in 177.328 ms, heap usage 172.917 MB -> 66.623 MB. [2024-08-23T21:19:23.853Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1508.991 ms) ====== [2024-08-23T21:19:23.853Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-23T21:19:23.853Z] GC before operation: completed in 180.054 ms, heap usage 191.766 MB -> 67.004 MB. [2024-08-23T21:19:25.782Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1390.989 ms) ====== [2024-08-23T21:19:25.782Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-23T21:19:25.782Z] GC before operation: completed in 178.782 ms, heap usage 163.841 MB -> 66.691 MB. [2024-08-23T21:19:26.722Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1394.508 ms) ====== [2024-08-23T21:19:26.722Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-23T21:19:26.722Z] GC before operation: completed in 185.208 ms, heap usage 111.891 MB -> 66.650 MB. [2024-08-23T21:19:28.649Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1406.420 ms) ====== [2024-08-23T21:19:28.649Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-23T21:19:28.649Z] GC before operation: completed in 186.702 ms, heap usage 181.007 MB -> 67.307 MB. [2024-08-23T21:19:30.579Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1359.212 ms) ====== [2024-08-23T21:19:30.579Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-23T21:19:30.579Z] GC before operation: completed in 226.117 ms, heap usage 117.285 MB -> 66.702 MB. [2024-08-23T21:19:31.518Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1378.929 ms) ====== [2024-08-23T21:19:31.518Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-23T21:19:31.518Z] GC before operation: completed in 186.427 ms, heap usage 190.170 MB -> 67.341 MB. [2024-08-23T21:19:33.487Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1307.920 ms) ====== [2024-08-23T21:19:33.487Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-23T21:19:33.487Z] GC before operation: completed in 188.965 ms, heap usage 147.527 MB -> 67.151 MB. [2024-08-23T21:19:34.427Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1355.583 ms) ====== [2024-08-23T21:19:34.427Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-23T21:19:35.365Z] GC before operation: completed in 190.257 ms, heap usage 129.003 MB -> 67.278 MB. [2024-08-23T21:19:36.310Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1367.088 ms) ====== [2024-08-23T21:19:36.310Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-23T21:19:36.310Z] GC before operation: completed in 193.301 ms, heap usage 107.544 MB -> 67.115 MB. [2024-08-23T21:19:38.381Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1346.732 ms) ====== [2024-08-23T21:19:38.381Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-23T21:19:38.381Z] GC before operation: completed in 196.818 ms, heap usage 292.861 MB -> 67.918 MB. [2024-08-23T21:19:39.321Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1368.601 ms) ====== [2024-08-23T21:19:39.321Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-23T21:19:39.321Z] GC before operation: completed in 194.041 ms, heap usage 204.689 MB -> 68.019 MB. [2024-08-23T21:19:41.285Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1349.025 ms) ====== [2024-08-23T21:19:41.285Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-23T21:19:41.285Z] GC before operation: completed in 199.927 ms, heap usage 223.334 MB -> 67.976 MB. [2024-08-23T21:19:42.225Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1387.156 ms) ====== [2024-08-23T21:19:42.225Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-23T21:19:43.164Z] GC before operation: completed in 200.544 ms, heap usage 222.058 MB -> 68.057 MB. [2024-08-23T21:19:44.104Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1302.944 ms) ====== [2024-08-23T21:19:44.104Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-23T21:19:44.104Z] GC before operation: completed in 201.546 ms, heap usage 230.663 MB -> 68.150 MB. [2024-08-23T21:19:46.032Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1326.252 ms) ====== [2024-08-23T21:19:46.032Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-23T21:19:46.032Z] GC before operation: completed in 202.287 ms, heap usage 188.343 MB -> 68.250 MB. [2024-08-23T21:19:46.981Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1374.104 ms) ====== [2024-08-23T21:19:46.981Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-23T21:19:46.981Z] GC before operation: completed in 200.532 ms, heap usage 117.698 MB -> 67.786 MB. [2024-08-23T21:19:49.077Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1427.929 ms) ====== [2024-08-23T21:19:49.078Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-23T21:19:49.078Z] GC before operation: completed in 207.691 ms, heap usage 147.706 MB -> 68.157 MB. [2024-08-23T21:19:50.029Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1347.611 ms) ====== [2024-08-23T21:19:50.029Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-23T21:19:50.968Z] GC before operation: completed in 210.792 ms, heap usage 129.934 MB -> 68.272 MB. [2024-08-23T21:19:51.908Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1365.809 ms) ====== [2024-08-23T21:19:51.908Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-23T21:19:51.908Z] GC before operation: completed in 208.941 ms, heap usage 213.648 MB -> 68.649 MB. [2024-08-23T21:19:53.854Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1381.728 ms) ====== [2024-08-23T21:19:53.854Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-23T21:19:53.854Z] GC before operation: completed in 200.198 ms, heap usage 187.031 MB -> 68.754 MB. [2024-08-23T21:19:54.794Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1348.311 ms) ====== [2024-08-23T21:19:54.794Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-23T21:19:55.733Z] GC before operation: completed in 206.320 ms, heap usage 146.619 MB -> 68.711 MB. [2024-08-23T21:19:56.674Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1332.735 ms) ====== [2024-08-23T21:19:56.674Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-23T21:19:56.674Z] GC before operation: completed in 204.592 ms, heap usage 125.899 MB -> 68.657 MB. [2024-08-23T21:19:58.604Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1346.054 ms) ====== [2024-08-23T21:19:58.604Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-23T21:19:58.604Z] GC before operation: completed in 210.346 ms, heap usage 158.082 MB -> 68.922 MB. [2024-08-23T21:19:59.544Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1329.599 ms) ====== [2024-08-23T21:20:00.489Z] ----------------------------------- [2024-08-23T21:20:00.489Z] renaissance-dec-tree_0_PASSED [2024-08-23T21:20:00.489Z] ----------------------------------- [2024-08-23T21:20:00.489Z] [2024-08-23T21:20:00.489Z] TEST TEARDOWN: [2024-08-23T21:20:00.489Z] Nothing to be done for teardown. [2024-08-23T21:20:00.489Z] renaissance-dec-tree_0 Finish Time: Fri Aug 23 21:19:59 2024 Epoch Time (ms): 1724447999605