[2025-03-06T00:12:36.419Z] Running test renaissance-als_0 ... [2025-03-06T00:12:36.419Z] =============================================== [2025-03-06T00:12:36.419Z] renaissance-als_0 Start Time: Thu Mar 6 00:12:35 2025 Epoch Time (ms): 1741219955075 [2025-03-06T00:12:36.419Z] variation: NoOptions [2025-03-06T00:12:36.419Z] JVM_OPTIONS: [2025-03-06T00:12:36.419Z] { \ [2025-03-06T00:12:36.419Z] echo ""; echo "TEST SETUP:"; \ [2025-03-06T00:12:36.419Z] echo "Nothing to be done for setup."; \ [2025-03-06T00:12:36.419Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-als_0"; \ [2025-03-06T00:12:36.419Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-als_0"; \ [2025-03-06T00:12:36.419Z] echo ""; echo "TESTING:"; \ [2025-03-06T00:12:36.419Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-als_0"/als.json" als; \ [2025-03-06T00:12:36.419Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-06T00:12:36.419Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-06T00:12:36.419Z] echo "Nothing to be done for teardown."; \ [2025-03-06T00:12:36.419Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17412198715947/TestTargetResult"; [2025-03-06T00:12:36.419Z] [2025-03-06T00:12:36.419Z] TEST SETUP: [2025-03-06T00:12:36.419Z] Nothing to be done for setup. [2025-03-06T00:12:36.419Z] [2025-03-06T00:12:36.419Z] TESTING: [2025-03-06T00:12:41.077Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-06T00:12:46.148Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-03-06T00:12:51.283Z] WARNING: An illegal reflective access operation has occurred [2025-03-06T00:12:51.283Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17412198715947/renaissance-als_0/harness-001236-13113581679378977204/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-03-06T00:12:51.283Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-03-06T00:12:51.283Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-03-06T00:12:51.283Z] WARNING: All illegal access operations will be denied in a future release [2025-03-06T00:12:54.429Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-03-06T00:12:54.429Z] GC before operation: completed in 194.899 ms, heap usage 85.502 MB -> 33.770 MB. [2025-03-06T00:14:16.619Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:14:16.619Z] There is no way to check that no silent failure occurred. [2025-03-06T00:14:16.619Z] ====== als (apache-spark) [default], iteration 0 completed (74768.961 ms) ====== [2025-03-06T00:14:16.619Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-03-06T00:14:16.619Z] GC before operation: completed in 274.387 ms, heap usage 250.577 MB -> 55.994 MB. [2025-03-06T00:14:51.900Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:14:51.900Z] There is no way to check that no silent failure occurred. [2025-03-06T00:14:51.900Z] ====== als (apache-spark) [default], iteration 1 completed (39393.975 ms) ====== [2025-03-06T00:14:51.900Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-03-06T00:14:51.900Z] GC before operation: completed in 977.676 ms, heap usage 487.087 MB -> 58.905 MB. [2025-03-06T00:15:33.381Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:15:33.381Z] There is no way to check that no silent failure occurred. [2025-03-06T00:15:33.381Z] ====== als (apache-spark) [default], iteration 2 completed (40926.314 ms) ====== [2025-03-06T00:15:33.381Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-03-06T00:15:33.381Z] GC before operation: completed in 325.554 ms, heap usage 304.301 MB -> 58.976 MB. [2025-03-06T00:16:02.803Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:16:02.803Z] There is no way to check that no silent failure occurred. [2025-03-06T00:16:02.803Z] ====== als (apache-spark) [default], iteration 3 completed (28214.084 ms) ====== [2025-03-06T00:16:02.803Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-03-06T00:16:02.803Z] GC before operation: completed in 299.070 ms, heap usage 376.478 MB -> 59.425 MB. [2025-03-06T00:16:28.032Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:16:28.032Z] There is no way to check that no silent failure occurred. [2025-03-06T00:16:28.032Z] ====== als (apache-spark) [default], iteration 4 completed (26099.159 ms) ====== [2025-03-06T00:16:28.032Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-03-06T00:16:28.032Z] GC before operation: completed in 505.680 ms, heap usage 371.900 MB -> 59.848 MB. [2025-03-06T00:17:03.281Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:17:03.281Z] There is no way to check that no silent failure occurred. [2025-03-06T00:17:03.281Z] ====== als (apache-spark) [default], iteration 5 completed (32604.463 ms) ====== [2025-03-06T00:17:03.281Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-03-06T00:17:03.281Z] GC before operation: completed in 814.452 ms, heap usage 258.818 MB -> 60.016 MB. [2025-03-06T00:17:28.289Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:17:28.289Z] There is no way to check that no silent failure occurred. [2025-03-06T00:17:28.289Z] ====== als (apache-spark) [default], iteration 6 completed (26344.646 ms) ====== [2025-03-06T00:17:28.289Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-03-06T00:17:28.289Z] GC before operation: completed in 420.815 ms, heap usage 273.518 MB -> 60.470 MB. [2025-03-06T00:17:49.490Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:17:49.490Z] There is no way to check that no silent failure occurred. [2025-03-06T00:17:49.490Z] ====== als (apache-spark) [default], iteration 7 completed (22836.602 ms) ====== [2025-03-06T00:17:49.490Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-03-06T00:17:50.140Z] GC before operation: completed in 384.650 ms, heap usage 282.129 MB -> 60.809 MB. [2025-03-06T00:18:29.072Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:18:29.072Z] There is no way to check that no silent failure occurred. [2025-03-06T00:18:29.072Z] ====== als (apache-spark) [default], iteration 8 completed (36284.444 ms) ====== [2025-03-06T00:18:29.072Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-03-06T00:18:29.072Z] GC before operation: completed in 384.368 ms, heap usage 244.829 MB -> 61.073 MB. [2025-03-06T00:18:58.292Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:18:58.292Z] There is no way to check that no silent failure occurred. [2025-03-06T00:18:58.292Z] ====== als (apache-spark) [default], iteration 9 completed (31103.918 ms) ====== [2025-03-06T00:18:58.292Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-03-06T00:18:58.293Z] GC before operation: completed in 733.553 ms, heap usage 425.403 MB -> 61.606 MB. [2025-03-06T00:19:34.650Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:19:34.650Z] There is no way to check that no silent failure occurred. [2025-03-06T00:19:34.650Z] ====== als (apache-spark) [default], iteration 10 completed (35844.971 ms) ====== [2025-03-06T00:19:34.650Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-03-06T00:19:34.650Z] GC before operation: completed in 397.296 ms, heap usage 406.040 MB -> 62.006 MB. [2025-03-06T00:20:09.165Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:20:09.165Z] There is no way to check that no silent failure occurred. [2025-03-06T00:20:09.165Z] ====== als (apache-spark) [default], iteration 11 completed (31510.196 ms) ====== [2025-03-06T00:20:09.165Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-03-06T00:20:09.165Z] GC before operation: completed in 262.784 ms, heap usage 357.483 MB -> 62.247 MB. [2025-03-06T00:20:27.449Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:20:27.449Z] There is no way to check that no silent failure occurred. [2025-03-06T00:20:27.449Z] ====== als (apache-spark) [default], iteration 12 completed (19032.265 ms) ====== [2025-03-06T00:20:27.450Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-03-06T00:20:27.450Z] GC before operation: completed in 209.495 ms, heap usage 455.794 MB -> 62.797 MB. [2025-03-06T00:21:18.315Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:21:18.315Z] There is no way to check that no silent failure occurred. [2025-03-06T00:21:18.315Z] ====== als (apache-spark) [default], iteration 13 completed (44984.988 ms) ====== [2025-03-06T00:21:18.315Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-03-06T00:21:18.315Z] GC before operation: completed in 279.414 ms, heap usage 409.162 MB -> 63.028 MB. [2025-03-06T00:22:20.010Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:22:20.010Z] There is no way to check that no silent failure occurred. [2025-03-06T00:22:20.010Z] ====== als (apache-spark) [default], iteration 14 completed (63945.230 ms) ====== [2025-03-06T00:22:20.010Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-03-06T00:22:20.010Z] GC before operation: completed in 942.892 ms, heap usage 360.424 MB -> 63.271 MB. [2025-03-06T00:22:57.680Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:22:57.680Z] There is no way to check that no silent failure occurred. [2025-03-06T00:22:57.680Z] ====== als (apache-spark) [default], iteration 15 completed (40947.785 ms) ====== [2025-03-06T00:22:57.680Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-03-06T00:22:58.486Z] GC before operation: completed in 1422.078 ms, heap usage 371.667 MB -> 63.751 MB. [2025-03-06T00:23:28.907Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:23:28.907Z] There is no way to check that no silent failure occurred. [2025-03-06T00:23:28.907Z] ====== als (apache-spark) [default], iteration 16 completed (26912.268 ms) ====== [2025-03-06T00:23:28.907Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-03-06T00:23:28.907Z] GC before operation: completed in 545.872 ms, heap usage 421.792 MB -> 64.033 MB. [2025-03-06T00:24:04.447Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:24:04.447Z] There is no way to check that no silent failure occurred. [2025-03-06T00:24:04.447Z] ====== als (apache-spark) [default], iteration 17 completed (38166.266 ms) ====== [2025-03-06T00:24:04.447Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-03-06T00:24:04.447Z] GC before operation: completed in 650.545 ms, heap usage 357.416 MB -> 64.204 MB. [2025-03-06T00:24:39.337Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:24:39.337Z] There is no way to check that no silent failure occurred. [2025-03-06T00:24:39.337Z] ====== als (apache-spark) [default], iteration 18 completed (30268.767 ms) ====== [2025-03-06T00:24:39.337Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-03-06T00:24:39.337Z] GC before operation: completed in 370.608 ms, heap usage 275.656 MB -> 64.280 MB. [2025-03-06T00:25:04.888Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:25:04.888Z] There is no way to check that no silent failure occurred. [2025-03-06T00:25:04.888Z] ====== als (apache-spark) [default], iteration 19 completed (29016.864 ms) ====== [2025-03-06T00:25:04.888Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-03-06T00:25:04.888Z] GC before operation: completed in 306.147 ms, heap usage 306.357 MB -> 64.602 MB. [2025-03-06T00:25:31.297Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:25:31.297Z] There is no way to check that no silent failure occurred. [2025-03-06T00:25:31.297Z] ====== als (apache-spark) [default], iteration 20 completed (25494.347 ms) ====== [2025-03-06T00:25:31.297Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-03-06T00:25:31.297Z] GC before operation: completed in 1270.818 ms, heap usage 397.940 MB -> 64.713 MB. [2025-03-06T00:25:57.426Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:25:57.426Z] There is no way to check that no silent failure occurred. [2025-03-06T00:25:57.426Z] ====== als (apache-spark) [default], iteration 21 completed (26370.303 ms) ====== [2025-03-06T00:25:57.426Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-03-06T00:25:58.220Z] GC before operation: completed in 442.401 ms, heap usage 376.971 MB -> 65.049 MB. [2025-03-06T00:26:19.664Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:26:19.664Z] There is no way to check that no silent failure occurred. [2025-03-06T00:26:19.664Z] ====== als (apache-spark) [default], iteration 22 completed (20359.477 ms) ====== [2025-03-06T00:26:19.664Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-03-06T00:26:19.664Z] GC before operation: completed in 325.023 ms, heap usage 315.986 MB -> 65.164 MB. [2025-03-06T00:26:54.496Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:26:54.496Z] There is no way to check that no silent failure occurred. [2025-03-06T00:26:54.496Z] ====== als (apache-spark) [default], iteration 23 completed (31938.557 ms) ====== [2025-03-06T00:26:54.496Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-03-06T00:26:54.496Z] GC before operation: completed in 454.345 ms, heap usage 288.896 MB -> 65.328 MB. [2025-03-06T00:27:27.686Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:27:27.686Z] There is no way to check that no silent failure occurred. [2025-03-06T00:27:27.686Z] ====== als (apache-spark) [default], iteration 24 completed (34999.753 ms) ====== [2025-03-06T00:27:27.686Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-03-06T00:27:27.686Z] GC before operation: completed in 752.752 ms, heap usage 272.722 MB -> 62.975 MB. [2025-03-06T00:28:04.749Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:28:04.749Z] There is no way to check that no silent failure occurred. [2025-03-06T00:28:04.749Z] ====== als (apache-spark) [default], iteration 25 completed (35958.745 ms) ====== [2025-03-06T00:28:04.749Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-03-06T00:28:04.749Z] GC before operation: completed in 1789.848 ms, heap usage 147.243 MB -> 62.552 MB. [2025-03-06T00:28:34.084Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:28:34.084Z] There is no way to check that no silent failure occurred. [2025-03-06T00:28:34.084Z] ====== als (apache-spark) [default], iteration 26 completed (27921.785 ms) ====== [2025-03-06T00:28:34.084Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-03-06T00:28:34.084Z] GC before operation: completed in 360.092 ms, heap usage 240.902 MB -> 62.932 MB. [2025-03-06T00:28:55.388Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:28:55.388Z] There is no way to check that no silent failure occurred. [2025-03-06T00:28:55.388Z] ====== als (apache-spark) [default], iteration 27 completed (20744.277 ms) ====== [2025-03-06T00:28:55.388Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-03-06T00:28:55.388Z] GC before operation: completed in 687.090 ms, heap usage 264.342 MB -> 63.141 MB. [2025-03-06T00:29:31.849Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:29:31.849Z] There is no way to check that no silent failure occurred. [2025-03-06T00:29:31.849Z] ====== als (apache-spark) [default], iteration 28 completed (36603.647 ms) ====== [2025-03-06T00:29:31.849Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-03-06T00:29:31.849Z] GC before operation: completed in 441.143 ms, heap usage 271.143 MB -> 63.538 MB. [2025-03-06T00:29:57.469Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:29:57.469Z] There is no way to check that no silent failure occurred. [2025-03-06T00:29:57.469Z] ====== als (apache-spark) [default], iteration 29 completed (24366.898 ms) ====== [2025-03-06T00:29:57.469Z] ----------------------------------- [2025-03-06T00:29:57.469Z] renaissance-als_0_PASSED [2025-03-06T00:29:57.469Z] ----------------------------------- [2025-03-06T00:29:57.469Z] [2025-03-06T00:29:57.469Z] TEST TEARDOWN: [2025-03-06T00:29:57.469Z] Nothing to be done for teardown. [2025-03-06T00:29:57.469Z] renaissance-als_0 Finish Time: Thu Mar 6 00:29:56 2025 Epoch Time (ms): 1741220996187