[2024-08-29T04:34:00.599Z] Running test renaissance-als_0 ... [2024-08-29T04:34:00.599Z] =============================================== [2024-08-29T04:34:00.599Z] renaissance-als_0 Start Time: Thu Aug 29 04:34:00 2024 Epoch Time (ms): 1724906040499 [2024-08-29T04:34:00.599Z] variation: NoOptions [2024-08-29T04:34:00.599Z] JVM_OPTIONS: [2024-08-29T04:34:00.599Z] { \ [2024-08-29T04:34:00.599Z] echo ""; echo "TEST SETUP:"; \ [2024-08-29T04:34:00.599Z] echo "Nothing to be done for setup."; \ [2024-08-29T04:34:00.599Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17249060406468/renaissance-als_0"; \ [2024-08-29T04:34:00.599Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17249060406468/renaissance-als_0"; \ [2024-08-29T04:34:00.599Z] echo ""; echo "TESTING:"; \ [2024-08-29T04:34:00.599Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-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_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17249060406468/renaissance-als_0"/als.json" als; \ [2024-08-29T04:34:00.599Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17249060406468/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-29T04:34:00.599Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-29T04:34:00.599Z] echo "Nothing to be done for teardown."; \ [2024-08-29T04:34:00.599Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17249060406468/TestTargetResult"; [2024-08-29T04:34:00.599Z] [2024-08-29T04:34:00.599Z] TEST SETUP: [2024-08-29T04:34:00.599Z] Nothing to be done for setup. [2024-08-29T04:34:00.599Z] [2024-08-29T04:34:00.599Z] TESTING: [2024-08-29T04:34:04.076Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-29T04:34:05.697Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-29T04:34:10.251Z] WARNING: An illegal reflective access operation has occurred [2024-08-29T04:34:10.251Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17249060406468/renaissance-als_0/harness-043401-18365112568473712271/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-29T04:34:10.251Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-29T04:34:10.251Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-29T04:34:10.251Z] WARNING: All illegal access operations will be denied in a future release [2024-08-29T04:34:12.772Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-29T04:34:13.564Z] GC before operation: completed in 117.265 ms, heap usage 88.499 MB -> 33.799 MB. [2024-08-29T04:34:39.571Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:34:39.571Z] There is no way to check that no silent failure occurred. [2024-08-29T04:34:39.571Z] ====== als (apache-spark) [default], iteration 0 completed (26348.531 ms) ====== [2024-08-29T04:34:39.571Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-29T04:34:39.571Z] GC before operation: completed in 217.098 ms, heap usage 156.265 MB -> 55.906 MB. [2024-08-29T04:34:58.827Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:34:58.827Z] There is no way to check that no silent failure occurred. [2024-08-29T04:34:58.827Z] ====== als (apache-spark) [default], iteration 1 completed (18138.768 ms) ====== [2024-08-29T04:34:58.827Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-29T04:34:58.827Z] GC before operation: completed in 231.669 ms, heap usage 330.815 MB -> 58.673 MB. [2024-08-29T04:35:15.201Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:35:15.201Z] There is no way to check that no silent failure occurred. [2024-08-29T04:35:15.201Z] ====== als (apache-spark) [default], iteration 2 completed (16338.647 ms) ====== [2024-08-29T04:35:15.201Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-29T04:35:15.201Z] GC before operation: completed in 198.011 ms, heap usage 218.001 MB -> 58.760 MB. [2024-08-29T04:35:34.324Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:35:34.324Z] There is no way to check that no silent failure occurred. [2024-08-29T04:35:34.324Z] ====== als (apache-spark) [default], iteration 3 completed (19412.994 ms) ====== [2024-08-29T04:35:34.324Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-29T04:35:34.324Z] GC before operation: completed in 243.769 ms, heap usage 423.262 MB -> 59.403 MB. [2024-08-29T04:35:50.744Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:35:50.744Z] There is no way to check that no silent failure occurred. [2024-08-29T04:35:50.744Z] ====== als (apache-spark) [default], iteration 4 completed (15670.156 ms) ====== [2024-08-29T04:35:50.744Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-29T04:35:50.744Z] GC before operation: completed in 186.469 ms, heap usage 252.710 MB -> 59.456 MB. [2024-08-29T04:36:04.772Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:36:04.772Z] There is no way to check that no silent failure occurred. [2024-08-29T04:36:04.772Z] ====== als (apache-spark) [default], iteration 5 completed (13433.875 ms) ====== [2024-08-29T04:36:04.772Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-29T04:36:04.772Z] GC before operation: completed in 258.634 ms, heap usage 258.765 MB -> 60.001 MB. [2024-08-29T04:36:21.155Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:36:21.155Z] There is no way to check that no silent failure occurred. [2024-08-29T04:36:21.155Z] ====== als (apache-spark) [default], iteration 6 completed (16147.990 ms) ====== [2024-08-29T04:36:21.155Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-29T04:36:21.155Z] GC before operation: completed in 247.632 ms, heap usage 558.185 MB -> 60.707 MB. [2024-08-29T04:36:38.306Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:36:38.306Z] There is no way to check that no silent failure occurred. [2024-08-29T04:36:38.306Z] ====== als (apache-spark) [default], iteration 7 completed (16482.187 ms) ====== [2024-08-29T04:36:38.306Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-29T04:36:38.306Z] GC before operation: completed in 238.099 ms, heap usage 298.577 MB -> 60.689 MB. [2024-08-29T04:36:54.672Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:36:54.672Z] There is no way to check that no silent failure occurred. [2024-08-29T04:36:54.672Z] ====== als (apache-spark) [default], iteration 8 completed (18011.599 ms) ====== [2024-08-29T04:36:54.672Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-29T04:36:55.468Z] GC before operation: completed in 311.730 ms, heap usage 510.813 MB -> 61.334 MB. [2024-08-29T04:37:14.664Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:37:14.664Z] There is no way to check that no silent failure occurred. [2024-08-29T04:37:14.664Z] ====== als (apache-spark) [default], iteration 9 completed (18473.385 ms) ====== [2024-08-29T04:37:14.664Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-29T04:37:14.664Z] GC before operation: completed in 221.574 ms, heap usage 265.612 MB -> 61.258 MB. [2024-08-29T04:37:28.874Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:37:28.874Z] There is no way to check that no silent failure occurred. [2024-08-29T04:37:28.874Z] ====== als (apache-spark) [default], iteration 10 completed (15030.074 ms) ====== [2024-08-29T04:37:28.874Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-29T04:37:28.874Z] GC before operation: completed in 106.076 ms, heap usage 597.985 MB -> 62.078 MB. [2024-08-29T04:37:45.533Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:37:45.533Z] There is no way to check that no silent failure occurred. [2024-08-29T04:37:45.533Z] ====== als (apache-spark) [default], iteration 11 completed (14739.668 ms) ====== [2024-08-29T04:37:45.533Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-29T04:37:45.533Z] GC before operation: completed in 166.628 ms, heap usage 395.439 MB -> 62.185 MB. [2024-08-29T04:37:56.382Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:37:56.382Z] There is no way to check that no silent failure occurred. [2024-08-29T04:37:56.382Z] ====== als (apache-spark) [default], iteration 12 completed (11192.610 ms) ====== [2024-08-29T04:37:56.382Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-29T04:37:56.382Z] GC before operation: completed in 243.490 ms, heap usage 333.794 MB -> 62.510 MB. [2024-08-29T04:38:10.666Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:38:10.666Z] There is no way to check that no silent failure occurred. [2024-08-29T04:38:10.666Z] ====== als (apache-spark) [default], iteration 13 completed (13990.972 ms) ====== [2024-08-29T04:38:10.666Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-29T04:38:10.666Z] GC before operation: completed in 183.878 ms, heap usage 332.623 MB -> 62.873 MB. [2024-08-29T04:38:20.928Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:38:20.928Z] There is no way to check that no silent failure occurred. [2024-08-29T04:38:20.928Z] ====== als (apache-spark) [default], iteration 14 completed (10053.186 ms) ====== [2024-08-29T04:38:20.928Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-29T04:38:20.928Z] GC before operation: completed in 114.287 ms, heap usage 472.867 MB -> 63.315 MB. [2024-08-29T04:38:31.202Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:38:31.202Z] There is no way to check that no silent failure occurred. [2024-08-29T04:38:31.202Z] ====== als (apache-spark) [default], iteration 15 completed (11687.725 ms) ====== [2024-08-29T04:38:31.202Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-29T04:38:32.021Z] GC before operation: completed in 145.749 ms, heap usage 295.705 MB -> 63.480 MB. [2024-08-29T04:38:48.709Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:38:48.709Z] There is no way to check that no silent failure occurred. [2024-08-29T04:38:48.709Z] ====== als (apache-spark) [default], iteration 16 completed (17249.273 ms) ====== [2024-08-29T04:38:48.709Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-29T04:38:49.532Z] GC before operation: completed in 203.148 ms, heap usage 483.662 MB -> 64.009 MB. [2024-08-29T04:39:03.970Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:39:03.970Z] There is no way to check that no silent failure occurred. [2024-08-29T04:39:03.970Z] ====== als (apache-spark) [default], iteration 17 completed (14679.931 ms) ====== [2024-08-29T04:39:03.970Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-29T04:39:03.970Z] GC before operation: completed in 104.291 ms, heap usage 199.279 MB -> 63.958 MB. [2024-08-29T04:39:16.136Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:39:16.136Z] There is no way to check that no silent failure occurred. [2024-08-29T04:39:16.136Z] ====== als (apache-spark) [default], iteration 18 completed (11176.375 ms) ====== [2024-08-29T04:39:16.136Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-29T04:39:16.136Z] GC before operation: completed in 202.059 ms, heap usage 374.913 MB -> 64.486 MB. [2024-08-29T04:39:28.633Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:39:28.633Z] There is no way to check that no silent failure occurred. [2024-08-29T04:39:28.633Z] ====== als (apache-spark) [default], iteration 19 completed (13278.916 ms) ====== [2024-08-29T04:39:28.633Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-29T04:39:28.633Z] GC before operation: completed in 197.736 ms, heap usage 449.674 MB -> 64.772 MB. [2024-08-29T04:39:40.760Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:39:40.760Z] There is no way to check that no silent failure occurred. [2024-08-29T04:39:40.760Z] ====== als (apache-spark) [default], iteration 20 completed (11238.147 ms) ====== [2024-08-29T04:39:40.760Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-29T04:39:40.760Z] GC before operation: completed in 225.775 ms, heap usage 362.190 MB -> 64.745 MB. [2024-08-29T04:39:52.946Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:39:52.946Z] There is no way to check that no silent failure occurred. [2024-08-29T04:39:52.946Z] ====== als (apache-spark) [default], iteration 21 completed (12228.738 ms) ====== [2024-08-29T04:39:52.946Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-29T04:39:52.946Z] GC before operation: completed in 127.431 ms, heap usage 212.082 MB -> 64.806 MB. [2024-08-29T04:40:05.156Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:40:05.156Z] There is no way to check that no silent failure occurred. [2024-08-29T04:40:05.156Z] ====== als (apache-spark) [default], iteration 22 completed (11782.503 ms) ====== [2024-08-29T04:40:05.156Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-29T04:40:05.156Z] GC before operation: completed in 137.150 ms, heap usage 218.892 MB -> 64.957 MB. [2024-08-29T04:40:17.270Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:40:17.270Z] There is no way to check that no silent failure occurred. [2024-08-29T04:40:17.270Z] ====== als (apache-spark) [default], iteration 23 completed (11624.693 ms) ====== [2024-08-29T04:40:17.270Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-29T04:40:17.270Z] GC before operation: completed in 225.922 ms, heap usage 443.677 MB -> 65.594 MB. [2024-08-29T04:40:27.607Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:40:27.607Z] There is no way to check that no silent failure occurred. [2024-08-29T04:40:27.607Z] ====== als (apache-spark) [default], iteration 24 completed (11540.688 ms) ====== [2024-08-29T04:40:27.607Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-29T04:40:28.420Z] GC before operation: completed in 218.565 ms, heap usage 541.454 MB -> 65.887 MB. [2024-08-29T04:40:39.278Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:40:39.278Z] There is no way to check that no silent failure occurred. [2024-08-29T04:40:39.278Z] ====== als (apache-spark) [default], iteration 25 completed (11147.678 ms) ====== [2024-08-29T04:40:39.278Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-29T04:40:39.278Z] GC before operation: completed in 191.939 ms, heap usage 261.263 MB -> 65.410 MB. [2024-08-29T04:40:53.511Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:40:53.511Z] There is no way to check that no silent failure occurred. [2024-08-29T04:40:53.511Z] ====== als (apache-spark) [default], iteration 26 completed (12899.440 ms) ====== [2024-08-29T04:40:53.511Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-29T04:40:53.511Z] GC before operation: completed in 198.973 ms, heap usage 279.177 MB -> 65.928 MB. [2024-08-29T04:41:07.774Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:41:07.774Z] There is no way to check that no silent failure occurred. [2024-08-29T04:41:07.774Z] ====== als (apache-spark) [default], iteration 27 completed (13459.841 ms) ====== [2024-08-29T04:41:07.774Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-29T04:41:07.774Z] GC before operation: completed in 300.045 ms, heap usage 332.783 MB -> 66.012 MB. [2024-08-29T04:41:22.128Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:41:22.128Z] There is no way to check that no silent failure occurred. [2024-08-29T04:41:22.128Z] ====== als (apache-spark) [default], iteration 28 completed (15380.176 ms) ====== [2024-08-29T04:41:22.128Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-29T04:41:22.128Z] GC before operation: completed in 202.309 ms, heap usage 426.045 MB -> 66.507 MB. [2024-08-29T04:41:38.960Z] WARNING: This benchmark provides no result that can be validated. [2024-08-29T04:41:38.960Z] There is no way to check that no silent failure occurred. [2024-08-29T04:41:38.960Z] ====== als (apache-spark) [default], iteration 29 completed (16607.573 ms) ====== [2024-08-29T04:41:38.960Z] ----------------------------------- [2024-08-29T04:41:38.960Z] renaissance-als_0_PASSED [2024-08-29T04:41:38.960Z] ----------------------------------- [2024-08-29T04:41:38.960Z] [2024-08-29T04:41:38.960Z] TEST TEARDOWN: [2024-08-29T04:41:38.960Z] Nothing to be done for teardown. [2024-08-29T04:41:38.960Z] renaissance-als_0 Finish Time: Thu Aug 29 04:41:38 2024 Epoch Time (ms): 1724906498596