[2024-08-16T16:13:22.097Z] Running test renaissance-als_0 ... [2024-08-16T16:13:22.097Z] =============================================== [2024-08-16T16:13:22.097Z] renaissance-als_0 Start Time: Fri Aug 16 12:13:21 2024 Epoch Time (ms): 1723824801440 [2024-08-16T16:13:22.097Z] variation: NoOptions [2024-08-16T16:13:22.097Z] JVM_OPTIONS: [2024-08-16T16:13:22.097Z] { \ [2024-08-16T16:13:22.097Z] echo ""; echo "TEST SETUP:"; \ [2024-08-16T16:13:22.097Z] echo "Nothing to be done for setup."; \ [2024-08-16T16:13:22.097Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17238247553785/renaissance-als_0"; \ [2024-08-16T16:13:22.097Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17238247553785/renaissance-als_0"; \ [2024-08-16T16:13:22.097Z] echo ""; echo "TESTING:"; \ [2024-08-16T16:13:22.097Z] "/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_17238247553785/renaissance-als_0"/als.json" als; \ [2024-08-16T16:13:22.097Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_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_17238247553785/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-16T16:13:22.097Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-16T16:13:22.097Z] echo "Nothing to be done for teardown."; \ [2024-08-16T16:13:22.097Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17238247553785/TestTargetResult"; [2024-08-16T16:13:22.097Z] [2024-08-16T16:13:22.097Z] TEST SETUP: [2024-08-16T16:13:22.097Z] Nothing to be done for setup. [2024-08-16T16:13:22.097Z] [2024-08-16T16:13:22.097Z] TESTING: [2024-08-16T16:13:25.946Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-16T16:13:29.873Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-16T16:13:33.837Z] WARNING: An illegal reflective access operation has occurred [2024-08-16T16:13:33.837Z] 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_17238247553785/renaissance-als_0/harness-121322-11702015600517510719/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-16T16:13:33.837Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-16T16:13:33.837Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-16T16:13:33.837Z] WARNING: All illegal access operations will be denied in a future release [2024-08-16T16:13:35.170Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-16T16:13:35.170Z] GC before operation: completed in 160.189 ms, heap usage 55.500 MB -> 33.783 MB. [2024-08-16T16:14:08.921Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:14:08.921Z] There is no way to check that no silent failure occurred. [2024-08-16T16:14:08.921Z] ====== als (apache-spark) [default], iteration 0 completed (33864.335 ms) ====== [2024-08-16T16:14:08.921Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-16T16:14:09.566Z] GC before operation: completed in 233.213 ms, heap usage 314.790 MB -> 56.105 MB. [2024-08-16T16:14:34.288Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:14:34.288Z] There is no way to check that no silent failure occurred. [2024-08-16T16:14:34.288Z] ====== als (apache-spark) [default], iteration 1 completed (23007.727 ms) ====== [2024-08-16T16:14:34.288Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-16T16:14:34.288Z] GC before operation: completed in 330.069 ms, heap usage 211.107 MB -> 58.450 MB. [2024-08-16T16:14:55.010Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:14:55.010Z] There is no way to check that no silent failure occurred. [2024-08-16T16:14:55.010Z] ====== als (apache-spark) [default], iteration 2 completed (22105.495 ms) ====== [2024-08-16T16:14:55.010Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-16T16:14:55.010Z] GC before operation: completed in 428.192 ms, heap usage 234.361 MB -> 58.819 MB. [2024-08-16T16:15:15.627Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:15:15.627Z] There is no way to check that no silent failure occurred. [2024-08-16T16:15:15.627Z] ====== als (apache-spark) [default], iteration 3 completed (18709.405 ms) ====== [2024-08-16T16:15:15.627Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-16T16:15:15.627Z] GC before operation: completed in 219.687 ms, heap usage 436.614 MB -> 59.559 MB. [2024-08-16T16:15:33.211Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:15:33.212Z] There is no way to check that no silent failure occurred. [2024-08-16T16:15:33.212Z] ====== als (apache-spark) [default], iteration 4 completed (17866.839 ms) ====== [2024-08-16T16:15:33.212Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-16T16:15:33.212Z] GC before operation: completed in 343.725 ms, heap usage 183.166 MB -> 59.590 MB. [2024-08-16T16:15:53.567Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:15:53.567Z] There is no way to check that no silent failure occurred. [2024-08-16T16:15:53.567Z] ====== als (apache-spark) [default], iteration 5 completed (20053.125 ms) ====== [2024-08-16T16:15:53.567Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-16T16:15:53.567Z] GC before operation: completed in 326.229 ms, heap usage 311.469 MB -> 60.149 MB. [2024-08-16T16:16:14.421Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:16:14.421Z] There is no way to check that no silent failure occurred. [2024-08-16T16:16:14.421Z] ====== als (apache-spark) [default], iteration 6 completed (21573.451 ms) ====== [2024-08-16T16:16:14.421Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-16T16:16:15.067Z] GC before operation: completed in 401.551 ms, heap usage 166.052 MB -> 60.206 MB. [2024-08-16T16:16:39.892Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:16:39.892Z] There is no way to check that no silent failure occurred. [2024-08-16T16:16:39.892Z] ====== als (apache-spark) [default], iteration 7 completed (23436.877 ms) ====== [2024-08-16T16:16:39.892Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-16T16:16:39.892Z] GC before operation: completed in 247.747 ms, heap usage 196.507 MB -> 60.547 MB. [2024-08-16T16:17:00.644Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:17:00.644Z] There is no way to check that no silent failure occurred. [2024-08-16T16:17:00.644Z] ====== als (apache-spark) [default], iteration 8 completed (20519.793 ms) ====== [2024-08-16T16:17:00.644Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-16T16:17:00.644Z] GC before operation: completed in 488.000 ms, heap usage 294.319 MB -> 61.103 MB. [2024-08-16T16:17:21.319Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:17:21.319Z] There is no way to check that no silent failure occurred. [2024-08-16T16:17:21.319Z] ====== als (apache-spark) [default], iteration 9 completed (20445.954 ms) ====== [2024-08-16T16:17:21.319Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-16T16:17:21.319Z] GC before operation: completed in 315.942 ms, heap usage 274.323 MB -> 61.439 MB. [2024-08-16T16:17:42.249Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:17:42.249Z] There is no way to check that no silent failure occurred. [2024-08-16T16:17:42.249Z] ====== als (apache-spark) [default], iteration 10 completed (19728.432 ms) ====== [2024-08-16T16:17:42.249Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-16T16:17:42.249Z] GC before operation: completed in 289.761 ms, heap usage 344.568 MB -> 61.939 MB. [2024-08-16T16:18:03.469Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:18:03.469Z] There is no way to check that no silent failure occurred. [2024-08-16T16:18:03.469Z] ====== als (apache-spark) [default], iteration 11 completed (21805.573 ms) ====== [2024-08-16T16:18:03.469Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-16T16:18:03.469Z] GC before operation: completed in 415.667 ms, heap usage 227.265 MB -> 61.911 MB. [2024-08-16T16:18:24.760Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:18:24.760Z] There is no way to check that no silent failure occurred. [2024-08-16T16:18:24.760Z] ====== als (apache-spark) [default], iteration 12 completed (20895.875 ms) ====== [2024-08-16T16:18:24.760Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-16T16:18:24.760Z] GC before operation: completed in 353.442 ms, heap usage 167.745 MB -> 62.339 MB. [2024-08-16T16:18:50.467Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:18:50.467Z] There is no way to check that no silent failure occurred. [2024-08-16T16:18:50.467Z] ====== als (apache-spark) [default], iteration 13 completed (25128.727 ms) ====== [2024-08-16T16:18:50.467Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-16T16:18:50.467Z] GC before operation: completed in 281.100 ms, heap usage 344.041 MB -> 62.961 MB. [2024-08-16T16:19:15.023Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:19:15.023Z] There is no way to check that no silent failure occurred. [2024-08-16T16:19:15.023Z] ====== als (apache-spark) [default], iteration 14 completed (23065.318 ms) ====== [2024-08-16T16:19:15.023Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-16T16:19:15.023Z] GC before operation: completed in 369.398 ms, heap usage 195.283 MB -> 63.011 MB. [2024-08-16T16:19:36.213Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:19:36.213Z] There is no way to check that no silent failure occurred. [2024-08-16T16:19:36.213Z] ====== als (apache-spark) [default], iteration 15 completed (22545.187 ms) ====== [2024-08-16T16:19:36.213Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-16T16:19:36.213Z] GC before operation: completed in 994.953 ms, heap usage 185.749 MB -> 63.300 MB. [2024-08-16T16:20:07.261Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:20:07.261Z] There is no way to check that no silent failure occurred. [2024-08-16T16:20:07.261Z] ====== als (apache-spark) [default], iteration 16 completed (28642.708 ms) ====== [2024-08-16T16:20:07.261Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-16T16:20:07.261Z] GC before operation: completed in 547.834 ms, heap usage 301.826 MB -> 63.820 MB. [2024-08-16T16:20:22.194Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:20:22.194Z] There is no way to check that no silent failure occurred. [2024-08-16T16:20:22.194Z] ====== als (apache-spark) [default], iteration 17 completed (17137.317 ms) ====== [2024-08-16T16:20:22.194Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-16T16:20:22.826Z] GC before operation: completed in 385.791 ms, heap usage 429.073 MB -> 64.345 MB. [2024-08-16T16:20:56.277Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:20:56.277Z] There is no way to check that no silent failure occurred. [2024-08-16T16:20:56.277Z] ====== als (apache-spark) [default], iteration 18 completed (25670.580 ms) ====== [2024-08-16T16:20:56.277Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-16T16:20:56.277Z] GC before operation: completed in 658.008 ms, heap usage 174.238 MB -> 64.158 MB. [2024-08-16T16:21:21.960Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:21:21.960Z] There is no way to check that no silent failure occurred. [2024-08-16T16:21:21.960Z] ====== als (apache-spark) [default], iteration 19 completed (30360.286 ms) ====== [2024-08-16T16:21:21.960Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-16T16:21:21.960Z] GC before operation: completed in 497.586 ms, heap usage 205.727 MB -> 64.420 MB. [2024-08-16T16:21:46.888Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:21:46.888Z] There is no way to check that no silent failure occurred. [2024-08-16T16:21:46.888Z] ====== als (apache-spark) [default], iteration 20 completed (25407.007 ms) ====== [2024-08-16T16:21:46.888Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-16T16:21:46.888Z] GC before operation: completed in 704.576 ms, heap usage 136.175 MB -> 64.609 MB. [2024-08-16T16:22:07.471Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:22:07.471Z] There is no way to check that no silent failure occurred. [2024-08-16T16:22:07.471Z] ====== als (apache-spark) [default], iteration 21 completed (19330.344 ms) ====== [2024-08-16T16:22:07.471Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-16T16:22:07.471Z] GC before operation: completed in 341.285 ms, heap usage 188.306 MB -> 64.811 MB. [2024-08-16T16:22:24.811Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:22:24.811Z] There is no way to check that no silent failure occurred. [2024-08-16T16:22:24.811Z] ====== als (apache-spark) [default], iteration 22 completed (18746.155 ms) ====== [2024-08-16T16:22:24.811Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-16T16:22:24.811Z] GC before operation: completed in 317.948 ms, heap usage 273.758 MB -> 65.149 MB. [2024-08-16T16:22:45.455Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:22:45.455Z] There is no way to check that no silent failure occurred. [2024-08-16T16:22:45.455Z] ====== als (apache-spark) [default], iteration 23 completed (19450.799 ms) ====== [2024-08-16T16:22:45.455Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-16T16:22:45.455Z] GC before operation: completed in 515.456 ms, heap usage 301.474 MB -> 65.414 MB. [2024-08-16T16:23:06.422Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:23:06.422Z] There is no way to check that no silent failure occurred. [2024-08-16T16:23:06.422Z] ====== als (apache-spark) [default], iteration 24 completed (21062.122 ms) ====== [2024-08-16T16:23:06.422Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-16T16:23:06.422Z] GC before operation: completed in 421.551 ms, heap usage 374.370 MB -> 65.757 MB. [2024-08-16T16:23:31.350Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:23:31.350Z] There is no way to check that no silent failure occurred. [2024-08-16T16:23:31.350Z] ====== als (apache-spark) [default], iteration 25 completed (24406.249 ms) ====== [2024-08-16T16:23:31.350Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-16T16:23:31.350Z] GC before operation: completed in 872.559 ms, heap usage 167.316 MB -> 65.409 MB. [2024-08-16T16:23:55.643Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:23:55.643Z] There is no way to check that no silent failure occurred. [2024-08-16T16:23:55.643Z] ====== als (apache-spark) [default], iteration 26 completed (24325.935 ms) ====== [2024-08-16T16:23:55.643Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-16T16:23:56.310Z] GC before operation: completed in 358.644 ms, heap usage 299.091 MB -> 65.936 MB. [2024-08-16T16:24:20.961Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:24:20.961Z] There is no way to check that no silent failure occurred. [2024-08-16T16:24:20.961Z] ====== als (apache-spark) [default], iteration 27 completed (24881.995 ms) ====== [2024-08-16T16:24:20.961Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-16T16:24:22.402Z] GC before operation: completed in 452.963 ms, heap usage 154.753 MB -> 65.859 MB. [2024-08-16T16:24:46.920Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:24:46.920Z] There is no way to check that no silent failure occurred. [2024-08-16T16:24:46.920Z] ====== als (apache-spark) [default], iteration 28 completed (24817.791 ms) ====== [2024-08-16T16:24:46.920Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-16T16:24:46.920Z] GC before operation: completed in 428.703 ms, heap usage 182.196 MB -> 66.154 MB. [2024-08-16T16:25:04.420Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T16:25:04.420Z] There is no way to check that no silent failure occurred. [2024-08-16T16:25:04.420Z] ====== als (apache-spark) [default], iteration 29 completed (17174.641 ms) ====== [2024-08-16T16:25:04.420Z] ----------------------------------- [2024-08-16T16:25:04.420Z] renaissance-als_0_PASSED [2024-08-16T16:25:04.420Z] ----------------------------------- [2024-08-16T16:25:04.420Z] [2024-08-16T16:25:04.420Z] TEST TEARDOWN: [2024-08-16T16:25:04.420Z] Nothing to be done for teardown. [2024-08-16T16:25:04.420Z] renaissance-als_0 Finish Time: Fri Aug 16 12:25:04 2024 Epoch Time (ms): 1723825504327