Emails are NOT getting sent from SonarQube - 6.7.5. LTS Community Edition

Pattem · March 11, 2019, 9:40am

I have issue similar to # Fail to set up email notification on sonarqube-7.3

Recently installed SonarQube - 6.7.5. LTS Community Edition in RHEL 7 server and configured email settings at Administration > General Settings > Email with SMTP and port 25.

when I click “Send Test Email” button at " Test Configuration" from SonarQube UI, I observed below error:

Read timed out. Exception reading response. Sending the email to the following server failed : smtps.internal.xx.com:25

but, when i try to send the test mail from RHEL server with below command, then the email has been sent successfully.

echo “test-sonarqube” | mailx -s “test-sonarqube” username@example.com

Could you please let me know what all have to verify and fix the issue to send email from SonarQube.

Thank you.

ganncamp · March 11, 2019, 6:10pm

Hi,

Where did you see the ‘Read timed out’ error? Via the UI or in the logs? And did you see any (other) errors in the logs?

Ann

Pattem · March 11, 2019, 6:17pm

Hi,

Thanks for the response. I see ‘Read timed out’ error? Via the UI. I dont see any such mail related error in logs.

Could you pleas let me know , usually where will these mail related errors will logged?

Pattem · March 11, 2019, 6:23pm

i dont see any error in /var/log/maillog.

I could see “status=sent” in maillog and also result of “mailq” command is Mail queue is empty.

ganncamp · March 11, 2019, 6:28pm

Hi,

I meant the SonarQube logs: https://docs.sonarqube.org/latest/setup/troubleshooting/

Ann

Pattem · March 11, 2019, 6:46pm

Hi, i dont see any errors in “sonar.log, es.log, web.log and ce.log” that refers to emails or postfix.

ganncamp · March 11, 2019, 7:37pm

Hi,

What errors do you see in those logs?

Ann

Pattem · March 11, 2019, 8:24pm

Hi, I could only log updated today is access.log, and here it is:

