[2025-03-06T00:30:54.515Z] Running test renaissance-als_0 ... [2025-03-06T00:30:54.831Z] =============================================== [2025-03-06T00:30:54.832Z] renaissance-als_0 Start Time: Thu Mar 6 00:30:54 2025 Epoch Time (ms): 1741221054640 [2025-03-06T00:30:55.161Z] variation: NoOptions [2025-03-06T00:30:55.161Z] JVM_OPTIONS: [2025-03-06T00:30:55.161Z] { \ [2025-03-06T00:30:55.161Z] echo ""; echo "TEST SETUP:"; \ [2025-03-06T00:30:55.161Z] echo "Nothing to be done for setup."; \ [2025-03-06T00:30:55.161Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17412209919842\\renaissance-als_0"; \ [2025-03-06T00:30:55.161Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17412209919842\\renaissance-als_0"; \ [2025-03-06T00:30:55.161Z] echo ""; echo "TESTING:"; \ [2025-03-06T00:30:55.161Z] "c:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17412209919842\\renaissance-als_0"\\als.json" als; \ [2025-03-06T00:30:55.161Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17412209919842\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-06T00:30:55.161Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-06T00:30:55.161Z] echo "Nothing to be done for teardown."; \ [2025-03-06T00:30:55.161Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17412209919842\\TestTargetResult"; [2025-03-06T00:30:55.161Z] [2025-03-06T00:30:55.161Z] TEST SETUP: [2025-03-06T00:30:55.161Z] Nothing to be done for setup. [2025-03-06T00:30:55.161Z] [2025-03-06T00:30:55.161Z] TESTING: [2025-03-06T00:31:10.945Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-06T00:31:10.945Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-03-06T00:31:13.157Z] WARNING: An illegal reflective access operation has occurred [2025-03-06T00:31:13.157Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17412209919842/renaissance-als_0/harness-003055-18315127377437675910/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-03-06T00:31:13.157Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-03-06T00:31:13.157Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-03-06T00:31:13.157Z] WARNING: All illegal access operations will be denied in a future release [2025-03-06T00:31:15.386Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-03-06T00:31:15.386Z] GC before operation: completed in 102.597 ms, heap usage 100.500 MB -> 34.294 MB. [2025-03-06T00:31:43.439Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:31:43.439Z] There is no way to check that no silent failure occurred. [2025-03-06T00:31:43.439Z] ====== als (apache-spark) [default], iteration 0 completed (27718.794 ms) ====== [2025-03-06T00:31:43.439Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-03-06T00:31:43.439Z] GC before operation: completed in 146.628 ms, heap usage 294.712 MB -> 56.598 MB. [2025-03-06T00:31:59.415Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:31:59.415Z] There is no way to check that no silent failure occurred. [2025-03-06T00:31:59.415Z] ====== als (apache-spark) [default], iteration 1 completed (16033.352 ms) ====== [2025-03-06T00:31:59.415Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-03-06T00:31:59.415Z] GC before operation: completed in 147.191 ms, heap usage 530.996 MB -> 59.503 MB. [2025-03-06T00:32:15.348Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:32:15.348Z] There is no way to check that no silent failure occurred. [2025-03-06T00:32:15.348Z] ====== als (apache-spark) [default], iteration 2 completed (15431.863 ms) ====== [2025-03-06T00:32:15.348Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-03-06T00:32:15.348Z] GC before operation: completed in 148.025 ms, heap usage 165.427 MB -> 59.321 MB. [2025-03-06T00:32:31.385Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:32:31.385Z] There is no way to check that no silent failure occurred. [2025-03-06T00:32:31.385Z] ====== als (apache-spark) [default], iteration 3 completed (15064.131 ms) ====== [2025-03-06T00:32:31.385Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-03-06T00:32:31.385Z] GC before operation: completed in 136.876 ms, heap usage 174.625 MB -> 59.657 MB. [2025-03-06T00:32:47.340Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:32:47.340Z] There is no way to check that no silent failure occurred. [2025-03-06T00:32:47.340Z] ====== als (apache-spark) [default], iteration 4 completed (15359.328 ms) ====== [2025-03-06T00:32:47.340Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-03-06T00:32:47.340Z] GC before operation: completed in 131.362 ms, heap usage 498.018 MB -> 60.483 MB. [2025-03-06T00:33:00.404Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:33:00.404Z] There is no way to check that no silent failure occurred. [2025-03-06T00:33:00.404Z] ====== als (apache-spark) [default], iteration 5 completed (14678.197 ms) ====== [2025-03-06T00:33:00.404Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-03-06T00:33:00.404Z] GC before operation: completed in 128.160 ms, heap usage 313.497 MB -> 60.627 MB. [2025-03-06T00:33:16.272Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:33:16.272Z] There is no way to check that no silent failure occurred. [2025-03-06T00:33:16.272Z] ====== als (apache-spark) [default], iteration 6 completed (14946.476 ms) ====== [2025-03-06T00:33:16.272Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-03-06T00:33:16.272Z] GC before operation: completed in 156.888 ms, heap usage 411.607 MB -> 61.182 MB. [2025-03-06T00:33:32.287Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:33:32.287Z] There is no way to check that no silent failure occurred. [2025-03-06T00:33:32.287Z] ====== als (apache-spark) [default], iteration 7 completed (15253.275 ms) ====== [2025-03-06T00:33:32.287Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-03-06T00:33:32.287Z] GC before operation: completed in 134.251 ms, heap usage 433.144 MB -> 61.453 MB. [2025-03-06T00:33:48.374Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:33:48.374Z] There is no way to check that no silent failure occurred. [2025-03-06T00:33:48.374Z] ====== als (apache-spark) [default], iteration 8 completed (15037.003 ms) ====== [2025-03-06T00:33:48.374Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-03-06T00:33:48.374Z] GC before operation: completed in 158.503 ms, heap usage 426.461 MB -> 61.798 MB. [2025-03-06T00:34:02.055Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:34:02.055Z] There is no way to check that no silent failure occurred. [2025-03-06T00:34:02.055Z] ====== als (apache-spark) [default], iteration 9 completed (14857.207 ms) ====== [2025-03-06T00:34:02.055Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-03-06T00:34:02.055Z] GC before operation: completed in 160.721 ms, heap usage 259.435 MB -> 61.935 MB. [2025-03-06T00:34:17.792Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:34:17.792Z] There is no way to check that no silent failure occurred. [2025-03-06T00:34:17.792Z] ====== als (apache-spark) [default], iteration 10 completed (14872.777 ms) ====== [2025-03-06T00:34:17.792Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-03-06T00:34:17.792Z] GC before operation: completed in 137.703 ms, heap usage 396.823 MB -> 62.466 MB. [2025-03-06T00:34:31.070Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:34:31.070Z] There is no way to check that no silent failure occurred. [2025-03-06T00:34:31.070Z] ====== als (apache-spark) [default], iteration 11 completed (14583.344 ms) ====== [2025-03-06T00:34:31.070Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-03-06T00:34:31.070Z] GC before operation: completed in 173.684 ms, heap usage 365.042 MB -> 62.699 MB. [2025-03-06T00:34:46.932Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:34:46.932Z] There is no way to check that no silent failure occurred. [2025-03-06T00:34:46.932Z] ====== als (apache-spark) [default], iteration 12 completed (14706.855 ms) ====== [2025-03-06T00:34:46.932Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-03-06T00:34:46.932Z] GC before operation: completed in 166.782 ms, heap usage 433.276 MB -> 63.149 MB. [2025-03-06T00:35:02.762Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:35:02.762Z] There is no way to check that no silent failure occurred. [2025-03-06T00:35:02.762Z] ====== als (apache-spark) [default], iteration 13 completed (14714.509 ms) ====== [2025-03-06T00:35:02.762Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-03-06T00:35:02.762Z] GC before operation: completed in 134.353 ms, heap usage 292.537 MB -> 63.285 MB. [2025-03-06T00:35:15.817Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:35:15.817Z] There is no way to check that no silent failure occurred. [2025-03-06T00:35:15.817Z] ====== als (apache-spark) [default], iteration 14 completed (14746.147 ms) ====== [2025-03-06T00:35:15.817Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-03-06T00:35:15.817Z] GC before operation: completed in 162.898 ms, heap usage 449.999 MB -> 63.930 MB. [2025-03-06T00:35:31.648Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:35:31.648Z] There is no way to check that no silent failure occurred. [2025-03-06T00:35:31.648Z] ====== als (apache-spark) [default], iteration 15 completed (14850.364 ms) ====== [2025-03-06T00:35:31.648Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-03-06T00:35:31.648Z] GC before operation: completed in 142.786 ms, heap usage 375.774 MB -> 64.094 MB. [2025-03-06T00:35:47.568Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:35:47.568Z] There is no way to check that no silent failure occurred. [2025-03-06T00:35:47.568Z] ====== als (apache-spark) [default], iteration 16 completed (14819.174 ms) ====== [2025-03-06T00:35:47.568Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-03-06T00:35:47.568Z] GC before operation: completed in 147.185 ms, heap usage 362.823 MB -> 64.503 MB. [2025-03-06T00:36:00.609Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:36:00.609Z] There is no way to check that no silent failure occurred. [2025-03-06T00:36:00.609Z] ====== als (apache-spark) [default], iteration 17 completed (14580.345 ms) ====== [2025-03-06T00:36:00.609Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-03-06T00:36:00.609Z] GC before operation: completed in 150.722 ms, heap usage 530.007 MB -> 65.046 MB. [2025-03-06T00:36:16.474Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:36:16.474Z] There is no way to check that no silent failure occurred. [2025-03-06T00:36:16.474Z] ====== als (apache-spark) [default], iteration 18 completed (14742.421 ms) ====== [2025-03-06T00:36:16.474Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-03-06T00:36:16.474Z] GC before operation: completed in 141.819 ms, heap usage 408.470 MB -> 65.030 MB. [2025-03-06T00:36:32.203Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:36:32.203Z] There is no way to check that no silent failure occurred. [2025-03-06T00:36:32.203Z] ====== als (apache-spark) [default], iteration 19 completed (14618.082 ms) ====== [2025-03-06T00:36:32.203Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-03-06T00:36:32.203Z] GC before operation: completed in 143.483 ms, heap usage 410.156 MB -> 65.353 MB. [2025-03-06T00:36:45.275Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:36:45.276Z] There is no way to check that no silent failure occurred. [2025-03-06T00:36:45.276Z] ====== als (apache-spark) [default], iteration 20 completed (14619.720 ms) ====== [2025-03-06T00:36:45.276Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-03-06T00:36:45.276Z] GC before operation: completed in 175.993 ms, heap usage 158.271 MB -> 64.972 MB. [2025-03-06T00:37:01.182Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:37:01.182Z] There is no way to check that no silent failure occurred. [2025-03-06T00:37:01.182Z] ====== als (apache-spark) [default], iteration 21 completed (15249.310 ms) ====== [2025-03-06T00:37:01.182Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-03-06T00:37:01.182Z] GC before operation: completed in 144.673 ms, heap usage 489.568 MB -> 65.858 MB. [2025-03-06T00:37:17.028Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:37:17.028Z] There is no way to check that no silent failure occurred. [2025-03-06T00:37:17.028Z] ====== als (apache-spark) [default], iteration 22 completed (14821.300 ms) ====== [2025-03-06T00:37:17.028Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-03-06T00:37:17.028Z] GC before operation: completed in 135.539 ms, heap usage 415.315 MB -> 65.773 MB. [2025-03-06T00:37:30.164Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:37:30.164Z] There is no way to check that no silent failure occurred. [2025-03-06T00:37:30.164Z] ====== als (apache-spark) [default], iteration 23 completed (14850.883 ms) ====== [2025-03-06T00:37:30.164Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-03-06T00:37:30.164Z] GC before operation: completed in 145.639 ms, heap usage 381.855 MB -> 66.071 MB. [2025-03-06T00:37:46.045Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:37:46.045Z] There is no way to check that no silent failure occurred. [2025-03-06T00:37:46.045Z] ====== als (apache-spark) [default], iteration 24 completed (14707.440 ms) ====== [2025-03-06T00:37:46.045Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-03-06T00:37:46.045Z] GC before operation: completed in 140.407 ms, heap usage 180.798 MB -> 65.893 MB. [2025-03-06T00:38:01.802Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:38:01.802Z] There is no way to check that no silent failure occurred. [2025-03-06T00:38:01.802Z] ====== als (apache-spark) [default], iteration 25 completed (14941.489 ms) ====== [2025-03-06T00:38:01.802Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-03-06T00:38:01.802Z] GC before operation: completed in 146.823 ms, heap usage 338.118 MB -> 66.196 MB. [2025-03-06T00:38:15.052Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:38:15.052Z] There is no way to check that no silent failure occurred. [2025-03-06T00:38:15.052Z] ====== als (apache-spark) [default], iteration 26 completed (14794.604 ms) ====== [2025-03-06T00:38:15.052Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-03-06T00:38:15.052Z] GC before operation: completed in 156.884 ms, heap usage 319.761 MB -> 66.530 MB. [2025-03-06T00:38:30.819Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:38:30.819Z] There is no way to check that no silent failure occurred. [2025-03-06T00:38:30.819Z] ====== als (apache-spark) [default], iteration 27 completed (14597.876 ms) ====== [2025-03-06T00:38:30.819Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-03-06T00:38:30.819Z] GC before operation: completed in 148.290 ms, heap usage 322.149 MB -> 66.619 MB. [2025-03-06T00:38:46.558Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:38:46.558Z] There is no way to check that no silent failure occurred. [2025-03-06T00:38:46.558Z] ====== als (apache-spark) [default], iteration 28 completed (14512.028 ms) ====== [2025-03-06T00:38:46.558Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-03-06T00:38:46.558Z] GC before operation: completed in 143.484 ms, heap usage 411.931 MB -> 67.111 MB. [2025-03-06T00:38:59.658Z] WARNING: This benchmark provides no result that can be validated. [2025-03-06T00:38:59.658Z] There is no way to check that no silent failure occurred. [2025-03-06T00:38:59.658Z] ====== als (apache-spark) [default], iteration 29 completed (14376.570 ms) ====== [2025-03-06T00:38:59.658Z] ----------------------------------- [2025-03-06T00:38:59.658Z] renaissance-als_0_PASSED [2025-03-06T00:38:59.658Z] ----------------------------------- [2025-03-06T00:38:59.986Z] [2025-03-06T00:38:59.986Z] TEST TEARDOWN: [2025-03-06T00:38:59.986Z] Nothing to be done for teardown. [2025-03-06T00:38:59.986Z] renaissance-als_0 Finish Time: Thu Mar 6 00:38:59 2025 Epoch Time (ms): 1741221539796