Email notificatie werkt niet meer. Maar de testmail komt wel aan.

[Stefonline]

Hallo allen,

Uit het niets komen er geen email meldingen meer binnen. Dit heeft altijd goed gewerkt. Als ik bij meldingen en test mail verstuur komt die gewoon aan. Maar meldingen betreft het systeem komen niet aan.

Ik gebruik geen Gmail maar gewoon de smtp instellingen van mijn mail provider.

Wie heeft hier ook ervaring mee?

Stefan

[Basalt]

Sinds 1 december heb ik ook regelmatig dat een van de backup e-mails niet aankomt.

In /var/log/messages staat dan:

Code: [Selecteer]

Dec 12 05:49:41 Basalt synolocalbkp: smtp.c (161) Timeout while reading server reply.
Dec 12 05:49:41 Basalt synolocalbkp: smtp.c (406) Failed to write smtp command.
Dec 12 05:49:41 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)

Deze e-mails gaan rechtstreeks naar de smtp van Ziggo (niet via relay op de nas).
Ik vermoed dat daar iets niet helemaal lekker zit.

@Stefonline : zit jij ook bij Ziggo?

[Stefonline]

@Basalt ja ik heb ook Ziggo en maak ook rechtstreeks gebruik van de SMTP
Ik ben dus niet de enige

[Briolet]

Op een ziggo forum zag ik gisteren wel een melding die beweerd dan een ziggo medewerker had beweerd dat er momenteel problemen zijn met smtp. (Dan is inmiddels uit 3e hand)

Welke smpt server gebruik je? smtp.ziggo.nl?  Ik gebruik die voor al mijn mail en heb tot nu toe geen probleem ervaren.

[Stefonline]

Terwijl ik er over nadenk, bedenk ik me nu dat ik het verkeerd uitleg aan jullie. Maar het probleem blijft hetzelfde.

Mijn Provider is Ziggo dus ik ging ervan uit dat ik ook mail verstuur via ziggo maar dat is helemaal niet zo. Ik heb ivm eigen domein een andere mail provider nl mijndomein.nl. Dus dat was verkeerde info waarvoor sorry.

Neemt niet weg dat het probleem hetzelfde is. Test mail komt wel aan en b.v. backup mailtjes niet.
Mogelijke oplossing zou kunnen zijn om wel via ziggo te gaan versturen.

Sorry voor de verwarring.
Stefan

[Briolet]

Bedenk ook dat er twee soorten mail zijn binnen dsm. Beide moet je apart instellen.

[Stefonline]

ik ken alleen de instellingen bij configuratie > melding. Welke mis ik dan?

[Briolet]

Die bij je account instellingen rechtsboven. Maar de backup meldingen lopen via de instellingen die jij kent, dus dat is het niet.

[Stefonline]

@2Briolet grote kans dat dat het was. Ik laat het weten.
Dank allemaal

[Basalt]

Bij mij gaat het alleen maar slechter. Laatste 4 dagen is geen van de 2 backup e-mails verzonden.

Ook het testbericht versturen ging eerst 3x fout, pas de 4e keer lukte het.
Foutmelding was bij die drie keer telkens:

Het verzenden van het testbericht is mislukt. Controleer uw instellingen en probeer het opnieuw.
Timeout while reading server reply

En in /var/log/messages:

Code: [Selecteer]

Dec 19 21:39:10 Basalt entry.cgi_SYNO.Core.Notification.Mail[1].send_test[11580]: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dit zijn mijn instellingen bij "Melding"
:

[Basalt]

Oh, wow, ik heb een generiek probleem met het verzenden van e-mails 

Tussen 22:05 en 22:06 heb ik vijf test mails (Test 1...5) naar mezelf verzonden met mijn e-mail client.
Resultaat:
Test 1: ontvangen om 22:13
Test 2: ontvangen om 22:06
Test 3: nog steeds niet ontvangen!
Test 4: ontvangen om 22:23
Test 5: ontvangen om 22:07

Rond 22:13 in de Wachtrij van Mailserver gekeken, daar stonden nog 2 e-mails (inmiddels nog maar 1 dus):


Vervolgens ook gekeken in /volume1/@maillog/maillog (het ">>>>" commentaar heb ik uiteraard toegevoegd)

Code: [Selecteer]

