Package: spamassassin Version: 3.2.5-6I have found that in some rare cases spamd does not send the checked mail back through sendmail. If is removed from postfix queue and never sent.
The example of failed delivery:Dec 16 18:27:48 centurion postfix/smtpd[9706]: connect from localhost[127.0.0.1] Dec 16 18:27:50 centurion postfix/smtpd[9706]: NOQUEUE: filter: RCPT from localhost[127.0.0.1]: <localhost[127.0.0.1]>: Client host triggers FILTER spamassassin:dummy; from=<dmitry.kats...@nbic.nl> to=<b.vanbreuke...@uu.nl> proto=ESMTP helo=<[127.0.0.1]> Dec 16 18:27:50 centurion postfix/smtpd[9706]: E3FDA600B8FA: client=localhost[127.0.0.1], sasl_method=PLAIN, sasl_username=dmi...@centurion Dec 16 18:27:51 centurion postfix/smtpd[9706]: E3FDA600B8FA: filter: RCPT from localhost[127.0.0.1]: <localhost[127.0.0.1]>: Client host triggers FILTER spamassassin:dummy; from=<dmitry.kats...@nbic.nl> to=<h.w.p.vandento...@uu.nl> proto=ESMTP helo=<[127.0.0.1]> Dec 16 18:27:51 centurion postfix/cleanup[9709]: E3FDA600B8FA: message-id=<4b291878.2020...@nbic.nl> Dec 16 18:27:51 centurion postfix/qmgr[4731]: E3FDA600B8FA: from=<dmitry.kats...@nbic.nl>, size=1969, nrcpt=2 (queue active) Dec 16 18:27:51 centurion spamd[2012]: spamd: connection from localhost [127.0.0.1] at port 38955 Dec 16 18:27:51 centurion spamd[2012]: spamd: handle_user unable to find user: 'H.W.P.vandenToorn' Dec 16 18:27:51 centurion spamd[2012]: spamd: still running as root: user not specified with -u, not found, or set to root, falling back to nobody Dec 16 18:27:51 centurion spamd[2012]: spamd: processing message <4b291878.2020...@nbic.nl> for H.W.P.vandenToorn:65534 Dec 16 18:27:52 centurion postfix/smtpd[9706]: disconnect from localhost[127.0.0.1] Dec 16 18:28:10 centurion spamd[2012]: auto-whitelist: open of auto-whitelist file failed: locker: safe_lock: cannot create tmp lockfile /nonexistent/.spamassassin/auto-whitelist.lock.centurion.dynalias.com.2012 for /nonexistent/.spamassassin/auto-whitelist.lock: No such file or directory Dec 16 18:28:10 centurion spamd[2012]: spamd: clean message (-101.4/5.0) for H.W.P.vandenToorn:65534 in 18.2 seconds, 1961 bytes. Dec 16 18:28:10 centurion spamd[2012]: spamd: result: . -101 - ALL_TRUSTED,USER_IN_WHITELIST scantime=18.2,size=1961,user=H.W.P.vandenToorn,uid=65534,required_score=5.0,rhost=localhost,raddr=127.0.0.1,rport=38955,mid=<4b291878.2020...@nbic.nl>,autolearn=failed Dec 16 18:28:10 centurion postfix/pipe[9710]: E3FDA600B8FA: to=<h.w.p.vandento...@uu.nl>, relay=spamassassin, delay=20, delays=1.3/0.02/0/18, dsn=2.0.0, status=sent (delivered via spamassassin service) Dec 16 18:28:10 centurion postfix/pipe[9710]: E3FDA600B8FA: to=<b.vanbreuke...@uu.nl>, relay=spamassassin, delay=20, delays=1.3/0.02/0/18, dsn=2.0.0, status=sent (delivered via spamassassin service)
Dec 16 18:28:10 centurion postfix/qmgr[4731]: E3FDA600B8FA: removed Dec 16 18:28:10 centurion spamd[1597]: prefork: child states: IIpostfix/pipe reports that the message was delivered to spamassassin, but it is never being piped to sendmail. strace of postfix is attached.
The example of successful delivery via spamassassin filter (with save configuration settings):
Dec 8 13:15:24 centurion postfix/smtpd[12361]: connect from localhost[127.0.0.1] Dec 8 13:15:27 centurion postfix/smtpd[12361]: NOQUEUE: filter: RCPT from localhost[127.0.0.1]: <localhost[127.0.0.1]>: Client host triggers FILTER spamassassin:dummy; from=<dm...@mail.ru> to=<pam...@yahoo.com> proto=ESMTP helo=<[127.0.0.1]> Dec 8 13:15:27 centurion postfix/smtpd[12361]: AE891600CF01: client=localhost[127.0.0.1], sasl_method=PLAIN, sasl_username=dmi...@centurion Dec 8 13:15:29 centurion postfix/cleanup[12365]: AE891600CF01: message-id=<4b1e426e.2020...@mail.ru> Dec 8 13:15:29 centurion postfix/qmgr[25264]: AE891600CF01: from=<dm...@mail.ru>, size=1750, nrcpt=1 (queue active) Dec 8 13:15:29 centurion spamd[321]: spamd: connection from localhost [127.0.0.1] at port 52403 Dec 8 13:15:29 centurion spamd[321]: spamd: handle_user unable to find user: 'pamitu' Dec 8 13:15:29 centurion spamd[321]: spamd: still running as root: user not specified with -u, not found, or set to root, falling back to nobody Dec 8 13:15:29 centurion spamd[321]: spamd: processing message <4b1e426e.2020...@mail.ru> for pamitu:65534 Dec 8 13:15:29 centurion postfix/smtpd[12361]: disconnect from localhost[127.0.0.1] Dec 8 13:15:53 centurion spamd[321]: auto-whitelist: open of auto-whitelist file failed: locker: safe_lock: cannot create tmp lockfile /nonexistent/.spamassassin/auto-whitelist.lock.centurion.dynalias.com.321 for /nonexistent/.spamassassin/auto-whitelist.lock: No such file or directory Dec 8 13:15:53 centurion spamd[321]: spamd: clean message (-1.4/5.0) for pamitu:65534 in 24.1 seconds, 1742 bytes. Dec 8 13:15:53 centurion spamd[321]: spamd: result: . -1 - ALL_TRUSTED scantime=24.1,size=1742,user=pamitu,uid=65534,required_score=5.0,rhost=localhost,raddr=127.0.0.1,rport=52403,mid=<4b1e426e.2020...@mail.ru>,autolearn=failed
Dec 8 13:15:53 centurion spamd[2684]: prefork: child states: IIDec 8 13:15:53 centurion postfix/pickup[11237]: 946D6600EFFD: uid=65534 from=<dm...@mail.ru> Dec 8 13:15:53 centurion postfix/cleanup[12365]: 946D6600EFFD: message-id=<4b1e426e.2020...@mail.ru> Dec 8 13:15:53 centurion postfix/pipe[12366]: AE891600CF01: to=<pam...@yahoo.com>, relay=spamassassin, delay=26, delays=2.1/0.06/0/24,dsn=2.0.0, status=sent (delivered via spamassassin service)
Dec 8 13:15:53 centurion postfix/qmgr[25264]: AE891600CF01: removedDec 8 13:15:53 centurion postfix/qmgr[25264]: 946D6600EFFD: from=<dm...@mail.ru>, size=2056, nrcpt=1 (queue active) Dec 8 13:15:55 centurion postfix/smtp[12380]: 946D6600EFFD: to=<pam...@yahoo.com>, relay=194.134.41.21[194.134.41.21]:25, delay=2.1, delays=0.1/0.02/1.1/0.89, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as AD1B66618F)
Dec 8 13:15:55 centurion postfix/qmgr[25264]: 946D6600EFFD: removed Additional information: # dpkg -l | egrep '(spam|postfix)' ii postfix 2.6.5-3 ii postfix-pcre 2.6.5-3 ii spamassassin 3.2.5-6 ii spamc 3.2.5-6 -- With best regards, Dmitry
postfix_config.tar.bz2
Description: Binary data
postfix.strace.gz
Description: application/gzip
