NEOHAPSIS - Peace of Mind Through Integrity and Insight

Neohapsis is currently accepting applications for employment. For more information, please visit our website www.neohapsis.com or email hr@neohapsis.com

Neohapsis > Archives > Postfix Discussion> 2006-08

Re: bare user names and {dk,sid}-milter

From: Tuan Van (lang.thanggmail.com)
Date: Tue Aug 01 2006 - 11:39:52 CDT

Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]

Tony Earnshaw wrote:
> This doesn't happen on our site running Postfix 2.3.2 and dk-milter
> 1.4.1 with Wietse's patch as documented in the 2.3.2 MILTER_README.html.
> Maybe your startup parameters are wrong?
>
> ps aux | grep dk-filter
> root 31123 0.0 0.1 46392 1644 ? Ssl Jul26
> 0:05 /usr/bin/dk-filter -l -p inet:10003 -d barlaeus.nl -
> s /etc/certs/dk-filter/mail.private.pem -S mail -C dnserror=tempfail -H
> -D
>
> Make sure you don't have -C nosignature=reject or similar.
>
> --Tonni
>
>

Thanks for response. I have postfix 2.3.2 and dk-milter 0.4.1 but
dk-milter isn't the one that rejects mail. I took sid-milter (0.2.13)
out then mail from <someone> goes through (I should have tried that
before.). I've posted in the wrong forum. Just want to correct thing
I've mis-reported.

dk-milter and sid-milter start with:
# ps aux | grep -- -filter
milter 11417 0.0 0.2 20612 1064 ? Ssl 08:32 0:00
/usr/bin/dk-filter -u milter -l -p inet:8025localhost -c simple -d
mytestmail.gotdns.org -s /etc/mail/dk-filter/test.private -S test
milter 13985 0.0 0.1 27612 824 ? Ssl 09:07 0:00
/usr/bin/sid-filter -u milter -l -p inet:8026localhost -d
mytestmail.gotdns.com

below is the verbose logs

