[2024-09-26T22:25:04.488Z] Running test renaissance-log-regression_0 ... [2024-09-26T22:25:04.488Z] =============================================== [2024-09-26T22:25:04.488Z] renaissance-log-regression_0 Start Time: Thu Sep 26 18:06:10 2024 Epoch Time (ms): 1727391970612 [2024-09-26T22:25:04.488Z] variation: NoOptions [2024-09-26T22:25:04.488Z] JVM_OPTIONS: [2024-09-26T22:25:04.488Z] { \ [2024-09-26T22:25:04.488Z] echo ""; echo "TEST SETUP:"; \ [2024-09-26T22:25:04.488Z] echo "Nothing to be done for setup."; \ [2024-09-26T22:25:04.488Z] mkdir -p "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/aqa-tests/TKG/../TKG/output_17273899267799/renaissance-log-regression_0"; \ [2024-09-26T22:25:04.488Z] cd "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/aqa-tests/TKG/../TKG/output_17273899267799/renaissance-log-regression_0"; \ [2024-09-26T22:25:04.488Z] echo ""; echo "TESTING:"; \ [2024-09-26T22:25:04.488Z] "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/jdkbinary/j2sdk-image/bin/java" -jar "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/aqa-tests/TKG/../TKG/output_17273899267799/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-09-26T22:25:04.488Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/aqa-tests/TKG/..; rm -f -r "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/aqa-tests/TKG/../TKG/output_17273899267799/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-26T22:25:04.488Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-26T22:25:04.488Z] echo "Nothing to be done for teardown."; \ [2024-09-26T22:25:04.488Z] } 2>&1 | tee -a "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_sparcv9_solaris/aqa-tests/TKG/../TKG/output_17273899267799/TestTargetResult"; [2024-09-26T22:25:04.488Z] [2024-09-26T22:25:04.488Z] TEST SETUP: [2024-09-26T22:25:04.488Z] Nothing to be done for setup. [2024-09-26T22:25:04.488Z] [2024-09-26T22:25:04.488Z] TESTING: [2024-09-26T22:25:13.223Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-26T22:25:18.058Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-26T22:25:28.436Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-09-26T22:25:28.436Z] GC before operation: completed in 329.670 ms, heap usage 68.766 MB -> 27.133 MB. [2024-09-26T22:26:01.542Z] ====== log-regression (apache-spark) [default], iteration 0 completed (29477.850 ms) ====== [2024-09-26T22:26:01.542Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-09-26T22:26:01.542Z] GC before operation: completed in 1005.236 ms, heap usage 645.452 MB -> 104.502 MB. [2024-09-26T22:26:05.492Z] ====== log-regression (apache-spark) [default], iteration 1 completed (6752.792 ms) ====== [2024-09-26T22:26:05.492Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-09-26T22:26:06.131Z] GC before operation: completed in 508.219 ms, heap usage 561.578 MB -> 104.755 MB. [2024-09-26T22:26:10.973Z] ====== log-regression (apache-spark) [default], iteration 2 completed (5322.056 ms) ====== [2024-09-26T22:26:10.973Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-09-26T22:26:11.622Z] GC before operation: completed in 483.949 ms, heap usage 549.821 MB -> 105.175 MB. [2024-09-26T22:26:17.588Z] ====== log-regression (apache-spark) [default], iteration 3 completed (5667.090 ms) ====== [2024-09-26T22:26:17.588Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-09-26T22:26:18.229Z] GC before operation: completed in 500.908 ms, heap usage 535.473 MB -> 105.355 MB. [2024-09-26T22:26:23.065Z] ====== log-regression (apache-spark) [default], iteration 4 completed (4750.764 ms) ====== [2024-09-26T22:26:23.065Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-09-26T22:26:23.065Z] GC before operation: completed in 529.539 ms, heap usage 537.522 MB -> 105.603 MB. [2024-09-26T22:26:28.656Z] ====== log-regression (apache-spark) [default], iteration 5 completed (4536.221 ms) ====== [2024-09-26T22:26:28.656Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-09-26T22:26:28.656Z] GC before operation: completed in 431.461 ms, heap usage 512.795 MB -> 105.691 MB. [2024-09-26T22:26:32.722Z] ====== log-regression (apache-spark) [default], iteration 6 completed (4488.858 ms) ====== [2024-09-26T22:26:32.722Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-09-26T22:26:33.364Z] GC before operation: completed in 458.204 ms, heap usage 588.433 MB -> 106.350 MB. [2024-09-26T22:26:38.203Z] ====== log-regression (apache-spark) [default], iteration 7 completed (4404.213 ms) ====== [2024-09-26T22:26:38.203Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-09-26T22:26:38.203Z] GC before operation: completed in 449.205 ms, heap usage 572.824 MB -> 106.585 MB. [2024-09-26T22:26:42.041Z] ====== log-regression (apache-spark) [default], iteration 8 completed (4265.071 ms) ====== [2024-09-26T22:26:42.041Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-09-26T22:26:42.683Z] GC before operation: completed in 392.937 ms, heap usage 560.037 MB -> 106.894 MB. [2024-09-26T22:26:47.512Z] ====== log-regression (apache-spark) [default], iteration 9 completed (4200.298 ms) ====== [2024-09-26T22:26:47.512Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-09-26T22:26:47.512Z] GC before operation: completed in 493.514 ms, heap usage 548.362 MB -> 107.073 MB. [2024-09-26T22:26:51.331Z] ====== log-regression (apache-spark) [default], iteration 10 completed (4267.495 ms) ====== [2024-09-26T22:26:51.331Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-09-26T22:26:52.041Z] GC before operation: completed in 407.937 ms, heap usage 539.808 MB -> 107.272 MB. [2024-09-26T22:26:56.904Z] ====== log-regression (apache-spark) [default], iteration 11 completed (4257.552 ms) ====== [2024-09-26T22:26:56.904Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-09-26T22:26:56.904Z] GC before operation: completed in 413.504 ms, heap usage 540.943 MB -> 107.516 MB. [2024-09-26T22:27:00.721Z] ====== log-regression (apache-spark) [default], iteration 12 completed (4298.043 ms) ====== [2024-09-26T22:27:00.721Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-09-26T22:27:01.363Z] GC before operation: completed in 410.250 ms, heap usage 534.799 MB -> 107.637 MB. [2024-09-26T22:27:05.185Z] ====== log-regression (apache-spark) [default], iteration 13 completed (4063.303 ms) ====== [2024-09-26T22:27:05.185Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-09-26T22:27:05.827Z] GC before operation: completed in 510.422 ms, heap usage 519.307 MB -> 107.865 MB. [2024-09-26T22:27:10.652Z] ====== log-regression (apache-spark) [default], iteration 14 completed (3997.991 ms) ====== [2024-09-26T22:27:10.652Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-09-26T22:27:10.652Z] GC before operation: completed in 494.805 ms, heap usage 523.952 MB -> 108.111 MB. [2024-09-26T22:27:14.488Z] ====== log-regression (apache-spark) [default], iteration 15 completed (4040.074 ms) ====== [2024-09-26T22:27:14.488Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-09-26T22:27:15.130Z] GC before operation: completed in 460.770 ms, heap usage 515.374 MB -> 108.286 MB. [2024-09-26T22:27:18.980Z] ====== log-regression (apache-spark) [default], iteration 16 completed (3983.140 ms) ====== [2024-09-26T22:27:18.981Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-09-26T22:27:19.625Z] GC before operation: completed in 520.952 ms, heap usage 592.597 MB -> 109.038 MB. [2024-09-26T22:27:23.438Z] ====== log-regression (apache-spark) [default], iteration 17 completed (4149.232 ms) ====== [2024-09-26T22:27:23.438Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-09-26T22:27:24.078Z] GC before operation: completed in 439.904 ms, heap usage 563.706 MB -> 109.229 MB. [2024-09-26T22:27:27.895Z] ====== log-regression (apache-spark) [default], iteration 18 completed (4110.056 ms) ====== [2024-09-26T22:27:27.896Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-09-26T22:27:28.540Z] GC before operation: completed in 482.922 ms, heap usage 564.485 MB -> 109.456 MB. [2024-09-26T22:27:32.986Z] ====== log-regression (apache-spark) [default], iteration 19 completed (4340.322 ms) ====== [2024-09-26T22:27:33.627Z] ----------------------------------- [2024-09-26T22:27:33.627Z] renaissance-log-regression_0_PASSED [2024-09-26T22:27:33.627Z] ----------------------------------- [2024-09-26T22:27:33.627Z] [2024-09-26T22:27:33.627Z] TEST TEARDOWN: [2024-09-26T22:27:33.627Z] Nothing to be done for teardown. [2024-09-26T22:27:33.627Z] renaissance-log-regression_0 Finish Time: Thu Sep 26 18:08:39 2024 Epoch Time (ms): 1727392119949