[2024-08-15T06:39:25.811Z] Running test renaissance-als_0 ... [2024-08-15T06:39:25.811Z] =============================================== [2024-08-15T06:39:25.811Z] renaissance-als_0 Start Time: Thu Aug 15 06:39:25 2024 Epoch Time (ms): 1723703965487 [2024-08-15T06:39:25.811Z] variation: NoOptions [2024-08-15T06:39:25.811Z] JVM_OPTIONS: [2024-08-15T06:39:25.811Z] { \ [2024-08-15T06:39:25.811Z] echo ""; echo "TEST SETUP:"; \ [2024-08-15T06:39:25.811Z] echo "Nothing to be done for setup."; \ [2024-08-15T06:39:25.811Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17237038963107/renaissance-als_0"; \ [2024-08-15T06:39:25.811Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17237038963107/renaissance-als_0"; \ [2024-08-15T06:39:25.811Z] echo ""; echo "TESTING:"; \ [2024-08-15T06:39:25.811Z] "/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_17237038963107/renaissance-als_0"/als.json" als; \ [2024-08-15T06:39:25.811Z] 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_17237038963107/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-15T06:39:25.811Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-15T06:39:25.812Z] echo "Nothing to be done for teardown."; \ [2024-08-15T06:39:25.812Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17237038963107/TestTargetResult"; [2024-08-15T06:39:25.812Z] [2024-08-15T06:39:25.812Z] TEST SETUP: [2024-08-15T06:39:25.812Z] Nothing to be done for setup. [2024-08-15T06:39:25.812Z] [2024-08-15T06:39:25.812Z] TESTING: [2024-08-15T06:39:32.646Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-15T06:39:38.995Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-15T06:39:43.660Z] WARNING: An illegal reflective access operation has occurred [2024-08-15T06:39:43.660Z] 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_17237038963107/renaissance-als_0/harness-063927-10345353398108289209/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-15T06:39:43.660Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-15T06:39:43.660Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-15T06:39:43.660Z] WARNING: All illegal access operations will be denied in a future release [2024-08-15T06:39:45.778Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-15T06:39:45.778Z] GC before operation: completed in 105.734 ms, heap usage 90.507 MB -> 33.591 MB. [2024-08-15T06:40:25.308Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:40:25.308Z] There is no way to check that no silent failure occurred. [2024-08-15T06:40:25.308Z] ====== als (apache-spark) [default], iteration 0 completed (39257.915 ms) ====== [2024-08-15T06:40:25.308Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-15T06:40:25.308Z] GC before operation: completed in 183.163 ms, heap usage 372.234 MB -> 55.926 MB. [2024-08-15T06:40:53.466Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:40:53.466Z] There is no way to check that no silent failure occurred. [2024-08-15T06:40:53.466Z] ====== als (apache-spark) [default], iteration 1 completed (24264.390 ms) ====== [2024-08-15T06:40:53.466Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-15T06:40:53.466Z] GC before operation: completed in 178.953 ms, heap usage 523.200 MB -> 58.825 MB. [2024-08-15T06:41:17.281Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:41:17.281Z] There is no way to check that no silent failure occurred. [2024-08-15T06:41:17.281Z] ====== als (apache-spark) [default], iteration 2 completed (27398.240 ms) ====== [2024-08-15T06:41:17.281Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-15T06:41:18.026Z] GC before operation: completed in 368.744 ms, heap usage 144.099 MB -> 58.605 MB. [2024-08-15T06:41:46.604Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:41:46.604Z] There is no way to check that no silent failure occurred. [2024-08-15T06:41:46.604Z] ====== als (apache-spark) [default], iteration 3 completed (28405.646 ms) ====== [2024-08-15T06:41:46.604Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-15T06:41:46.604Z] GC before operation: completed in 225.258 ms, heap usage 226.059 MB -> 59.032 MB. [2024-08-15T06:42:10.494Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:42:10.494Z] There is no way to check that no silent failure occurred. [2024-08-15T06:42:10.494Z] ====== als (apache-spark) [default], iteration 4 completed (22730.320 ms) ====== [2024-08-15T06:42:10.494Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-15T06:42:10.495Z] GC before operation: completed in 559.916 ms, heap usage 320.933 MB -> 59.580 MB. [2024-08-15T06:42:34.497Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:42:34.497Z] There is no way to check that no silent failure occurred. [2024-08-15T06:42:34.497Z] ====== als (apache-spark) [default], iteration 5 completed (24244.292 ms) ====== [2024-08-15T06:42:34.497Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-15T06:42:34.497Z] GC before operation: completed in 234.399 ms, heap usage 197.819 MB -> 59.667 MB. [2024-08-15T06:43:03.616Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:43:03.616Z] There is no way to check that no silent failure occurred. [2024-08-15T06:43:03.616Z] ====== als (apache-spark) [default], iteration 6 completed (26155.267 ms) ====== [2024-08-15T06:43:03.616Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-15T06:43:03.616Z] GC before operation: completed in 225.081 ms, heap usage 351.151 MB -> 60.303 MB. [2024-08-15T06:43:23.932Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:43:23.932Z] There is no way to check that no silent failure occurred. [2024-08-15T06:43:23.932Z] ====== als (apache-spark) [default], iteration 7 completed (22401.272 ms) ====== [2024-08-15T06:43:23.932Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-15T06:43:23.932Z] GC before operation: completed in 698.258 ms, heap usage 449.710 MB -> 60.908 MB. [2024-08-15T06:43:53.268Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:43:53.268Z] There is no way to check that no silent failure occurred. [2024-08-15T06:43:53.268Z] ====== als (apache-spark) [default], iteration 8 completed (28873.303 ms) ====== [2024-08-15T06:43:53.268Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-15T06:43:53.268Z] GC before operation: completed in 963.394 ms, heap usage 213.941 MB -> 60.700 MB. [2024-08-15T06:44:24.464Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:44:24.464Z] There is no way to check that no silent failure occurred. [2024-08-15T06:44:24.464Z] ====== als (apache-spark) [default], iteration 9 completed (30448.391 ms) ====== [2024-08-15T06:44:24.464Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-15T06:44:24.464Z] GC before operation: completed in 449.065 ms, heap usage 214.425 MB -> 61.132 MB. [2024-08-15T06:44:52.944Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:44:52.944Z] There is no way to check that no silent failure occurred. [2024-08-15T06:44:52.944Z] ====== als (apache-spark) [default], iteration 10 completed (25754.420 ms) ====== [2024-08-15T06:44:52.944Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-15T06:44:52.944Z] GC before operation: completed in 212.395 ms, heap usage 256.306 MB -> 61.654 MB. [2024-08-15T06:45:22.583Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:45:22.583Z] There is no way to check that no silent failure occurred. [2024-08-15T06:45:22.583Z] ====== als (apache-spark) [default], iteration 11 completed (27836.524 ms) ====== [2024-08-15T06:45:22.583Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-15T06:45:22.583Z] GC before operation: completed in 691.268 ms, heap usage 317.156 MB -> 62.028 MB. [2024-08-15T06:45:43.340Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:45:43.341Z] There is no way to check that no silent failure occurred. [2024-08-15T06:45:43.341Z] ====== als (apache-spark) [default], iteration 12 completed (23206.457 ms) ====== [2024-08-15T06:45:43.341Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-15T06:45:43.341Z] GC before operation: completed in 325.774 ms, heap usage 405.825 MB -> 62.469 MB. [2024-08-15T06:46:07.550Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:46:07.550Z] There is no way to check that no silent failure occurred. [2024-08-15T06:46:07.550Z] ====== als (apache-spark) [default], iteration 13 completed (24416.936 ms) ====== [2024-08-15T06:46:07.550Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-15T06:46:07.551Z] GC before operation: completed in 730.465 ms, heap usage 509.536 MB -> 62.900 MB. [2024-08-15T06:46:41.852Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:46:41.852Z] There is no way to check that no silent failure occurred. [2024-08-15T06:46:41.852Z] ====== als (apache-spark) [default], iteration 14 completed (32207.825 ms) ====== [2024-08-15T06:46:41.852Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-15T06:46:41.852Z] GC before operation: completed in 283.694 ms, heap usage 255.802 MB -> 62.951 MB. [2024-08-15T06:47:02.212Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:47:02.212Z] There is no way to check that no silent failure occurred. [2024-08-15T06:47:02.212Z] ====== als (apache-spark) [default], iteration 15 completed (22129.031 ms) ====== [2024-08-15T06:47:02.212Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-15T06:47:03.210Z] GC before operation: completed in 491.142 ms, heap usage 480.153 MB -> 63.668 MB. [2024-08-15T06:47:27.976Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:47:27.976Z] There is no way to check that no silent failure occurred. [2024-08-15T06:47:27.976Z] ====== als (apache-spark) [default], iteration 16 completed (23214.812 ms) ====== [2024-08-15T06:47:27.976Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-15T06:47:27.976Z] GC before operation: completed in 505.607 ms, heap usage 316.393 MB -> 63.745 MB. [2024-08-15T06:47:57.111Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:47:57.111Z] There is no way to check that no silent failure occurred. [2024-08-15T06:47:57.111Z] ====== als (apache-spark) [default], iteration 17 completed (30445.487 ms) ====== [2024-08-15T06:47:57.111Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-15T06:47:57.111Z] GC before operation: completed in 419.443 ms, heap usage 246.386 MB -> 64.104 MB. [2024-08-15T06:48:26.340Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:48:26.340Z] There is no way to check that no silent failure occurred. [2024-08-15T06:48:26.341Z] ====== als (apache-spark) [default], iteration 18 completed (27805.620 ms) ====== [2024-08-15T06:48:26.341Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-15T06:48:26.341Z] GC before operation: completed in 665.645 ms, heap usage 219.863 MB -> 63.947 MB. [2024-08-15T06:48:51.071Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:48:51.071Z] There is no way to check that no silent failure occurred. [2024-08-15T06:48:51.071Z] ====== als (apache-spark) [default], iteration 19 completed (25144.303 ms) ====== [2024-08-15T06:48:51.071Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-15T06:48:51.071Z] GC before operation: completed in 274.494 ms, heap usage 357.251 MB -> 64.494 MB. [2024-08-15T06:49:08.037Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:49:08.037Z] There is no way to check that no silent failure occurred. [2024-08-15T06:49:08.037Z] ====== als (apache-spark) [default], iteration 20 completed (16487.613 ms) ====== [2024-08-15T06:49:08.037Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-15T06:49:08.037Z] GC before operation: completed in 276.891 ms, heap usage 356.413 MB -> 64.643 MB. [2024-08-15T06:49:32.087Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:49:32.087Z] There is no way to check that no silent failure occurred. [2024-08-15T06:49:32.087Z] ====== als (apache-spark) [default], iteration 21 completed (21987.133 ms) ====== [2024-08-15T06:49:32.087Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-15T06:49:32.087Z] GC before operation: completed in 255.819 ms, heap usage 259.894 MB -> 64.927 MB. [2024-08-15T06:49:56.264Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:49:56.264Z] There is no way to check that no silent failure occurred. [2024-08-15T06:49:56.264Z] ====== als (apache-spark) [default], iteration 22 completed (25126.638 ms) ====== [2024-08-15T06:49:56.265Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-15T06:49:56.265Z] GC before operation: completed in 375.894 ms, heap usage 307.011 MB -> 64.949 MB. [2024-08-15T06:50:21.125Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:50:21.125Z] There is no way to check that no silent failure occurred. [2024-08-15T06:50:21.125Z] ====== als (apache-spark) [default], iteration 23 completed (25738.118 ms) ====== [2024-08-15T06:50:21.125Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-15T06:50:21.776Z] GC before operation: completed in 282.240 ms, heap usage 309.884 MB -> 65.277 MB. [2024-08-15T06:50:50.525Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:50:50.525Z] There is no way to check that no silent failure occurred. [2024-08-15T06:50:50.525Z] ====== als (apache-spark) [default], iteration 24 completed (25802.020 ms) ====== [2024-08-15T06:50:50.525Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-15T06:50:50.525Z] GC before operation: completed in 368.424 ms, heap usage 332.328 MB -> 65.483 MB. [2024-08-15T06:51:10.710Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:51:10.710Z] There is no way to check that no silent failure occurred. [2024-08-15T06:51:10.711Z] ====== als (apache-spark) [default], iteration 25 completed (20751.391 ms) ====== [2024-08-15T06:51:10.711Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-15T06:51:10.711Z] GC before operation: completed in 311.913 ms, heap usage 321.059 MB -> 65.556 MB. [2024-08-15T06:51:35.135Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:51:35.135Z] There is no way to check that no silent failure occurred. [2024-08-15T06:51:35.135Z] ====== als (apache-spark) [default], iteration 26 completed (26306.215 ms) ====== [2024-08-15T06:51:35.135Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-15T06:51:35.777Z] GC before operation: completed in 292.446 ms, heap usage 397.529 MB -> 66.059 MB. [2024-08-15T06:51:56.426Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:51:56.426Z] There is no way to check that no silent failure occurred. [2024-08-15T06:51:56.426Z] ====== als (apache-spark) [default], iteration 27 completed (19756.738 ms) ====== [2024-08-15T06:51:56.426Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-15T06:51:56.426Z] GC before operation: completed in 397.807 ms, heap usage 484.015 MB -> 66.174 MB. [2024-08-15T06:52:20.189Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:52:20.189Z] There is no way to check that no silent failure occurred. [2024-08-15T06:52:20.189Z] ====== als (apache-spark) [default], iteration 28 completed (21940.909 ms) ====== [2024-08-15T06:52:20.189Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-15T06:52:20.189Z] GC before operation: completed in 222.229 ms, heap usage 261.599 MB -> 66.209 MB. [2024-08-15T06:52:40.271Z] WARNING: This benchmark provides no result that can be validated. [2024-08-15T06:52:40.271Z] There is no way to check that no silent failure occurred. [2024-08-15T06:52:40.271Z] ====== als (apache-spark) [default], iteration 29 completed (20848.348 ms) ====== [2024-08-15T06:52:40.271Z] ----------------------------------- [2024-08-15T06:52:40.271Z] renaissance-als_0_PASSED [2024-08-15T06:52:40.271Z] ----------------------------------- [2024-08-15T06:52:40.271Z] [2024-08-15T06:52:40.271Z] TEST TEARDOWN: [2024-08-15T06:52:40.271Z] Nothing to be done for teardown. [2024-08-15T06:52:40.271Z] renaissance-als_0 Finish Time: Thu Aug 15 06:52:39 2024 Epoch Time (ms): 1723704759094