[root@test11 logs]# tail -200 access.log
1.120.x.xx - - [11/Mar/2019:11:12:55 +0100] “GET /api/measures/search?projectKeys=com.xx.xxx%3Atest1&metricKeys=alert_status%2Cbugs%2Creliability_rating%2Cvulnerabilities%2Csecurity_rating%2Ccode_smells%2Csqale_rating%2Cduplicated_lines_density%2Ccoverage%2Cncloc%2Cncloc_language_distribution HTTP/1.0” 200 15 “https://sonarqube-test.xx.xxx.se/projects” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEa”
1.120.x.xx - - [11/Mar/2019:11:13:00 +0100] “POST /api/authentication/logout HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/sessions/logout” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEc”
1.120.x.xx - - [11/Mar/2019:11:13:00 +0100] “GET / HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/sessions/logout” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEd”
1.120.x.xx - - [11/Mar/2019:11:13:01 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-11T07%3A07%3A12%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEe”
1.120.x.xx - - [11/Mar/2019:11:13:01 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEf”
1.120.x.xx - - [11/Mar/2019:11:13:01 +0100] “GET /api/users/current HTTP/1.0” 200 98 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEg”
1.120.x.xx - - [11/Mar/2019:11:13:02 +0100] “GET /api/languages/list HTTP/1.0” 200 509 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEi”
1.120.x.xx - - [11/Mar/2019:11:13:02 +0100] “GET /api/navigation/global HTTP/1.0” 200 576 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEh”
1.120.x.xx - - [11/Mar/2019:11:13:02 +0100] “GET /api/issues/search?resolved=false&facets=types&ps=1&additionalFields=_all HTTP/1.0” 200 762 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEk”
1.120.x.xx - - [11/Mar/2019:11:13:02 +0100] “GET /api/components/search_projects?ps=1 HTTP/1.0” 200 222 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEj”
1.120.x.xx - - [11/Mar/2019:11:13:02 +0100] “GET /api/settings/values?keys=sonar.lf.aboutText HTTP/1.0” 200 15 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEl”
1.120.x.xx - - [11/Mar/2019:11:13:57 +0100] “GET /about HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEm”
1.120.x.xx - - [11/Mar/2019:11:13:57 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-11T07%3A07%3A12%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEn”
1.120.x.xx - - [11/Mar/2019:11:13:58 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEo”
1.120.x.xx - - [11/Mar/2019:11:13:58 +0100] “GET /api/users/current HTTP/1.0” 200 98 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEp”
1.120.x.xx - - [11/Mar/2019:11:13:58 +0100] “GET /api/languages/list HTTP/1.0” 200 509 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEr”
1.120.x.xx - - [11/Mar/2019:11:13:58 +0100] “GET /api/navigation/global HTTP/1.0” 200 576 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEq”
1.120.x.xx - - [11/Mar/2019:11:13:58 +0100] “GET /api/issues/search?resolved=false&facets=types&ps=1&additionalFields=_all HTTP/1.0” 200 762 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEt”
1.120.x.xx - - [11/Mar/2019:11:13:58 +0100] “GET /api/components/search_projects?ps=1 HTTP/1.0” 200 222 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEs”
1.120.x.xx - - [11/Mar/2019:11:13:59 +0100] “GET /api/settings/values?keys=sonar.lf.aboutText HTTP/1.0” 200 15 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEu”
1.120.x.xx - - [11/Mar/2019:11:14:00 +0100] “GET /about HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEv”
1.120.x.xx - - [11/Mar/2019:11:14:01 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-11T07%3A07%3A12%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEw”
1.120.x.xx - - [11/Mar/2019:11:14:01 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEx”
1.120.x.xx - - [11/Mar/2019:11:14:01 +0100] “GET /api/users/current HTTP/1.0” 200 98 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEy”
1.120.x.xx - - [11/Mar/2019:11:14:02 +0100] “GET /api/languages/list HTTP/1.0” 200 509 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE0”
1.120.x.xx - - [11/Mar/2019:11:14:02 +0100] “GET /api/navigation/global HTTP/1.0” 200 576 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAEz”
1.120.x.xx - - [11/Mar/2019:11:14:02 +0100] “GET /api/issues/search?resolved=false&facets=types&ps=1&additionalFields=_all HTTP/1.0” 200 762 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE2”
1.120.x.xx - - [11/Mar/2019:11:14:02 +0100] “GET /api/components/search_projects?ps=1 HTTP/1.0” 200 222 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE1”
1.120.x.xx - - [11/Mar/2019:11:14:02 +0100] “GET /api/settings/values?keys=sonar.lf.aboutText HTTP/1.0” 200 15 “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE3”
1.120.x.xx - - [11/Mar/2019:11:14:04 +0100] “GET /sessions/new HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/about” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE4”
1.120.x.xx - - [11/Mar/2019:11:14:04 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-11T07%3A07%3A12%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE5”
1.120.x.xx - - [11/Mar/2019:11:14:05 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE6”
1.120.x.xx - - [11/Mar/2019:11:14:05 +0100] “GET /api/users/identity_providers HTTP/1.0” 200 24 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE7”
1.120.x.xx - - [11/Mar/2019:11:14:05 +0100] “GET /api/navigation/global HTTP/1.0” 200 576 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE8”
1.120.x.xx - - [11/Mar/2019:11:14:08 +0100] “POST /api/authentication/login HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE9”
1.120.x.xx - - [11/Mar/2019:11:14:08 +0100] “GET / HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE+”
1.120.x.xx - - [11/Mar/2019:11:14:08 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-11T07%3A07%3A12%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAE/”
1.120.x.xx - - [11/Mar/2019:11:14:09 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFA”
1.120.x.xx - - [11/Mar/2019:11:14:09 +0100] “GET /api/users/current HTTP/1.0” 200 309 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFB”
1.120.x.xx - - [11/Mar/2019:11:14:09 +0100] “GET /api/navigation/global HTTP/1.0” 200 575 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFC”
1.120.x.xx - - [11/Mar/2019:11:14:09 +0100] “GET /api/languages/list HTTP/1.0” 200 509 “https://sonarqube-test.xx.xxx.se/” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFD”
1.120.x.xx - - [11/Mar/2019:11:14:10 +0100] “GET /api/components/search_projects?filter=isFavorite&ps=1 HTTP/1.0” 200 77 “https://sonarqube-test.xx.xxx.se/projects” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFE”
1.120.x.xx - - [11/Mar/2019:11:14:10 +0100] “GET /api/components/search_projects?ps=50&facets=reliability_rating%2Csecurity_rating%2Csqale_rating%2Ccoverage%2Cduplicated_lines_density%2Cncloc%2Calert_status%2Clanguages%2Ctags&f=analysisDate%2CleakPeriodDate HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/projects” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFF”
1.120.x.xx - - [11/Mar/2019:11:14:10 +0100] “GET /api/organizations/search?organizations=default-organization HTTP/1.0” 200 144 “https://sonarqube-test.xx.xxx.se/projects” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFH”
1.120.x.xx - - [11/Mar/2019:11:14:10 +0100] “GET /api/measures/search?projectKeys=com.xx.xxx%3Atest1&metricKeys=alert_status%2Cbugs%2Creliability_rating%2Cvulnerabilities%2Csecurity_rating%2Ccode_smells%2Csqale_rating%2Cduplicated_lines_density%2Ccoverage%2Cncloc%2Cncloc_language_distribution HTTP/1.0” 200 15 “https://sonarqube-test.xx.xxx.se/projects” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFG”
1.120.x.xx - - [11/Mar/2019:11:14:15 +0100] “GET /api/navigation/settings HTTP/1.0” 200 41 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFI”
1.120.x.xx - - [11/Mar/2019:11:14:15 +0100] “GET /api/editions/status HTTP/1.0” 200 72 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFJ”
1.120.x.xx - - [11/Mar/2019:11:14:15 +0100] “GET /api/settings/list_definitions? HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFK”
1.120.x.xx - - [11/Mar/2019:11:14:15 +0100] “GET /api/settings/values?keys=sonar.dbcleaner.hoursBeforeKeepingOnlyOneSnapshotByDay%2Csonar.dbcleaner.weeksBeforeKeepingOnlyOneSnapshotByWeek%2Csonar.dbcleaner.weeksBeforeKeepingOnlyOneSnapshotByMonth%2Csonar.dbcleaner.weeksBeforeKeepingOnlyAnalysesWithVersion%2Csonar.dbcleaner.weeksBeforeDeletingAllSnapshots%2Csonar.dbcleaner.daysBeforeDeletingClosedIssues%2Csonar.dbcleaner.cleanDirectory%2Csonar.lf.aboutText%2Csonar.builtInQualityProfiles.disableNotificationOnUpdate%2Csonar.links.ci%2Csonar.cpd.cross_project%2Csonar.issues.defaultAssigneeLogin%2Cemail.prefix%2Csonar.lf.enableGravatar%2Cemail.from%2Cemail.fromName%2Csonar.lf.gravatarServerUrl%2Csonar.leak.period%2Csonar.lf.logoUrl%2Csonar.preview.includePlugins%2Csonar.preview.excludePlugins%2Csonar.links.scm%2Cemail.smtp_secure_connection.secured%2Csonar.core.serverBaseURL%2Csonar.onboardingTutorial.showToNewUsers%2Cemail.smtp_host.secured%2Cemail.smtp_password.secured%2Cemail.smtp_port.secured%2Cemail.smtp_username.secured%2Csonar.lf.logoWidthPx HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFL”
1.120.x.xx - - [11/Mar/2019:11:33:45 +0100] “GET /sessions/new HTTP/1.0” 200 - “-” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFM”
1.120.x.xx - - [11/Mar/2019:11:33:45 +0100] “GET /css/sonar.3398ab84.css HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFN”
1.120.x.xx - - [11/Mar/2019:11:33:45 +0100] “GET /js/vendor.c4ad594b.js HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFO”
1.120.x.xx - - [11/Mar/2019:11:33:45 +0100] “GET /js/app.3398ab84.js HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFP”
1.120.x.xx - - [11/Mar/2019:11:33:46 +0100] “GET /js/269.541c9b3a.chunk.js HTTP/1.0” 200 4847 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFQ”
1.120.x.xx - - [11/Mar/2019:11:33:46 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-10T10%3A23%3A45%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFR”
1.120.x.xx - - [11/Mar/2019:11:33:46 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFS”
1.120.x.xx - - [11/Mar/2019:11:33:46 +0100] “GET /api/users/identity_providers HTTP/1.0” 200 24 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFT”
1.120.x.xx - - [11/Mar/2019:11:33:46 +0100] “GET /api/navigation/global HTTP/1.0” 200 576 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFU”
1.120.x.xx - - [11/Mar/2019:11:48:57 +0100] “GET /admin/settings HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/admin” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFV”
1.120.x.xx - - [11/Mar/2019:11:48:58 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-11T07%3A07%3A12%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFW”
1.120.x.xx - - [11/Mar/2019:11:48:58 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFX”
1.120.x.xx - - [11/Mar/2019:11:48:58 +0100] “GET /api/users/current HTTP/1.0” 200 309 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFY”
1.120.x.xx - - [11/Mar/2019:11:48:59 +0100] “GET /api/languages/list HTTP/1.0” 200 509 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFa”
1.120.x.xx - - [11/Mar/2019:11:48:59 +0100] “GET /api/navigation/global HTTP/1.0” 200 575 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFZ”
1.120.x.xx - - [11/Mar/2019:11:48:59 +0100] “GET /api/navigation/settings HTTP/1.0” 200 41 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFb”
1.120.x.xx - - [11/Mar/2019:11:48:59 +0100] “GET /api/editions/status HTTP/1.0” 200 72 “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFc”
1.120.x.xx - - [11/Mar/2019:11:48:59 +0100] “GET /api/settings/list_definitions? HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFd”
1.120.x.xx - - [11/Mar/2019:11:48:59 +0100] “GET /api/settings/values?keys=sonar.dbcleaner.hoursBeforeKeepingOnlyOneSnapshotByDay%2Csonar.dbcleaner.weeksBeforeKeepingOnlyOneSnapshotByWeek%2Csonar.dbcleaner.weeksBeforeKeepingOnlyOneSnapshotByMonth%2Csonar.dbcleaner.weeksBeforeKeepingOnlyAnalysesWithVersion%2Csonar.dbcleaner.weeksBeforeDeletingAllSnapshots%2Csonar.dbcleaner.daysBeforeDeletingClosedIssues%2Csonar.dbcleaner.cleanDirectory%2Csonar.lf.aboutText%2Csonar.builtInQualityProfiles.disableNotificationOnUpdate%2Csonar.links.ci%2Csonar.cpd.cross_project%2Csonar.issues.defaultAssigneeLogin%2Cemail.prefix%2Csonar.lf.enableGravatar%2Cemail.from%2Cemail.fromName%2Csonar.lf.gravatarServerUrl%2Csonar.leak.period%2Csonar.lf.logoUrl%2Csonar.preview.includePlugins%2Csonar.preview.excludePlugins%2Csonar.links.scm%2Cemail.smtp_secure_connection.secured%2Csonar.core.serverBaseURL%2Csonar.onboardingTutorial.showToNewUsers%2Cemail.smtp_host.secured%2Cemail.smtp_password.secured%2Cemail.smtp_port.secured%2Cemail.smtp_username.secured%2Csonar.lf.logoWidthPx HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/admin/settings” “Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.109 Safari/537.36” “AWlnITefbYKmAkyxAAFe”
1.120.x.xx - - [11/Mar/2019:11:49:59 +0100] “GET /sessions/new HTTP/1.0” 200 - “-” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFf”
1.120.x.xx - - [11/Mar/2019:11:49:59 +0100] “GET /css/sonar.3398ab84.css HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFg”
1.120.x.xx - - [11/Mar/2019:11:49:59 +0100] “GET /js/vendor.c4ad594b.js HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFh”
1.120.x.xx - - [11/Mar/2019:11:50:00 +0100] “GET /js/app.3398ab84.js HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFi”
1.120.x.xx - - [11/Mar/2019:11:50:00 +0100] “GET /js/269.541c9b3a.chunk.js HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFj”
1.120.x.xx - - [11/Mar/2019:11:50:00 +0100] “GET /api/l10n/index?locale=en-US&ts=2019-03-10T10%3A23%3A45%2B0000 HTTP/1.0” 304 - “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFk”
1.120.x.xx - - [11/Mar/2019:11:50:00 +0100] “GET /api/system/status HTTP/1.0” 200 76 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFl”
1.120.x.xx - - [11/Mar/2019:11:50:00 +0100] “GET /api/users/identity_providers HTTP/1.0” 200 24 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFm”
1.120.x.xx - - [11/Mar/2019:11:50:00 +0100] “GET /api/navigation/global HTTP/1.0” 200 576 “https://sonarqube-test.xx.xxx.se/sessions/new” “Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)” “AWlnITefbYKmAkyxAAFn”
1.120.x.xx - - [11/Mar/2019:14:25:36 +0100] “GET /admin/settings HTTP/1.0” 200 - “https://sonarqube-test.xx.xxx.se/admin” "Mozilla/5.0 (Windows NT 6.1) AppleW

Pattem · March 12, 2019, 8:02am

This is what i have observed below error from UI.

Pattem · March 12, 2019, 8:06am

Can any one please let me know if you have any idea on what shall be done to resolve the issue.

Thank you.

ganncamp · March 12, 2019, 12:05pm

Hi,

The access logs aren’t really relevant here. I meant the server’s process logs: https://docs.sonarqube.org/latest/setup/troubleshooting/

Ann

Pattem · March 15, 2019, 9:52am

Hi, I have found below email related errors in /opt/sonarqube/logs/web.log

2019.03.15 10:49:07 ERROR web[o.s.s.n.e.EmailNotificationChannel] Unable to send email
org.apache.commons.mail.EmailException: Sending the email to the following server failed : smtps.internal.xx.com:25
at org.apache.commons.mail.Email.sendMimeMessage(Email.java:1469)
at org.apache.commons.mail.Email.send(Email.java:1496)
at org.sonar.server.notification.email.EmailNotificationChannel.send(EmailNotificationChannel.java:184)
at org.sonar.server.notification.email.EmailNotificationChannel.deliver(EmailNotificationChannel.java:129)
at org.sonar.server.notification.email.EmailNotificationChannel.deliver(EmailNotificationChannel.java:104)
at org.sonar.server.notification.NotificationService.dispatch(NotificationService.java:84)
at org.sonar.server.notification.NotificationService.deliver(NotificationService.java:73)
at org.sonar.server.notification.NotificationDaemon.processQueue(NotificationDaemon.java:109)
at org.sonar.server.notification.NotificationDaemon.lambda$start$0(NotificationDaemon.java:81)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused by: javax.mail.MessagingException: Exception reading response
at com.sun.mail.smtp.SMTPTransport.readServerResponse(SMTPTransport.java:2369)
at com.sun.mail.smtp.SMTPTransport.openServer(SMTPTransport.java:2096)
at com.sun.mail.smtp.SMTPTransport.protocolConnect(SMTPTransport.java:712)
at javax.mail.Service.connect(Service.java:366)
at javax.mail.Service.connect(Service.java:246)
at javax.mail.Service.connect(Service.java:195)
at javax.mail.Transport.send0(Transport.java:254)
at javax.mail.Transport.send(Transport.java:124)
at org.apache.commons.mail.Email.sendMimeMessage(Email.java:1459)
… 15 common frames omitted
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:171)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at com.sun.mail.util.TraceInputStream.read(TraceInputStream.java:124)
at java.io.BufferedInputStream.fill(BufferedInputStream.java:246)
at java.io.BufferedInputStream.read(BufferedInputStream.java:265)
at com.sun.mail.util.LineInputStream.readLine(LineInputStream.java:92)
at com.sun.mail.smtp.SMTPTransport.readServerResponse(SMTPTransport.java:2349)
… 23 common frames omitted
2019.03.15 10:49:37 ERROR web[o.s.s.n.e.EmailNotificationChannel] Unable to send email
org.apache.commons.mail.EmailException: Sending the email to the following server failed : smtps.internal.xx.com:25
at org.apache.commons.mail.Email.sendMimeMessage(Email.java:1469)
at org.apache.commons.mail.Email.send(Email.java:1496)
at org.sonar.server.notification.email.EmailNotificationChannel.send(EmailNotificationChannel.java:184)
at org.sonar.server.notification.email.EmailNotificationChannel.deliver(EmailNotificationChannel.java:129)
at org.sonar.server.notification.email.EmailNotificationChannel.deliver(EmailNotificationChannel.java:104)
at org.sonar.server.notification.NotificationService.dispatch(NotificationService.java:84)
at org.sonar.server.notification.NotificationService.deliver(NotificationService.java:73)
at org.sonar.server.notification.NotificationDaemon.processQueue(NotificationDaemon.java:109)
at org.sonar.server.notification.NotificationDaemon.lambda$start$0(NotificationDaemon.java:81)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused by: javax.mail.MessagingException: Exception reading response
at com.sun.mail.smtp.SMTPTransport.readServerResponse(SMTPTransport.java:2369)
at com.sun.mail.smtp.SMTPTransport.openServer(SMTPTransport.java:2096)
at com.sun.mail.smtp.SMTPTransport.protocolConnect(SMTPTransport.java:712)
at javax.mail.Service.connect(Service.java:366)
at javax.mail.Service.connect(Service.java:246)
at javax.mail.Service.connect(Service.java:195)
at javax.mail.Transport.send0(Transport.java:254)
at javax.mail.Transport.send(Transport.java:124)
at org.apache.commons.mail.Email.sendMimeMessage(Email.java:1459)
… 15 common frames omitted
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:171)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at com.sun.mail.util.TraceInputStream.read(TraceInputStream.java:124)
at java.io.BufferedInputStream.fill(BufferedInputStream.java:246)
at java.io.BufferedInputStream.read(BufferedInputStream.java:265)
at com.sun.mail.util.LineInputStream.readLine(LineInputStream.java:92)
at com.sun.mail.smtp.SMTPTransport.readServerResponse(SMTPTransport.java:2349)
… 23 common frames omitted

ganncamp · March 15, 2019, 11:36am

Hi,

The trick with a stacktrace is to read the initial message and the ‘Caused by’ clauses. If I condense your log to that, I get this little story:

Pattem:

org.apache.commons.mail.EmailException: Sending the email to the following server failed : [smtps.internal.xx.com:25](http://smtps.internal.xx.com:25)
...
Caused by: javax.mail.MessagingException: Exception reading response
...
Caused by: java.net.SocketTimeoutException: Read timed out

which tells me that your mail server didn’t give the expected response in a timely manner. I really think you need to investigate this on your mail server’s side.

Ann

Pattem · March 15, 2019, 11:51am

Hi,

Thanks very much for the response.

The mail server (smtps.inertenal.xx.com:25) configuration is working for production. And i have set up sonarqube in new environment, here the same mail server configuration does not working properly.

I will check it as suggested. Thanks very much again.

Pattem · March 20, 2019, 10:16am

Hi @ganncamp,

I have checked with our mail server team, they confirmed it seems mail server (smtp) is working without any issue. But I’m still getting below error from sonarqube UI.

Read timed out. Exception reading response. Sending the email to the following server failed : smtps.internal.xx.com:25

And also i dont see sonarqube is writing email/smtp respective logs in “web.log” . Can you please suggest me if there are any other alternate ways to resolve this.

Thank you.

Pattem · March 25, 2019, 11:48am

Hi,

Can any one please suggest me on this issue.

Thank you.

Pattem · March 26, 2019, 5:38pm

But, the respective error is not written in web.log. Could you please let me know, if you have suggestions to track this issue. Thank you.

ganncamp · July 13, 2022, 12:16pm

2 posts were split to a new topic: Trouble sending notifications