[2024-08-10T14:33:41.281Z] Running test renaissance-dec-tree_0 ... [2024-08-10T14:33:41.281Z] =============================================== [2024-08-10T14:33:41.281Z] renaissance-dec-tree_0 Start Time: Sat Aug 10 14:33:41 2024 Epoch Time (ms): 1723300421179 [2024-08-10T14:33:41.281Z] variation: NoOptions [2024-08-10T14:33:41.281Z] JVM_OPTIONS: [2024-08-10T14:33:41.281Z] { \ [2024-08-10T14:33:41.281Z] echo ""; echo "TEST SETUP:"; \ [2024-08-10T14:33:41.281Z] echo "Nothing to be done for setup."; \ [2024-08-10T14:33:41.281Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232999331475/renaissance-dec-tree_0"; \ [2024-08-10T14:33:41.282Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232999331475/renaissance-dec-tree_0"; \ [2024-08-10T14:33:41.282Z] echo ""; echo "TESTING:"; \ [2024-08-10T14:33:41.282Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232999331475/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-10T14:33:41.282Z] 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_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232999331475/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-10T14:33:41.282Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-10T14:33:41.282Z] echo "Nothing to be done for teardown."; \ [2024-08-10T14:33:41.282Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232999331475/TestTargetResult"; [2024-08-10T14:33:41.282Z] [2024-08-10T14:33:41.282Z] TEST SETUP: [2024-08-10T14:33:41.282Z] Nothing to be done for setup. [2024-08-10T14:33:41.282Z] [2024-08-10T14:33:41.282Z] TESTING: [2024-08-10T14:33:45.107Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-10T14:33:46.870Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-10T14:33:47.726Z] WARNING: An illegal reflective access operation has occurred [2024-08-10T14:33:47.726Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17232999331475/renaissance-dec-tree_0/harness-143341-17014319557152074970/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-10T14:33:47.726Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-10T14:33:47.726Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-10T14:33:47.726Z] WARNING: All illegal access operations will be denied in a future release [2024-08-10T14:33:50.448Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-10T14:33:50.448Z] GC before operation: completed in 63.069 ms, heap usage 51.442 MB -> 33.761 MB. [2024-08-10T14:34:01.126Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10989.716 ms) ====== [2024-08-10T14:34:01.126Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-10T14:34:01.126Z] GC before operation: completed in 158.769 ms, heap usage 111.578 MB -> 63.761 MB. [2024-08-10T14:34:04.887Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3492.996 ms) ====== [2024-08-10T14:34:04.887Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-10T14:34:04.887Z] GC before operation: completed in 99.263 ms, heap usage 115.462 MB -> 63.681 MB. [2024-08-10T14:34:07.620Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2547.789 ms) ====== [2024-08-10T14:34:07.620Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-10T14:34:07.620Z] GC before operation: completed in 102.023 ms, heap usage 156.779 MB -> 64.393 MB. [2024-08-10T14:34:10.350Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2333.953 ms) ====== [2024-08-10T14:34:10.350Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-10T14:34:10.350Z] GC before operation: completed in 115.136 ms, heap usage 131.479 MB -> 64.605 MB. [2024-08-10T14:34:12.120Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2262.974 ms) ====== [2024-08-10T14:34:12.120Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-10T14:34:12.120Z] GC before operation: completed in 138.264 ms, heap usage 239.342 MB -> 64.828 MB. [2024-08-10T14:34:14.997Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1995.313 ms) ====== [2024-08-10T14:34:14.997Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-10T14:34:14.997Z] GC before operation: completed in 110.960 ms, heap usage 223.509 MB -> 65.032 MB. [2024-08-10T14:34:16.309Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1791.532 ms) ====== [2024-08-10T14:34:16.309Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-10T14:34:16.309Z] GC before operation: completed in 116.461 ms, heap usage 299.247 MB -> 65.240 MB. [2024-08-10T14:34:18.066Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1850.829 ms) ====== [2024-08-10T14:34:18.066Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-10T14:34:18.066Z] GC before operation: completed in 114.140 ms, heap usage 229.639 MB -> 65.202 MB. [2024-08-10T14:34:19.823Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1715.443 ms) ====== [2024-08-10T14:34:19.823Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-10T14:34:20.678Z] GC before operation: completed in 109.829 ms, heap usage 238.202 MB -> 65.727 MB. [2024-08-10T14:34:22.440Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1683.149 ms) ====== [2024-08-10T14:34:22.440Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-10T14:34:22.440Z] GC before operation: completed in 114.213 ms, heap usage 228.263 MB -> 65.587 MB. [2024-08-10T14:34:24.204Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1680.232 ms) ====== [2024-08-10T14:34:24.204Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-10T14:34:24.204Z] GC before operation: completed in 123.301 ms, heap usage 215.218 MB -> 65.680 MB. [2024-08-10T14:34:25.973Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1686.712 ms) ====== [2024-08-10T14:34:25.973Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-10T14:34:25.973Z] GC before operation: completed in 127.513 ms, heap usage 72.398 MB -> 65.632 MB. [2024-08-10T14:34:26.828Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1521.153 ms) ====== [2024-08-10T14:34:26.828Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-10T14:34:27.691Z] GC before operation: completed in 118.273 ms, heap usage 216.842 MB -> 65.766 MB. [2024-08-10T14:34:28.550Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1502.122 ms) ====== [2024-08-10T14:34:28.550Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-10T14:34:28.550Z] GC before operation: completed in 120.376 ms, heap usage 129.100 MB -> 66.013 MB. [2024-08-10T14:34:30.312Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1468.984 ms) ====== [2024-08-10T14:34:30.312Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-10T14:34:30.312Z] GC before operation: completed in 127.913 ms, heap usage 236.066 MB -> 66.134 MB. [2024-08-10T14:34:32.074Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1447.440 ms) ====== [2024-08-10T14:34:32.074Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-10T14:34:32.074Z] GC before operation: completed in 127.773 ms, heap usage 264.344 MB -> 66.306 MB. [2024-08-10T14:34:33.833Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1426.182 ms) ====== [2024-08-10T14:34:33.834Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-10T14:34:33.834Z] GC before operation: completed in 123.789 ms, heap usage 70.809 MB -> 65.939 MB. [2024-08-10T14:34:35.596Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1429.928 ms) ====== [2024-08-10T14:34:35.596Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-10T14:34:35.596Z] GC before operation: completed in 118.264 ms, heap usage 249.938 MB -> 66.343 MB. [2024-08-10T14:34:36.451Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1369.857 ms) ====== [2024-08-10T14:34:36.451Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-10T14:34:36.451Z] GC before operation: completed in 141.715 ms, heap usage 246.171 MB -> 66.658 MB. [2024-08-10T14:34:38.214Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1385.018 ms) ====== [2024-08-10T14:34:38.214Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-10T14:34:38.214Z] GC before operation: completed in 132.851 ms, heap usage 224.211 MB -> 66.578 MB. [2024-08-10T14:34:39.974Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1408.844 ms) ====== [2024-08-10T14:34:39.974Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-10T14:34:39.975Z] GC before operation: completed in 126.129 ms, heap usage 189.713 MB -> 66.826 MB. [2024-08-10T14:34:40.831Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1417.560 ms) ====== [2024-08-10T14:34:40.831Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-10T14:34:41.687Z] GC before operation: completed in 125.617 ms, heap usage 238.282 MB -> 72.372 MB. [2024-08-10T14:34:42.545Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1340.805 ms) ====== [2024-08-10T14:34:42.545Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-10T14:34:42.545Z] GC before operation: completed in 124.751 ms, heap usage 207.615 MB -> 67.009 MB. [2024-08-10T14:34:44.445Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1320.076 ms) ====== [2024-08-10T14:34:44.445Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-10T14:34:44.445Z] GC before operation: completed in 145.227 ms, heap usage 190.260 MB -> 66.958 MB. [2024-08-10T14:34:45.300Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1385.933 ms) ====== [2024-08-10T14:34:45.300Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-10T14:34:46.157Z] GC before operation: completed in 147.324 ms, heap usage 222.840 MB -> 78.363 MB. [2024-08-10T14:34:47.012Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1373.199 ms) ====== [2024-08-10T14:34:47.012Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-10T14:34:47.012Z] GC before operation: completed in 130.040 ms, heap usage 218.032 MB -> 67.166 MB. [2024-08-10T14:34:48.772Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1369.323 ms) ====== [2024-08-10T14:34:48.772Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-10T14:34:48.772Z] GC before operation: completed in 127.696 ms, heap usage 258.897 MB -> 78.552 MB. [2024-08-10T14:34:50.531Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1294.761 ms) ====== [2024-08-10T14:34:50.531Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-10T14:34:50.531Z] GC before operation: completed in 126.567 ms, heap usage 272.010 MB -> 67.514 MB. [2024-08-10T14:34:51.391Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1399.409 ms) ====== [2024-08-10T14:34:51.391Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-10T14:34:51.391Z] GC before operation: completed in 126.210 ms, heap usage 263.535 MB -> 67.467 MB. [2024-08-10T14:34:53.151Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1506.911 ms) ====== [2024-08-10T14:34:53.151Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-10T14:34:53.151Z] GC before operation: completed in 135.612 ms, heap usage 117.848 MB -> 67.393 MB. [2024-08-10T14:34:54.910Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1532.933 ms) ====== [2024-08-10T14:34:54.910Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-10T14:34:54.910Z] GC before operation: completed in 130.633 ms, heap usage 128.373 MB -> 67.769 MB. [2024-08-10T14:34:56.670Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1403.944 ms) ====== [2024-08-10T14:34:56.670Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-10T14:34:56.670Z] GC before operation: completed in 133.994 ms, heap usage 141.679 MB -> 67.873 MB. [2024-08-10T14:34:58.427Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1362.492 ms) ====== [2024-08-10T14:34:58.427Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-10T14:34:58.427Z] GC before operation: completed in 130.722 ms, heap usage 243.874 MB -> 67.841 MB. [2024-08-10T14:34:59.283Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1279.275 ms) ====== [2024-08-10T14:34:59.283Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-10T14:34:59.283Z] GC before operation: completed in 138.508 ms, heap usage 243.862 MB -> 73.744 MB. [2024-08-10T14:35:01.043Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1455.796 ms) ====== [2024-08-10T14:35:01.043Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-10T14:35:01.043Z] GC before operation: completed in 144.051 ms, heap usage 196.673 MB -> 68.186 MB. [2024-08-10T14:35:02.803Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1487.264 ms) ====== [2024-08-10T14:35:02.803Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-10T14:35:02.803Z] GC before operation: completed in 137.598 ms, heap usage 266.972 MB -> 68.117 MB. [2024-08-10T14:35:04.008Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1336.808 ms) ====== [2024-08-10T14:35:04.008Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-10T14:35:04.008Z] GC before operation: completed in 137.725 ms, heap usage 146.876 MB -> 68.598 MB. [2024-08-10T14:35:05.767Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1288.188 ms) ====== [2024-08-10T14:35:05.767Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-10T14:35:05.767Z] GC before operation: completed in 143.606 ms, heap usage 211.286 MB -> 84.810 MB. [2024-08-10T14:35:06.622Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1312.587 ms) ====== [2024-08-10T14:35:06.622Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-10T14:35:07.479Z] GC before operation: completed in 146.793 ms, heap usage 280.000 MB -> 79.707 MB. [2024-08-10T14:35:08.334Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1273.280 ms) ====== [2024-08-10T14:35:08.334Z] ----------------------------------- [2024-08-10T14:35:08.334Z] renaissance-dec-tree_0_PASSED [2024-08-10T14:35:08.334Z] ----------------------------------- [2024-08-10T14:35:08.334Z] [2024-08-10T14:35:08.334Z] TEST TEARDOWN: [2024-08-10T14:35:08.334Z] Nothing to be done for teardown. [2024-08-10T14:35:08.334Z] renaissance-dec-tree_0 Finish Time: Sat Aug 10 14:35:08 2024 Epoch Time (ms): 1723300508161