dovecot mailing list stopped delivering mail

Christian Anthon anthon at rth.dk
Thu Mar 28 14:31:05 EET 2019


Ahh,

I had made some changes to our own server around the time, but couldn't 
for the life of me understand why it would selectively refuse to talk to 
the dovecot mailing list server.

Thanks for clearing it up so promptly.

Cheers, Christian.

On 28/03/2019 13.21, Aki Tuomi wrote:
> Fixed, we had smtp_security_level=verify, which I forgot to remove when
> we removed the relay server we used. Now it should work.
>
> Aki
>
> On 28.3.2019 13.59, Christian Anthon via dovecot wrote:
>> Strangest thing. Since some time Marts 25. I'm no longer receiving
>> mails from the dovecot mailing list server. Mails from other sources
>> are behaving fine.
>>
>> Instead I'm just seing
>>
>> Mar 26 08:27:54 dna01 postfix/smtpd[107746]: Anonymous TLS connection
>> established from talvi.dovecot.org[94.237.25.159]: TLSv1.2 with cipher
>> ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
>> Mar 26 08:27:54 dna01 postfix/smtpd[107746]: disconnect from
>> talvi.dovecot.org[94.237.25.159] ehlo=1 starttls=1 quit=1 commands=3
>>
>> And then no more.
>>
>> I tried turning up the postfix verbosity, but I'm none the wiser. I
>> realize that this is probably not a dovecot issue, but anybody with
>> any ideas?
>>
>> Cheers, Christian (and please send an off-list reply also)
>>
>> Verbose log:
>>
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: connection established
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: master_notify: status 0
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: name_mask: resource
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: name_mask: software
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: connect from
>> talvi.dovecot.org[94.237.25.159]
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: smtp_stream_setup:
>> maxtime=300 enable_deadline=0
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 192.168.3.0/24
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 192.168.3.0/24
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 127.0.0.0/8
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 127.0.0.0/8
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr request = connect
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr ident =
>> smtp:94.237.25.159
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value: 0
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: count
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: count
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value: 1
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: rate
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: rate
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value: 1
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: report connect to all milters
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup: "j"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "genome.ku.dk"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{daemon_name}"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "genome.ku.dk"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{daemon_addr}"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "192.168.3.112"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup: "v"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "Postfix 3.3.3"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect:
>> non-protocol events for protocol version 6:
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect:
>> transport=inet endpoint=localhost:11332
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: trying... [127.0.0.1]
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: vstream_tweak_tcp:
>> TCP_MAXSEG 32741
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: fd=11: stream buffer size
>> old=0 new=65482
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect:
>> my_version=0x6
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect:
>> my_actions=0x1ff SMFIF_ADDHDRS SMFIF_CHGBODY SMFIF_ADDRCPT
>> SMFIF_DELRCPT SMFIF_CHGHDRS SMFIF_QUARANTINE SMFIF_CHGFROM
>> SMFIF_ADDRCPT_PAR SMFIF_SETSYMLIST
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect:
>> my_events=0x1fffff SMFIP_NOCONNECT SMFIP_NOHELO SMFIP_NOMAIL
>> SMFIP_NORCPT SMFIP_NOBODY SMFIP_NOHDRS SMFIP_NOEOH SMFIP_NR_HDR
>> SMFIP_NOUNKNOWN SMFIP_NODATA SMFIP_SKIP SMFIP_RCPT_REJ SMFIP_NR_CONN
>> SMFIP_NR_HELO SMFIP_NR_MAIL SMFIP_NR_RCPT SMFIP_NR_DATA SMFIP_NR_UNKN
>> SMFIP_NR_EOH SMFIP_NR_BODY SMFIP_HDR_LEADSPC
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect: milter
>> inet:localhost:11332 version 6
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect: events
>> SMFIP_NR_HDR SMFIP_NR_CONN SMFIP_NR_HELO SMFIP_NR_MAIL SMFIP_NR_RCPT
>> SMFIP_NR_DATA SMFIP_NR_UNKN SMFIP_NR_EOH SMFIP_NR_BODY
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_connect: requests
>> SMFIF_ADDHDRS SMFIF_CHGBODY SMFIF_ADDRCPT SMFIF_DELRCPT SMFIF_CHGHDRS
>> SMFIF_QUARANTINE SMFIF_CHGFROM SMFIF_ADDRCPT_PAR SMFIF_SETSYMLIST
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_conn_event: milter
>> inet:localhost:11332: connect talvi.dovecot.org/94.237.25.159
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: event: SMFIC_CONNECT;
>> macros: j=genome.ku.dk {daemon_name}=genome.ku.dk
>> {daemon_addr}=192.168.3.112 v=Postfix 3.3.3
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: skipping reply for event
>> SMFIC_CONNECT from milter inet:localhost:11332
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 220 genome.ku.dk ESMTP Postfix
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: <
>> talvi.dovecot.org[94.237.25.159]: EHLO talvi.dovecot.org
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: report helo to all milters
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{tls_version}"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cipher}"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cipher_bits}"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cert_subject}"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cert_issuer}"
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_helo_event: milter
>> inet:localhost:11332: helo talvi.dovecot.org
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: event: SMFIC_HELO; macros:
>> (none)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: skipping reply for event
>> SMFIC_HELO from milter inet:localhost:11332
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-genome.ku.dk
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-PIPELINING
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-SIZE 150000000
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-VRFY
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-ETRN
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-STARTTLS
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-ENHANCEDSTATUSCODES
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-8BITMIME
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250 DSN
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: <
>> talvi.dovecot.org[94.237.25.159]: STARTTLS
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: query milter states for
>> other event
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_other_event:
>> milter inet:localhost:11332
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 220 2.0.0 Ready to start TLS
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: abort all milters
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_abort: abort
>> milter inet:localhost:11332
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: auto_clnt_open: connected
>> to private/tlsmgr
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr request = seed
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr size = 32
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value: 0
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: seed
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: seed
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value:
>> HIDDEN_BEFORE_POST
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr request = tktkey
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr keyname = [data
>> 16 bytes]
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value:
>> 4294967295
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: keybuf
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: keybuf
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value:
>> HIDDEN_BEFORE_POST
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr request = tktkey
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr keyname = [data
>> 0 bytes]
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value: 0
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: keybuf
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: keybuf
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value:
>> HIDDEN_BEFORE_POST
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: Anonymous TLS connection
>> established from talvi.dovecot.org[94.237.25.159]: TLSv1.2 with cipher
>> ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_create: SASL service=smtp, realm=(null)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: name_mask: noanonymous
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: Connecting
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: auth reply: VERSION?1?1
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: auth reply: MECH?PLAIN?plaintext
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: name_mask: plaintext
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: auth reply: MECH?LOGIN?plaintext
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: name_mask: plaintext
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: auth reply: SPID?62898
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: auth reply: CUID?107
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: auth reply: COOKIE?HIDDEN_BEFORE_POST
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_connect: auth reply: DONE
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_mech_filter: keep mechanism: PLAIN
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_mech_filter: keep mechanism: LOGIN
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: <
>> talvi.dovecot.org[94.237.25.159]: QUIT
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 221 2.0.0 Bye
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 192.168.3.0/24
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 192.168.3.0/24
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 127.0.0.0/8
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 127.0.0.0/8
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr request =
>> disconnect
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: send attr ident =
>> smtp:94.237.25.159
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute value: 0
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: disconnect event to all
>> milters
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: milter8_disc_event: quit
>> milter inet:localhost:11332
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: disconnect from
>> talvi.dovecot.org[94.237.25.159] ehlo=1 starttls=1 quit=1 commands=3
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: free all milters
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: free milter
>> inet:localhost:11332
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: master_notify: status 1
>> Mar 28 10:57:42 dna01 postfix/smtpd[66648]: connection closed
>> Mar 28 10:57:47 dna01 postfix/smtpd[66648]: auto_clnt_close:
>> disconnect private/tlsmgr stream
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: connection established
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: master_notify: status 0
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: name_mask: resource
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: name_mask: software
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: connect from
>> talvi.dovecot.org[94.237.25.159]
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: smtp_stream_setup:
>> maxtime=300 enable_deadline=0
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 192.168.3.0/24
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 192.168.3.0/24
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 127.0.0.0/8
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 127.0.0.0/8
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: send attr request = connect
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: send attr ident =
>> smtp:94.237.25.159
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: status
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute value: 0
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: count
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: count
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute value: 1
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: rate
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: rate
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute value: 2
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: report connect to all milters
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup: "j"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "genome.ku.dk"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{daemon_name}"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "genome.ku.dk"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{daemon_addr}"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "192.168.3.112"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup: "v"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> result "Postfix 3.3.3"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect:
>> non-protocol events for protocol version 6:
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect:
>> transport=inet endpoint=localhost:11332
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: trying... [127.0.0.1]
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: vstream_tweak_tcp:
>> TCP_MAXSEG 32741
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: fd=11: stream buffer size
>> old=0 new=65482
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect:
>> my_version=0x6
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect:
>> my_actions=0x1ff SMFIF_ADDHDRS SMFIF_CHGBODY SMFIF_ADDRCPT
>> SMFIF_DELRCPT SMFIF_CHGHDRS SMFIF_QUARANTINE SMFIF_CHGFROM
>> SMFIF_ADDRCPT_PAR SMFIF_SETSYMLIST
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect:
>> my_events=0x1fffff SMFIP_NOCONNECT SMFIP_NOHELO SMFIP_NOMAIL
>> SMFIP_NORCPT SMFIP_NOBODY SMFIP_NOHDRS SMFIP_NOEOH SMFIP_NR_HDR
>> SMFIP_NOUNKNOWN SMFIP_NODATA SMFIP_SKIP SMFIP_RCPT_REJ SMFIP_NR_CONN
>> SMFIP_NR_HELO SMFIP_NR_MAIL SMFIP_NR_RCPT SMFIP_NR_DATA SMFIP_NR_UNKN
>> SMFIP_NR_EOH SMFIP_NR_BODY SMFIP_HDR_LEADSPC
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect: milter
>> inet:localhost:11332 version 6
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect: events
>> SMFIP_NR_HDR SMFIP_NR_CONN SMFIP_NR_HELO SMFIP_NR_MAIL SMFIP_NR_RCPT
>> SMFIP_NR_DATA SMFIP_NR_UNKN SMFIP_NR_EOH SMFIP_NR_BODY
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_connect: requests
>> SMFIF_ADDHDRS SMFIF_CHGBODY SMFIF_ADDRCPT SMFIF_DELRCPT SMFIF_CHGHDRS
>> SMFIF_QUARANTINE SMFIF_CHGFROM SMFIF_ADDRCPT_PAR SMFIF_SETSYMLIST
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_conn_event: milter
>> inet:localhost:11332: connect talvi.dovecot.org/94.237.25.159
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: event: SMFIC_CONNECT;
>> macros: j=genome.ku.dk {daemon_name}=genome.ku.dk
>> {daemon_addr}=192.168.3.112 v=Postfix 3.3.3
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: skipping reply for event
>> SMFIC_CONNECT from milter inet:localhost:11332
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 220 genome.ku.dk ESMTP Postfix
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: <
>> talvi.dovecot.org[94.237.25.159]: EHLO talvi.dovecot.org
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: report helo to all milters
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{tls_version}"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cipher}"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cipher_bits}"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cert_subject}"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter_macro_lookup:
>> "{cert_issuer}"
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_helo_event: milter
>> inet:localhost:11332: helo talvi.dovecot.org
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: event: SMFIC_HELO; macros:
>> (none)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: skipping reply for event
>> SMFIC_HELO from milter inet:localhost:11332
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-genome.ku.dk
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-PIPELINING
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-SIZE 150000000
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-VRFY
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-ETRN
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-STARTTLS
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-ENHANCEDSTATUSCODES
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250-8BITMIME
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 250 DSN
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: <
>> talvi.dovecot.org[94.237.25.159]: STARTTLS
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: query milter states for
>> other event
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_other_event:
>> milter inet:localhost:11332
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 220 2.0.0 Ready to start TLS
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: abort all milters
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_abort: abort
>> milter inet:localhost:11332
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: auto_clnt_open: connected
>> to private/tlsmgr
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: send attr request = seed
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: send attr size = 32
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: status
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute value: 0
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: seed
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: seed
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute value:
>> HIDDEN_BEFORE_POST
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/tlsmgr: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: Anonymous TLS connection
>> established from talvi.dovecot.org[94.237.25.159]: TLSv1.2 with cipher
>> ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_create: SASL service=smtp, realm=(null)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: name_mask: noanonymous
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_mech_filter: keep mechanism: PLAIN
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]:
>> xsasl_dovecot_server_mech_filter: keep mechanism: LOGIN
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: <
>> talvi.dovecot.org[94.237.25.159]: QUIT
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: >
>> talvi.dovecot.org[94.237.25.159]: 221 2.0.0 Bye
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 192.168.3.0/24
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 192.168.3.0/24
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostname:
>> smtpd_client_event_limit_exceptions: talvi.dovecot.org ~? 127.0.0.0/8
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_hostaddr:
>> smtpd_client_event_limit_exceptions: 94.237.25.159 ~? 127.0.0.0/8
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> talvi.dovecot.org: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: match_list_match:
>> 94.237.25.159: no match
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: send attr request =
>> disconnect
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: send attr ident =
>> smtp:94.237.25.159
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: status
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: status
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute value: 0
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: private/anvil: wanted
>> attribute: (list terminator)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: input attribute name: (end)
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: disconnect event to all
>> milters
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: milter8_disc_event: quit
>> milter inet:localhost:11332
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: disconnect from
>> talvi.dovecot.org[94.237.25.159] ehlo=1 starttls=1 quit=1 commands=3
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: free all milters
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: free milter
>> inet:localhost:11332
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: master_notify: status 1
>> Mar 28 10:57:55 dna01 postfix/smtpd[66648]: connection closed
>> Mar 28 10:58:00 dna01 postfix/smtpd[66648]: auto_clnt_close:
>> disconnect private/tlsmgr stream
>>
-- 
Christian Anthon



More information about the dovecot mailing list