dk-milter only:
Aug 1 08:42:26 mail postfix/smtpd[11706]: connection established
Aug 1 08:42:26 mail postfix/smtpd[11706]: master_notify: status 0
Aug 1 08:42:26 mail postfix/smtpd[11706]: name_mask: resource
Aug 1 08:42:26 mail postfix/smtpd[11706]: name_mask: software
Aug 1 08:42:26 mail postfix/smtpd[11706]: xsasl_cyrus_server_create:
SASL service=smtp, realm=(null)
Aug 1 08:42:26 mail postfix/smtpd[11706]: name_mask: noanonymous
Aug 1 08:42:26 mail postfix/smtpd[11706]: connect from localhost[127.0.0.1]
Aug 1 08:42:26 mail postfix/smtpd[11706]: match_list_match: localhost:
no match
Aug 1 08:42:26 mail postfix/smtpd[11706]: match_list_match: 127.0.0.1:
no match
Aug 1 08:42:26 mail postfix/smtpd[11706]: match_list_match: localhost:
no match
Aug 1 08:42:26 mail postfix/smtpd[11706]: match_list_match: 127.0.0.1:
no match
Aug 1 08:42:26 mail postfix/smtpd[11706]: match_hostname: localhost ~?
127.0.0.0/8
Aug 1 08:42:26 mail postfix/smtpd[11706]: match_hostaddr: 127.0.0.1 ~?
127.0.0.0/8
Aug 1 08:42:26 mail postfix/smtpd[11706]: report connect to all milters
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter_macro_lookup: "j"
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter_macro_lookup: result
"mail.mytestmail.gotdns.org"
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter_macro_lookup:
"{daemon_name}"
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter_macro_lookup: result
"mail.mytestmail.gotdns.org"
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter_macro_lookup: "v"
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter_macro_lookup: result
"Postfix 2.3.2"
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect: non-protocol
events for protocol version 2: SMFIP_NOUNKNOWN SMFIP_NODATA 0xfffffc00
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect:
transport=inet endpoint=localhost:8026
Aug 1 08:42:26 mail postfix/smtpd[11706]: trying... [127.0.0.1]
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect: my_version=0x2
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect:
my_actions=0x3d SMFIF_ADDHDRS SMFIF_ADDRCPT SMFIF_DELRCPT SMFIF_CHGHDRS
SMFIF_QUARANTINE
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect:
my_events=0x7f SMFIP_NOCONNECT SMFIP_NOHELO SMFIP_NOMAIL SMFIP_NORCPT
SMFIP_NOBODY SMFIP_NOHDRS SMFIP_NOEOH
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect: milter
inet:localhost:8026 version 2
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect: events
SMFIP_NOHELO SMFIP_NORCPT SMFIP_NOBODY
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_connect: requests
SMFIF_ADDHDRS SMFIF_CHGHDRS
Aug 1 08:42:26 mail postfix/smtpd[11706]: milter8_conn_event: milter
inet:localhost:8026: connect localhost/127.0.0.1
Aug 1 08:42:26 mail postfix/smtpd[11706]: event: SMFIC_CONNECT; macros:
j=mail.mytestmail.gotdns.org {daemon_name}=mail.mytestmail.gotdns.org
v=Postfix 2.3.2
Aug 1 08:42:26 mail postfix/smtpd[11706]: reply: SMFIR_CONTINUE data 0
bytes
Aug 1 08:42:26 mail postfix/smtpd[11706]: > localhost[127.0.0.1]: 220
mail.mytestmail.gotdns.org ESMTP Postfix
Aug 1 08:42:43 mail postfix/smtpd[11706]: < localhost[127.0.0.1]: EHLO
example.com
Aug 1 08:42:43 mail postfix/smtpd[11706]: report helo to all milters
Aug 1 08:42:43 mail postfix/smtpd[11706]: milter_macro_lookup:
"{tls_version}"
Aug 1 08:42:43 mail postfix/smtpd[11706]: milter_macro_lookup: "{cipher}"
Aug 1 08:42:43 mail postfix/smtpd[11706]: milter_macro_lookup:
"{cipher_bits}"
Aug 1 08:42:43 mail postfix/smtpd[11706]: milter_macro_lookup:
"{cert_subject}"
Aug 1 08:42:43 mail postfix/smtpd[11706]: milter_macro_lookup:
"{cert_issuer}"
Aug 1 08:42:43 mail postfix/smtpd[11706]: milter8_helo_event: milter
inet:localhost:8026: helo example.com
Aug 1 08:42:43 mail postfix/smtpd[11706]: event: SMFIC_HELO; macros: (none)
Aug 1 08:42:43 mail postfix/smtpd[11706]: skipping event SMFIC_HELO for
milter inet:localhost:8026
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]:
250-mail.mytestmail.gotdns.org
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]:
250-PIPELINING
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]:
250-SIZE 10240000
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]: 250-VRFY
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]: 250-ETRN
Aug 1 08:42:43 mail postfix/smtpd[11706]: match_list_match: localhost:
no match
Aug 1 08:42:43 mail postfix/smtpd[11706]: match_list_match: 127.0.0.1:
no match
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]:
250-AUTH PLAIN
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]:
250-ENHANCEDSTATUSCODES
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]:
250-8BITMIME
Aug 1 08:42:43 mail postfix/smtpd[11706]: > localhost[127.0.0.1]: 250 DSN
Aug 1 08:42:51 mail postfix/smtpd[11706]: < localhost[127.0.0.1]: MAIL
FROM:<someone>
Aug 1 08:42:51 mail postfix/smtpd[11706]: extract_addr: input: <someone>
Aug 1 08:42:51 mail postfix/smtpd[11706]: smtpd_check_addr: addr=someone
Aug 1 08:42:51 mail postfix/smtpd[11706]: ctable_locate: leave existing
entry key someone
Aug 1 08:42:51 mail postfix/smtpd[11706]: extract_addr: in: <someone>,
result: someone
Aug 1 08:42:51 mail postfix/smtpd[11706]: report sender to all milters
Aug 1 08:42:51 mail postfix/smtpd[11706]: milter_macro_lookup: "i"
Aug 1 08:42:51 mail postfix/smtpd[11706]: milter_macro_lookup:
"{auth_type}"
Aug 1 08:42:51 mail postfix/smtpd[11706]: milter_macro_lookup:
"{auth_authen}"
Aug 1 08:42:51 mail postfix/smtpd[11706]: milter_macro_lookup:
"{auth_author}"
Aug 1 08:42:51 mail postfix/smtpd[11706]: milter_macro_lookup:
"{mail_addr}"
Aug 1 08:42:51 mail postfix/smtpd[11706]: milter_macro_lookup: result
"someone"
Aug 1 08:42:51 mail postfix/smtpd[11706]: milter8_mail_event: milter
inet:localhost:8026: mail <someone>
Aug 1 08:42:51 mail postfix/smtpd[11706]: event: SMFIC_MAIL; macros:
{mail_addr}=someone
Aug 1 08:42:51 mail postfix/smtpd[11706]: reply: SMFIR_TEMPFAIL data 0
bytes
Aug 1 08:42:51 mail postfix/smtpd[11706]: NOQUEUE: milter-reject: MAIL
from localhost[127.0.0.1]: 451 4.7.1 Service unavailable - try again
later; proto=ESMTP helo=<example.com>
Aug 1 08:42:51 mail postfix/smtpd[11706]: > localhost[127.0.0.1]: 451
4.7.1 Service unavailable - try again later