Dec 19 22:12:44 Basalt postfix/qmgr[8763]: 32CA89304022: from=<MIJN_EMAIL_ADRES>, size=1613, nrcpt=1 (queue active)

Dec 19 22:12:58 Basalt postfix/smtp[17310]: 32CA89304022: to=<MIJN_EMAIL_ADRES>, relay=smtp.ziggo.nl[212.54.42.9]:587, delay=431, delays=416/0.21/14/0, dsn=4.4.2, status=deferred (lost connection with smtp.ziggo.nl[212.54.42.9] while performing the EHLO handshake)
>>>> Mislukt

Dec 19 22:12:58 Basalt postfix/smtp[17308]: Untrusted TLS connection established to smtp.ziggo.nl[212.54.42.9]:587: TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
Dec 19 22:12:59 Basalt postfix/smtp[17308]: 839B49304021: to=<MIJN_EMAIL_ADRES>, relay=smtp.ziggo.nl[212.54.42.9]:587, delay=473, delays=458/0.4/15/0.07, dsn=2.0.0, status=sent (250 OK id=1ii36R-0001CH-1k)
Dec 19 22:12:59 Basalt postfix/qmgr[8763]: 839B49304021: removed
>>>> Gelukt

Dec 19 22:13:03 Basalt postfix/smtp[17309]: D65069304023: to=<MIJN_EMAIL_ADRES>, relay=smtp.ziggo.nl[212.54.42.9]:587, delay=422, delays=402/0.21/20/0, dsn=4.4.2, status=deferred (lost connection with smtp.ziggo.nl[212.54.42.9] while performing the EHLO handshake)
>>>> Mislukt

Dec 19 22:15:06 Basalt postfix/anvil[15940]: statistics: max connection rate 5/86400s for (587:IP_VAN_MIJN_PC) at Dec 19 22:06:18
Dec 19 22:15:06 Basalt postfix/anvil[15940]: statistics: max connection count 1 for (587:IP_VAN_MIJN_PC) at Dec 19 22:05:06
Dec 19 22:15:06 Basalt postfix/anvil[15940]: statistics: max cache size 1 at Dec 19 22:05:06

Dec 19 22:22:43 Basalt postfix/qmgr[8763]: D65069304023: from=<MIJN_EMAIL_ADRES>, size=1615, nrcpt=1 (queue active)
Dec 19 22:22:43 Basalt postfix/qmgr[8763]: 32CA89304022: from=<MIJN_EMAIL_ADRES>, size=1613, nrcpt=1 (queue active)

Dec 19 22:23:07 Basalt postfix/smtp[19068]: Untrusted TLS connection established to smtp.ziggo.nl[212.54.42.9]:587: TLSv1.2 with cipher
ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
Dec 19 22:23:07 Basalt postfix/smtp[19068]: D65069304023: to=<MIJN_EMAIL_ADRES>, relay=smtp.ziggo.nl[212.54.42.9]:587, delay=1025, delays=1001/0.08/24/0.07, dsn=2.0.0, status=sent (250 OK id=1ii3GF-0008Qb-99)
Dec 19 22:23:07 Basalt postfix/qmgr[8763]: D65069304023: removed
>>>> Gelukt

Dec 19 22:23:07 Basalt postfix/smtp[19069]: 32CA89304022: to=<MIJN_EMAIL_ADRES>, relay=smtp.ziggo.nl[212.54.42.9]:587, delay=1039, delays=1015/0.08/24/0, dsn=4.4.2, status=deferred (lost connection with smtp.ziggo.nl[212.54.42.9] while performing the EHLO handshake)
>>>> Mislukt

Vreemd genoeg gaat het met een "Untrusted TLS connection" wel goed.

Wie weet wat hier aan de hand is?

[Briolet]

@BasaIt, ik zie dat je ook mailserver gebruikt. Waarom zendt je de meldingen naar Ziggo en houdt ze niet op de nas? 

Verder zijn jouw instellingen identiek als bij mijn voor de relayserver van Mail Server naar ziggo.

Ik zie alleen niet waarom hij bij jou dan 'untrusted' is. Ik krijg altijd 'trusted' bij Ziggo met dezelfde cipher:

Code: [Selecteer]

2019-12-19T16:00:14+01:00  postfix/smtp[6655]: Trusted TLS connection established to smtp.ziggo.nl[212.54.42.9]:587: TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)

