Hallo!
Ich habe schon seit geraumer Zeit ein RapidSSL Wildcard SSL-Zertifikat. Dieses setze ich in Apache, Dovecot und Postfix ein.
Seit ein paar Wochen mehren sich Berichte von Kunden, bei denen der Mail-Client sich plötzlich nicht mehr verbinden will. Nachdem ich das Verhalten auch selber reproduzieren kann, kann ich mal erklären was los ist:
Sporadisch wird einfach die Verbindung zum Server unterbrochen. Egal ob IMAP, POP oder SMTP, egal ob Windows Live Mail, Thunderbird oder Apple Mail. Manchmal will man ne Mail abschicken oder nen IMAP-Ordner öffnen und da kommt ne "Unbekannte" Fehlermeldung, mal funktioniert es. Völlig willkürlich.
Ich habe dann sichergestellt, dass die Zertifikate tatsächlich auch richtig sind. Sind sie auch: Private Key, CA und Certificate sind einwandfrei.
Also hab ich mir mal etwas verbosere Logs von Postfix und Dovecot besorgt.
So sieht es aus, wenn es nicht klappt:
Und so wenig Minuten später, bei einem erneuten Versuch:
In Dovecot sehe ich folgende Fehler:
Ich habe den Server neugestartet, die Firewall abgeschaltet, die Zertifikate neu hochgeladen, aber es bringt nichts. Was ist da los? Ich weiss momentan nicht, was ich da machen soll...
Ich habe schon seit geraumer Zeit ein RapidSSL Wildcard SSL-Zertifikat. Dieses setze ich in Apache, Dovecot und Postfix ein.
Seit ein paar Wochen mehren sich Berichte von Kunden, bei denen der Mail-Client sich plötzlich nicht mehr verbinden will. Nachdem ich das Verhalten auch selber reproduzieren kann, kann ich mal erklären was los ist:
Sporadisch wird einfach die Verbindung zum Server unterbrochen. Egal ob IMAP, POP oder SMTP, egal ob Windows Live Mail, Thunderbird oder Apple Mail. Manchmal will man ne Mail abschicken oder nen IMAP-Ordner öffnen und da kommt ne "Unbekannte" Fehlermeldung, mal funktioniert es. Völlig willkürlich.
Ich habe dann sichergestellt, dass die Zertifikate tatsächlich auch richtig sind. Sind sie auch: Private Key, CA und Certificate sind einwandfrei.
Also hab ich mir mal etwas verbosere Logs von Postfix und Dovecot besorgt.
So sieht es aus, wenn es nicht klappt:
Code:
3.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: connect from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
4.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: setting up TLS connection from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
5.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]: TLS cipher list "ALL:+RC4:@STRENGTH"
6.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: SSL_accept:before/accept initialization
7.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: SSL_accept:SSLv3 read client hello B
8.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: SSL_accept:SSLv3 write server hello A
9.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: SSL_accept:SSLv3 write certificate A
10.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: SSL_accept:SSLv3 write server done A
11.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: SSL_accept:SSLv3 flush data
12.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: SSL_accept error from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]: -1
13.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: lost connection after STARTTLS from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
14.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: disconnect from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
15.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: connect from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
16.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: lost connection after MAIL from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
17.
Mar 5 20:15:24 mercury postfix/smtpd[24551]: disconnect from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
Und so wenig Minuten später, bei einem erneuten Versuch:
Code:
22.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: initializing the server-side TLS engine
23.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: connect from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
24.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: setting up TLS connection from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
25.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]: TLS cipher list "ALL:+RC4:@STRENGTH"
26.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:before/accept initialization
27.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 read client hello B
28.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 write server hello A
29.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 write certificate A
30.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 write server done A
31.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 flush data
32.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 read client key exchange A
33.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 read finished A
34.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 write session ticket A
35.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 write change cipher spec A
36.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 write finished A
37.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: SSL_accept:SSLv3 flush data
38.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: Anonymous TLS connection established from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]: TLSv1 with cipher AES128-SHA (128/128 bits)
39.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: 9B3C93FA2C: client=xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx], sasl_method=LOGIN, sasl_username=xxx
40.
Mar 5 20:18:53 mercury postfix/cleanup[24712]: 9B3C93FA2C: message-id=<A1DEE5BBBD1F4E4CB5BF9AD0D3B1F98F@Angus>
41.
Mar 5 20:18:53 mercury postfix/qmgr[24412]: 9B3C93FA2C: from=<[email protected]>, size=1303, nrcpt=1 (queue active)
42.
Mar 5 20:18:53 mercury postfix/smtpd[24710]: disconnect from xxx.kabel-badenwuerttemberg.de[46.xxx.xxx.xxx]
43.
Mar 5 20:18:53 mercury postfix/smtp[24713]: 9B3C93FA2C: to=<[email protected]>, relay=xxx.xxx.xxx[188.xxx.xxx.xxx]:25, delay=0.38, delays=0.19/0.01/0.12/0.06, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as E8FC024534)
44.
Mar 5 20:18:53 mercury postfix/qmgr[24412]: 9B3C93FA2C: removed
In Dovecot sehe ich folgende Fehler:
Code:
Mar 5 22:18:23 mercury dovecot: imap-login: Disconnected (no auth attempts): rip=46.xxx.xxx.xxx, lip=188.xxx.xxx.xxx, TLS: Disconnected
Mar 5 22:18:25 mercury dovecot: imap-login: Disconnected (no auth attempts): rip=46.xxx.xxx.xxx, lip=188.xxx.xxx.xxx, TLS handshaking: Disconnected
Ich habe den Server neugestartet, die Firewall abgeschaltet, die Zertifikate neu hochgeladen, aber es bringt nichts. Was ist da los? Ich weiss momentan nicht, was ich da machen soll...