Hi List,
I'm still struggling with dspam integration with postfix.
Now I have:
--
address_verify_map = btree:${data_directory}/verify
alias_maps = dbm:/etc/opt/redknot/postfix/aliases
config_directory = /etc/opt/redknot/postfix
disable_vrfy_command = yes
home_mailbox = Maildir/
mailbox_command = /opt/redknot/libexec/dovecot/deliver -a "$RECIPIENT"
-m "$EXTENSION" -s
mailbox_transport = dspam-lmtp:[127.0.0.1]:10025
mydestination = $myhostname, localhost.$mydomain, localhost
mydomain = chuck.redknot.nl
myhostname = chuck.redknot.nl
recipient_delimiter = +
relay_domains = $mydestination, atdstramproy.nl
smtpd_banner = $myhostname ESMTP
smtpd_data_restrictions = reject_unauth_pipelining, permit
smtpd_delay_reject = yes
smtpd_helo_required = yes
smtpd_proxy_filter = 127.0.0.1:10027
smtpd_proxy_options = speed_adjust
smtpd_recipient_restrictions = reject_non_fqdn_helo_hostname,
reject_non_fqdn_sender, reject_non_fqdn_recipient,
reject_unknown_sender_domain, reject_unknown_recipient_domain,
reject_unauth_destination, reject_rbl_client virbl.dnsbl.bit.nl,
check_policy_service inet:localhost:10031, check_policy_service
inet:localhost:10030, check_policy_service inet:localhost:10029,
permit
smtpd_tls_cert_file = /etc/opt/redknot/ssl/chuck.redknot.nl.cer
smtpd_tls_key_file = /etc/opt/redknot/ssl/chuck.redknot.nl.key
smtpd_use_tls = yes
soft_bounce = yes
strict_rfc821_envelopes = yes
transport_maps = dbm:/etc/opt/redknot/postfix/transport
unknown_address_reject_code = 550
unknown_hostname_reject_code = 550
unknown_local_recipient_reject_code = 550
unverified_recipient_reject_code = 550
virtual_alias_maps = dbm:/etc/opt/redknot/postfix/virtual
--
So I'm using a mailbox_transport to call dspam. Unfortantly the mail
doesn't show up in the logs after the lmtp part (I have lmtp -v in
master.cf) and the mail isn't delivered. When I remove the
mailbox_transport and restart postfix the mails get delivered. Why
does the LMTP conversation stop in the last three lines, I expect to
see the actual message?
Sep 8 16:38:32 chuck postfix/smtpd[24691]: [ID 197553 mail.info]
connect from mail-yw0-f44.google.com[209.85.213.44]
Sep 8 16:38:38 chuck policyd-spf[24698]: [ID 702911 mail.info] None;
identity=helo; client-ip=209.85.213.44; helo=mail-yw0-f44.google.com; envelope-from=martijndemun...@gmail.com
; receiver=mart...@redknot.nl
Sep 8 16:38:38 chuck policyd-spf[24698]: [ID 702911 mail.info] Pass;
identity=mailfrom; client-ip=209.85.213.44; helo=mail-yw0-
f44.google.com; envelope-from=martijndemun...@gmail.com; receiver=mart...@redknot.nl
Sep 8 16:38:38 chuck postfix/smtpd[24691]: [ID 197553 mail.info]
NOQUEUE: client=mail-yw0-f44.google.com[209.85.213.44]
Sep 8 16:38:39 chuck postfix/smtpd[24686]: [ID 197553 mail.info]
connect from localhost[127.0.0.1]
Sep 8 16:38:39 chuck postfix/smtpd[24686]: [ID 197553 mail.info]
167E810897: client=mail-yw0-f44.google.com[209.85.213.44]
Sep 8 16:38:39 chuck postfix/cleanup[24687]: [ID 197553 mail.info]
167E810897: message-id=<aanlkti=5jghf56pzvnfr0qqhvxqwk_zvxndx18eox...@mail.gmail.com
>
Sep 8 16:38:39 chuck postfix/qmgr[24585]: [ID 197553 mail.info]
167E810897: from=<martijndemun...@gmail.com>, size=2401, nrcpt=1
(queue active)
Sep 8 16:38:39 chuck postfix/smtpd[24691]: [ID 197553 mail.info]
proxy-accept: END-OF-MESSAGE: 250 2.0.0 Ok: queued as 167E810897;
from=<martijndemun...@gmail.com> to=<mart...@redknot.nl> proto=ESMTP
helo=<mail-yw0-f44.google.com>
Sep 8 16:38:39 chuck postfix/smtpd[24686]: [ID 197553 mail.info]
disconnect from localhost[127.0.0.1]
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const mail
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const ipv4
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck last message repeated 2 times
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
name_mask: ipv4
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const chuck.redknot.nl
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const Postfix
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand ${multi_instance_name:postfix}${multi_instance_name?
$multi_instance_name} -> postfix
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const postfix
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const postdrop
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $myhostname, localhost.$mydomain, localhost ->
chuck.redknot.nl, localhost.chuck.redknot.nl, localhost
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $myhostname -> chuck.redknot.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const /opt/redknot/libexec/postfix
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const /opt/redknot/var/lib/postfix
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const /opt/redknot/sbin
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const /opt/redknot/var/spool/postfix
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const pid
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const all
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const double-bounce
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const nobody
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const dbm:/etc/mail/aliases
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 20100608
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 2.7.1
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const dbm
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const deferred, defer
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const +
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $mydestination, atdstramproy.nl -> chuck.redknot.nl,
localhost.chuck.redknot.nl, localhost, atdstramproy.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $relay_domains -> chuck.redknot.nl,
localhost.chuck.redknot.nl, localhost, atdstramproy.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const TZ MAIL_CONFIG LANG
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const MAIL_CONFIG MAIL_DEBUG MAIL_LOGTAG TZ XAUTHORITY
DISPLAY LANG=C
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const subnet
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const +=
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const -=+
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
debug_peer_list
,fast_flush_domains
,mynetworks
,permit_mx_backup_networks
,qmqpd_authorized_clients,relay_domains,smtpd_access_maps
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const bounce
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const cleanup
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const defer
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const pickup
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const qmgr
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const rewrite
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const showq
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const error
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const flush
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const verify
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const trace
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const proxymap
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const proxywrite
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const yes
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 100s
Sep 8 16:38:39 chuck last message repeated 3 times
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 3600s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 5s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 1000s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 10s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 1s
Sep 8 16:38:39 chuck last message repeated 3 times
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 500s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 18000s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 1s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
name_mask: subnet
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
inet_addr_local: configured 2 IPv4 addresses
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
been_here: 127.0.0.0/8: 0
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
been_here: 82.94.170.192/26: 0
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
mynetworks: 127.0.0.0/8 82.94.170.192/26
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 127.0.0.0/8 82.94.170.192/26
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 0s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 300s
Sep 8 16:38:39 chuck last message repeated 7 times
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 120s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 180s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 600s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 20s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 300s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 500s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 10s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 2s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 300s
Sep 8 16:38:39 chuck last message repeated 3 times
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 5s
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 90d
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const resource, software
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const postmaster
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const noplaintext, noanonymous
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $lmtp_sasl_security_options -> noplaintext,
noanonymous
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $lmtp_sasl_tls_security_options -> noplaintext,
noanonymous
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $lmtp_tls_cert_file ->
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $lmtp_tls_dcert_file ->
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const medium
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const SSLv3, TLSv1
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const hostname
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const nexthop
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const md5
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const !SSLv2
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const export
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $lmtp_tls_eccert_file ->
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const cyrus
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck last message repeated 1 time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: expand $myhostname -> chuck.redknot.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const dns
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const scache
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck last message repeated 4 times
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const canonical, virtual
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const 24
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const disable_esmtp,delay_dotcrlf
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
dict_eval: const
Sep 8 16:38:39 chuck last message repeated 7 times
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
process generation: 21 (21)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
match_string: fast_flush_domains ~? debug_peer_list
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
match_string: fast_flush_domains ~? fast_flush_domains
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
name_mask: canonical
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
name_mask: virtual
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
name_mask: dns
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] host
name lookup methods: dns
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
auto_clnt_create: transport=local endpoint=private/scache
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
connection established
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
master_notify: status 0
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
deliver_request_initial: send initial status
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] send
attr status = 0
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: flags
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: flags
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 3
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: queue_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: queue_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: active
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: queue_id
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: queue_id
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 167E810897
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: offset
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: offset
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 666
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: size
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: size
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 2401
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: nexthop
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: nexthop
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: [127.0.0.1]:10025
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: encoding
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: encoding
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: (end)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: sender
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: sender
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: martijndemun...@gmail.com
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: envelope_id
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: envelope_id
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: (end)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: ret_flags
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: ret_flags
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 0
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: time
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: TIef7wABYB1Mh5/vAATHoUyHn
+8ABRssAAAAAAAAAAAAAAAAAAAAAAAAAAA=
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: log_client_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: log_client_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: mail-yw0-f44.google.com
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: log_client_address
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: log_client_address
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 209.85.213.44
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: log_client_port
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: log_client_port
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 36919
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: log_protocol_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: log_protocol_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: ESMTP
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: log_helo_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: log_helo_name
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: mail-yw0-f44.google.com
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: sasl_method
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: sasl_method
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: (end)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: sasl_username
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: sasl_username
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: (end)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: sasl_sender
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: sasl_sender
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: (end)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: rewrite_context
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: rewrite_context
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: remote
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: recipient_count
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: recipient_count
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 1
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: (list terminator)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: (end)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: original_recipient
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: original_recipient
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: mart...@redknot.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: recipient
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: recipient
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: martijn_redknot...@chuck.redknot.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: offset
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: offset
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 4294967295
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: dsn_orig_rcpt
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: dsn_orig_rcpt
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: rfc822;mart...@redknot.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: notify_flags
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: notify_flags
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute value: 0
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] dspam-
lmtp socket: wanted attribute: (list terminator)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] input
attribute name: (end)
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
deliver_request_get: file active/167E810897
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
deliver_message: from martijndemun...@gmail.com
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
smtp_parse_destination: [127.0.0.1]:10025 24
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
connecting to 127.0.0.1 port 10025
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
smtp_addr_one: host 127.0.0.1
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] begin
127.0.0.1 address list
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
pref 0 host 127.0.0.1/127.0.0.1
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] end
127.0.0.1 address list
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
smtp_connect_addr: trying: 127.0.0.1[127.0.0.1] port 10025...
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
vstream_tweak_tcp: TCP_MAXSEG 8180
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
global TLS level: none
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 220 DSPAM LMTP 3.9.0 Ready
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] >
127.0.0.1[127.0.0.1]:10025: LHLO chuck.redknot.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 250-chuck.redknot.nl
myhostname = chuck.redknot.nl
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 250-PIPELINING
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 250-ENHANCEDSTATUSCODES
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 250-8BITMIME
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 250 SIZE
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info]
server features: 0x100f size 0
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] Using
LMTP PIPELINING, TCP send buffer size is 4096
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] >
127.0.0.1[127.0.0.1]:10025: MAIL FROM:<martijndemun...@gmail.com>
SIZE=2401
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] >
127.0.0.1[127.0.0.1]:10025: RCPT
TO:<martijn_redknot...@chuck.redknot.nl>
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] >
127.0.0.1[127.0.0.1]:10025: DATA
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 250 2.1.0 OK
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 250 2.1.5 OK
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] <
127.0.0.1[127.0.0.1]:10025: 354 Enter mail, end with "." on a line by
itself
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] >
127.0.0.1[127.0.0.1]:10025: .
Sep 8 16:38:39 chuck postfix/lmtp[24700]: [ID 197553 mail.info] >
127.0.0.1[127.0.0.1]:10025: QUIT
