[Mimedefang] Killed mimedefang (Out of Memory)

Egon Gruber egon.gruber at sarnerweb.de
Mon Jun 6 05:12:50 EDT 2005 

Hello!

I work just for few years with mimedefang and spamassassin and our
spamfilter work very well.

The last week I update the mimedefang filter from the version 2.49  to
2.51 and spamassassin 3.0.3.

Before I installed mimedefang always to a OS Fedora Core, but since a 
month every
three or four days the server freeze and I could see only a lot of 
kernel messages
and I must make a hard reboot of the server. After then all work fine 
until the
next freeze in three days later.
So I change the OS to RedHat ES 4.0. on a 64 bit System.
For three days the installation work very well, but then I receive a lot 
of kernel messages
(see the following messages) and then mimedefang was killed. (but in 
/var/lock/subsys/mimedefang it
wasn't killed the file).

I make all the configuration like the HOWTO on:

http://www.mickeyhill.com/mimedefang-howto/

I have installed MTA sendmail with the following configuration:

INPUT_MAIL_FILTER(`mimedefang', 
`S=unix:/var/spool/MIMEDefang/mimedefang.sock, T=S:5m;R:5m')

I create a RAM-based spool directory of 500 MB.

**********************
/var/log/messages:
**********************

Jun  4 09:31:16 ms kernel: oom-killer: gfp_mask=0x1d2
Jun  4 09:31:16 ms kernel: Node 0 DMA per-cpu:
Jun  4 09:31:16 ms kernel: cpu 0 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 0 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: cpu 1 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 1 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: cpu 2 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 2 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: cpu 3 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 3 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: Node 0 Normal per-cpu:
Jun  4 09:31:16 ms kernel: cpu 0 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 0 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms kernel: cpu 1 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 1 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms kernel: cpu 2 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 2 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms kernel: cpu 3 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 3 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms kernel: Node 0 HighMem per-cpu: empty
Jun  4 09:31:16 ms kernel:
Jun  4 09:31:16 ms kernel: Free pages:        2604kB (0kB HighMem)
Jun  4 09:31:16 ms kernel: Active:1300279 inactive:208704 dirty:0 
writeback:0 unstable:0 free:651 slab:5223 mapped:1506283 pagetables:6208
Jun  4 09:31:16 ms kernel: Node 0 DMA free:4kB min:4kB low:8kB high:12kB 
active:6680kB inactive:4896kB present:16384kB
Jun  4 09:31:16 ms kernel: protections[]: 0 0 0
Jun  4 09:31:16 ms kernel: Node 0 Normal free:2600kB min:2652kB 
low:5304kB high:7956kB active:5194844kB inactive:829408kB present:7061504kB
Jun  4 09:31:16 ms kernel: protections[]: 0 0 0
Jun  4 09:31:16 ms kernel: Node 0 HighMem free:0kB min:128kB low:256kB 
high:384kB active:0kB inactive:0kB present:0kB
Jun  4 09:31:16 ms kernel: protections[]: 0 0 0
Jun  4 09:31:16 ms kernel: Node 0 DMA: 1*4kB 0*8kB 0*16kB 0*32kB 0*64kB 
0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4kB
Jun  4 09:31:16 ms kernel: Node 0 Normal: 0*4kB 1*8kB 0*16kB 1*32kB 
0*64kB 0*128kB 0*256kB 1*512kB 0*1024kB 1*2048kB 0*4096kB = 2600kB
Jun  4 09:31:16 ms kernel: Node 0 HighMem: empty
Jun  4 09:31:16 ms kernel: Swap cache: add 7657, delete 7657, find 
1337/1680, race 0+0
Jun  4 09:31:16 ms kernel: Out of Memory: Killed process 8667 (mimedefang).
Jun  4 09:31:16 ms kernel: oom-killer: gfp_mask=0x1d2
Jun  4 09:31:16 ms kernel: Node 0 DMA per-cpu:
Jun  4 09:31:16 ms kernel: cpu 0 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 0 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: cpu 1 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 1 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: cpu 2 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 2 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: cpu 3 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 3 cold: low 0, high 2, batch 1
Jun  4 09:31:16 ms kernel: Node 0 Normal per-cpu:
Jun  4 09:31:16 ms kernel: cpu 0 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 0 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms kernel: cpu 1 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 1 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms kernel: cpu 2 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 2 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms clamd[4657]: Client disconnected
Jun  4 09:31:16 ms kernel: cpu 3 hot: low 32, high 96, batch 16
Jun  4 09:31:16 ms kernel: cpu 3 cold: low 0, high 32, batch 16
Jun  4 09:31:16 ms kernel: Node 0 HighMem per-cpu: empty
Jun  4 09:31:16 ms kernel:
Jun  4 09:31:16 ms kernel: Free pages:        2644kB (0kB HighMem)
Jun  4 09:31:16 ms kernel: Active:1051152 inactive:457653 dirty:0 
writeback:0 unstable:0 free:661 slab:5220 mapped:1506283 pagetables:6208
Jun  4 09:31:16 ms kernel: Node 0 DMA free:4kB min:4kB low:8kB high:12kB 
active:6704kB inactive:4872kB present:16384kB
Jun  4 09:31:16 ms kernel: protections[]: 0 0 0
Jun  4 09:31:16 ms kernel: Node 0 Normal free:2640kB min:2652kB 
low:5304kB high:7956kB active:4197400kB inactive:1826172kB present:7061504kB
Jun  4 09:31:16 ms kernel: protections[]: 0 0 0
Jun  4 09:31:16 ms kernel: Node 0 HighMem free:0kB min:128kB low:256kB 
high:384kB active:0kB inactive:0kB present:0kB
Jun  4 09:31:16 ms kernel: protections[]: 0 0 0
Jun  4 09:31:16 ms kernel: Node 0 DMA: 1*4kB 0*8kB 0*16kB 0*32kB 0*64kB 
0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4kB
Jun  4 09:31:16 ms kernel: Node 0 Normal: 0*4kB 4*8kB 1*16kB 1*32kB 
0*64kB 0*128kB 0*256kB 1*512kB 0*1024kB 1*2048kB 0*4096kB = 2640kB
Jun  4 09:31:16 ms kernel: Node 0 HighMem: empty
Jun  4 09:31:16 ms kernel: Swap cache: add 7657, delete 7657, find 
1337/1680, race 0+0
Jun  4 09:31:16 ms kernel: Out of Memory: Killed process 8715 (mimedefang).
Jun  4 09:31:16 ms kernel: oom-killer: gfp_mask=0x1d2
Jun  4 09:31:16 ms kernel: Node 0 DMA per-cpu:
Jun  4 09:31:16 ms kernel: cpu 0 hot: low 2, high 6, batch 1
Jun  4 09:31:16 ms kernel: cpu 0 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: cpu 1 hot: low 2, high 6, batch 1
Jun  4 09:31:17 ms kernel: cpu 1 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: cpu 2 hot: low 2, high 6, batch 1
Jun  4 09:31:17 ms kernel: cpu 2 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: cpu 3 hot: low 2, high 6, batch 1
Jun  4 09:31:17 ms kernel: cpu 3 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: Node 0 Normal per-cpu:
Jun  4 09:31:17 ms kernel: cpu 0 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 0 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: cpu 1 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 1 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: cpu 2 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 2 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: cpu 3 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 3 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: Node 0 HighMem per-cpu: empty
Jun  4 09:31:17 ms kernel:
Jun  4 09:31:17 ms kernel: Free pages:        2644kB (0kB HighMem)
Jun  4 09:31:17 ms kernel: Active:1047955 inactive:461348 dirty:0 
writeback:0 unstable:0 free:661 slab:5220 mapped:1506283 pagetables:6208
Jun  4 09:31:17 ms kernel: Node 0 DMA free:4kB min:4kB low:8kB high:12kB 
active:8728kB inactive:2848kB present:16384kB
Jun  4 09:31:17 ms kernel: protections[]: 0 0 0
Jun  4 09:31:17 ms kernel: Node 0 Normal free:2640kB min:2652kB 
low:5304kB high:7956kB active:4183076kB inactive:1842416kB present:7061504kB
Jun  4 09:31:17 ms kernel: protections[]: 0 0 0
Jun  4 09:31:17 ms kernel: Node 0 HighMem free:0kB min:128kB low:256kB 
high:384kB active:0kB inactive:0kB present:0kB
Jun  4 09:31:17 ms kernel: protections[]: 0 0 0
Jun  4 09:31:17 ms kernel: Node 0 DMA: 1*4kB 0*8kB 0*16kB 0*32kB 0*64kB 
0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4kB
Jun  4 09:31:17 ms kernel: Node 0 Normal: 0*4kB 4*8kB 1*16kB 1*32kB 
0*64kB 0*128kB 0*256kB 1*512kB 0*1024kB 1*2048kB 0*4096kB = 2640kB
Jun  4 09:31:17 ms kernel: Node 0 HighMem: empty
Jun  4 09:31:17 ms kernel: Swap cache: add 7657, delete 7657, find 
1337/1680, race 0+0
Jun  4 09:31:17 ms kernel: Out of Memory: Killed process 8757 
(mimedefang.pl).
Jun  4 09:31:17 ms kernel: oom-killer: gfp_mask=0x1d2
Jun  4 09:31:17 ms kernel: Node 0 DMA per-cpu:
Jun  4 09:31:17 ms kernel: cpu 0 hot: low 2, high 6, batch 1
Jun  4 09:31:17 ms kernel: cpu 0 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: cpu 1 hot: low 2, high 6, batch 1
Jun  4 09:31:17 ms kernel: cpu 1 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: cpu 2 hot: low 2, high 6, batch 1
Jun  4 09:31:17 ms kernel: cpu 2 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: cpu 3 hot: low 2, high 6, batch 1
Jun  4 09:31:17 ms kernel: cpu 3 cold: low 0, high 2, batch 1
Jun  4 09:31:17 ms kernel: Node 0 Normal per-cpu:
Jun  4 09:31:17 ms kernel: cpu 0 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 0 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: cpu 1 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 1 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: cpu 2 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 2 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: cpu 3 hot: low 32, high 96, batch 16
Jun  4 09:31:17 ms kernel: cpu 3 cold: low 0, high 32, batch 16
Jun  4 09:31:17 ms kernel: Node 0 HighMem per-cpu: empty
Jun  4 09:31:17 ms kernel:
Jun  4 09:31:17 ms kernel: Free pages:        2644kB (0kB HighMem)
Jun  4 09:31:17 ms kernel: Active:745500 inactive:763979 dirty:0 
writeback:0 unstable:0 free:661 slab:5221 mapped:1506283 pagetables:6208
Jun  4 09:31:17 ms kernel: Node 0 DMA free:4kB min:4kB low:8kB high:12kB 
active:9160kB inactive:2416kB present:16384kB
Jun  4 09:31:17 ms kernel: protections[]: 0 0 0
Jun  4 09:31:17 ms kernel: Node 0 Normal free:2640kB min:2652kB 
low:5304kB high:7956kB active:2972392kB inactive:3053756kB present:7061504kB
Jun  4 09:31:17 ms kernel: protections[]: 0 0 0
Jun  4 09:31:17 ms kernel: Node 0 HighMem free:0kB min:128kB low:256kB 
high:384kB active:0kB inactive:0kB present:0kB
Jun  4 09:31:17 ms kernel: protections[]: 0 0 0
Jun  4 09:31:17 ms kernel: Node 0 DMA: 1*4kB 0*8kB 0*16kB 0*32kB 0*64kB 
0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4kB
Jun  4 09:31:17 ms crond(pam_unix)[9249]: session closed for user root
Jun  4 09:31:17 ms kernel: Node 0 Normal: 0*4kB 4*8kB 1*16kB 1*32kB 
0*64kB 0*128kB 0*256kB 1*512kB 0*1024kB 1*2048kB 0*4096kB = 2640kB
Jun  4 09:31:17 ms kernel: Node 0 HighMem: empty
Jun  4 09:31:17 ms kernel: Swap cache: add 7657, delete 7657, find 
1337/1680, race 0+0
Jun  4 09:31:17 ms kernel: Out of Memory: Killed process 23779 
(mimedefang.pl).
**********************



**********************
/var/log/maillog
**********************
Jun  4 09:25:11 ms-b1 sendmail[9234]: j547P9f3009225: 
to=<issovr at example.com>, delay=00:00:02, xdelay=00:00:00, mailer=relay, 
pri=123357, relay=ms.example.com. [62.101.0.5], dsn=2.0.0, stat=Sent 
(j547PBb06933
 Message accepted for delivery)
Jun  4 09:25:12 ms-b1 sendmail[9230]: j547NUA9008733: 
to=<gsd at example.com>, delay=00:01:42, xdelay=00:00:03, mailer=relay, 
pri=185033, relay=ms.example.com. [62.101.0.5], dsn=2.0.0, stat=Sent 
(j547PCb06940
Message accepted for delivery)
Jun  4 09:25:12 ms-b1 mimedefang-multiplexor[4757]: Slave 32 stderr: 
Pyzor -> check failed: Can't fork at 
/usr/lib/perl5/vendor_perl/5.8.5/Mail/SpamAssassin/Util.pm line 1017.
Jun  4 09:25:13 ms-b1 mimedefang-multiplexor[4757]: Slave 32 stderr: DCC 
-> check failed: Can't fork at 
/usr/lib/perl5/vendor_perl/5.8.5/Mail/SpamAssassin/Util.pm line 1017.
Jun  4 09:25:13 ms-b1 mimedefang.pl[19147]: spam-info: 
-0.236/7.5,j547NXvC008789,<news at cgilscuola.it>,BAYES_00,FRONTPAGE,HTML_FONT_BIG,HTML_MESSAGE,HTML_SHOUTING3,HTML_TAG_EXIST_TBODY,NO_REAL_NAME 

Jun  4 09:25:13 ms-b1 mimedefang[4773]: j547NXvC008789: Filter time is 
16396ms
Jun  4 09:28:37 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
56 (pid 6547): Busy timeout
Jun  4 09:31:15 ms-b1 sendmail[8796]: j547NXs4008796: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:15 ms-b1 sendmail[8796]: j547NXs4008796: Milter 
(mimedefang): to error state
Jun  4 09:31:15 ms-b1 sendmail[9097]: j547Om6G009097: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:15 ms-b1 sendmail[9097]: j547Om6G009097: Milter 
(mimedefang): to error state
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
40 (pid 8748): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
27 (pid 8738): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 6 
(pid 8739): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 3 
(pid 8737): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 56 (pid 6547) 
taking way too long to exit; sending SIGKILL
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
60 (pid 19171): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
35 (pid 19152): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
65 (pid 19175): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
62 (pid 19172): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
51 (pid 19148): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
23 (pid 8770): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 5 
(pid 8786): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
41 (pid 8775): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
42 (pid 8801): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
43 (pid 8795): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
59 (pid 19151): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
24 (pid 8769): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
12 (pid 8761): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
11 (pid 8764): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
17 (pid 8776): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
19 (pid 8759): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
21 (pid 8757): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
20 (pid 8743): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
69 (pid 19149): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 8 
(pid 8765): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
66 (pid 19173): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Killing busy slave 
57 (pid 19150): Busy timeout
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Idle slave 38 
(pid 23779) exited due to signal 9 (SLAVE DIED UNEXPECTEDLY)
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 38 resource 
usage: req=4, scans=1, user=7.431, sys=0.460, nswap=0, majflt=0, 
minflt=54240, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
51 (pid 19148) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 51 resource 
usage: req=33, scans=10, user=12.136, sys=0.931, nswap=0, majflt=7, 
minflt=136195, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 sendmail[8704]: j547NT4e008704: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:15 ms-b1 sendmail[8704]: j547NT4e008704: Milter 
(mimedefang): to error state
Jun  4 09:31:15 ms-b1 sendmail[8734]: j547NUNR008734: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:15 ms-b1 sendmail[8734]: j547NUNR008734: Milter 
(mimedefang): to error state
Jun  4 09:31:15 ms-b1 sendmail[8747]: j547NXar008747: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:15 ms-b1 sendmail[8747]: j547NXar008747: Milter 
(mimedefang): to error state
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
21 (pid 8757) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 21 resource 
usage: req=6, scans=2, user=7.653, sys=22.458, nswap=0, majflt=20, 
minflt=48818, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
69 (pid 19149) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 69 resource 
usage: req=16, scans=6, user=12.963, sys=16.257, nswap=0, majflt=41, 
minflt=96032, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
57 (pid 19150) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 57 resource 
usage: req=14, scans=4, user=11.670, sys=19.504, nswap=0, majflt=28, 
minflt=70769, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
59 (pid 19151) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 59 resource 
usage: req=12, scans=4, user=11.649, sys=19.505, nswap=0, majflt=3, 
minflt=71379, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 5 
(pid 8786) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 5 resource 
usage: req=5, scans=2, user=6.088, sys=18.777, nswap=0, majflt=16, 
minflt=45267, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
66 (pid 19173) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 66 resource 
usage: req=15, scans=5, user=7.690, sys=14.218, nswap=0, majflt=11, 
minflt=68924, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
23 (pid 8770) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 23 resource 
usage: req=3, scans=1, user=6.335, sys=15.152, nswap=0, majflt=6, 
minflt=45847, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 sendmail[8745]: j547NViu008745: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:15 ms-b1 sendmail[8745]: j547NViu008745: Milter 
(mimedefang): to error state
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
12 (pid 8761) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:15 ms-b1 mimedefang-multiplexor[4757]: Slave 12 resource 
usage: req=5, scans=1, user=6.251, sys=13.984, nswap=0, majflt=31, 
minflt=45866, maxrss=0, bi=0, bo=0
Jun  4 09:31:15 ms-b1 sendmail[9279]: j547NXs4008796: 
to=<ssp at example.com.it>, delay=00:06:55, xdelay=00:00:00, mailer=relay, 
pri=185030, relay=ms.example.com. [62.101.0.5], dsn=2.0.0, stat=Sent 
(j547VFb07768 Mes
sage accepted for delivery)
Jun  4 09:31:15 ms-b1 sendmail[8771]: j547NWR3008771: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:15 ms-b1 sendmail[8771]: j547NWR3008771: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8762]: j547NWHn008762: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8762]: j547NWHn008762: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8808]: j547NYR9008808: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8808]: j547NYR9008808: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8740]: j547NWxj008740: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8740]: j547NWxj008740: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
27 (pid 8738) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 27 resource 
usage: req=1, scans=1, user=6.148, sys=17.726, nswap=0, majflt=7, 
minflt=45038, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 sendmail[9292]: j547NUNR008734: 
to=<gsd at example.com.it>, delay=00:07:46, xdelay=00:00:01, mailer=relay, 
pri=185033, relay=ms.example.com. [62.101.0.5], dsn=2.0.0, stat=Sent 
(j547VFb07781
Message accepted for delivery)
Jun  4 09:31:16 ms-b1 sendmail[8780]: j547NWKa008780: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8811]: j547NY2f008811: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8811]: j547NY2f008811: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9280]: j547VF9g009280: Milter 
(mimedefang): read returned -1: Connection reset by ms.example.com
Jun  4 09:31:16 ms-b1 sendmail[9280]: j547VF9g009280: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9280]: j547VF9g009280: Milter 
(mimedefang): init failed to open
Jun  4 09:31:16 ms-b1 sendmail[9280]: j547VF9g009280: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9280]: j547VF9g009280: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9277]: j547VFmH009277: Milter 
(mimedefang): read returned -1: Connection reset by ms.example.com
Jun  4 09:31:16 ms-b1 sendmail[9277]: j547VFmH009277: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9277]: j547VFmH009277: Milter 
(mimedefang): init failed to open
Jun  4 09:31:16 ms-b1 sendmail[9277]: j547VFmH009277: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9294]: j547NXar008747: 
to=<ssp at example.com.it>, delay=00:06:44, xdelay=00:00:01, mailer=relay, 
pri=185034, relay=ms.example.com. [62.101.0.5], dsn=2.0.0, stat=Sent 
(j547VFb07782
 Message accepted for delivery)
