[milters] Archive

Lists Index Date Thread Search

Article: 34
From: Pfeiffer, Sebastian (BREKOM)
Date: 2009-07-21 04:58:48 -0400
Subject: Milter-gris and new libsnert

Hi!

I'm running milter-gris-0.21.115 with libsnert-1.66.950 and sendmail-8.13 in production on Debian Etch since many months. I'm testing a new server with milter-gris-0.21.116 with no success. Starting with an empty db (no db file at all), no greylisting occurs. Going back to milter-gris-0.21.115 and exactly the same config shows the desired results, so I suspect a problem with the current version of milter-gris.

Sebastian Pfeiffer

Test with libsnert-1.66.950 and milter-gris-0.21.116:
Jul 20 15:41:40 mail01 milter-gris[533]: 00001 NOQUEUE: filterOpen(107d3d0, 'dyndsl-095-033-066-074.ewe-ip-backbone.de', [95.33.66.74])
Jul 20 15:41:40 mail01 milter-gris[533]: 00001 NOQUEUE: enter smfAccessClient(107d690, milter-gris-connect:, dyndsl-095-033-066-074.ewe-ip-backbone.de, 95.33.66.74, 0, 0)
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=31:"milter-gris-connect:95.33.66.74" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=28:"milter-gris-connect:95.33.66" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=25:"milter-gris-connect:95.33" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=22:"milter-gris-connect:95" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=61:"milter-gris-connect:dyndsl-095-033-066-074.ewe-ip-backbone.de" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=38:"milter-gris-connect:ewe-ip-backbone.de" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=22:"milter-gris-connect:de" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=20:"milter-gris-connect:" value="" rc=-2
Jul 20 15:41:40 mail01 milter-gris[533]: 00001 NOQUEUE: enter smfAccessPattern(107d690, "dyndsl-095-033-066-074.ewe-ip-backbone.de", "(NULL)...",
0)
Jul 20 15:41:40 mail01 milter-gris[533]: 00001 NOQUEUE: exit  smfAccessPattern(107d690, "dyndsl-095-033-066-074.ewe-ip-backbone.de", "(NULL)...",
0) rc=_ action=''
Jul 20 15:41:40 mail01 milter-gris[533]: 00001 NOQUEUE: enter smfAccessPattern(107d690, "95.33.66.74", "(NULL)...", 0)
Jul 20 15:41:40 mail01 milter-gris[533]: 00001 NOQUEUE: exit  smfAccessPattern(107d690, "95.33.66.74", "(NULL)...", 0) rc=_ action=''
Jul 20 15:41:40 mail01 milter-gris[533]: 00001 NOQUEUE: exit  smfAccessClient(107d690, milter-gris-connect:, dyndsl-095-033-066-074.ewe-ip-backbone.de, 95.33.66.74, 0, 0) access=95
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=19:"connect:95.33.66.74" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=16:"connect:95.33.66" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=13:"connect:95.33" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=10:"connect:95" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=49:"connect:dyndsl-095-033-066-074.ewe-ip-backbone.de" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=26:"connect:ewe-ip-backbone.de" value=""
Jul 20 15:41:40 mail01 milter-gris[533]: map="access" key=10:"connect:de" value=""
Jul 20 15:41:44 mail01 milter-gris[533]: 00001 NOQUEUE: filterHelo(107d3d0, 'alkfdj')
Jul 20 15:41:54 mail01 milter-gris[533]: 00001 n6KDfeRr000544: filterMail(107d3d0, 107ebe0) MAIL='<x@4e4.de>' <BLOCKED::mailto:x@4e4.de>'>
Jul 20 15:41:54 mail01 milter-gris[533]: 00001 n6KDfeRr000544: address='x@4e4.de' <BLOCKED::mailto:address='x@4e4.de'>  localleft='x' localright='' domain='4e4.de' auth='(NULL)'
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=25:"milter-gris-from:x@4e4.de" value=""
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=23:"milter-gris-from:4e4.de" value=""
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=19:"milter-gris-from:de" value=""
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=19:"milter-gris-from:x@" value=""
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=17:"milter-gris-from:" value="" rc=-2
Jul 20 15:41:54 mail01 milter-gris[533]: 00001 n6KDfeRr000544: enter smfAccessPattern(107d690, "x@4e4.de <BLOCKED::mailto:x@4e4.de> ",
"(NULL)...", 0)
Jul 20 15:41:54 mail01 milter-gris[533]: 00001 n6KDfeRr000544: exit  smfAccessPattern(107d690, "x@4e4.de <BLOCKED::mailto:x@4e4.de> ",
"(NULL)...", 0) rc=_ action=''
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=13:"from:x@4e4.de" value=""
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=11:"from:4e4.de" value=""
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=7:"from:de"
value=""
Jul 20 15:41:54 mail01 milter-gris[533]: map="access" key=7:"from:x@"
value=""
Jul 20 15:41:54 mail01 milter-gris[533]: 00001 n6KDfeRr000544: sender=<x@4e4.de <BLOCKED::mailto:x@4e4.de> > access=? skipConnection=0 skipMessage=0
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: filterRcpt(107d3d0, 107e040) RCPT='<spfeiffer@brekom.de>' <BLOCKED::mailto:spfeiffer@brekom.de>'>
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: address='spfeiffer@brekom.de' <BLOCKED::mailto:address='spfeiffer@brekom.de'>  localleft='spfeiffer' localright='' domain='brekom.de'
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=34:"milter-gris-to:spfeiffer@brekom.de" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=24:"milter-gris-to:brekom.de" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=17:"milter-gris-to:de" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=25:"milter-gris-to:spfeiffer@" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=15:"milter-gris-to:" value="" rc=-2
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: enter smfAccessPattern(107d690, "spfeiffer@brekom.de <BLOCKED::mailto:spfeiffer@brekom.de> ", "(NULL)...", 0)
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: exit  smfAccessPattern(107d690, "spfeiffer@brekom.de <BLOCKED::mailto:spfeiffer@brekom.de> ", "(NULL)...", 0) rc=_ action=''
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=24:"spam:spfeiffer@brekom.de" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=14:"spam:brekom.de" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=7:"spam:de"
value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=15:"spam:spfeiffer@" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=22:"to:spfeiffer@brekom.de" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=12:"to:brekom.de" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=5:"to:de"
value=""
Jul 20 15:42:07 mail01 milter-gris[533]: map="access" key=13:"to:spfeiffer@" value=""
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: recipient=<spfeiffer@brekom.de <BLOCKED::mailto:spfeiffer@brekom.de> > access=? skipConnection=0 skipRecipient=0
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: cache get key={auto,spfeiffer@brekom.de,x@4e4.de} value={-1 0 0} rc=-1
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: now=4a64742f
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: key={95.33.66.74,x@4e4.de,spfeiffer@brekom.de}
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: cache get key={95.33.66.74,x@4e4.de,spfeiffer@brekom.de} value={-1 0 0} rc=-1
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: no grey listing for {95.33.66.74,x@4e4.de,spfeiffer@brekom.de}
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: upgrading grey listing for {95.33.66.74,x@4e4.de,spfeiffer@brekom.de}
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: cache update key={95.33.66.74,x@4e4.de,spfeiffer@brekom.de} value={0 4a64742f 1} rc=0
Key not in cache, but accepted? Strange.
Jul 20 15:42:07 mail01 milter-gris[533]: 00001 n6KDfeRr000544: accepted grey listing {95.33.66.74,x@4e4.de,spfeiffer@brekom.de}
Jul 20 15:42:09 mail01 milter-gris[533]: 00001 n6KDfeRr000544: filterData(107d3d0)


