It started as an operator error, albiet an unexpected one.

I had 3 IP addresses for our mailserver, one "primary"
which receives mail "from outside", one "internal", and
I added another, to which I pointed secondary MX to, in
order to test postscreen.

So it worked quite well for some time, and I decided to
switch primary MX (the same host!) to use postscreen
too.

So I added second postscreen line into main.cf, with the
primary MX IP, and the rest of the line being the same
as for the other postscreen entry.

I watched it for a while, it all worked well.

But at the next day I found out that our mailserver is
at higher than usual load and our maillog is filled up
(2Gb without O_LARGEFILES).

First problematic log series was small:

Apr  2 07:18:36 isrv postfix/postscreen[27447]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 196.203.156.75
Apr  2 07:18:36 isrv postfix/postscreen[27447]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 204.110.60.86
Apr  2 07:18:36 isrv postfix/postscreen[27447]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 41.68.21.167
Apr  2 07:18:36 isrv postfix/postscreen[27447]: cache 
/var/lib/postfix/postscreen_cache.db full cleanup: retained=765 dropped=5 
entries

But second series is where the problem started:

Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.136.166.127
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.254.94.254
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.136.166.127
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.254.94.254
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.136.166.127
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.254.94.254
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.136.166.127
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.254.94.254
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.136.166.127
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.254.94.254
Apr  3 00:34:03 isrv postfix/postscreen[1817]: warning: database 
/var/lib/postfix/postscreen_cache.db: could not delete entry for 213.136.166.127
[.....]

This goes on and on and on, it is sitting there trying
to remove the two entries ad infinitum, but meanwhile
processes incoming connections -- so email works still.

libdb used is this one:
 ii  libdb4.8    4.8.30-2    Berkeley v4.8 Database Libraries [runtime]
and postfix is 2.8.2.

I haven't tried to debug the issue yet, -- had no time
to investigate when it happened, I just removed second
postscreen entry and postscren_cache.db (the latter were
recreated on next restart).  So this is just a heads-up
for now, without any useful information.  Hopefully I'll
be able to provide something in a few days.

Thanks!

/mjt

Reply via email to