sid-milter only:
Aug 1 08:48:35 mail postfix/smtpd[11874]: connection established
Aug 1 08:48:35 mail postfix/smtpd[11874]: master_notify: status 0
Aug 1 08:48:35 mail postfix/smtpd[11874]: name_mask: resource
Aug 1 08:48:35 mail postfix/smtpd[11874]: name_mask: software
Aug 1 08:48:35 mail postfix/smtpd[11874]: xsasl_cyrus_server_create:
SASL service=smtp, realm=(null)
Aug 1 08:48:35 mail postfix/smtpd[11874]: name_mask: noanonymous
Aug 1 08:48:35 mail postfix/smtpd[11874]: connect from localhost[127.0.0.1]
Aug 1 08:48:35 mail postfix/smtpd[11874]: match_list_match: localhost:
no match
Aug 1 08:48:35 mail postfix/smtpd[11874]: match_list_match: 127.0.0.1:
no match
Aug 1 08:48:35 mail postfix/smtpd[11874]: match_list_match: localhost:
no match
Aug 1 08:48:35 mail postfix/smtpd[11874]: match_list_match: 127.0.0.1:
no match
Aug 1 08:48:35 mail postfix/smtpd[11874]: match_hostname: localhost ~?
127.0.0.0/8
Aug 1 08:48:35 mail postfix/smtpd[11874]: match_hostaddr: 127.0.0.1 ~?
127.0.0.0/8
Aug 1 08:48:35 mail postfix/smtpd[11874]: report connect to all milters
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter_macro_lookup: "j"
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter_macro_lookup: result
"mail.mytestmail.gotdns.org"
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter_macro_lookup:
"{daemon_name}"
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter_macro_lookup: result
"mail.mytestmail.gotdns.org"
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter_macro_lookup: "v"
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter_macro_lookup: result
"Postfix 2.3.2"
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect: non-protocol
events for protocol version 2: SMFIP_NOUNKNOWN SMFIP_NODATA 0xfffffc00
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect:
transport=inet endpoint=localhost:8025
Aug 1 08:48:35 mail postfix/smtpd[11874]: trying... [127.0.0.1]
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect: my_version=0x2
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect:
my_actions=0x3d SMFIF_ADDHDRS SMFIF_ADDRCPT SMFIF_DELRCPT SMFIF_CHGHDRS
SMFIF_QUARANTINE
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect:
my_events=0x7f SMFIP_NOCONNECT SMFIP_NOHELO SMFIP_NOMAIL SMFIP_NORCPT
SMFIP_NOBODY SMFIP_NOHDRS SMFIP_NOEOH
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect: milter
inet:localhost:8025 version 2
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect: events
SMFIP_NOHELO SMFIP_NORCPT
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_connect: requests
SMFIF_ADDHDRS SMFIF_CHGHDRS
Aug 1 08:48:35 mail postfix/smtpd[11874]: milter8_conn_event: milter
inet:localhost:8025: connect localhost/127.0.0.1
Aug 1 08:48:35 mail postfix/smtpd[11874]: event: SMFIC_CONNECT; macros:
j=mail.mytestmail.gotdns.org {daemon_name}=mail.mytestmail.gotdns.org
v=Postfix 2.3.2
Aug 1 08:48:35 mail postfix/smtpd[11874]: reply: SMFIR_CONTINUE data 0
bytes
Aug 1 08:48:35 mail postfix/smtpd[11874]: > localhost[127.0.0.1]: 220
mail.mytestmail.gotdns.org ESMTP Postfix
Aug 1 08:48:42 mail postfix/smtpd[11874]: < localhost[127.0.0.1]: EHLO
example.com
Aug 1 08:48:42 mail postfix/smtpd[11874]: report helo to all milters
Aug 1 08:48:42 mail postfix/smtpd[11874]: milter_macro_lookup:
"{tls_version}"
Aug 1 08:48:42 mail postfix/smtpd[11874]: milter_macro_lookup: "{cipher}"
Aug 1 08:48:42 mail postfix/smtpd[11874]: milter_macro_lookup:
"{cipher_bits}"
Aug 1 08:48:42 mail postfix/smtpd[11874]: milter_macro_lookup:
"{cert_subject}"
Aug 1 08:48:42 mail postfix/smtpd[11874]: milter_macro_lookup:
"{cert_issuer}"
Aug 1 08:48:42 mail postfix/smtpd[11874]: milter8_helo_event: milter
inet:localhost:8025: helo example.com
Aug 1 08:48:42 mail postfix/smtpd[11874]: event: SMFIC_HELO; macros: (none)
Aug 1 08:48:42 mail postfix/smtpd[11874]: skipping event SMFIC_HELO for
milter inet:localhost:8025
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]:
250-mail.mytestmail.gotdns.org
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]:
250-PIPELINING
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]:
250-SIZE 10240000
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]: 250-VRFY
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]: 250-ETRN
Aug 1 08:48:42 mail postfix/smtpd[11874]: match_list_match: localhost:
no match
Aug 1 08:48:42 mail postfix/smtpd[11874]: match_list_match: 127.0.0.1:
no match
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]:
250-AUTH PLAIN
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]:
250-ENHANCEDSTATUSCODES
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]:
250-8BITMIME
Aug 1 08:48:42 mail postfix/smtpd[11874]: > localhost[127.0.0.1]: 250 DSN
Aug 1 08:48:48 mail postfix/smtpd[11874]: < localhost[127.0.0.1]: MAIL
FROM:<someone>
Aug 1 08:48:48 mail postfix/smtpd[11874]: extract_addr: input: <someone>
Aug 1 08:48:48 mail postfix/smtpd[11874]: smtpd_check_addr: addr=someone
Aug 1 08:48:48 mail postfix/smtpd[11874]: ctable_locate: leave existing
entry key someone
Aug 1 08:48:48 mail postfix/smtpd[11874]: extract_addr: in: <someone>,
result: someone
Aug 1 08:48:48 mail postfix/smtpd[11874]: report sender to all milters
Aug 1 08:48:48 mail postfix/smtpd[11874]: milter_macro_lookup: "i"
Aug 1 08:48:48 mail postfix/smtpd[11874]: milter_macro_lookup:
"{auth_type}"
Aug 1 08:48:48 mail postfix/smtpd[11874]: milter_macro_lookup:
"{auth_authen}"
Aug 1 08:48:48 mail postfix/smtpd[11874]: milter_macro_lookup:
"{auth_author}"
Aug 1 08:48:48 mail postfix/smtpd[11874]: milter_macro_lookup:
"{mail_addr}"
Aug 1 08:48:48 mail postfix/smtpd[11874]: milter_macro_lookup: result
"someone"
Aug 1 08:48:48 mail postfix/smtpd[11874]: milter8_mail_event: milter
inet:localhost:8025: mail <someone>
Aug 1 08:48:48 mail postfix/smtpd[11874]: event: SMFIC_MAIL; macros:
{mail_addr}=someone
Aug 1 08:48:48 mail postfix/smtpd[11874]: reply: SMFIR_CONTINUE data 0
bytes
Aug 1 08:48:48 mail postfix/smtpd[11874]: fsspace: .: block size 4096,
blocks free 89226
Aug 1 08:48:48 mail postfix/smtpd[11874]: smtpd_check_queue: blocks
4096 avail 89226 min_free 0 msg_size_limit 10240000
Aug 1 08:48:48 mail postfix/smtpd[11874]: > localhost[127.0.0.1]: 250
2.1.0 Ok

Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]