dovecot mailing list stopped delivering mail
Aki Tuomi
aki.tuomi at open-xchange.com
Thu Mar 28 14:21:09 EET 2019
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
>
More information about the dovecot
mailing list