Hi there,
We recently switched to qpsmtpd-prefork because we noticed we could
handle about twice as many connections.
Since we're using prefork, we get a lot of these "Could not print" erros
in the logs, looking like:
Could not print [220 smtp.domain.com ESMTP]
It occurs random, a full debug log of such a connection looks like:
Feb 13 22:13:38 mail qpsmtpd[78914]: Connection from host.domain.com
[123.123.123.123]
Feb 13 22:13:38 mail qpsmtpd[78914]: dnsbl
Feb 13 22:13:38 mail qpsmtpd[78914]: RBLSMTPD not set for 123.123.123.123
Feb 13 22:13:38 mail qpsmtpd[78914]: trying to get config for dnsbl_allow
Feb 13 22:13:38 mail qpsmtpd[78914]: trying to get config for dnsbl_zones
Feb 13 22:13:38 mail qpsmtpd[78914]: Checking
123.123.123.123.relays.dnsbl.sorbs.net for A record in the background
Feb 13 22:13:38 mail qpsmtpd[78914]: Checking
123.123.123.123.list.dsbl.org for A record in the background
Feb 13 22:13:38 mail qpsmtpd[78914]: Checking
123.123.123.123.sbl-xbl.spamhaus.org for A record in the background
Feb 13 22:13:38 mail qpsmtpd[78914]: Plugin dnsbl, hook connect returned
DECLINED,
Feb 13 22:13:38 mail qpsmtpd[78914]: count_unrecognized_commands
Feb 13 22:13:38 mail qpsmtpd[78914]: Plugin count_unrecognized_commands,
hook connect returned DECLINED,
Feb 13 22:13:38 mail qpsmtpd[78914]: check_earlytalker
Feb 13 22:13:39 mail qpsmtpd[78914]: remote host said nothing
spontaneous, proceeding
Feb 13 22:13:39 mail qpsmtpd[78914]: Plugin check_earlytalker, hook
connect returned DECLINED,
Feb 13 22:13:39 mail qpsmtpd[78914]: trying to get config for smtpgreeting
Feb 13 22:13:39 mail qpsmtpd[78914]: 220 mail.argewebhosting.nl ESMTP
Feb 13 22:13:39 mail qpsmtpd[78914]: Could not print [220
smtp.domain.com ESMTP]:
Feb 13 22:13:39 mail qpsmtpd[78914]: trying to get config for timeoutsmtpd
The plugins we use:
dnsbl
count_unrecognized_commands
check_earlytalker
check_spamhelo
require_resolvable_host
vpopmail
rcpt_ok
check_basicheaders 7
virus/clamav clamd_conf=/usr/local/etc/clamd.conf
clamscan_path=/usr/local/bin/clamdscan action=reject
queue/qmail-queue
The errors occur while connecting, before check_earlytalker, the 220
simply doesn't show.
These errors off course, delay the mail delivery. The logtype is already
"DEBUG" and not helping very much a this point...
We're using the qpsmtpd-03x branch from SVN.
It happens on al 8 of our mailservers, from different IP's, it's also
reproducable (just connect a bunch of times, from the 40 connects, about
4 gave me a timeout).
I'd be happy to hear some suggestions!
Regards,
Ruben van der Zwan