Jun  4 09:31:16 ms-b1 sendmail[9296]: j547NT4e008704: 
to=<fos at example.com.it>, delay=00:07:47, xdelay=00:00:01, mailer=relay, 
pri=185031, relay=ms.example.com. [62.101.0.5], dsn=2.0.0, stat=Sent 
(j547VFb07783 Me
ssage accepted for delivery)
Jun  4 09:31:16 ms-b1 sendmail[8805]: j547NXF2008805: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8805]: j547NXF2008805: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9297]: j547VGt1009297: Milter 
(mimedefang): error connecting to filter: Connection refused by 
/var/spool/MIMEDefang/mimedefang.sock
Jun  4 09:31:16 ms-b1 sendmail[9297]: j547VGt1009297: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9297]: j547VGt1009297: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9298]: j547VGkL009298: Milter 
(mimedefang): error connecting to filter: Connection refused by 
/var/spool/MIMEDefang/mimedefang.sock
Jun  4 09:31:16 ms-b1 sendmail[9298]: j547VGkL009298: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9298]: j547VGkL009298: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[8772]: j547NWZI008772: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8772]: j547NWZI008772: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8708]: j547NWSr008708: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8708]: j547NWSr008708: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8746]: j547NVVv008746: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8746]: j547NVVv008746: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8763]: j547NWbY008763: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8763]: j547NWbY008763: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9302]: j547VGDc009302: Milter 
(mimedefang): error connecting to filter: Connection refused by 
/var/spool/MIMEDefang/mimedefang.sock
Jun  4 09:31:16 ms-b1 sendmail[9302]: j547VGDc009302: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8788]: j547NW2T008788: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8741]: j547NW9K008741: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8741]: j547NW9K008741: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
35 (pid 19152) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 35 resource 
usage: req=6, scans=2, user=10.387, sys=11.857, nswap=0, majflt=4, 
minflt=58698, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
60 (pid 19171) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 60 resource 
usage: req=5, scans=2, user=11.311, sys=15.176, nswap=0, majflt=68, 
minflt=60060, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
62 (pid 19172) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 62 resource 
usage: req=3, scans=2, user=11.183, sys=11.828, nswap=0, majflt=14, 
minflt=59132, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
65 (pid 19175) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 65 resource 
usage: req=9, scans=2, user=11.320, sys=16.747, nswap=0, majflt=3, 
minflt=59622, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
56 (pid 6547) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 sendmail[9301]: j547VGca009301: Milter 
(mimedefang): error connecting to filter: Connection refused by 
/var/spool/MIMEDefang/mimedefang.sock
Jun  4 09:31:16 ms-b1 sendmail[9301]: j547VGca009301: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8788]: j547NW2T008788: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9244]: j547VGsk009244: Milter 
(mimedefang): error connecting to filter: Connection refused by 
/var/spool/MIMEDefang/mimedefang.sock
Jun  4 09:31:16 ms-b1 sendmail[9277]: j547VFmH009277: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9281]: j547VFfu009281: Milter 
(mimedefang): read returned -1: Connection reset by ms.example.com
Jun  4 09:31:16 ms-b1 sendmail[9281]: j547VFfu009281: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9281]: j547VFfu009281: Milter 
(mimedefang): init failed to open
Jun  4 09:31:16 ms-b1 sendmail[9281]: j547VFfu009281: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9281]: j547VFfu009281: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9282]: j547VF14009282: Milter 
(mimedefang): read returned -1: Connection reset by ms.example.com
Jun  4 09:31:16 ms-b1 sendmail[9282]: j547VF14009282: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9282]: j547VF14009282: Milter 
(mimedefang): init failed to open
Jun  4 09:31:16 ms-b1 sendmail[9282]: j547VF14009282: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9282]: j547VF14009282: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9283]: j547VFiB009283: Milter 
(mimedefang): read returned -1: Connection reset by ms.example.com
Jun  4 09:31:16 ms-b1 sendmail[9283]: j547VFiB009283: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9283]: j547VFiB009283: Milter 
(mimedefang): init failed to open
Jun  4 09:31:16 ms-b1 sendmail[9283]: j547VFiB009283: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9283]: j547VFiB009283: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9245]: j547VF1S009245: Milter 
(mimedefang): read returned -1: Connection reset by ms.example.com
Jun  4 09:28:42 ms-b1 sendmail[8726]: j547NUnb008726: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8726]: j547NUnb008726: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9300]: j547VGAF009300: Milter 
(mimedefang): error connecting to filter: Connection refused by 
/var/spool/MIMEDefang/mimedefang.sock
Jun  4 09:31:16 ms-b1 sendmail[9245]: j547VF1S009245: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9299]: j547VGmb009299: Milter 
(mimedefang): error connecting to filter: Connection refused by 
/var/spool/MIMEDefang/mimedefang.sock
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 56 resource 
usage: req=1, scans=1, user=6.547, sys=12.949, nswap=0, majflt=4, 
minflt=48558, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 sendmail[9244]: j547VGsk009244: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9240]: j547PEu1009240: Milter 
(mimedefang): read returned -1: Connection reset by ms.example.com
Jun  4 09:31:16 ms-b1 sendmail[9240]: j547PEu1009240: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8780]: j547NWKa008780: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8749]: j547NW2k008749: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8749]: j547NW2k008749: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8659]: j547NQaW008659: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8659]: j547NQaW008659: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9300]: j547VGAF009300: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9245]: j547VF1S009245: Milter 
(mimedefang): init failed to open
Jun  4 09:31:16 ms-b1 sendmail[9299]: j547VGmb009299: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 6 
(pid 8739) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 6 resource 
usage: req=1, scans=1, user=6.485, sys=20.898, nswap=0, majflt=13, 
minflt=46579, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Reap: Killed slave 
20 (pid 8743) exited due to SIGTERM/SIGKILL as expected.
Jun  4 09:31:16 ms-b1 mimedefang-multiplexor[4757]: Slave 20 resource 
usage: req=10, scans=3, user=7.146, sys=24.985, nswap=0, majflt=8, 
minflt=58898, maxrss=0, bi=0, bo=0
Jun  4 09:31:16 ms-b1 sendmail[8802]: j547NXQ6008802: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8802]: j547NXQ6008802: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8799]: j547NXsO008799: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[9245]: j547VF1S009245: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9245]: j547VF1S009245: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9299]: j547VGmb009299: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[8750]: j547NWaV008750: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[9300]: j547VGAF009300: 
from=<e.g.vogel at t-online.de>, size=35304, class=0, nrcpts=1, 
msgid=<200506040726.j547QBo07057 at ms.example.com>, proto=ESMTP, 
daemon=MTA, relay=ms.example.com [62.101.0
.5]
Jun  4 09:31:16 ms-b1 sendmail[9300]: j547VGAF009300: 
to=<sa at example.com.it>, delay=00:00:00, mailer=relay, pri=65304, stat=queued
Jun  4 09:31:16 ms-b1 sendmail[9244]: j547VGsk009244: ms.example.com 
[62.101.0.5] did not issue MAIL/EXPN/VRFY/ETRN during connection to MTA
Jun  4 09:31:16 ms-b1 sendmail[9239]: j547PEn2009239: Milter 
(mimedefang): write(D) returned -1, expected 113: Broken pipe
Jun  4 09:31:16 ms-b1 sendmail[9239]: j547PEn2009239: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8725]: j547NUx9008725: Milter 
(mimedefang): timeout before data read
Jun  4 09:31:16 ms-b1 sendmail[8725]: j547NUx9008725: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8799]: j547NXsO008799: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[8750]: j547NWaV008750: Milter 
(mimedefang): to error state
Jun  4 09:31:16 ms-b1 sendmail[9302]: j547VGDc009302: 
from=<csa.fe at istruzione.it>, size=41901, class=0, nrcpts=1, 
msgid=<200506040726.j547QKo07083 at ms.example.com>, proto=ESMTP, 
daemon=MTA, relay=ms.example.com [62.101.0.
5]

**********************
I have 3 questions:

1. Because the OS killed mimedefang (receive Out of Memory: Killed 
process)? It is a problem with the configurations and how I could 
resolve my problem that in
   the future mimedefang wasn't killed from the OS?
2. After killing mimedefang sendmail write the mail to our mailboxes, 
without antiviruscheck and without spamfiltering. If mimedefang is killed,
   how could say sendmail to write all the mail in his mailq or go to 
error-state? So we have a problem if in the future mimedefang is killed
   and all the mailtraffic goes without antivirus- and antispamfitering. 
Is there a solution?
3. Have other people problems with freeze system on fedora 2, too?

Thanks in advance,
Egon

More information about the MIMEDefang mailing list