somehow broke fetchmail trying to fix outgoing email :(

Abe Stone via Fetchmail-users <[email protected]>
Newsgroups gmane.mail.fetchmail.user
Message-ID <[email protected]> 
Hi,

When I got up this morning I found that my outgoing mail
wasn't working. Of course that had nothing to do with
fetchmail, and I was still able to retrieve my mail from
gmail using POP3 as usual. I spent most of the day getting
the outgoing mail to work again. But now I find that
fetchmail can't deliver the incoming mail locally anymore. I
get "smtp listener protocol error."

The weird thing is, even when I change main.cf back to what
it was before (which would break my outgoing mail again, but
never mind that), the problem persists.

I'm running fetchmail 6.4.4 on Mac OS 10.13.6 (High Sierra).

The verbose fetchmail log looks like this (as you can see,
everything works fine until it tries to deliver locally):

fetchmail: 6.4.4 querying pop.gmail.com (protocol POP3) at Thu, 01 Oct 2020 21:50:34 -0700 (PDT): poll started
fetchmail: Trying to connect to 108.177.98.108/995...connected.
fetchmail: Server certificate:
fetchmail: Issuer Organization: Google Trust Services
fetchmail: Issuer CommonName: GTS CA 1O1
fetchmail: Subject CommonName: pop.gmail.com
fetchmail: Subject Alternative Name: pop.gmail.com
fetchmail: pop.gmail.com key fingerprint: 80:74:2A:92:40:2C:6E:B2:82:95:8F:EF:E5:74:61:BD
fetchmail: SSL/TLS: using protocol TLSv1.3, cipher TLS_AES_256_GCM_SHA384, 256/256 secret/processed bits
fetchmail: POP3< +OK Gpop ready for requests from 135.180.12.77 t18mb74240021ioi
fetchmail: POP3> CAPA
fetchmail: POP3< +OK Capability list follows
fetchmail: POP3< USER
fetchmail: POP3< RESP-CODES
fetchmail: POP3< EXPIRE 0
fetchmail: POP3< LOGIN-DELAY 300
fetchmail: POP3< TOP
fetchmail: POP3< UIDL
fetchmail: POP3< X-GOOGLE-RICO
fetchmail: POP3< SASL PLAIN XOAUTH2 OAUTHBEARER
fetchmail: POP3< .
fetchmail: POP3> USER [email protected]
fetchmail: POP3< +OK send PASS
fetchmail: POP3> PASS *
fetchmail: POP3< +OK Welcome.
fetchmail: POP3> STAT
fetchmail: POP3< +OK 59 2750128
fetchmail: 59 messages for [email protected] at pop.gmail.com (2750128 octets).
fetchmail: POP3> LIST 1
fetchmail: POP3< +OK 1 35221
fetchmail: POP3> RETR 1
fetchmail: POP3< +OK message follows
fetchmail: reading message [email protected]@pop.gmail.com:1 of 59 (35221 octets)Trying to connect to 127.0.0.1/25...connected.
fetchmail: smtp listener protocol error
fetchmail: Trying to connect to 127.0.0.1/25...connected.
fetchmail: smtp listener protocol error
fetchmail: SMTP connect to localhost failed
fetchmail: POP3> QUIT
fetchmail: POP3< --Mjk5MjIxMDM3OTAzNjQ2MDg
fetchmail: SMTP transaction error while fetching from [email protected]@pop.gmail.com and delivering to SMTP host localhost
fetchmail: 6.4.4 querying pop.gmail.com (protocol POP3) at Thu, 01 Oct 2020 22:00:35 -0700 (PDT): poll completed
fetchmail: Query status=10 (SMTP)
fetchmail: normal termination, status 10

The verbose log from smtpd looks like this:

2020-10-01 21:50:35.514198-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:50:35.514284-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: client_address
2020-10-01 21:50:35.514358-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 127.0.0.1
2020-10-01 21:50:35.514407-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:50:35.514451-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: client_port
2020-10-01 21:50:35.514491-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 50368
2020-10-01 21:50:35.514531-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:50:35.514569-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: server_address
2020-10-01 21:50:35.514605-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 127.0.0.1
2020-10-01 21:50:35.514644-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:50:35.514681-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: server_port
2020-10-01 21:50:35.514718-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 25
2020-10-01 21:50:35.514799-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:50:35.514876-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: (end)
2020-10-01 21:50:35.515437-0700 0x72ee     Info        0x0                  1414   smtp: connection established
2020-10-01 21:50:35.515588-0700 0x72ee     Info        0x0                  1414   smtp: master_notify: status 0
2020-10-01 21:50:35.515790-0700 0x72ee     Info        0x0                  1414   smtp: deliver_request_initial: send initial status
2020-10-01 21:50:35.515918-0700 0x72ee     Info        0x0                  1414   smtp: send attr status = 0
2020-10-01 21:55:35.535124-0700 0x72ee     Info        0x0                  1414   smtp: master_notify: status 1
2020-10-01 21:55:35.535214-0700 0x72ee     Info        0x0                  1414   smtp: connection closed
2020-10-01 21:55:35.608088-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:55:35.608128-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: client_address
2020-10-01 21:55:35.608156-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 127.0.0.1
2020-10-01 21:55:35.608198-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:55:35.608260-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: client_port
2020-10-01 21:55:35.608309-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 50664
2020-10-01 21:55:35.608358-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:55:35.608407-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: server_address
2020-10-01 21:55:35.608453-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 127.0.0.1
2020-10-01 21:55:35.608525-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:55:35.608572-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: server_port
2020-10-01 21:55:35.608616-0700 0x72ee     Info        0x0                  1414   smtp: input attribute value: 25
2020-10-01 21:55:35.608661-0700 0x72ee     Info        0x0                  1414   smtp: unknown_stream: wanted attribute: (any attribute name or list terminator)
2020-10-01 21:55:35.608705-0700 0x72ee     Info        0x0                  1414   smtp: input attribute name: (end)
2020-10-01 21:55:35.608915-0700 0x72ee     Info        0x0                  1414   smtp: connection established
2020-10-01 21:55:35.608986-0700 0x72ee     Info        0x0                  1414   smtp: master_notify: status 0
2020-10-01 21:55:35.609031-0700 0x72ee     Info        0x0                  1414   smtp: deliver_request_initial: send initial status
2020-10-01 21:55:35.609075-0700 0x72ee     Info        0x0                  1414   smtp: send attr status = 0
2020-10-01 22:00:35.554329-0700 0x72ee     Info        0x0                  1414   smtp: master_notify: status 1
2020-10-01 22:00:35.554409-0700 0x72ee     Info        0x0                  1414   smtp: connection closed
2020-10-01 22:02:15.557521-0700 0x72ee     Info        0x0                  1414   smtp: idle timeout -- exiting

The lines I changed in main.cf were relayhost (switched from
smtp.gmail.com to my ISP's smtp server) and the stuff about
TLS, SASL, etc. The old one had:

smtp_use_tls = yes
smtp_sasl_auth_enable = yes
smtp_sasl_mechanism_filter = plain
smtp_sasl_security_options =
smtp_sasl_password_maps = hash:/etc/postfix/sasl_passwd
smtp_tls_security_level = encrypt

The new one has:

smtp_use_tls = yes
smtp_sasl_auth_enable = yes
smtp_tls_security_level = encrypt
smtp_sasl_tls_security_options = noanonymous
smtp_sasl_mechanism_filter = login
smtp_sasl_security_options = 
smtp_sasl_password_maps = hash:/etc/postfix/sasl_passwd
smtp_tls_wrappermode = yes

But, as I said, even when I change back to the old main.cf,
fetchmail still doesn't work. (The above logs were generated
using the *old* main.cf.)

I have reloaded postfix many times and even rebooted.

Any help would be appreciated.

Thank you,
-- 
 Abe Stone
 [email protected]
lmpx.com only provides a reader for public news (NNTP) servers. It is not affiliated with the servers or forums shown here and is not responsible for the content of articles, which is written by their respective authors.