[2024-08-28T21:53:25.199Z] Running test renaissance-als_0 ... [2024-08-28T21:53:25.199Z] =============================================== [2024-08-28T21:53:25.199Z] renaissance-als_0 Start Time: Wed Aug 28 21:53:25 2024 Epoch Time (ms): 1724882005076 [2024-08-28T21:53:25.199Z] variation: NoOptions [2024-08-28T21:53:25.199Z] JVM_OPTIONS: [2024-08-28T21:53:25.199Z] { \ [2024-08-28T21:53:25.199Z] echo ""; echo "TEST SETUP:"; \ [2024-08-28T21:53:25.199Z] echo "Nothing to be done for setup."; \ [2024-08-28T21:53:25.199Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_172488200392/renaissance-als_0"; \ [2024-08-28T21:53:25.199Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_172488200392/renaissance-als_0"; \ [2024-08-28T21:53:25.199Z] echo ""; echo "TESTING:"; \ [2024-08-28T21:53:25.199Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk-11.0.25+5/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_172488200392/renaissance-als_0"/als.json" als; \ [2024-08-28T21:53:25.199Z] 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_172488200392/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-28T21:53:25.199Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-28T21:53:25.199Z] echo "Nothing to be done for teardown."; \ [2024-08-28T21:53:25.199Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_172488200392/TestTargetResult"; [2024-08-28T21:53:25.199Z] [2024-08-28T21:53:25.199Z] TEST SETUP: [2024-08-28T21:53:25.199Z] Nothing to be done for setup. [2024-08-28T21:53:26.024Z] [2024-08-28T21:53:26.024Z] TESTING: [2024-08-28T21:53:41.061Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-28T21:53:55.453Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-28T21:54:15.086Z] WARNING: An illegal reflective access operation has occurred [2024-08-28T21:54:15.086Z] 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_172488200392/renaissance-als_0/harness-215329-18316244935352061498/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-28T21:54:15.086Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-28T21:54:15.086Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-28T21:54:15.086Z] WARNING: All illegal access operations will be denied in a future release [2024-08-28T21:54:31.774Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-28T21:54:31.774Z] GC before operation: completed in 497.953 ms, heap usage 98.000 MB -> 34.043 MB. [2024-08-28T21:57:08.814Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T21:57:08.814Z] There is no way to check that no silent failure occurred. [2024-08-28T21:57:08.814Z] ====== als (apache-spark) [default], iteration 0 completed (156725.683 ms) ====== [2024-08-28T21:57:08.814Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-28T21:57:08.814Z] GC before operation: completed in 812.720 ms, heap usage 397.902 MB -> 56.357 MB. [2024-08-28T21:58:29.146Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T21:58:29.146Z] There is no way to check that no silent failure occurred. [2024-08-28T21:58:29.146Z] ====== als (apache-spark) [default], iteration 1 completed (73990.926 ms) ====== [2024-08-28T21:58:29.146Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-28T21:58:29.146Z] GC before operation: completed in 744.257 ms, heap usage 350.326 MB -> 58.940 MB. [2024-08-28T21:59:37.504Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T21:59:37.504Z] There is no way to check that no silent failure occurred. [2024-08-28T21:59:37.504Z] ====== als (apache-spark) [default], iteration 2 completed (72126.746 ms) ====== [2024-08-28T21:59:37.504Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-28T21:59:37.504Z] GC before operation: completed in 893.379 ms, heap usage 468.676 MB -> 59.383 MB. [2024-08-28T22:00:56.974Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:00:56.974Z] There is no way to check that no silent failure occurred. [2024-08-28T22:00:56.974Z] ====== als (apache-spark) [default], iteration 3 completed (69378.649 ms) ====== [2024-08-28T22:00:56.974Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-28T22:00:56.974Z] GC before operation: completed in 973.859 ms, heap usage 480.734 MB -> 59.823 MB. [2024-08-28T22:01:54.607Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:01:54.607Z] There is no way to check that no silent failure occurred. [2024-08-28T22:01:54.607Z] ====== als (apache-spark) [default], iteration 4 completed (64324.585 ms) ====== [2024-08-28T22:01:54.607Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-28T22:01:54.607Z] GC before operation: completed in 775.329 ms, heap usage 584.687 MB -> 60.161 MB. [2024-08-28T22:02:52.041Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:02:52.041Z] There is no way to check that no silent failure occurred. [2024-08-28T22:02:52.041Z] ====== als (apache-spark) [default], iteration 5 completed (56700.321 ms) ====== [2024-08-28T22:02:52.041Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-28T22:02:52.041Z] GC before operation: completed in 839.621 ms, heap usage 185.922 MB -> 60.051 MB. [2024-08-28T22:03:59.779Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:03:59.779Z] There is no way to check that no silent failure occurred. [2024-08-28T22:03:59.779Z] ====== als (apache-spark) [default], iteration 6 completed (64079.210 ms) ====== [2024-08-28T22:03:59.779Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-28T22:03:59.779Z] GC before operation: completed in 827.272 ms, heap usage 537.920 MB -> 60.978 MB. [2024-08-28T22:05:08.240Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:05:08.240Z] There is no way to check that no silent failure occurred. [2024-08-28T22:05:08.240Z] ====== als (apache-spark) [default], iteration 7 completed (68315.281 ms) ====== [2024-08-28T22:05:08.240Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-28T22:05:08.240Z] GC before operation: completed in 887.351 ms, heap usage 351.201 MB -> 60.985 MB. [2024-08-28T22:06:16.881Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:06:16.881Z] There is no way to check that no silent failure occurred. [2024-08-28T22:06:16.881Z] ====== als (apache-spark) [default], iteration 8 completed (72404.342 ms) ====== [2024-08-28T22:06:16.881Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-28T22:06:16.881Z] GC before operation: completed in 861.668 ms, heap usage 517.746 MB -> 61.628 MB. [2024-08-28T22:07:25.439Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:07:25.439Z] There is no way to check that no silent failure occurred. [2024-08-28T22:07:25.439Z] ====== als (apache-spark) [default], iteration 9 completed (66789.245 ms) ====== [2024-08-28T22:07:25.439Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-28T22:07:25.439Z] GC before operation: completed in 845.277 ms, heap usage 565.679 MB -> 61.902 MB. [2024-08-28T22:08:33.901Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:08:33.901Z] There is no way to check that no silent failure occurred. [2024-08-28T22:08:33.902Z] ====== als (apache-spark) [default], iteration 10 completed (66840.734 ms) ====== [2024-08-28T22:08:33.902Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-28T22:08:33.902Z] GC before operation: completed in 771.565 ms, heap usage 481.776 MB -> 62.104 MB. [2024-08-28T22:09:42.734Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:09:42.734Z] There is no way to check that no silent failure occurred. [2024-08-28T22:09:42.734Z] ====== als (apache-spark) [default], iteration 11 completed (61756.778 ms) ====== [2024-08-28T22:09:42.734Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-28T22:09:42.734Z] GC before operation: completed in 756.866 ms, heap usage 548.575 MB -> 62.591 MB. [2024-08-28T22:10:41.488Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:10:41.488Z] There is no way to check that no silent failure occurred. [2024-08-28T22:10:41.488Z] ====== als (apache-spark) [default], iteration 12 completed (66802.043 ms) ====== [2024-08-28T22:10:41.488Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-28T22:10:42.284Z] GC before operation: completed in 863.307 ms, heap usage 383.384 MB -> 62.698 MB. [2024-08-28T22:12:02.055Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:12:02.055Z] There is no way to check that no silent failure occurred. [2024-08-28T22:12:02.055Z] ====== als (apache-spark) [default], iteration 13 completed (71398.578 ms) ====== [2024-08-28T22:12:02.055Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-28T22:12:02.055Z] GC before operation: completed in 955.660 ms, heap usage 439.330 MB -> 63.039 MB. [2024-08-28T22:13:09.782Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:13:09.782Z] There is no way to check that no silent failure occurred. [2024-08-28T22:13:09.782Z] ====== als (apache-spark) [default], iteration 14 completed (69622.232 ms) ====== [2024-08-28T22:13:09.782Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-28T22:13:09.782Z] GC before operation: completed in 939.833 ms, heap usage 233.840 MB -> 63.109 MB. [2024-08-28T22:14:18.169Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:14:18.169Z] There is no way to check that no silent failure occurred. [2024-08-28T22:14:18.169Z] ====== als (apache-spark) [default], iteration 15 completed (64906.208 ms) ====== [2024-08-28T22:14:18.169Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-28T22:14:18.169Z] GC before operation: completed in 971.997 ms, heap usage 130.623 MB -> 63.691 MB. [2024-08-28T22:15:26.155Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:15:26.155Z] There is no way to check that no silent failure occurred. [2024-08-28T22:15:26.155Z] ====== als (apache-spark) [default], iteration 16 completed (65792.409 ms) ====== [2024-08-28T22:15:26.155Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-28T22:15:26.155Z] GC before operation: completed in 833.078 ms, heap usage 372.334 MB -> 64.071 MB. [2024-08-28T22:16:34.923Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:16:34.923Z] There is no way to check that no silent failure occurred. [2024-08-28T22:16:34.923Z] ====== als (apache-spark) [default], iteration 17 completed (67837.165 ms) ====== [2024-08-28T22:16:34.923Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-28T22:16:34.923Z] GC before operation: completed in 916.995 ms, heap usage 211.081 MB -> 64.026 MB. [2024-08-28T22:17:32.881Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:17:32.882Z] There is no way to check that no silent failure occurred. [2024-08-28T22:17:32.882Z] ====== als (apache-spark) [default], iteration 18 completed (66103.581 ms) ====== [2024-08-28T22:17:32.882Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-28T22:17:33.671Z] GC before operation: completed in 1107.465 ms, heap usage 370.988 MB -> 63.705 MB. [2024-08-28T22:18:41.736Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:18:41.736Z] There is no way to check that no silent failure occurred. [2024-08-28T22:18:41.736Z] ====== als (apache-spark) [default], iteration 19 completed (65690.585 ms) ====== [2024-08-28T22:18:41.736Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-28T22:18:41.736Z] GC before operation: completed in 899.305 ms, heap usage 383.189 MB -> 62.068 MB. [2024-08-28T22:19:50.336Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:19:50.336Z] There is no way to check that no silent failure occurred. [2024-08-28T22:19:50.336Z] ====== als (apache-spark) [default], iteration 20 completed (63177.044 ms) ====== [2024-08-28T22:19:50.336Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-28T22:19:50.336Z] GC before operation: completed in 809.874 ms, heap usage 231.905 MB -> 61.824 MB. [2024-08-28T22:20:58.711Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:20:58.711Z] There is no way to check that no silent failure occurred. [2024-08-28T22:20:58.711Z] ====== als (apache-spark) [default], iteration 21 completed (69003.217 ms) ====== [2024-08-28T22:20:58.711Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-28T22:20:58.711Z] GC before operation: completed in 800.510 ms, heap usage 280.046 MB -> 62.457 MB. [2024-08-28T22:22:07.464Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:22:07.464Z] There is no way to check that no silent failure occurred. [2024-08-28T22:22:07.464Z] ====== als (apache-spark) [default], iteration 22 completed (70016.129 ms) ====== [2024-08-28T22:22:07.464Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-28T22:22:07.464Z] GC before operation: completed in 726.545 ms, heap usage 341.521 MB -> 62.465 MB. [2024-08-28T22:23:16.185Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:23:16.185Z] There is no way to check that no silent failure occurred. [2024-08-28T22:23:16.185Z] ====== als (apache-spark) [default], iteration 23 completed (65259.960 ms) ====== [2024-08-28T22:23:16.185Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-28T22:23:16.185Z] GC before operation: completed in 779.764 ms, heap usage 440.009 MB -> 62.974 MB. [2024-08-28T22:24:14.854Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:24:14.854Z] There is no way to check that no silent failure occurred. [2024-08-28T22:24:14.854Z] ====== als (apache-spark) [default], iteration 24 completed (59495.059 ms) ====== [2024-08-28T22:24:14.854Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-28T22:24:14.854Z] GC before operation: completed in 586.711 ms, heap usage 323.592 MB -> 63.098 MB. [2024-08-28T22:25:13.385Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:25:13.385Z] There is no way to check that no silent failure occurred. [2024-08-28T22:25:13.385Z] ====== als (apache-spark) [default], iteration 25 completed (59376.561 ms) ====== [2024-08-28T22:25:13.385Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-28T22:25:13.385Z] GC before operation: completed in 807.319 ms, heap usage 385.905 MB -> 63.066 MB. [2024-08-28T22:26:11.843Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:26:11.843Z] There is no way to check that no silent failure occurred. [2024-08-28T22:26:11.843Z] ====== als (apache-spark) [default], iteration 26 completed (60565.428 ms) ====== [2024-08-28T22:26:11.843Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-28T22:26:12.692Z] GC before operation: completed in 720.719 ms, heap usage 386.608 MB -> 63.414 MB. [2024-08-28T22:27:11.604Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:27:11.604Z] There is no way to check that no silent failure occurred. [2024-08-28T22:27:11.604Z] ====== als (apache-spark) [default], iteration 27 completed (59349.756 ms) ====== [2024-08-28T22:27:11.604Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-28T22:27:12.412Z] GC before operation: completed in 811.484 ms, heap usage 288.890 MB -> 63.396 MB. [2024-08-28T22:28:20.183Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:28:20.183Z] There is no way to check that no silent failure occurred. [2024-08-28T22:28:20.183Z] ====== als (apache-spark) [default], iteration 28 completed (65378.135 ms) ====== [2024-08-28T22:28:20.183Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-28T22:28:20.183Z] GC before operation: completed in 861.206 ms, heap usage 172.004 MB -> 63.496 MB. [2024-08-28T22:29:28.057Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T22:29:28.057Z] There is no way to check that no silent failure occurred. [2024-08-28T22:29:28.057Z] ====== als (apache-spark) [default], iteration 29 completed (62066.444 ms) ====== [2024-08-28T22:29:28.057Z] ----------------------------------- [2024-08-28T22:29:28.057Z] renaissance-als_0_PASSED [2024-08-28T22:29:28.057Z] ----------------------------------- [2024-08-28T22:29:28.057Z] [2024-08-28T22:29:28.057Z] TEST TEARDOWN: [2024-08-28T22:29:28.057Z] Nothing to be done for teardown. [2024-08-28T22:29:28.057Z] renaissance-als_0 Finish Time: Wed Aug 28 22:29:22 2024 Epoch Time (ms): 1724884162367