[2024-08-01T00:35:37.344Z] Running test renaissance-dec-tree_0 ... [2024-08-01T00:35:37.344Z] =============================================== [2024-08-01T00:35:37.344Z] renaissance-dec-tree_0 Start Time: Thu Aug 1 00:35:36 2024 Epoch Time (ms): 1722472536934 [2024-08-01T00:35:37.344Z] variation: NoOptions [2024-08-01T00:35:37.344Z] JVM_OPTIONS: [2024-08-01T00:35:37.344Z] { \ [2024-08-01T00:35:37.344Z] echo ""; echo "TEST SETUP:"; \ [2024-08-01T00:35:37.344Z] echo "Nothing to be done for setup."; \ [2024-08-01T00:35:37.344Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224722299498/renaissance-dec-tree_0"; \ [2024-08-01T00:35:37.344Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224722299498/renaissance-dec-tree_0"; \ [2024-08-01T00:35:37.344Z] echo ""; echo "TESTING:"; \ [2024-08-01T00:35:37.344Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_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_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224722299498/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-01T00:35:37.344Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224722299498/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-01T00:35:37.344Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-01T00:35:37.344Z] echo "Nothing to be done for teardown."; \ [2024-08-01T00:35:37.344Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17224722299498/TestTargetResult"; [2024-08-01T00:35:37.344Z] [2024-08-01T00:35:37.344Z] TEST SETUP: [2024-08-01T00:35:37.344Z] Nothing to be done for setup. [2024-08-01T00:35:37.344Z] [2024-08-01T00:35:37.344Z] TESTING: [2024-08-01T00:35:41.446Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-01T00:35:44.421Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-01T00:35:47.400Z] WARNING: An illegal reflective access operation has occurred [2024-08-01T00:35:47.400Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/output_17224722299498/renaissance-dec-tree_0/harness-003537-13275100007925186565/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-01T00:35:47.400Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-01T00:35:47.400Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-01T00:35:47.400Z] WARNING: All illegal access operations will be denied in a future release [2024-08-01T00:35:54.007Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-01T00:35:54.007Z] GC before operation: completed in 63.207 ms, heap usage 98.060 MB -> 34.390 MB. [2024-08-01T00:36:07.373Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11697.342 ms) ====== [2024-08-01T00:36:07.373Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-01T00:36:07.373Z] GC before operation: completed in 174.204 ms, heap usage 278.885 MB -> 64.423 MB. [2024-08-01T00:36:08.314Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2536.968 ms) ====== [2024-08-01T00:36:08.314Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-01T00:36:09.255Z] GC before operation: completed in 132.108 ms, heap usage 217.219 MB -> 64.735 MB. [2024-08-01T00:36:11.184Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1943.455 ms) ====== [2024-08-01T00:36:11.184Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-01T00:36:11.184Z] GC before operation: completed in 150.162 ms, heap usage 162.716 MB -> 64.954 MB. [2024-08-01T00:36:13.112Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1985.184 ms) ====== [2024-08-01T00:36:13.112Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-01T00:36:13.112Z] GC before operation: completed in 148.336 ms, heap usage 117.150 MB -> 64.668 MB. [2024-08-01T00:36:15.048Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1953.265 ms) ====== [2024-08-01T00:36:15.048Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-01T00:36:15.048Z] GC before operation: completed in 159.939 ms, heap usage 244.144 MB -> 65.285 MB. [2024-08-01T00:36:16.981Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1580.158 ms) ====== [2024-08-01T00:36:16.981Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-01T00:36:16.981Z] GC before operation: completed in 170.196 ms, heap usage 167.542 MB -> 65.377 MB. [2024-08-01T00:36:19.670Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2014.295 ms) ====== [2024-08-01T00:36:19.670Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-01T00:36:19.670Z] GC before operation: completed in 184.327 ms, heap usage 155.048 MB -> 65.443 MB. [2024-08-01T00:36:20.622Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1753.197 ms) ====== [2024-08-01T00:36:20.622Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-01T00:36:20.622Z] GC before operation: completed in 195.075 ms, heap usage 167.488 MB -> 65.697 MB. [2024-08-01T00:36:22.563Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1460.950 ms) ====== [2024-08-01T00:36:22.563Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-01T00:36:22.563Z] GC before operation: completed in 219.286 ms, heap usage 154.717 MB -> 65.664 MB. [2024-08-01T00:36:24.499Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1488.638 ms) ====== [2024-08-01T00:36:24.499Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-01T00:36:24.499Z] GC before operation: completed in 177.810 ms, heap usage 103.490 MB -> 65.618 MB. [2024-08-01T00:36:26.430Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1731.972 ms) ====== [2024-08-01T00:36:26.430Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-01T00:36:26.430Z] GC before operation: completed in 181.136 ms, heap usage 143.768 MB -> 65.993 MB. [2024-08-01T00:36:28.363Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1837.096 ms) ====== [2024-08-01T00:36:28.363Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-01T00:36:28.363Z] GC before operation: completed in 181.436 ms, heap usage 190.232 MB -> 66.388 MB. [2024-08-01T00:36:30.292Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2017.986 ms) ====== [2024-08-01T00:36:30.292Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-01T00:36:30.292Z] GC before operation: completed in 176.582 ms, heap usage 155.518 MB -> 66.232 MB. [2024-08-01T00:36:32.222Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1706.204 ms) ====== [2024-08-01T00:36:32.223Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-01T00:36:32.223Z] GC before operation: completed in 177.638 ms, heap usage 154.099 MB -> 66.345 MB. [2024-08-01T00:36:34.152Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1791.337 ms) ====== [2024-08-01T00:36:34.152Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-01T00:36:34.152Z] GC before operation: completed in 198.818 ms, heap usage 153.536 MB -> 66.424 MB. [2024-08-01T00:36:36.080Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1453.643 ms) ====== [2024-08-01T00:36:36.080Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-01T00:36:36.080Z] GC before operation: completed in 183.530 ms, heap usage 147.094 MB -> 66.592 MB. [2024-08-01T00:36:38.010Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1436.441 ms) ====== [2024-08-01T00:36:38.010Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-01T00:36:38.010Z] GC before operation: completed in 188.921 ms, heap usage 98.749 MB -> 66.287 MB. [2024-08-01T00:36:38.949Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1341.678 ms) ====== [2024-08-01T00:36:38.949Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-01T00:36:38.949Z] GC before operation: completed in 227.490 ms, heap usage 99.352 MB -> 66.533 MB. [2024-08-01T00:36:40.879Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1411.960 ms) ====== [2024-08-01T00:36:40.879Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-01T00:36:40.879Z] GC before operation: completed in 194.284 ms, heap usage 98.125 MB -> 66.641 MB. [2024-08-01T00:36:41.818Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1403.352 ms) ====== [2024-08-01T00:36:41.818Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-01T00:36:42.759Z] GC before operation: completed in 196.004 ms, heap usage 111.581 MB -> 66.589 MB. [2024-08-01T00:36:43.697Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1527.143 ms) ====== [2024-08-01T00:36:43.697Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-01T00:36:44.636Z] GC before operation: completed in 206.357 ms, heap usage 276.948 MB -> 67.248 MB. [2024-08-01T00:36:45.574Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1337.956 ms) ====== [2024-08-01T00:36:45.574Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-01T00:36:45.574Z] GC before operation: completed in 195.549 ms, heap usage 166.847 MB -> 67.064 MB. [2024-08-01T00:36:47.501Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1322.265 ms) ====== [2024-08-01T00:36:47.501Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-01T00:36:47.501Z] GC before operation: completed in 193.595 ms, heap usage 107.370 MB -> 77.770 MB. [2024-08-01T00:36:48.441Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1215.153 ms) ====== [2024-08-01T00:36:48.441Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-01T00:36:48.441Z] GC before operation: completed in 199.359 ms, heap usage 202.391 MB -> 67.559 MB. [2024-08-01T00:36:50.385Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1667.212 ms) ====== [2024-08-01T00:36:50.385Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-01T00:36:50.385Z] GC before operation: completed in 201.811 ms, heap usage 160.166 MB -> 67.390 MB. [2024-08-01T00:36:52.309Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1373.272 ms) ====== [2024-08-01T00:36:52.309Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-01T00:36:52.309Z] GC before operation: completed in 201.496 ms, heap usage 244.826 MB -> 67.756 MB. [2024-08-01T00:36:54.260Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1676.439 ms) ====== [2024-08-01T00:36:54.260Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-01T00:36:54.260Z] GC before operation: completed in 205.580 ms, heap usage 117.712 MB -> 67.299 MB. [2024-08-01T00:36:55.197Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1648.638 ms) ====== [2024-08-01T00:36:55.197Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-01T00:36:56.136Z] GC before operation: completed in 201.233 ms, heap usage 154.311 MB -> 67.669 MB. [2024-08-01T00:36:57.075Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1310.132 ms) ====== [2024-08-01T00:36:57.075Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-01T00:36:57.075Z] GC before operation: completed in 198.277 ms, heap usage 114.908 MB -> 67.481 MB. [2024-08-01T00:36:59.001Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1247.822 ms) ====== [2024-08-01T00:36:59.001Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-01T00:36:59.002Z] GC before operation: completed in 205.923 ms, heap usage 269.103 MB -> 68.135 MB. [2024-08-01T00:36:59.941Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1252.684 ms) ====== [2024-08-01T00:36:59.941Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-01T00:36:59.941Z] GC before operation: completed in 207.782 ms, heap usage 274.440 MB -> 68.235 MB. [2024-08-01T00:37:01.876Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1225.449 ms) ====== [2024-08-01T00:37:01.876Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-01T00:37:01.876Z] GC before operation: completed in 251.013 ms, heap usage 231.142 MB -> 68.346 MB. [2024-08-01T00:37:03.807Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1653.082 ms) ====== [2024-08-01T00:37:03.807Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-01T00:37:03.807Z] GC before operation: completed in 200.974 ms, heap usage 203.134 MB -> 68.584 MB. [2024-08-01T00:37:05.738Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1656.681 ms) ====== [2024-08-01T00:37:05.738Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-01T00:37:05.738Z] GC before operation: completed in 204.696 ms, heap usage 132.114 MB -> 68.375 MB. [2024-08-01T00:37:06.679Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1358.618 ms) ====== [2024-08-01T00:37:06.679Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-01T00:37:06.679Z] GC before operation: completed in 208.764 ms, heap usage 186.051 MB -> 68.622 MB. [2024-08-01T00:37:08.612Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1723.856 ms) ====== [2024-08-01T00:37:08.612Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-01T00:37:08.612Z] GC before operation: completed in 212.539 ms, heap usage 256.237 MB -> 68.863 MB. [2024-08-01T00:37:10.543Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2034.048 ms) ====== [2024-08-01T00:37:10.543Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-01T00:37:11.482Z] GC before operation: completed in 226.318 ms, heap usage 168.307 MB -> 68.695 MB. [2024-08-01T00:37:13.412Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2067.796 ms) ====== [2024-08-01T00:37:13.412Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-01T00:37:13.412Z] GC before operation: completed in 256.157 ms, heap usage 237.432 MB -> 68.915 MB. [2024-08-01T00:37:15.338Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2048.151 ms) ====== [2024-08-01T00:37:15.338Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-01T00:37:16.281Z] GC before operation: completed in 228.103 ms, heap usage 220.432 MB -> 69.140 MB. [2024-08-01T00:37:17.221Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1596.644 ms) ====== [2024-08-01T00:37:18.161Z] ----------------------------------- [2024-08-01T00:37:18.161Z] renaissance-dec-tree_0_PASSED [2024-08-01T00:37:18.161Z] ----------------------------------- [2024-08-01T00:37:18.161Z] [2024-08-01T00:37:18.161Z] TEST TEARDOWN: [2024-08-01T00:37:18.161Z] Nothing to be done for teardown. [2024-08-01T00:37:18.161Z] renaissance-dec-tree_0 Finish Time: Thu Aug 1 00:37:17 2024 Epoch Time (ms): 1722472637410