[2025-05-29T00:01:55.399Z] Running test renaissance-log-regression_0 ... [2025-05-29T00:01:55.399Z] =============================================== [2025-05-29T00:01:55.399Z] renaissance-log-regression_0 Start Time: Thu May 29 00:01:54 2025 Epoch Time (ms): 1748476914723 [2025-05-29T00:01:55.399Z] variation: NoOptions [2025-05-29T00:01:55.399Z] JVM_OPTIONS: [2025-05-29T00:01:55.399Z] { \ [2025-05-29T00:01:55.399Z] echo ""; echo "TEST SETUP:"; \ [2025-05-29T00:01:55.399Z] echo "Nothing to be done for setup."; \ [2025-05-29T00:01:55.399Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17484759497998/renaissance-log-regression_0"; \ [2025-05-29T00:01:55.399Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17484759497998/renaissance-log-regression_0"; \ [2025-05-29T00:01:55.399Z] echo ""; echo "TESTING:"; \ [2025-05-29T00:01:55.399Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17484759497998/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-05-29T00:01:55.399Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17484759497998/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-29T00:01:55.399Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-29T00:01:55.399Z] echo "Nothing to be done for teardown."; \ [2025-05-29T00:01:55.399Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17484759497998/TestTargetResult"; [2025-05-29T00:01:55.399Z] [2025-05-29T00:01:55.399Z] TEST SETUP: [2025-05-29T00:01:55.399Z] Nothing to be done for setup. [2025-05-29T00:01:55.399Z] [2025-05-29T00:01:55.399Z] TESTING: [2025-05-29T00:02:02.019Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2025-05-29T00:02:02.960Z] WARNING: An illegal reflective access operation has occurred [2025-05-29T00:02:02.960Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17484759497998/renaissance-log-regression_0/harness-000155-16801415633748712576/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-05-29T00:02:02.960Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-05-29T00:02:02.960Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-05-29T00:02:02.960Z] WARNING: All illegal access operations will be denied in a future release [2025-05-29T00:02:04.892Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-05-29T00:02:04.892Z] GC before operation: completed in 55.180 ms, heap usage 120.738 MB -> 35.044 MB. [2025-05-29T00:02:18.283Z] ====== log-regression (apache-spark) [default], iteration 0 completed (12635.989 ms) ====== [2025-05-29T00:02:18.283Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-05-29T00:02:18.283Z] GC before operation: completed in 157.816 ms, heap usage 352.797 MB -> 124.424 MB. [2025-05-29T00:02:20.213Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2650.793 ms) ====== [2025-05-29T00:02:20.213Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-05-29T00:02:20.213Z] GC before operation: completed in 108.160 ms, heap usage 372.479 MB -> 125.267 MB. [2025-05-29T00:02:22.259Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2246.446 ms) ====== [2025-05-29T00:02:22.259Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-05-29T00:02:22.259Z] GC before operation: completed in 176.766 ms, heap usage 254.050 MB -> 125.301 MB. [2025-05-29T00:02:24.191Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1911.500 ms) ====== [2025-05-29T00:02:24.191Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-05-29T00:02:24.191Z] GC before operation: completed in 110.140 ms, heap usage 417.742 MB -> 126.211 MB. [2025-05-29T00:02:26.120Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2042.757 ms) ====== [2025-05-29T00:02:26.120Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-05-29T00:02:27.060Z] GC before operation: completed in 118.870 ms, heap usage 361.429 MB -> 126.361 MB. [2025-05-29T00:02:28.990Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1997.353 ms) ====== [2025-05-29T00:02:28.990Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-05-29T00:02:28.990Z] GC before operation: completed in 122.529 ms, heap usage 629.983 MB -> 127.427 MB. [2025-05-29T00:02:31.372Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2035.190 ms) ====== [2025-05-29T00:02:31.372Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-05-29T00:02:31.372Z] GC before operation: completed in 128.144 ms, heap usage 241.335 MB -> 126.667 MB. [2025-05-29T00:02:33.307Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2007.462 ms) ====== [2025-05-29T00:02:33.307Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-05-29T00:02:33.307Z] GC before operation: completed in 131.221 ms, heap usage 351.304 MB -> 127.288 MB. [2025-05-29T00:02:35.246Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1938.766 ms) ====== [2025-05-29T00:02:35.246Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-05-29T00:02:35.246Z] GC before operation: completed in 132.001 ms, heap usage 366.859 MB -> 127.840 MB. [2025-05-29T00:02:37.184Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1878.017 ms) ====== [2025-05-29T00:02:37.184Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-05-29T00:02:37.184Z] GC before operation: completed in 140.207 ms, heap usage 557.533 MB -> 128.674 MB. [2025-05-29T00:02:39.115Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1902.940 ms) ====== [2025-05-29T00:02:39.115Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-05-29T00:02:39.115Z] GC before operation: completed in 142.075 ms, heap usage 599.625 MB -> 129.211 MB. [2025-05-29T00:02:41.045Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1859.022 ms) ====== [2025-05-29T00:02:41.045Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-05-29T00:02:41.045Z] GC before operation: completed in 139.407 ms, heap usage 726.573 MB -> 129.921 MB. [2025-05-29T00:02:42.972Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1785.443 ms) ====== [2025-05-29T00:02:42.972Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-05-29T00:02:42.972Z] GC before operation: completed in 148.501 ms, heap usage 474.223 MB -> 129.583 MB. [2025-05-29T00:02:44.901Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1716.511 ms) ====== [2025-05-29T00:02:44.902Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-05-29T00:02:44.902Z] GC before operation: completed in 137.372 ms, heap usage 371.104 MB -> 129.617 MB. [2025-05-29T00:02:46.833Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1839.522 ms) ====== [2025-05-29T00:02:46.833Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-05-29T00:02:46.833Z] GC before operation: completed in 138.590 ms, heap usage 261.346 MB -> 129.560 MB. [2025-05-29T00:02:48.762Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1700.477 ms) ====== [2025-05-29T00:02:48.762Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-05-29T00:02:48.762Z] GC before operation: completed in 139.636 ms, heap usage 470.381 MB -> 130.666 MB. [2025-05-29T00:02:50.703Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1793.078 ms) ====== [2025-05-29T00:02:50.703Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-05-29T00:02:50.703Z] GC before operation: completed in 139.923 ms, heap usage 520.861 MB -> 131.169 MB. [2025-05-29T00:02:52.635Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1666.282 ms) ====== [2025-05-29T00:02:52.635Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-05-29T00:02:52.635Z] GC before operation: completed in 141.961 ms, heap usage 486.719 MB -> 131.441 MB. [2025-05-29T00:02:54.567Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1718.568 ms) ====== [2025-05-29T00:02:54.567Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-05-29T00:02:54.567Z] GC before operation: completed in 153.189 ms, heap usage 280.669 MB -> 131.099 MB. [2025-05-29T00:02:56.498Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1687.078 ms) ====== [2025-05-29T00:02:56.498Z] ----------------------------------- [2025-05-29T00:02:56.498Z] renaissance-log-regression_0_PASSED [2025-05-29T00:02:56.498Z] ----------------------------------- [2025-05-29T00:02:56.498Z] [2025-05-29T00:02:56.498Z] TEST TEARDOWN: [2025-05-29T00:02:56.498Z] Nothing to be done for teardown. [2025-05-29T00:02:56.498Z] renaissance-log-regression_0 Finish Time: Thu May 29 00:02:55 2025 Epoch Time (ms): 1748476975991