[2024-08-23T20:46:57.776Z] Running test renaissance-als_0 ... [2024-08-23T20:46:57.776Z] =============================================== [2024-08-23T20:46:57.776Z] renaissance-als_0 Start Time: Fri Aug 23 20:46:57 2024 Epoch Time (ms): 1724446017154 [2024-08-23T20:46:57.776Z] variation: NoOptions [2024-08-23T20:46:57.776Z] JVM_OPTIONS: [2024-08-23T20:46:57.776Z] { \ [2024-08-23T20:46:57.776Z] echo ""; echo "TEST SETUP:"; \ [2024-08-23T20:46:57.776Z] echo "Nothing to be done for setup."; \ [2024-08-23T20:46:57.776Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1724445910903/renaissance-als_0"; \ [2024-08-23T20:46:57.776Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1724445910903/renaissance-als_0"; \ [2024-08-23T20:46:57.776Z] echo ""; echo "TESTING:"; \ [2024-08-23T20:46:57.776Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk-11.0.25+4/bin/..//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_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1724445910903/renaissance-als_0"/als.json" als; \ [2024-08-23T20:46:57.776Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1724445910903/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-23T20:46:57.776Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-23T20:46:57.776Z] echo "Nothing to be done for teardown."; \ [2024-08-23T20:46:57.776Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_1724445910903/TestTargetResult"; [2024-08-23T20:46:57.776Z] [2024-08-23T20:46:57.776Z] TEST SETUP: [2024-08-23T20:46:57.776Z] Nothing to be done for setup. [2024-08-23T20:46:57.776Z] [2024-08-23T20:46:57.776Z] TESTING: [2024-08-23T20:47:09.320Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-23T20:47:13.897Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-23T20:47:27.526Z] WARNING: An illegal reflective access operation has occurred [2024-08-23T20:47:27.526Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_1724445910903/renaissance-als_0/harness-204659-9885526109038516852/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-23T20:47:27.526Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-23T20:47:27.526Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-23T20:47:27.526Z] WARNING: All illegal access operations will be denied in a future release [2024-08-23T20:47:30.301Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-23T20:47:30.301Z] GC before operation: completed in 83.862 ms, heap usage 91.213 MB -> 34.045 MB. [2024-08-23T20:49:50.922Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:49:50.922Z] There is no way to check that no silent failure occurred. [2024-08-23T20:49:50.922Z] ====== als (apache-spark) [default], iteration 0 completed (135845.983 ms) ====== [2024-08-23T20:49:50.922Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-23T20:49:50.922Z] GC before operation: completed in 897.531 ms, heap usage 300.447 MB -> 56.158 MB. [2024-08-23T20:51:24.587Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:51:24.587Z] There is no way to check that no silent failure occurred. [2024-08-23T20:51:24.587Z] ====== als (apache-spark) [default], iteration 1 completed (88733.841 ms) ====== [2024-08-23T20:51:24.587Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-23T20:51:24.587Z] GC before operation: completed in 975.286 ms, heap usage 454.418 MB -> 58.905 MB. [2024-08-23T20:52:32.784Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:52:32.785Z] There is no way to check that no silent failure occurred. [2024-08-23T20:52:32.785Z] ====== als (apache-spark) [default], iteration 2 completed (68251.282 ms) ====== [2024-08-23T20:52:32.785Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-23T20:52:32.785Z] GC before operation: completed in 1162.085 ms, heap usage 307.571 MB -> 59.118 MB. [2024-08-23T20:53:41.413Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:53:41.413Z] There is no way to check that no silent failure occurred. [2024-08-23T20:53:41.413Z] ====== als (apache-spark) [default], iteration 3 completed (70317.521 ms) ====== [2024-08-23T20:53:41.413Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-23T20:53:41.413Z] GC before operation: completed in 564.978 ms, heap usage 169.806 MB -> 59.298 MB. [2024-08-23T20:54:49.325Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:54:49.325Z] There is no way to check that no silent failure occurred. [2024-08-23T20:54:49.325Z] ====== als (apache-spark) [default], iteration 4 completed (67257.121 ms) ====== [2024-08-23T20:54:49.325Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-23T20:54:49.325Z] GC before operation: completed in 785.957 ms, heap usage 219.183 MB -> 59.677 MB. [2024-08-23T20:56:09.815Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:56:09.815Z] There is no way to check that no silent failure occurred. [2024-08-23T20:56:09.815Z] ====== als (apache-spark) [default], iteration 5 completed (74603.612 ms) ====== [2024-08-23T20:56:09.816Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-23T20:56:09.816Z] GC before operation: completed in 827.012 ms, heap usage 148.492 MB -> 59.856 MB. [2024-08-23T20:57:17.575Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:57:17.575Z] There is no way to check that no silent failure occurred. [2024-08-23T20:57:17.575Z] ====== als (apache-spark) [default], iteration 6 completed (72270.100 ms) ====== [2024-08-23T20:57:17.575Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-23T20:57:17.575Z] GC before operation: completed in 1193.946 ms, heap usage 183.441 MB -> 60.319 MB. [2024-08-23T20:58:53.105Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T20:58:53.105Z] There is no way to check that no silent failure occurred. [2024-08-23T20:58:53.105Z] ====== als (apache-spark) [default], iteration 7 completed (86839.798 ms) ====== [2024-08-23T20:58:53.105Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-23T20:58:53.105Z] GC before operation: completed in 1170.107 ms, heap usage 419.123 MB -> 61.031 MB. [2024-08-23T21:00:11.310Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:00:11.310Z] There is no way to check that no silent failure occurred. [2024-08-23T21:00:11.310Z] ====== als (apache-spark) [default], iteration 8 completed (82651.179 ms) ====== [2024-08-23T21:00:11.310Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-23T21:00:11.310Z] GC before operation: completed in 1169.154 ms, heap usage 383.528 MB -> 61.300 MB. [2024-08-23T21:01:44.280Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:01:44.280Z] There is no way to check that no silent failure occurred. [2024-08-23T21:01:44.280Z] ====== als (apache-spark) [default], iteration 9 completed (89085.038 ms) ====== [2024-08-23T21:01:44.280Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-23T21:01:44.280Z] GC before operation: completed in 1219.260 ms, heap usage 575.835 MB -> 62.029 MB. [2024-08-23T21:03:03.643Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:03:03.643Z] There is no way to check that no silent failure occurred. [2024-08-23T21:03:03.643Z] ====== als (apache-spark) [default], iteration 10 completed (76822.994 ms) ====== [2024-08-23T21:03:03.643Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-23T21:03:03.643Z] GC before operation: completed in 1108.328 ms, heap usage 389.222 MB -> 61.978 MB. [2024-08-23T21:04:22.856Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:04:22.856Z] There is no way to check that no silent failure occurred. [2024-08-23T21:04:22.856Z] ====== als (apache-spark) [default], iteration 11 completed (84898.334 ms) ====== [2024-08-23T21:04:22.856Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-23T21:04:22.856Z] GC before operation: completed in 987.076 ms, heap usage 158.756 MB -> 62.025 MB. [2024-08-23T21:05:44.182Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:05:44.182Z] There is no way to check that no silent failure occurred. [2024-08-23T21:05:44.182Z] ====== als (apache-spark) [default], iteration 12 completed (79793.777 ms) ====== [2024-08-23T21:05:44.182Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-23T21:05:44.182Z] GC before operation: completed in 1083.364 ms, heap usage 380.751 MB -> 62.742 MB. [2024-08-23T21:07:05.470Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:07:05.470Z] There is no way to check that no silent failure occurred. [2024-08-23T21:07:05.470Z] ====== als (apache-spark) [default], iteration 13 completed (82861.141 ms) ====== [2024-08-23T21:07:05.470Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-23T21:07:05.470Z] GC before operation: completed in 1043.055 ms, heap usage 437.898 MB -> 63.220 MB. [2024-08-23T21:08:40.907Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:08:40.907Z] There is no way to check that no silent failure occurred. [2024-08-23T21:08:40.907Z] ====== als (apache-spark) [default], iteration 14 completed (89568.562 ms) ====== [2024-08-23T21:08:40.907Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-23T21:08:40.907Z] GC before operation: completed in 1368.252 ms, heap usage 489.350 MB -> 63.457 MB. [2024-08-23T21:10:16.870Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:10:16.870Z] There is no way to check that no silent failure occurred. [2024-08-23T21:10:16.870Z] ====== als (apache-spark) [default], iteration 15 completed (92919.449 ms) ====== [2024-08-23T21:10:16.870Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-23T21:10:16.870Z] GC before operation: completed in 1523.444 ms, heap usage 434.411 MB -> 62.582 MB. [2024-08-23T21:11:52.074Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:11:52.074Z] There is no way to check that no silent failure occurred. [2024-08-23T21:11:52.074Z] ====== als (apache-spark) [default], iteration 16 completed (94481.895 ms) ====== [2024-08-23T21:11:52.074Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-23T21:11:52.074Z] GC before operation: completed in 1451.890 ms, heap usage 575.656 MB -> 61.622 MB. [2024-08-23T21:13:26.904Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:13:26.904Z] There is no way to check that no silent failure occurred. [2024-08-23T21:13:26.904Z] ====== als (apache-spark) [default], iteration 17 completed (92401.299 ms) ====== [2024-08-23T21:13:26.904Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-23T21:13:26.904Z] GC before operation: completed in 1343.852 ms, heap usage 404.511 MB -> 61.228 MB. [2024-08-23T21:15:00.247Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:15:00.247Z] There is no way to check that no silent failure occurred. [2024-08-23T21:15:00.247Z] ====== als (apache-spark) [default], iteration 18 completed (94026.669 ms) ====== [2024-08-23T21:15:00.247Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-23T21:15:00.247Z] GC before operation: completed in 1278.845 ms, heap usage 519.648 MB -> 61.997 MB. [2024-08-23T21:16:21.196Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:16:21.196Z] There is no way to check that no silent failure occurred. [2024-08-23T21:16:21.196Z] ====== als (apache-spark) [default], iteration 19 completed (82721.929 ms) ====== [2024-08-23T21:16:21.196Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-23T21:16:21.196Z] GC before operation: completed in 985.385 ms, heap usage 300.094 MB -> 61.984 MB. [2024-08-23T21:17:40.736Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:17:40.736Z] There is no way to check that no silent failure occurred. [2024-08-23T21:17:40.736Z] ====== als (apache-spark) [default], iteration 20 completed (80425.679 ms) ====== [2024-08-23T21:17:40.736Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-23T21:17:40.736Z] GC before operation: completed in 1100.711 ms, heap usage 311.115 MB -> 62.176 MB. [2024-08-23T21:19:14.516Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:19:14.516Z] There is no way to check that no silent failure occurred. [2024-08-23T21:19:14.516Z] ====== als (apache-spark) [default], iteration 21 completed (81593.955 ms) ====== [2024-08-23T21:19:14.516Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-23T21:19:14.516Z] GC before operation: completed in 765.456 ms, heap usage 395.935 MB -> 62.551 MB. [2024-08-23T21:20:21.599Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:20:21.599Z] There is no way to check that no silent failure occurred. [2024-08-23T21:20:21.599Z] ====== als (apache-spark) [default], iteration 22 completed (77260.158 ms) ====== [2024-08-23T21:20:21.599Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-23T21:20:21.599Z] GC before operation: completed in 1056.509 ms, heap usage 475.150 MB -> 62.725 MB. [2024-08-23T21:21:41.268Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:21:41.268Z] There is no way to check that no silent failure occurred. [2024-08-23T21:21:41.268Z] ====== als (apache-spark) [default], iteration 23 completed (69495.095 ms) ====== [2024-08-23T21:21:41.268Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-23T21:21:41.268Z] GC before operation: completed in 812.188 ms, heap usage 466.304 MB -> 63.000 MB. [2024-08-23T21:22:48.992Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:22:48.992Z] There is no way to check that no silent failure occurred. [2024-08-23T21:22:48.992Z] ====== als (apache-spark) [default], iteration 24 completed (70427.528 ms) ====== [2024-08-23T21:22:48.992Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-23T21:22:48.992Z] GC before operation: completed in 1043.061 ms, heap usage 486.761 MB -> 63.237 MB. [2024-08-23T21:23:55.987Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:23:55.987Z] There is no way to check that no silent failure occurred. [2024-08-23T21:23:55.987Z] ====== als (apache-spark) [default], iteration 25 completed (69558.944 ms) ====== [2024-08-23T21:23:55.987Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-23T21:23:55.987Z] GC before operation: completed in 982.229 ms, heap usage 446.007 MB -> 63.233 MB. [2024-08-23T21:25:14.912Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:25:14.912Z] There is no way to check that no silent failure occurred. [2024-08-23T21:25:14.912Z] ====== als (apache-spark) [default], iteration 26 completed (70751.167 ms) ====== [2024-08-23T21:25:14.912Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-23T21:25:14.912Z] GC before operation: completed in 1149.213 ms, heap usage 504.345 MB -> 63.734 MB. [2024-08-23T21:26:22.516Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:26:22.516Z] There is no way to check that no silent failure occurred. [2024-08-23T21:26:22.516Z] ====== als (apache-spark) [default], iteration 27 completed (72842.926 ms) ====== [2024-08-23T21:26:22.516Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-23T21:26:22.516Z] GC before operation: completed in 955.000 ms, heap usage 385.686 MB -> 63.554 MB. [2024-08-23T21:27:44.373Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:27:44.373Z] There is no way to check that no silent failure occurred. [2024-08-23T21:27:44.373Z] ====== als (apache-spark) [default], iteration 28 completed (77217.626 ms) ====== [2024-08-23T21:27:44.373Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-23T21:27:44.373Z] GC before operation: completed in 1079.810 ms, heap usage 569.069 MB -> 64.077 MB. [2024-08-23T21:28:53.498Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:28:53.498Z] There is no way to check that no silent failure occurred. [2024-08-23T21:28:53.498Z] ====== als (apache-spark) [default], iteration 29 completed (72265.451 ms) ====== [2024-08-23T21:28:53.498Z] ----------------------------------- [2024-08-23T21:28:53.498Z] renaissance-als_0_PASSED [2024-08-23T21:28:53.498Z] ----------------------------------- [2024-08-23T21:28:53.498Z] [2024-08-23T21:28:53.498Z] TEST TEARDOWN: [2024-08-23T21:28:53.498Z] Nothing to be done for teardown. [2024-08-23T21:28:53.498Z] renaissance-als_0 Finish Time: Fri Aug 23 21:28:52 2024 Epoch Time (ms): 1724448532249