2019-12-19T16:00:14+01:00  postfix/smtp[6655]: 4E4671234D2: to=<xxx@domein.com>, relay=smtp.ziggo.nl[212.54.42.9]:587, delay=7.8, delays=7.2/0.17/0.29/0.15, dsn=2.0.0, status=sent (250 OK id=1ihxHi-0001HF-T7)

Maar dit staat los van TS. Als er bij de testmails geen probleem is, zal het daar niet in de verbinding met de provider zitten.

[Basalt]

Nog even verder teruggekeken in de maillog, die loopt vanaf 13 mei: ik heb kennelijk altijd al een "Untrusted TLS connection" ?!
Ik draai DSM 5.2, misschien dat de Mailserver daarom wat anders reageert?

De meldingen verstuur ik trouwens rechtstreeks naar Ziggo omdat ik tijdens hibernation enkele mail processen uitgeschakeld heb (mbv "Mail Relaxer").

Maar zowel rechtstreeks als via Mailserver gaat het versturen dus regelmatig fout, volgens de maillog vanwege "lost connection with smtp.ziggo.nl[212.54.42.9] while performing the EHLO handshake"

Dat kwam vroeger sporadisch voor (1x op 24 September), sinds December regelmatig, zie grep op /var/log/messages:

Code: [Selecteer]

Basalt> cat messages|grep mail_smtp_error_call_back.c
Jan  1 01:01:58 Basalt synonotify: mail_smtp_error_call_back.c (29) Failed to send email. (Failed to resolve host address.)
Jan  1 01:04:23 Basalt syno_disk_health_record: mail_smtp_error_call_back.c (29) Failed to send email. (Failed to resolve host address.)
Jan  9 09:42:49 Basalt synonotify: mail_smtp_error_call_back.c (29) Failed to send email. (Failed to resolve host address.)
Jan  9 09:42:53 Basalt synonotify: mail_smtp_error_call_back.c (29) Failed to send email. (Failed to resolve host address.)
Jan  9 22:30:34 Basalt synonotify: mail_smtp_error_call_back.c (29) Failed to send email. (Failed to resolve host address.)
Sep 24 06:00:27 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec  1 05:46:19 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec  1 07:23:55 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec  2 05:48:35 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec  5 05:50:09 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec  8 07:24:07 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec  9 05:48:02 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec  9 07:24:39 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 10 07:10:22 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 11 07:05:53 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 12 05:49:41 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 12 07:11:24 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 13 07:13:55 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 15 07:16:25 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 16 05:57:48 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 16 07:22:24 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 17 05:44:06 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 17 07:21:54 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 18 05:46:37 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 18 07:22:35 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 19 05:44:13 Basalt synolocalbkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 19 07:21:02 Basalt timebkp: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 19 21:39:10 Basalt entry.cgi_SYNO.Core.Notification.Mail[1].send_test[11580]: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 19 21:39:45 Basalt entry.cgi_SYNO.Core.Notification.Mail[1].send_test[11666]: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)
Dec 19 21:40:05 Basalt entry.cgi_SYNO.Core.Notification.Mail[1].send_test[11750]: mail_smtp_error_call_back.c (29) Failed to send email. (Timeout while reading server reply)

De "Test 3" mail is nu ook net binnengekomen (om 00:33), uiteindelijk lukt het verzenden dus wel...

[Birdy]

Heb je soms ook wel eens problemen met het versturen van E-mail, naar provider Ziggo, buiten DSM om ?

[Briolet]

Ik heb even naar dat 'Untrusted' gekeken. Zelf zie ik alleen "Trusted" en "anonymous". (Dat laatste ligt blijkbaar aan de gebruikte ciphers )

Het untrusted ligt er blijkbaar aan dat hij het certificaat niet kan valideren. Of de gebruikte domeinnaam staat niet in het certificaat, of hij weet niet waar de root certificaten staan. (Zie b.v. hier)

Het komt er op neer om het volgende aan de main.cf file toe te voegen:

Code: [Selecteer]

smtp_tls_CApath = /etc/ssl/certs
smtpd_tls_CApath = /etc/ssl/certs
Bij mij staat er alleen

Code: [Selecteer]

smtp_tls_CApath = /etc/ssl/certs/
Dat is bij mij blijkbaar voldoende. Het kan ook zijn dat in dsm 5.2 een bepaald root certificaat mist.

Echter, dit zal niets met de problemen te maken hebben.