[2023-04-19T09:54:07.468Z] Running test renaissance-log-regression_0 ... [2023-04-19T09:54:07.468Z] =============================================== [2023-04-19T09:54:07.468Z] renaissance-log-regression_0 Start Time: Wed Apr 19 10:54:07 2023 Epoch Time (ms): 1681898047222 [2023-04-19T09:54:07.468Z] variation: NoOptions [2023-04-19T09:54:07.468Z] JVM_OPTIONS: [2023-04-19T09:54:07.468Z] { \ [2023-04-19T09:54:07.468Z] echo ""; echo "TEST SETUP:"; \ [2023-04-19T09:54:07.468Z] echo "Nothing to be done for setup."; \ [2023-04-19T09:54:07.468Z] mkdir -p "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-log-regression_0"; \ [2023-04-19T09:54:07.468Z] cd "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-log-regression_0"; \ [2023-04-19T09:54:07.468Z] echo ""; echo "TESTING:"; \ [2023-04-19T09:54:07.468Z] "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/openjdkbinary/j2sdk-image/bin/java" -jar "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2023-04-19T09:54:07.468Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/..; rm -f -r "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-19T09:54:07.468Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-19T09:54:07.468Z] echo "Nothing to be done for teardown."; \ [2023-04-19T09:54:07.468Z] } 2>&1 | tee -a "/export/home/jenkins/sshagent/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_16818976478287/TestTargetResult"; [2023-04-19T09:54:07.468Z] [2023-04-19T09:54:07.468Z] TEST SETUP: [2023-04-19T09:54:07.468Z] Nothing to be done for setup. [2023-04-19T09:54:07.468Z] [2023-04-19T09:54:07.468Z] TESTING: [2023-04-19T09:54:11.251Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2023-04-19T09:54:12.908Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2023-04-19T09:54:16.680Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2023-04-19T09:54:17.020Z] GC before operation: completed in 164.876 ms, heap usage 64.957 MB -> 26.612 MB. [2023-04-19T09:54:24.275Z] ====== log-regression (apache-spark) [default], iteration 0 completed (7121.595 ms) ====== [2023-04-19T09:54:24.275Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2023-04-19T09:54:24.275Z] GC before operation: completed in 303.499 ms, heap usage 1.313 GB -> 112.187 MB. [2023-04-19T09:54:25.927Z] ====== log-regression (apache-spark) [default], iteration 1 completed (1350.495 ms) ====== [2023-04-19T09:54:25.927Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2023-04-19T09:54:25.927Z] GC before operation: completed in 183.130 ms, heap usage 1.287 GB -> 112.155 MB. [2023-04-19T09:54:27.064Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1253.380 ms) ====== [2023-04-19T09:54:27.064Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2023-04-19T09:54:27.394Z] GC before operation: completed in 170.849 ms, heap usage 1.186 GB -> 113.096 MB. [2023-04-19T09:54:28.539Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1127.402 ms) ====== [2023-04-19T09:54:28.539Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2023-04-19T09:54:28.869Z] GC before operation: completed in 194.376 ms, heap usage 1.012 GB -> 113.356 MB. [2023-04-19T09:54:30.015Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1208.581 ms) ====== [2023-04-19T09:54:30.015Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2023-04-19T09:54:30.015Z] GC before operation: completed in 160.332 ms, heap usage 1.014 GB -> 113.645 MB. [2023-04-19T09:54:31.666Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1294.708 ms) ====== [2023-04-19T09:54:31.666Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2023-04-19T09:54:31.666Z] GC before operation: completed in 168.888 ms, heap usage 1011.950 MB -> 113.999 MB. [2023-04-19T09:54:32.813Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1200.841 ms) ====== [2023-04-19T09:54:32.813Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2023-04-19T09:54:32.813Z] GC before operation: completed in 185.123 ms, heap usage 1020.541 MB -> 114.383 MB. [2023-04-19T09:54:33.965Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1154.307 ms) ====== [2023-04-19T09:54:33.965Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2023-04-19T09:54:34.293Z] GC before operation: completed in 114.567 ms, heap usage 1010.708 MB -> 114.871 MB. [2023-04-19T09:54:35.445Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1118.990 ms) ====== [2023-04-19T09:54:35.446Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2023-04-19T09:54:35.446Z] GC before operation: completed in 146.774 ms, heap usage 1014.694 MB -> 115.316 MB. [2023-04-19T09:54:36.585Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1053.648 ms) ====== [2023-04-19T09:54:36.585Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2023-04-19T09:54:36.585Z] GC before operation: completed in 133.177 ms, heap usage 1014.847 MB -> 115.765 MB. [2023-04-19T09:54:37.724Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1064.485 ms) ====== [2023-04-19T09:54:37.724Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2023-04-19T09:54:37.724Z] GC before operation: completed in 119.766 ms, heap usage 1.003 GB -> 116.206 MB. [2023-04-19T09:54:38.863Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1059.360 ms) ====== [2023-04-19T09:54:38.863Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2023-04-19T09:54:39.189Z] GC before operation: completed in 174.153 ms, heap usage 1.005 GB -> 116.647 MB. [2023-04-19T09:54:40.337Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1088.742 ms) ====== [2023-04-19T09:54:40.337Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2023-04-19T09:54:40.337Z] GC before operation: completed in 148.279 ms, heap usage 1.001 GB -> 117.078 MB. [2023-04-19T09:54:41.479Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1027.360 ms) ====== [2023-04-19T09:54:41.479Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2023-04-19T09:54:41.479Z] GC before operation: completed in 161.040 ms, heap usage 1.009 GB -> 117.561 MB. [2023-04-19T09:54:42.623Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1027.335 ms) ====== [2023-04-19T09:54:42.623Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2023-04-19T09:54:42.623Z] GC before operation: completed in 142.892 ms, heap usage 1.021 GB -> 117.918 MB. [2023-04-19T09:54:43.774Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1043.907 ms) ====== [2023-04-19T09:54:43.774Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2023-04-19T09:54:43.774Z] GC before operation: completed in 172.190 ms, heap usage 1.016 GB -> 118.385 MB. [2023-04-19T09:54:44.921Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1005.082 ms) ====== [2023-04-19T09:54:44.921Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2023-04-19T09:54:45.250Z] GC before operation: completed in 244.572 ms, heap usage 1.013 GB -> 118.880 MB. [2023-04-19T09:54:46.392Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1073.251 ms) ====== [2023-04-19T09:54:46.392Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2023-04-19T09:54:46.392Z] GC before operation: completed in 209.116 ms, heap usage 1.010 GB -> 119.320 MB. [2023-04-19T09:54:47.532Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1166.116 ms) ====== [2023-04-19T09:54:47.532Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2023-04-19T09:54:47.861Z] GC before operation: completed in 190.577 ms, heap usage 1.004 GB -> 119.751 MB. [2023-04-19T09:54:49.006Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1229.309 ms) ====== [2023-04-19T09:54:49.749Z] ----------------------------------- [2023-04-19T09:54:49.749Z] renaissance-log-regression_0_PASSED [2023-04-19T09:54:49.749Z] ----------------------------------- [2023-04-19T09:54:49.749Z] [2023-04-19T09:54:49.749Z] TEST TEARDOWN: [2023-04-19T09:54:49.749Z] Nothing to be done for teardown. [2023-04-19T09:54:49.749Z] renaissance-log-regression_0 Finish Time: Wed Apr 19 10:54:49 2023 Epoch Time (ms): 1681898089578