The same procedure with libsnert-1.66.950 and milter-gris-0.21.115 (only binaries exchanged and cache db deleted):
Jul 20 15:49:29 mail01 milter-gris[702]: 00001 NOQUEUE: filterOpen(16e23d0, 'dyndsl-095-033-066-074.ewe-ip-backbone.de', [95.33.66.74])
Jul 20 15:49:29 mail01 milter-gris[702]: 00001 NOQUEUE: enter smfAccessClient(16e2690, milter-gris-connect:, dyndsl-095-033-066-074.ewe-ip-backbone.de, 95.33.66.74, 0, 0)
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=31:"milter-gris-connect:95.33.66.74" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=28:"milter-gris-connect:95.33.66" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=25:"milter-gris-connect:95.33" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=22:"milter-gris-connect:95" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=61:"milter-gris-connect:dyndsl-095-033-066-074.ewe-ip-backbone.de" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=38:"milter-gris-connect:ewe-ip-backbone.de" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=22:"milter-gris-connect:de" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=20:"milter-gris-connect:" value="" rc=-2
Jul 20 15:49:29 mail01 milter-gris[702]: 00001 NOQUEUE: enter smfAccessPattern(16e2690, "dyndsl-095-033-066-074.ewe-ip-backbone.de", "(NULL)...",
0)
Jul 20 15:49:29 mail01 milter-gris[702]: 00001 NOQUEUE: exit  smfAccessPattern(16e2690, "dyndsl-095-033-066-074.ewe-ip-backbone.de", "(NULL)...",
0) rc=_ action=''
Jul 20 15:49:29 mail01 milter-gris[702]: 00001 NOQUEUE: enter smfAccessPattern(16e2690, "95.33.66.74", "(NULL)...", 0)
Jul 20 15:49:29 mail01 milter-gris[702]: 00001 NOQUEUE: exit  smfAccessPattern(16e2690, "95.33.66.74", "(NULL)...", 0) rc=_ action=''
Jul 20 15:49:29 mail01 milter-gris[702]: 00001 NOQUEUE: exit  smfAccessClient(16e2690, milter-gris-connect:, dyndsl-095-033-066-074.ewe-ip-backbone.de, 95.33.66.74, 0, 0) access=95
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=19:"connect:95.33.66.74" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=16:"connect:95.33.66" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=13:"connect:95.33" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=10:"connect:95" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=49:"connect:dyndsl-095-033-066-074.ewe-ip-backbone.de" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=26:"connect:ewe-ip-backbone.de" value=""
Jul 20 15:49:29 mail01 milter-gris[702]: map="access" key=10:"connect:de" value=""
Jul 20 15:49:36 mail01 milter-gris[702]: 00001 NOQUEUE: filterHelo(16e23d0, 'lskdj')
Jul 20 15:49:43 mail01 milter-gris[702]: 00001 n6KDnTtD000712: filterMail(16e23d0, 16e3be0) MAIL='<x@4e4.de>' <BLOCKED::mailto:x@4e4.de>'>
Jul 20 15:49:43 mail01 milter-gris[702]: 00001 n6KDnTtD000712: address='x@4e4.de' <BLOCKED::mailto:address='x@4e4.de'>  localleft='x' localright='' domain='4e4.de' auth='(NULL)'
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=25:"milter-gris-from:x@4e4.de" value=""
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=23:"milter-gris-from:4e4.de" value=""
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=19:"milter-gris-from:de" value=""
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=19:"milter-gris-from:x@" value=""
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=17:"milter-gris-from:" value="" rc=-2
Jul 20 15:49:43 mail01 milter-gris[702]: 00001 n6KDnTtD000712: enter smfAccessPattern(16e2690, "x@4e4.de <BLOCKED::mailto:x@4e4.de> ",
"(NULL)...", 0)
Jul 20 15:49:43 mail01 milter-gris[702]: 00001 n6KDnTtD000712: exit  smfAccessPattern(16e2690, "x@4e4.de <BLOCKED::mailto:x@4e4.de> ",
"(NULL)...", 0) rc=_ action=''
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=13:"from:x@4e4.de" value=""
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=11:"from:4e4.de" value=""
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=7:"from:de"
value=""
Jul 20 15:49:43 mail01 milter-gris[702]: map="access" key=7:"from:x@"
value=""
Jul 20 15:49:43 mail01 milter-gris[702]: 00001 n6KDnTtD000712: sender=<x@4e4.de <BLOCKED::mailto:x@4e4.de> > access=? skipConnection=0 skipMessage=0
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: filterRcpt(16e23d0, 16e3020) RCPT='<spfeiffer@brekom.de>' <BLOCKED::mailto:spfeiffer@brekom.de>'>
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: address='spfeiffer@brekom.de' <BLOCKED::mailto:address='spfeiffer@brekom.de'>  localleft='spfeiffer' localright='' domain='brekom.de'
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=34:"milter-gris-to:spfeiffer@brekom.de" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=24:"milter-gris-to:brekom.de" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=17:"milter-gris-to:de" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=25:"milter-gris-to:spfeiffer@" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=15:"milter-gris-to:" value="" rc=-2
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: enter smfAccessPattern(16e2690, "spfeiffer@brekom.de <BLOCKED::mailto:spfeiffer@brekom.de> ", "(NULL)...", 0)
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: exit  smfAccessPattern(16e2690, "spfeiffer@brekom.de <BLOCKED::mailto:spfeiffer@brekom.de> ", "(NULL)...", 0) rc=_ action=''
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=24:"spam:spfeiffer@brekom.de" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=14:"spam:brekom.de" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=7:"spam:de"
value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=15:"spam:spfeiffer@" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=22:"to:spfeiffer@brekom.de" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=12:"to:brekom.de" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=5:"to:de"
value=""
Jul 20 15:49:53 mail01 milter-gris[702]: map="access" key=13:"to:spfeiffer@" value=""
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: recipient=<spfeiffer@brekom.de <BLOCKED::mailto:spfeiffer@brekom.de> > access=? skipConnection=0 skipRecipient=0
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: cache get key={auto,spfeiffer@brekom.de,x@4e4.de} value={-1 0 0} rc=-1
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: now=4a647601
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: key={95.33.66.74,x@4e4.de,spfeiffer@brekom.de}
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: cache get key={95.33.66.74,x@4e4.de,spfeiffer@brekom.de} value={-1 0 0} rc=-1
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: no grey listing for {95.33.66.74,x@4e4.de,spfeiffer@brekom.de}
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: cache update key={95.33.66.74,x@4e4.de,spfeiffer@brekom.de} value={4 4a647601 1} rc=0
Same result of cache operations, but now correctly denied.
Jul 20 15:49:53 mail01 milter-gris[702]: 00001 n6KDnTtD000712: denied grey listing {95.33.66.74,x@4e4.de,spfeiffer@brekom.de} for 280 seconds
Jul 20 15:49:54 mail01 milter-gris[702]: 00001 n6KDnTtD000712: filterData(16e23d0)
Jul 20 15:49:54 mail01 milter-gris[702]: 00001 n6KDnTtD000712: reply 450 4.7.1 try again later


Lists Index Date Thread Search