[2024-08-08T02:39:19.750Z] Running test renaissance-dec-tree_0 ... [2024-08-08T02:39:19.750Z] =============================================== [2024-08-08T02:39:19.750Z] renaissance-dec-tree_0 Start Time: Thu Aug 8 02:39:19 2024 Epoch Time (ms): 1723084759675 [2024-08-08T02:39:19.750Z] variation: NoOptions [2024-08-08T02:39:19.750Z] JVM_OPTIONS: [2024-08-08T02:39:19.750Z] { \ [2024-08-08T02:39:19.750Z] echo ""; echo "TEST SETUP:"; \ [2024-08-08T02:39:19.750Z] echo "Nothing to be done for setup."; \ [2024-08-08T02:39:19.750Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17230842831066/renaissance-dec-tree_0"; \ [2024-08-08T02:39:19.750Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17230842831066/renaissance-dec-tree_0"; \ [2024-08-08T02:39:19.750Z] echo ""; echo "TESTING:"; \ [2024-08-08T02:39:19.750Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_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_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17230842831066/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-08T02:39:19.750Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17230842831066/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-08T02:39:19.750Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-08T02:39:19.750Z] echo "Nothing to be done for teardown."; \ [2024-08-08T02:39:19.750Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17230842831066/TestTargetResult"; [2024-08-08T02:39:19.750Z] [2024-08-08T02:39:19.750Z] TEST SETUP: [2024-08-08T02:39:19.750Z] Nothing to be done for setup. [2024-08-08T02:39:19.750Z] [2024-08-08T02:39:19.750Z] TESTING: [2024-08-08T02:39:23.324Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-08T02:39:24.559Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-08T02:39:25.147Z] WARNING: An illegal reflective access operation has occurred [2024-08-08T02:39:25.147Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/output_17230842831066/renaissance-dec-tree_0/harness-023920-16980380207258101721/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-08T02:39:25.147Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-08T02:39:25.147Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-08T02:39:25.147Z] WARNING: All illegal access operations will be denied in a future release [2024-08-08T02:39:26.389Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-08T02:39:26.389Z] GC before operation: completed in 51.093 ms, heap usage 74.591 MB -> 33.734 MB. [2024-08-08T02:39:34.708Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8171.575 ms) ====== [2024-08-08T02:39:34.708Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-08T02:39:34.708Z] GC before operation: completed in 155.244 ms, heap usage 239.470 MB -> 71.171 MB. [2024-08-08T02:39:38.291Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3052.177 ms) ====== [2024-08-08T02:39:38.291Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-08T02:39:38.291Z] GC before operation: completed in 118.434 ms, heap usage 130.729 MB -> 63.052 MB. [2024-08-08T02:39:40.224Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2181.155 ms) ====== [2024-08-08T02:39:40.224Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-08T02:39:40.224Z] GC before operation: completed in 147.278 ms, heap usage 183.006 MB -> 63.352 MB. [2024-08-08T02:39:43.007Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2701.713 ms) ====== [2024-08-08T02:39:43.007Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-08T02:39:43.594Z] GC before operation: completed in 159.599 ms, heap usage 234.862 MB -> 71.781 MB. [2024-08-08T02:39:45.552Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2124.354 ms) ====== [2024-08-08T02:39:45.552Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-08T02:39:45.552Z] GC before operation: completed in 128.330 ms, heap usage 217.925 MB -> 63.643 MB. [2024-08-08T02:39:47.481Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1806.558 ms) ====== [2024-08-08T02:39:47.481Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-08T02:39:47.481Z] GC before operation: completed in 106.186 ms, heap usage 104.326 MB -> 63.505 MB. [2024-08-08T02:39:49.441Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1912.088 ms) ====== [2024-08-08T02:39:49.441Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-08T02:39:49.441Z] GC before operation: completed in 148.116 ms, heap usage 209.180 MB -> 64.115 MB. [2024-08-08T02:39:51.392Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1941.067 ms) ====== [2024-08-08T02:39:51.392Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-08T02:39:51.392Z] GC before operation: completed in 160.944 ms, heap usage 159.813 MB -> 64.300 MB. [2024-08-08T02:39:54.137Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2059.609 ms) ====== [2024-08-08T02:39:54.137Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-08T02:39:54.137Z] GC before operation: completed in 118.495 ms, heap usage 189.677 MB -> 64.395 MB. [2024-08-08T02:39:56.078Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2273.438 ms) ====== [2024-08-08T02:39:56.078Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-08T02:39:56.078Z] GC before operation: completed in 167.413 ms, heap usage 207.397 MB -> 64.354 MB. [2024-08-08T02:39:58.813Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2095.966 ms) ====== [2024-08-08T02:39:58.813Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-08T02:39:58.813Z] GC before operation: completed in 178.907 ms, heap usage 161.904 MB -> 64.604 MB. [2024-08-08T02:40:00.743Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2043.117 ms) ====== [2024-08-08T02:40:00.743Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-08T02:40:00.743Z] GC before operation: completed in 143.897 ms, heap usage 216.955 MB -> 64.725 MB. [2024-08-08T02:40:02.692Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1920.492 ms) ====== [2024-08-08T02:40:02.692Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-08T02:40:02.692Z] GC before operation: completed in 198.186 ms, heap usage 237.441 MB -> 64.671 MB. [2024-08-08T02:40:05.516Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2318.914 ms) ====== [2024-08-08T02:40:05.516Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-08T02:40:05.516Z] GC before operation: completed in 175.495 ms, heap usage 227.905 MB -> 64.776 MB. [2024-08-08T02:40:07.450Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1943.052 ms) ====== [2024-08-08T02:40:07.450Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-08T02:40:07.450Z] GC before operation: completed in 138.060 ms, heap usage 181.999 MB -> 64.920 MB. [2024-08-08T02:40:09.134Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1615.182 ms) ====== [2024-08-08T02:40:09.135Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-08T02:40:09.135Z] GC before operation: completed in 170.819 ms, heap usage 252.022 MB -> 65.057 MB. [2024-08-08T02:40:11.093Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1958.418 ms) ====== [2024-08-08T02:40:11.093Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-08T02:40:11.093Z] GC before operation: completed in 203.878 ms, heap usage 197.502 MB -> 65.165 MB. [2024-08-08T02:40:13.111Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1921.204 ms) ====== [2024-08-08T02:40:13.111Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-08T02:40:13.707Z] GC before operation: completed in 194.017 ms, heap usage 259.888 MB -> 84.752 MB. [2024-08-08T02:40:15.642Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1896.670 ms) ====== [2024-08-08T02:40:15.642Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-08T02:40:15.642Z] GC before operation: completed in 174.484 ms, heap usage 269.545 MB -> 65.502 MB. [2024-08-08T02:40:17.576Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1730.351 ms) ====== [2024-08-08T02:40:17.576Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-08T02:40:17.576Z] GC before operation: completed in 150.819 ms, heap usage 184.155 MB -> 65.602 MB. [2024-08-08T02:40:19.530Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2130.557 ms) ====== [2024-08-08T02:40:19.530Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-08T02:40:19.530Z] GC before operation: completed in 190.449 ms, heap usage 239.191 MB -> 65.561 MB. [2024-08-08T02:40:21.497Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1777.029 ms) ====== [2024-08-08T02:40:21.497Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-08T02:40:21.497Z] GC before operation: completed in 159.869 ms, heap usage 230.362 MB -> 65.802 MB. [2024-08-08T02:40:23.453Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1775.583 ms) ====== [2024-08-08T02:40:23.453Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-08T02:40:23.453Z] GC before operation: completed in 159.725 ms, heap usage 189.619 MB -> 65.734 MB. [2024-08-08T02:40:25.412Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2021.023 ms) ====== [2024-08-08T02:40:25.412Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-08T02:40:26.012Z] GC before operation: completed in 177.664 ms, heap usage 268.670 MB -> 85.038 MB. [2024-08-08T02:40:27.956Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1817.893 ms) ====== [2024-08-08T02:40:27.956Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-08T02:40:27.956Z] GC before operation: completed in 204.021 ms, heap usage 305.190 MB -> 66.086 MB. [2024-08-08T02:40:29.912Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1618.385 ms) ====== [2024-08-08T02:40:29.913Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-08T02:40:29.913Z] GC before operation: completed in 146.217 ms, heap usage 101.976 MB -> 65.778 MB. [2024-08-08T02:40:31.151Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1639.693 ms) ====== [2024-08-08T02:40:31.151Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-08T02:40:31.756Z] GC before operation: completed in 174.477 ms, heap usage 219.610 MB -> 66.172 MB. [2024-08-08T02:40:33.704Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1947.139 ms) ====== [2024-08-08T02:40:33.704Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-08T02:40:33.704Z] GC before operation: completed in 183.278 ms, heap usage 145.187 MB -> 66.371 MB. [2024-08-08T02:40:34.942Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1618.780 ms) ====== [2024-08-08T02:40:34.942Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-08T02:40:35.536Z] GC before operation: completed in 143.624 ms, heap usage 127.053 MB -> 66.532 MB. [2024-08-08T02:40:37.482Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1739.353 ms) ====== [2024-08-08T02:40:37.482Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-08T02:40:37.482Z] GC before operation: completed in 162.191 ms, heap usage 110.238 MB -> 66.146 MB. [2024-08-08T02:40:39.437Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1773.233 ms) ====== [2024-08-08T02:40:39.437Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-08T02:40:39.437Z] GC before operation: completed in 169.067 ms, heap usage 114.334 MB -> 66.421 MB. [2024-08-08T02:40:40.677Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1656.110 ms) ====== [2024-08-08T02:40:40.677Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-08T02:40:41.269Z] GC before operation: completed in 222.291 ms, heap usage 242.653 MB -> 66.632 MB. [2024-08-08T02:40:43.219Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1908.832 ms) ====== [2024-08-08T02:40:43.219Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-08T02:40:43.219Z] GC before operation: completed in 190.551 ms, heap usage 204.376 MB -> 67.101 MB. [2024-08-08T02:40:45.166Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1802.013 ms) ====== [2024-08-08T02:40:45.167Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-08T02:40:45.167Z] GC before operation: completed in 182.696 ms, heap usage 222.303 MB -> 66.949 MB. [2024-08-08T02:40:47.134Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1738.806 ms) ====== [2024-08-08T02:40:47.134Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-08T02:40:47.134Z] GC before operation: completed in 191.321 ms, heap usage 259.442 MB -> 66.909 MB. [2024-08-08T02:40:49.089Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1847.828 ms) ====== [2024-08-08T02:40:49.089Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-08T02:40:49.089Z] GC before operation: completed in 198.813 ms, heap usage 221.927 MB -> 67.146 MB. [2024-08-08T02:40:51.073Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1719.778 ms) ====== [2024-08-08T02:40:51.073Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-08T02:40:51.073Z] GC before operation: completed in 182.926 ms, heap usage 115.714 MB -> 66.841 MB. [2024-08-08T02:40:53.025Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1753.130 ms) ====== [2024-08-08T02:40:53.025Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-08T02:40:53.025Z] GC before operation: completed in 195.129 ms, heap usage 127.671 MB -> 67.222 MB. [2024-08-08T02:40:54.968Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1729.182 ms) ====== [2024-08-08T02:40:54.968Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-08T02:40:54.968Z] GC before operation: completed in 235.100 ms, heap usage 126.442 MB -> 94.885 MB. [2024-08-08T02:40:54.968Z] 24/08/08 02:40:54 WARN BlockManager: Asked to remove block broadcast_540, which does not exist [2024-08-08T02:40:56.932Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1842.449 ms) ====== [2024-08-08T02:40:56.932Z] ----------------------------------- [2024-08-08T02:40:56.932Z] renaissance-dec-tree_0_PASSED [2024-08-08T02:40:56.932Z] ----------------------------------- [2024-08-08T02:40:56.932Z] [2024-08-08T02:40:56.932Z] TEST TEARDOWN: [2024-08-08T02:40:56.932Z] Nothing to be done for teardown. [2024-08-08T02:40:56.932Z] renaissance-dec-tree_0 Finish Time: Thu Aug 8 02:40:56 2024 Epoch Time (ms): 1723084856743