ubuntuusers.de

Nabend Leute,

unabhängig von der Software, die Mails verschicken möchte (https://gist.github.com/froemken/447580af285d96de4ad09aa54745a774) kriege ich bei dem Versuch per PHP über SMTP eine Verbindung aufzubauen ein Connection refused (Error 111).

Hier ein strace vom Tool mit dem ich den gegentest gemacht habe: https://pastebin.com/bdbyS1NS

Ich werde ehrlich gesagt nicht ganz schlau draus und hab gehofft wir haben hier ein paar kluge Köpfe die mal drüber schauen können.

Was ich soweit sagen kann:

• Der Mailserver ist vollständig konfiguriert

• mail und php Logs zeigen keinerlei Fehler auf

• Der Verbindungsversuch ist ebenfalls in keinerlei logs verzeichnet

• Thunderbird etc. können problemlos die E-Mail Adresse einrichten

• Senden/Empfangen über E-Mail Clients funktioniert ebenfalls

• Ports für SSL SMTP (465) ist offen

Würde mich da über Unterstützung freuen, verzweifle da langsam dran ^^

ss -ltn

Auf 25/tcp muss dein MTA lauschen. 465/tcp ist submission über SMTP und NICHT für die Verbindung mit einem MTA vorgesehen, auch wenn man das machen kann.

Der Fehler ist unabhängig vom Port/Protokoll.

Liefere doch mal die geforderte Ausgabe...

State                  Recv-Q                  Send-Q                                            Local Address:Port                                    Peer Address:Port                 Process
LISTEN                 0                       70                                                    127.0.0.1:33060                                        0.0.0.0:*
LISTEN                 0                       4096                                                  127.0.0.1:11332                                        0.0.0.0:*
LISTEN                 0                       4096                                                  127.0.0.1:11333                                        0.0.0.0:*
LISTEN                 0                       4096                                                  127.0.0.1:11334                                        0.0.0.0:*
LISTEN                 0                       151                                                   127.0.0.1:3306                                         0.0.0.0:*
LISTEN                 0                       100                                                5.75.135.112:587                                          0.0.0.0:*
LISTEN                 0                       100                                                   127.0.0.1:587                                          0.0.0.0:*
LISTEN                 0                       511                                                   127.0.0.1:6379                                         0.0.0.0:*
LISTEN                 0                       100                                                     0.0.0.0:143                                          0.0.0.0:*
LISTEN                 0                       511                                                     0.0.0.0:80                                           0.0.0.0:*
LISTEN                 0                       100                                                5.75.135.112:465                                          0.0.0.0:*
LISTEN                 0                       100                                                   127.0.0.1:465                                          0.0.0.0:*
LISTEN                 0                       256                                                   127.0.0.1:53                                           0.0.0.0:*
LISTEN                 0                       4096                                              127.0.0.53%lo:53                                           0.0.0.0:*
LISTEN                 0                       128                                                     0.0.0.0:22                                           0.0.0.0:*
LISTEN                 0                       100                                                5.75.135.112:25                                           0.0.0.0:*
LISTEN                 0                       100                                                   127.0.0.1:25                                           0.0.0.0:*
LISTEN                 0                       256                                                   127.0.0.1:8953                                         0.0.0.0:*
LISTEN                 0                       511                                                     0.0.0.0:443                                          0.0.0.0:*
LISTEN                 0                       100                                                     0.0.0.0:4190                                         0.0.0.0:*
LISTEN                 0                       100                                                     0.0.0.0:993                                          0.0.0.0:*
LISTEN                 0                       4096                                                      [::1]:11332                                           [::]:*
LISTEN                 0                       4096                                                      [::1]:11333                                           [::]:*
LISTEN                 0                       4096                                                      [::1]:11334                                           [::]:*
LISTEN                 0                       511                                                       [::1]:6379                                            [::]:*
LISTEN                 0                       100                                                       [::1]:587                                             [::]:*
LISTEN                 0                       100                                      [2a01:4f8:c0c:3570::1]:587                                             [::]:*
LISTEN                 0                       100                                                        [::]:143                                             [::]:*
LISTEN                 0                       511                                                        [::]:80                                              [::]:*
LISTEN                 0                       100                                                       [::1]:465                                             [::]:*
LISTEN                 0                       100                                      [2a01:4f8:c0c:3570::1]:465                                             [::]:*
LISTEN                 0                       256                                                       [::1]:53                                              [::]:*
LISTEN                 0                       128                                                        [::]:22                                              [::]:*
LISTEN                 0                       256                                                       [::1]:8953                                            [::]:*
LISTEN                 0                       100                                                       [::1]:25                                              [::]:*
LISTEN                 0                       100                                      [2a01:4f8:c0c:3570::1]:25                                              [::]:*
LISTEN                 0                       511                                                        [::]:443                                             [::]:*
LISTEN                 0                       100                                                        [::]:4190                                            [::]:*
LISTEN                 0                       100                                                        [::]:993                                             [::]:*

Mailserver ist wiefolgt eingerichtet: https://thomas-leister.de/mailserver-debian-buster/

Gut, dann teste mal mit

telnet ::1 25

, ob da alles funktioniert und schreibe mal "manuell" eine Mail. Dann nimmst du ::1 auf Port 25 in PHP.

telnet ::1 25 Verbindungsaufbau zu ::1...Es konnte keine Verbindung mit dem Host hergestellt werden, auf Port 25: Verbindungsfehler

sudo ss -ltnp

State                      Recv-Q                     Send-Q                                                  Local Address:Port                                           Peer Address:Port
Process
LISTEN                     0                          70                                                          127.0.0.1:33060                                               0.0.0.0:*
 users:(("mysqld",pid=4443,fd=21))
LISTEN                     0                          4096                                                        127.0.0.1:11332                                               0.0.0.0:*
 users:(("rspamd",pid=1103,fd=66),("rspamd",pid=830,fd=66))
LISTEN                     0                          4096                                                        127.0.0.1:11333                                               0.0.0.0:*
 users:(("rspamd",pid=1106,fd=73),("rspamd",pid=1105,fd=73),("rspamd",pid=830,fd=73))
LISTEN                     0                          4096                                                        127.0.0.1:11334                                               0.0.0.0:*
 users:(("rspamd",pid=1104,fd=69),("rspamd",pid=830,fd=69))
LISTEN                     0                          151                                                         127.0.0.1:3306                                                0.0.0.0:*
 users:(("mysqld",pid=4443,fd=65))
LISTEN                     0                          100                                                      5.75.135.112:587                                                 0.0.0.0:*
 users:(("master",pid=1062,fd=27))
LISTEN                     0                          100                                                         127.0.0.1:587                                                 0.0.0.0:*
 users:(("master",pid=1062,fd=26))
LISTEN                     0                          511                                                         127.0.0.1:6379                                                0.0.0.0:*
 users:(("redis-server",pid=717,fd=6))
LISTEN                     0                          100                                                           0.0.0.0:143                                                 0.0.0.0:*
 users:(("imap-login",pid=161215,fd=7),("imap-login",pid=161213,fd=7),("imap-login",pid=161209,fd=7),("imap-login",pid=142793,fd=7),("imap-login",pid=142791,fd=7),("imap-login",pid=142786,fd=7),("imap-login",pid=142785,fd=7),("imap-login",pid=142784,fd=7),("dovecot",pid=685,fd=38))
LISTEN                     0                          511                                                           0.0.0.0:80                                                  0.0.0.0:*
 users:(("nginx",pid=141811,fd=16),("nginx",pid=141810,fd=16),("nginx",pid=141809,fd=16),("nginx",pid=141808,fd=16),("nginx",pid=31274,fd=16))
LISTEN                     0                          100                                                      5.75.135.112:465                                                 0.0.0.0:*
 users:(("master",pid=1062,fd=21))
LISTEN                     0                          100                                                         127.0.0.1:465                                                 0.0.0.0:*
 users:(("master",pid=1062,fd=20))
LISTEN                     0                          256                                                         127.0.0.1:53                                                  0.0.0.0:*
 users:(("unbound",pid=775,fd=6))
LISTEN                     0                          4096                                                    127.0.0.53%lo:53                                                  0.0.0.0:*
 users:(("systemd-resolve",pid=649,fd=14))
LISTEN                     0                          128                                                           0.0.0.0:22                                                  0.0.0.0:*
 users:(("sshd",pid=750,fd=3))
LISTEN                     0                          100                                                      5.75.135.112:25                                                  0.0.0.0:*
 users:(("smtpd",pid=161242,fd=7),("master",pid=1062,fd=14))
LISTEN                     0                          100                                                         127.0.0.1:25                                                  0.0.0.0:*
 users:(("smtpd",pid=161242,fd=6),("master",pid=1062,fd=13))
LISTEN                     0                          256                                                         127.0.0.1:8953                                                0.0.0.0:*
 users:(("unbound",pid=775,fd=8))
LISTEN                     0                          511                                                           0.0.0.0:443                                                 0.0.0.0:*
 users:(("nginx",pid=141811,fd=18),("nginx",pid=141810,fd=18),("nginx",pid=141809,fd=18),("nginx",pid=141808,fd=18),("nginx",pid=31274,fd=18))
LISTEN                     0                          100                                                           0.0.0.0:4190                                                0.0.0.0:*
 users:(("dovecot",pid=685,fd=15))
LISTEN                     0                          100                                                           0.0.0.0:993                                                 0.0.0.0:*
 users:(("imap-login",pid=161215,fd=9),("imap-login",pid=161213,fd=9),("imap-login",pid=161209,fd=9),("imap-login",pid=142793,fd=9),("imap-login",pid=142791,fd=9),("imap-login",pid=142786,fd=9),("imap-login",pid=142785,fd=9),("imap-login",pid=142784,fd=9),("dovecot",pid=685,fd=40))
LISTEN                     0                          4096                                                            [::1]:11332                                                  [::]:*
 users:(("rspamd",pid=1103,fd=67),("rspamd",pid=830,fd=67))
LISTEN                     0                          4096                                                            [::1]:11333                                                  [::]:*
 users:(("rspamd",pid=1106,fd=75),("rspamd",pid=1105,fd=75),("rspamd",pid=830,fd=75))
LISTEN                     0                          4096                                                            [::1]:11334                                                  [::]:*
 users:(("rspamd",pid=1104,fd=71),("rspamd",pid=830,fd=71))
LISTEN                     0                          511                                                             [::1]:6379                                                   [::]:*
 users:(("redis-server",pid=717,fd=7))
LISTEN                     0                          100                                                             [::1]:587                                                    [::]:*
 users:(("master",pid=1062,fd=28))
LISTEN                     0                          100                                            [2a01:4f8:c0c:3570::1]:587                                                    [::]:*
 users:(("master",pid=1062,fd=29))
LISTEN                     0                          100                                                              [::]:143                                                    [::]:*
 users:(("imap-login",pid=161215,fd=8),("imap-login",pid=161213,fd=8),("imap-login",pid=161209,fd=8),("imap-login",pid=142793,fd=8),("imap-login",pid=142791,fd=8),("imap-login",pid=142786,fd=8),("imap-login",pid=142785,fd=8),("imap-login",pid=142784,fd=8),("dovecot",pid=685,fd=39))
LISTEN                     0                          511                                                              [::]:80                                                     [::]:*
 users:(("nginx",pid=141811,fd=17),("nginx",pid=141810,fd=17),("nginx",pid=141809,fd=17),("nginx",pid=141808,fd=17),("nginx",pid=31274,fd=17))
LISTEN                     0                          100                                                             [::1]:465                                                    [::]:*
 users:(("master",pid=1062,fd=22))
LISTEN                     0                          100                                            [2a01:4f8:c0c:3570::1]:465                                                    [::]:*
 users:(("master",pid=1062,fd=23))
LISTEN                     0                          256                                                             [::1]:53                                                     [::]:*
 users:(("unbound",pid=775,fd=4))
LISTEN                     0                          128                                                              [::]:22                                                     [::]:*
 users:(("sshd",pid=750,fd=4))
LISTEN                     0                          256                                                             [::1]:8953                                                   [::]:*
 users:(("unbound",pid=775,fd=7))
LISTEN                     0                          100                                                             [::1]:25                                                     [::]:*
 users:(("smtpd",pid=161242,fd=8),("master",pid=1062,fd=15))
LISTEN                     0                          100                                            [2a01:4f8:c0c:3570::1]:25                                                     [::]:*
 users:(("smtpd",pid=161242,fd=9),("master",pid=1062,fd=16))
LISTEN                     0                          511                                                              [::]:443                                                    [::]:*
 users:(("nginx",pid=141811,fd=19),("nginx",pid=141810,fd=19),("nginx",pid=141809,fd=19),("nginx",pid=141808,fd=19),("nginx",pid=31274,fd=19))
LISTEN                     0                          100                                                              [::]:4190                                                   [::]:*
 users:(("dovecot",pid=685,fd=16))
LISTEN                     0                          100                                                              [::]:993                                                    [::]:*
 users:(("imap-login",pid=161215,fd=10),("imap-login",pid=161213,fd=10),("imap-login",pid=161209,fd=10),("imap-login",pid=142793,fd=10),("imap-login",pid=142791,fd=10),("imap-login",pid=142786,fd=10),("imap-login",pid=142785,fd=10),("imap-login",pid=142784,fd=10),("dovecot",pid=685,fd=41))

was sagen die Logs des smtpd?

Jan 25 09:02:04 srv01 postfix/smtpd[161536]: connect from mail.ubuntu-de.org[87.79.26.38]
Jan 25 09:02:04 srv01 postfix/smtpd[161536]: D39425E956: client=mail.ubuntu-de.org[87.79.26.38]
Jan 25 09:02:04 srv01 postfix/cleanup[161540]: D39425E956: message-id=<167463732430.11.13742760023361941361@bbc13e73ec38>
Jan 25 09:02:06 srv01 postfix/qmgr[1064]: D39425E956: from=<system@ubuntuusers.de>, size=2675, nrcpt=1 (queue active)
Jan 25 09:02:06 srv01 postfix/smtpd[161536]: disconnect from mail.ubuntu-de.org[87.79.26.38] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
Jan 25 09:02:06 srv01 dovecot: lmtp(161544): Connect from local
Jan 25 09:02:06 srv01 dovecot: lmtp(info@example.com)<161544><Ewf5JQ7w0GMIdwIAOuFv1A>: sieve: msgid=<167463732430.11.13742760023361941361@bbc13e73ec38>: stored mail into mailbox 'INBOX'
Jan 25 09:02:06 srv01 postfix/lmtp[161543]: D39425E956: to=<info@example.com>, relay=srv01.example.com[private/dovecot-lmtp], delay=1.8, delays=1.8/0.01/0.02/0.04, dsn=2.0.0, status=sent (250 2.0.0 <info@example.com> Ewf5JQ7w0GMIdwIAOuFv1A Saved)
Jan 25 09:02:06 srv01 dovecot: lmtp(161544): Disconnect from local: Logged out (state=READY)
Jan 25 09:02:06 srv01 postfix/qmgr[1064]: D39425E956: removed

Hier ist die Mail von deiner Antwort wo du nach den smtpd Logs gefragt hast. Danach hab ich allerdings 3 Verbindungsversuche durchgeführt. Damit will ich dir zeigen, dass es die Verbindungsversuche nicht wahrnimmt. Das ist jetzt der mail.log von rsyslog. Im mail.err steht gar nichts drin.

Also ich korrigiere mich mal. Ich hab telnets von extern gemacht (vom PC aus):

telnet srv01.domain.de 25

220 srv01.domain.de ESMTP Postfix
EHLO srv01.domain.de
250-srv01.domain.de
250-PIPELINING
250-SIZE 52428800
250-ETRN
250-STARTTLS
250-ENHANCEDSTATUSCODES
250-8BITMIME
250-DSN
250-SMTPUTF8
250 CHUNKING
MAIL FROM: info@domain.de
250 2.1.0 Ok
RCPT TO: info@domain.de
250 2.1.5 Ok
DATA
354 End data with <CR><LF>.<CR><LF>
Subject: Testnachricht

Das ist ein Test

.
QUIT
451 4.7.1 Try again later
221 2.0.0 Bye


Verbindung zu Host verloren.

Der Logauszug dazu:

Jan 25 10:36:36 srv01 postfix/cleanup[163293]: 669A85DED8: milter-reject: END-OF-MESSAGE from p4fc05917.dip0.t-ipconnect.de[79.192.89.23]: 4.7.1 Try again later from=<info@domain.de> to=<info@domain.de> proto=ESMTP helo=<srv01.domain.de>

telnet srv01.domain.de 587

220 srv01.domain.de ESMTP Postfix
EHLO srv01.domain.de
250-srv01.domain.de
250-PIPELINING
250-SIZE 52428800
250-ETRN
250-STARTTLS
250-ENHANCEDSTATUSCODES
250-8BITMIME
250-DSN
250-SMTPUTF8
250 CHUNKING
MAIL FROM: info@domain.de
530 5.7.0 Must issue a STARTTLS command first

Der Logauszug dazu:

Jan 25 10:34:38 srv01 postfix/smtpd[163265]: connect from p4fc05917.dip0.t-ipconnect.de[79.192.89.23]
Jan 25 10:36:09 srv01 postfix/smtpd[163265]: 669A85DED8: client=p4fc05917.dip0.t-ipconnect.de[79.192.89.23]
Jan 25 10:36:35 srv01 postfix/cleanup[163293]: 669A85DED8: message-id=<>
Jan 25 10:36:36 srv01 postfix/cleanup[163293]: 669A85DED8: milter-reject: END-OF-MESSAGE from p4fc05917.dip0.t-ipconnect.de[79.192.89.23]: 4.7.1 Try again later; from=<info@domain.de> to=<info@domain.de> proto=ESMTP helo=<srv01.domain.de>
Jan 25 10:36:36 srv01 postfix/smtpd[163265]: disconnect from p4fc05917.dip0.t-ipconnect.de[79.192.89.23] ehlo=1 mail=1 rcpt=1 data=0/1 quit=1 commands=4/5

telnet srv01.domain.de 465

Hier bekomme ich kein "220 srv01.domain.de ESMTP Postfix". Ich hab das telnet Fenster einfach offen gelassen. Irgendwann ist er in Timeout gegangen.

Der Logauszug dazu:

Jan 25 10:44:22 srv01 postfix/smtps/smtpd[163499]: connect from p4fc05917.dip0.t-ipconnect.de[79.192.89.23]
Jan 25 10:44:38 srv01 postfix/anvil[163267]: statistics: max connection rate 1/60s for (smtp:79.192.89.23) at Jan 25 10:34:38
Jan 25 10:44:38 srv01 postfix/anvil[163267]: statistics: max connection count 1 for (smtp:79.192.89.23) at Jan 25 10:34:38
Jan 25 10:44:38 srv01 postfix/anvil[163267]: statistics: max cache size 1 at Jan 25 10:34:38
Jan 25 10:46:14 srv01 postfix/smtps/smtpd[163499]: SSL_accept error from p4fc05917.dip0.t-ipconnect.de[79.192.89.23]: -1
Jan 25 10:46:14 srv01 postfix/smtps/smtpd[163499]: warning: TLS library problem: error:0A00010B:SSL routines::wrong version number:../ssl/record/ssl3_record.c:354:
Jan 25 10:46:14 srv01 postfix/smtps/smtpd[163499]: lost connection after CONNECT from p4fc05917.dip0.t-ipconnect.de[79.192.89.23]
Jan 25 10:46:14 srv01 postfix/smtps/smtpd[163499]: disconnect from p4fc05917.dip0.t-ipconnect.de[79.192.89.23] commands=0/0

Jan 25 10:36:36 srv01 postfix/cleanup[163293]: 669A85DED8: milter-reject: END-OF-MESSAGE from p4fc05917.dip0.t-ipconnect.de[79.192.89.23]: 4.7.1 Try again later; from=<info@example.com> to=<info@example.com> proto=ESMTP helo=<srv01.example.com>

Ist ein MTA-Problem. Wenn du einen Milter aktiv hast, musst du schauen, was der filtern und warum er das hier filtert.

In diesem Fall filtert er, weil ich versuche den Server als open-relay zu nutzen, was natürlich per milter gefiltert wird. Zugriff war von extern über telnet.

Dann teste vom gleichen System, sodass er unauthentifiziert relayen darf (muss man ggf. konfigurieren!). Nur so sieht man, was passiert, wenn es php machen würde.