[2024-09-25T20:45:48.473Z] Running test renaissance-als_0 ... [2024-09-25T20:45:48.473Z] =============================================== [2024-09-25T20:45:48.473Z] renaissance-als_0 Start Time: Wed Sep 25 20:45:47 2024 Epoch Time (ms): 1727297147522 [2024-09-25T20:45:48.473Z] variation: NoOptions [2024-09-25T20:45:48.473Z] JVM_OPTIONS: [2024-09-25T20:45:48.473Z] { \ [2024-09-25T20:45:48.473Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T20:45:48.473Z] echo "Nothing to be done for setup."; \ [2024-09-25T20:45:48.473Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17272970993569/renaissance-als_0"; \ [2024-09-25T20:45:48.473Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17272970993569/renaissance-als_0"; \ [2024-09-25T20:45:48.473Z] echo ""; echo "TESTING:"; \ [2024-09-25T20:45:48.473Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17272970993569/renaissance-als_0"/als.json" als; \ [2024-09-25T20:45:48.473Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17272970993569/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T20:45:48.473Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T20:45:48.473Z] echo "Nothing to be done for teardown."; \ [2024-09-25T20:45:48.473Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17272970993569/TestTargetResult"; [2024-09-25T20:45:48.473Z] [2024-09-25T20:45:48.473Z] TEST SETUP: [2024-09-25T20:45:48.473Z] Nothing to be done for setup. [2024-09-25T20:45:48.473Z] [2024-09-25T20:45:48.473Z] TESTING: [2024-09-25T20:45:51.422Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-25T20:45:53.330Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-25T20:45:56.275Z] WARNING: An illegal reflective access operation has occurred [2024-09-25T20:45:56.275Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17272970993569/renaissance-als_0/harness-204548-17247085688405616293/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-09-25T20:45:56.275Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-09-25T20:45:56.275Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-09-25T20:45:56.275Z] WARNING: All illegal access operations will be denied in a future release [2024-09-25T20:45:59.222Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-09-25T20:45:59.222Z] GC before operation: completed in 69.940 ms, heap usage 85.976 MB -> 33.799 MB. [2024-09-25T20:46:17.252Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:46:17.252Z] There is no way to check that no silent failure occurred. [2024-09-25T20:46:17.252Z] ====== als (apache-spark) [default], iteration 0 completed (17455.246 ms) ====== [2024-09-25T20:46:17.252Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-09-25T20:46:17.252Z] GC before operation: completed in 112.976 ms, heap usage 403.990 MB -> 56.197 MB. [2024-09-25T20:46:26.845Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:46:26.845Z] There is no way to check that no silent failure occurred. [2024-09-25T20:46:26.845Z] ====== als (apache-spark) [default], iteration 1 completed (10330.716 ms) ====== [2024-09-25T20:46:26.845Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-09-25T20:46:26.845Z] GC before operation: completed in 110.460 ms, heap usage 362.685 MB -> 58.704 MB. [2024-09-25T20:46:34.838Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:46:34.838Z] There is no way to check that no silent failure occurred. [2024-09-25T20:46:34.838Z] ====== als (apache-spark) [default], iteration 2 completed (7977.093 ms) ====== [2024-09-25T20:46:34.838Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-09-25T20:46:34.838Z] GC before operation: completed in 114.290 ms, heap usage 250.554 MB -> 58.986 MB. [2024-09-25T20:46:42.850Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:46:42.851Z] There is no way to check that no silent failure occurred. [2024-09-25T20:46:42.851Z] ====== als (apache-spark) [default], iteration 3 completed (8021.353 ms) ====== [2024-09-25T20:46:42.851Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-09-25T20:46:42.851Z] GC before operation: completed in 107.133 ms, heap usage 263.946 MB -> 59.338 MB. [2024-09-25T20:46:50.909Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:46:50.909Z] There is no way to check that no silent failure occurred. [2024-09-25T20:46:50.909Z] ====== als (apache-spark) [default], iteration 4 completed (7787.239 ms) ====== [2024-09-25T20:46:50.909Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-09-25T20:46:50.909Z] GC before operation: completed in 106.438 ms, heap usage 509.533 MB -> 59.999 MB. [2024-09-25T20:46:58.908Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:46:58.908Z] There is no way to check that no silent failure occurred. [2024-09-25T20:46:58.908Z] ====== als (apache-spark) [default], iteration 5 completed (7622.904 ms) ====== [2024-09-25T20:46:58.908Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-09-25T20:46:58.908Z] GC before operation: completed in 123.239 ms, heap usage 287.735 MB -> 60.243 MB. [2024-09-25T20:47:06.909Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:47:06.909Z] There is no way to check that no silent failure occurred. [2024-09-25T20:47:06.909Z] ====== als (apache-spark) [default], iteration 6 completed (7631.893 ms) ====== [2024-09-25T20:47:06.909Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-09-25T20:47:06.909Z] GC before operation: completed in 110.391 ms, heap usage 571.729 MB -> 60.850 MB. [2024-09-25T20:47:15.010Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:47:15.010Z] There is no way to check that no silent failure occurred. [2024-09-25T20:47:15.010Z] ====== als (apache-spark) [default], iteration 7 completed (7665.248 ms) ====== [2024-09-25T20:47:15.010Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-09-25T20:47:15.010Z] GC before operation: completed in 106.428 ms, heap usage 211.964 MB -> 60.562 MB. [2024-09-25T20:47:21.605Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:47:21.605Z] There is no way to check that no silent failure occurred. [2024-09-25T20:47:21.605Z] ====== als (apache-spark) [default], iteration 8 completed (7505.939 ms) ====== [2024-09-25T20:47:21.605Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-09-25T20:47:21.605Z] GC before operation: completed in 118.140 ms, heap usage 459.429 MB -> 61.459 MB. [2024-09-25T20:47:29.590Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:47:29.590Z] There is no way to check that no silent failure occurred. [2024-09-25T20:47:29.590Z] ====== als (apache-spark) [default], iteration 9 completed (7824.086 ms) ====== [2024-09-25T20:47:29.590Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-09-25T20:47:29.590Z] GC before operation: completed in 113.895 ms, heap usage 184.359 MB -> 61.348 MB. [2024-09-25T20:47:37.580Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:47:37.580Z] There is no way to check that no silent failure occurred. [2024-09-25T20:47:37.580Z] ====== als (apache-spark) [default], iteration 10 completed (7619.197 ms) ====== [2024-09-25T20:47:37.580Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-09-25T20:47:37.580Z] GC before operation: completed in 121.568 ms, heap usage 370.776 MB -> 61.925 MB. [2024-09-25T20:47:45.593Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:47:45.593Z] There is no way to check that no silent failure occurred. [2024-09-25T20:47:45.593Z] ====== als (apache-spark) [default], iteration 11 completed (7500.684 ms) ====== [2024-09-25T20:47:45.593Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-09-25T20:47:45.593Z] GC before operation: completed in 122.492 ms, heap usage 314.872 MB -> 62.269 MB. [2024-09-25T20:47:53.571Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:47:53.571Z] There is no way to check that no silent failure occurred. [2024-09-25T20:47:53.571Z] ====== als (apache-spark) [default], iteration 12 completed (7471.117 ms) ====== [2024-09-25T20:47:53.571Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-09-25T20:47:53.571Z] GC before operation: completed in 125.189 ms, heap usage 397.911 MB -> 62.715 MB. [2024-09-25T20:48:03.745Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:03.745Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:03.745Z] ====== als (apache-spark) [default], iteration 13 completed (7372.935 ms) ====== [2024-09-25T20:48:03.745Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-09-25T20:48:03.745Z] GC before operation: completed in 119.727 ms, heap usage 372.318 MB -> 63.026 MB. [2024-09-25T20:48:07.857Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:07.857Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:07.857Z] ====== als (apache-spark) [default], iteration 14 completed (7341.488 ms) ====== [2024-09-25T20:48:07.857Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-09-25T20:48:07.857Z] GC before operation: completed in 118.443 ms, heap usage 393.845 MB -> 63.223 MB. [2024-09-25T20:48:15.832Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:15.832Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:15.832Z] ====== als (apache-spark) [default], iteration 15 completed (7344.548 ms) ====== [2024-09-25T20:48:15.832Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-09-25T20:48:15.832Z] GC before operation: completed in 109.998 ms, heap usage 302.856 MB -> 63.486 MB. [2024-09-25T20:48:22.394Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:22.394Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:22.394Z] ====== als (apache-spark) [default], iteration 16 completed (7225.469 ms) ====== [2024-09-25T20:48:22.394Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-09-25T20:48:22.394Z] GC before operation: completed in 124.006 ms, heap usage 341.058 MB -> 64.061 MB. [2024-09-25T20:48:30.366Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:30.366Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:30.366Z] ====== als (apache-spark) [default], iteration 17 completed (7362.484 ms) ====== [2024-09-25T20:48:30.366Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-09-25T20:48:30.366Z] GC before operation: completed in 117.673 ms, heap usage 200.194 MB -> 64.057 MB. [2024-09-25T20:48:38.361Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:38.361Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:38.361Z] ====== als (apache-spark) [default], iteration 18 completed (7428.350 ms) ====== [2024-09-25T20:48:38.361Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-09-25T20:48:38.361Z] GC before operation: completed in 117.508 ms, heap usage 267.470 MB -> 64.341 MB. [2024-09-25T20:48:44.909Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:44.909Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:44.909Z] ====== als (apache-spark) [default], iteration 19 completed (7334.299 ms) ====== [2024-09-25T20:48:44.909Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-09-25T20:48:44.909Z] GC before operation: completed in 116.525 ms, heap usage 223.843 MB -> 64.436 MB. [2024-09-25T20:48:52.916Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:48:52.916Z] There is no way to check that no silent failure occurred. [2024-09-25T20:48:52.916Z] ====== als (apache-spark) [default], iteration 20 completed (7302.547 ms) ====== [2024-09-25T20:48:52.916Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-09-25T20:48:52.916Z] GC before operation: completed in 121.131 ms, heap usage 357.657 MB -> 64.808 MB. [2024-09-25T20:49:00.899Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:00.899Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:00.899Z] ====== als (apache-spark) [default], iteration 21 completed (7545.149 ms) ====== [2024-09-25T20:49:00.899Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-09-25T20:49:00.899Z] GC before operation: completed in 112.214 ms, heap usage 223.885 MB -> 64.851 MB. [2024-09-25T20:49:07.471Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:07.471Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:07.471Z] ====== als (apache-spark) [default], iteration 22 completed (7593.646 ms) ====== [2024-09-25T20:49:07.471Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-09-25T20:49:07.471Z] GC before operation: completed in 113.982 ms, heap usage 378.947 MB -> 65.208 MB. [2024-09-25T20:49:15.466Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:15.466Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:15.466Z] ====== als (apache-spark) [default], iteration 23 completed (7462.075 ms) ====== [2024-09-25T20:49:15.466Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-09-25T20:49:15.466Z] GC before operation: completed in 117.178 ms, heap usage 316.834 MB -> 65.540 MB. [2024-09-25T20:49:23.760Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:23.760Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:23.760Z] ====== als (apache-spark) [default], iteration 24 completed (7613.522 ms) ====== [2024-09-25T20:49:23.760Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-09-25T20:49:23.760Z] GC before operation: completed in 111.826 ms, heap usage 300.959 MB -> 65.558 MB. [2024-09-25T20:49:30.332Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:30.332Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:30.332Z] ====== als (apache-spark) [default], iteration 25 completed (7304.424 ms) ====== [2024-09-25T20:49:30.332Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-09-25T20:49:30.332Z] GC before operation: completed in 117.304 ms, heap usage 532.946 MB -> 66.016 MB. [2024-09-25T20:49:38.357Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:38.357Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:38.357Z] ====== als (apache-spark) [default], iteration 26 completed (7372.082 ms) ====== [2024-09-25T20:49:38.357Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-09-25T20:49:38.357Z] GC before operation: completed in 111.183 ms, heap usage 413.523 MB -> 66.143 MB. [2024-09-25T20:49:44.934Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:44.934Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:44.934Z] ====== als (apache-spark) [default], iteration 27 completed (7246.021 ms) ====== [2024-09-25T20:49:44.934Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-09-25T20:49:45.864Z] GC before operation: completed in 109.543 ms, heap usage 450.981 MB -> 66.315 MB. [2024-09-25T20:49:52.444Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:49:52.444Z] There is no way to check that no silent failure occurred. [2024-09-25T20:49:52.444Z] ====== als (apache-spark) [default], iteration 28 completed (7357.531 ms) ====== [2024-09-25T20:49:52.444Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-09-25T20:49:52.444Z] GC before operation: completed in 128.195 ms, heap usage 173.957 MB -> 66.172 MB. [2024-09-25T20:50:00.533Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T20:50:00.533Z] There is no way to check that no silent failure occurred. [2024-09-25T20:50:00.533Z] ====== als (apache-spark) [default], iteration 29 completed (7269.008 ms) ====== [2024-09-25T20:50:00.533Z] ----------------------------------- [2024-09-25T20:50:00.533Z] renaissance-als_0_PASSED [2024-09-25T20:50:00.533Z] ----------------------------------- [2024-09-25T20:50:00.533Z] [2024-09-25T20:50:00.533Z] TEST TEARDOWN: [2024-09-25T20:50:00.533Z] Nothing to be done for teardown. [2024-09-25T20:50:00.533Z] renaissance-als_0 Finish Time: Wed Sep 25 20:50:00 2024 Epoch Time (ms): 1727297400086