[Dspam-user] dspam with pgsql does nothing to messages

[Svetozar M. <sve...@eu...>]

Hi All,
I googled my problem nearly hole day and all I came upon was errors in config or errors in build options. I fight with DSPAM to work several days already and I need help so I'm apologize for asking, but  if this is already discussed just point me to right link and I hope will manage.
The problem is that  messages goes to DSPAM and return to mail server without any additional headers or any kind of sign that the message is checked for spam.
The setup is Postfix  with DSPAM 3.10.1 and CLAMSMTP and dovecot . Linux distribution is CentOS6 x86_64.

here some details:

dspam --version

DSPAM Anti-Spam Suite 3.10.1 (agent/library)

Copyright (C) 2002-2011 DSPAM Project
http://dspam.sourceforge.net.

DSPAM may be copied only under the terms of the GNU Affero General Public
License, a copy of which can be found with the DSPAM distribution kit.

Configuration parameters:  '--build=x86_64-unknown-linux-gnu' '--host=x86_64-unknown-linux-gnu' '--target=x86_64-redhat-linux-gnu' '--program-prefix=' '--prefix=/usr' '--exec-prefix=/usr' '--bindir=/usr/bin' '--sbindir=/usr/sbin' '--datadir=/usr/share' '--includedir=/usr/include' '--libdir=/usr/lib64' '--libexecdir=/usr/libexec' '--localstatedir=/var' '--sharedstatedir=/var/lib' '--mandir=/usr/share/man' '--infodir=/usr/share/info' '--enable-long-usernames' '--enable-syslog' '--enable-large-scale' '--disable-domain-scale' '--disable-homedir' '--enable-virtual-users' '--enable-preferences-extension' '--with-mysql-includes=/usr/include/mysql' '--with-mysql-libraries=/usr/lib64/mysql' '--with-pgsql-includes=/usr/include/pgsql' '--with-pgsql-libraries=/usr/lib64' '--enable-daemon' '--enable-debug' '--enable-verbose-debug' '--enable-external-lookup' '--with-storage-driver=hash_drv,mysql_drv,pgsql_drv,sqlite3_drv' '--with-dspam-home=/var/lib/dspam' '--with-dspam-owner=dspam' '--with-dspam-group=mail' '--with-dspam-home-group=mail' '--with-dspam-mode=2511' '--with-logdir=/var/log/dspam' '--with-logfile=/var/log/dspam/dspam.log' '--sysconfdir=/etc' 'build_alias=x86_64-unknown-linux-gnu' 'host_alias=x86_64-unknown-linux-gnu' 'target_alias=x86_64-redhat-linux-gnu' 'CFLAGS=-O2 -g -pipe -Wall -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector --param=ssp-buffer-size=4 -m64 -mtune=generic'


dspam.debug:

25303: [09/29/2011 16:56:22] read attribute 'TrainingMode'
25303: [09/29/2011 16:56:22] find attribute 'TrainingMode'
25303: [09/29/2011 16:56:22]  -> found attribute 'TrainingMode' with value 'teft'
25303: [09/29/2011 16:56:22]  -> read attribute 'TrainingMode' with value 'teft'
25303: [09/29/2011 16:56:22] read attribute 'TrustedDeliveryAgent'
25303: [09/29/2011 16:56:22] find attribute 'TrustedDeliveryAgent'
25303: [09/29/2011 16:56:22]  -> found attribute 'TrustedDeliveryAgent' with value '/usr/bin/sendmail'
25303: [09/29/2011 16:56:22]  -> read attribute 'TrustedDeliveryAgent' with value '/usr/bin/sendmail'
25303: [09/29/2011 16:56:22] read attribute 'QuarantineAgent'
25303: [09/29/2011 16:56:22] find attribute 'QuarantineAgent'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'QuarantineAgent'
25303: [09/29/2011 16:56:22] No QuarantineAgent option found. Using standard quarantine.
25303: [09/29/2011 16:56:22] find attribute 'Feature'
25303: [09/29/2011 16:56:22]  -> found attribute 'Feature' with value 'noise'
25303: [09/29/2011 16:56:22] find attribute 'Feature'
25303: [09/29/2011 16:56:22]  -> found attribute 'Feature' with value 'noise'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'DataSource' with value 'document'
25303: [09/29/2011 16:56:22] find attribute 'DataSource'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'DataSource'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] match attribute 'Broken' with value 'lineStripping'
25303: [09/29/2011 16:56:22] find attribute 'Broken'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'Broken'
25303: [09/29/2011 16:56:22] match attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ParseToHeaders'
25303: [09/29/2011 16:56:22]  -> found attribute 'ParseToHeaders' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ParseToHeaders' with value 'on'
25303: [09/29/2011 16:56:22] read attribute 'StorageDriver'
25303: [09/29/2011 16:56:22] find attribute 'StorageDriver'
25303: [09/29/2011 16:56:22]  -> found attribute 'StorageDriver' with value '/usr/lib64/dspam/libpgsql_drv.so'
25303: [09/29/2011 16:56:22]  -> read attribute 'StorageDriver' with value '/usr/lib64/dspam/libpgsql_drv.so'
25303: [09/29/2011 16:56:22] match attribute 'ExtLookup' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'ExtLookup'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'ExtLookup'
25303: [09/29/2011 16:56:22] match attribute 'EnablePlusedDetail' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'EnablePlusedDetail'
25303: [09/29/2011 16:56:22]  -> found attribute 'EnablePlusedDetail' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'EnablePlusedDetail' with value 'on'
25303: [09/29/2011 16:56:22] DSPAM Instance Startup
25303: [09/29/2011 16:56:22] input args: /usr/bin/dspam --deliver=innocent,spam --user s.m...@do...d --mail-from=sve...@do...d --debug 
25303: [09/29/2011 16:56:22] pass-thru args: /usr/bin/sendmail 
25303: [09/29/2011 16:56:22] processing user s.m...@do...d
25303: [09/29/2011 16:56:22] uid = 494, euid = 494, gid = 493, egid = 12
25303: [09/29/2011 16:56:22] loading preferences for user s.m...@do...d
25303: [09/29/2011 16:56:22] read attribute 'Home'
25303: [09/29/2011 16:56:22] find attribute 'Home'
25303: [09/29/2011 16:56:22]  -> found attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22] read attribute 'DefaultProfile'
25303: [09/29/2011 16:56:22] find attribute 'DefaultProfile'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'DefaultProfile'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLUser' with value 'dspam'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLPass' with value 'DSp2mp@s!'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLDb' with value 'dspam'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLConnectionCache'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLConnectionCache' with value '3'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLConnectionCache'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUIDInSignature'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLUIDInSignature' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUIDInSignature'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualTable'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLVirtualTable' with value 'dspam_virtual_uids'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualTable'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUIDField'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLVirtualUIDField' with value 'uid'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUIDField'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUsernameField'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLVirtualUsernameField' with value 'username'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUsernameField'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLPort'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPort'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'PgSQLPort'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLUser' with value 'dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLUser' with value 'dspam'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLPass' with value 'DSp2mp@s!'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLPass' with value 'DSp2mp@s!'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLDb' with value 'dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLDb' with value 'dspam'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLVirtualTable'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualTable'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLVirtualTable' with value 'dspam_virtual_uids'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLVirtualTable' with value 'dspam_virtual_uids'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLVirtualUIDField'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUIDField'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLVirtualUIDField' with value 'uid'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLVirtualUIDField' with value 'uid'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLVirtualUsernameField'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUsernameField'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLVirtualUsernameField' with value 'username'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLVirtualUsernameField' with value 'username'
25303: [09/29/2011 16:56:22] _pgsql_drv_getpwnam: successful returning struct for name: s.m...@do...d
25303: [09/29/2011 16:56:22] Loading preferences for uid 1
25303: [09/29/2011 16:56:22] destroying/freeing configuration
25303: [09/29/2011 16:56:22] read attribute 'Home'
25303: [09/29/2011 16:56:22] find attribute 'Home'
25303: [09/29/2011 16:56:22]  -> found attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22] read attribute 'DefaultProfile'
25303: [09/29/2011 16:56:22] find attribute 'DefaultProfile'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'DefaultProfile'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLUser' with value 'dspam'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLPass' with value 'DSp2mp@s!'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLDb' with value 'dspam'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLConnectionCache'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLConnectionCache' with value '3'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLConnectionCache'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUIDInSignature'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLUIDInSignature' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUIDInSignature'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualTable'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLVirtualTable' with value 'dspam_virtual_uids'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualTable'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUIDField'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLVirtualUIDField' with value 'uid'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUIDField'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUsernameField'
25303: [09/29/2011 16:56:22] add attribute 'PgSQLVirtualUsernameField' with value 'username'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLVirtualUsernameField'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLServer'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLServer' with value '/tmp'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLPort'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPort'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'PgSQLPort'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLUser'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLUser' with value 'dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLUser' with value 'dspam'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLPass'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLPass' with value 'DSp2mp@s!'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLPass' with value 'DSp2mp@s!'
25303: [09/29/2011 16:56:22] read attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22] find attribute 'PgSQLDb'
25303: [09/29/2011 16:56:22]  -> found attribute 'PgSQLDb' with value 'dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'PgSQLDb' with value 'dspam'
25303: [09/29/2011 16:56:22] Loading preferences for uid 0
25303: [09/29/2011 16:56:22] destroying/freeing configuration
25303: [09/29/2011 16:56:22] loaded default preferences externally
25303: [09/29/2011 16:56:22] match attribute 'AllowOverride' with value 'optOut'
25303: [09/29/2011 16:56:22] find attribute 'AllowOverride'
25303: [09/29/2011 16:56:22]  -> found attribute 'AllowOverride' with value 'enableBNR'
25303: [09/29/2011 16:56:22]  -> matched attribute 'AllowOverride' with value 'optOut'
25303: [09/29/2011 16:56:22] match attribute 'AllowOverride' with value 'spamAction'
25303: [09/29/2011 16:56:22] find attribute 'AllowOverride'
25303: [09/29/2011 16:56:22]  -> found attribute 'AllowOverride' with value 'enableBNR'
25303: [09/29/2011 16:56:22]  -> matched attribute 'AllowOverride' with value 'spamAction'
25303: [09/29/2011 16:56:22] aggregated preference 'optOut' => 'on'
25303: [09/29/2011 16:56:22] aggregated preference 'trainingMode' => 'TEFT'
25303: [09/29/2011 16:56:22] aggregated preference 'spamAction' => 'tag'
25303: [09/29/2011 16:56:22] aggregated preference 'spamSubject' => '[SPAM]'
25303: [09/29/2011 16:56:22] aggregated preference 'statisticalSedation' => '5'
25303: [09/29/2011 16:56:22] aggregated preference 'enableBNR' => 'on'
25303: [09/29/2011 16:56:22] aggregated preference 'signatureLocation' => 'headers'
25303: [09/29/2011 16:56:22] aggregated preference 'tagSpam' => 'on'
25303: [09/29/2011 16:56:22] aggregated preference 'tagNonspam' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'optIn' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'whitelistThreshold' => '10'
25303: [09/29/2011 16:56:22] aggregated preference 'makeCorpus' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'storeFragments' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'processorBias' => 'on'
25303: [09/29/2011 16:56:22] aggregated preference 'fallbackDomain' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'trainPristine' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'ignoreRBLLookups' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'RBLInoculate' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'notifications' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'TrainPristine' => 'off'
25303: [09/29/2011 16:56:22] aggregated preference 'optOutClamAV' => 'on'
25303: [09/29/2011 16:56:22] match attribute 'TrainPristine' with value 'on'
25303: [09/29/2011 16:56:22] find attribute 'TrainPristine'
25303: [09/29/2011 16:56:22]  -> found attribute 'TrainPristine' with value 'off'
25303: [09/29/2011 16:56:22]  -> match: not found attribute 'TrainPristine' with value 'on'
25303: [09/29/2011 16:56:22] read attribute 'Home'
25303: [09/29/2011 16:56:22] find attribute 'Home'
25303: [09/29/2011 16:56:22]  -> found attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22] using /var/lib/dspam/opt-in/s.m...@do...d.dspam as path
25303: [09/29/2011 16:56:22] read attribute 'Home'
25303: [09/29/2011 16:56:22] find attribute 'Home'
25303: [09/29/2011 16:56:22]  -> found attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22]  -> read attribute 'Home' with value '/var/lib/dspam'
25303: [09/29/2011 16:56:22] using /var/lib/dspam/opt-out/s.m...@do...dspam as path
25303: [09/29/2011 16:56:22] read attribute 'MaxMessageSize'
25303: [09/29/2011 16:56:22] find attribute 'MaxMessageSize'
25303: [09/29/2011 16:56:22]  -> found attribute 'MaxMessageSize' with value '4194304'
25303: [09/29/2011 16:56:22]  -> read attribute 'MaxMessageSize' with value '4194304'
25303: [09/29/2011 16:56:22] read attribute 'MaxMessageSize'
25303: [09/29/2011 16:56:22] find attribute 'MaxMessageSize'
25303: [09/29/2011 16:56:22]  -> found attribute 'MaxMessageSize' with value '4194304'
25303: [09/29/2011 16:56:22]  -> read attribute 'MaxMessageSize' with value '4194304'
25303: [09/29/2011 16:56:22] read attribute 'QuarantineMailbox'
25303: [09/29/2011 16:56:22] find attribute 'QuarantineMailbox'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'QuarantineMailbox'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryProto'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryProto' with value 'SMTP'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryIdent'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryIdent'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryIdent' with value 'localhost'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryIdent' with value 'localhost'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryHost'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryHost'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryHost' with value '127.0.0.1'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryHost' with value '127.0.0.1'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryPort'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryPort'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryPort' with value '10025'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryPort' with value '10025'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryPort'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryPort'
25303: [09/29/2011 16:56:22]  -> found attribute 'DeliveryPort' with value '10025'
25303: [09/29/2011 16:56:22]  -> read attribute 'DeliveryPort' with value '10025'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryHost.domain.tld'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryHost.domain.tld'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'DeliveryHost.domain.tld'
25303: [09/29/2011 16:56:22] read attribute 'DeliveryPort.domain.tld'
25303: [09/29/2011 16:56:22] find attribute 'DeliveryPort.domain.tld'
25303: [09/29/2011 16:56:22]  -> read: not found attribute 'DeliveryPort.domain.tld'
25303: [09/29/2011 16:56:22] Establishing connection to 127.0.0.1:10025
25303: [09/29/2011 16:56:22] Connection established
25303: [09/29/2011 16:56:22] RECV: 220 smtp.passthru

25303: [09/29/2011 16:56:22] SEND: HELO localhost
25303: [09/29/2011 16:56:22] RECV: 250 smtp.passthru

25303: [09/29/2011 16:56:22] SEND: MAIL FROM:<sve...@do...d>
25303: [09/29/2011 16:56:22] RECV: 250 2.1.0 Ok

25303: [09/29/2011 16:56:22] SEND: RCPT TO:<s.m...@do...d>
25303: [09/29/2011 16:56:22] RECV: 250 2.1.5 Ok

25303: [09/29/2011 16:56:22] SEND: DATA
25303: [09/29/2011 16:56:22] RECV: 354 Start mail input; end with <CRLF>.<CRLF>

25303: [09/29/2011 16:56:22] SEND: 
.
25303: [09/29/2011 16:56:22] RECV: 250 2.0.0 Ok: queued as 3C3B32141231

25303: [09/29/2011 16:56:22] SEND: QUIT
25303: [09/29/2011 16:56:22] RECV: 221 2.0.0 Bye

25303: [09/29/2011 16:56:22] DSPAM Instance Shutdown.  Exit Code: 0
25303: [09/29/2011 16:56:22] destroying/freeing configuration




POSTFIX MASTER.CF:

localhost:10024 inet n -        n       -       -       smtpd
        -o content_filter=clamav:127.0.0.1:10025
        -o receive_override_options=no_unknown_recipient_checks,no_header_body_checks
        -o smtpd_helo_restrictions=
        -o smtpd_client_restrictions=
        -o smtpd_sender_restrictions=
        -o smtpd_recipient_restrictions=permit_mynetworks,reject
        -o mynetworks=127.0.0.0/8
        -o smtpd_authorized_xforward_hosts=127.0.0.0/8

dspam     unix  -       n       n       -       10      pipe
        flags=Ru user=dspam argv=/usr/bin/dspam  --deliver=innocent,spam --user ${recipient} --mail-from=${sender} --debug

dspam-retrain unix - n n - 10 pipe
        flags=Rhq user=dspam argv=/usr/bin/dspam --mode=teft --class=${nexthop} --source=error  --user ${sender} --debug



DSPAM.CONF:

Home /var/lib/dspam
StorageDriver /usr/lib64/dspam/libpgsql_drv.so
TrustedDeliveryAgent "/usr/bin/sendmail"
DeliveryHost            127.0.0.1
DeliveryPort            10025
DeliveryIdent           localhost
DeliveryProto           SMTP
EnablePlusedDetail      off
OnFail error
Trust root
Trust dspam
Trust vmail
Trust postfix
Debug *
DebugOpt process spam fp classify corpus
TrainingMode teft
TestConditionalTraining on
Feature noise
Feature whitelist
Algorithm graham burton
Tokenizer chain
PValue bcr
WebStats off
ImprobabilityDrive on
#
Preference "trainingMode=TEFT"          # { TOE | TUM | TEFT | NOTRAIN } -> default:teft
Preference "spamAction=deliver" # { quarantine | tag | deliver } -> default:quarantine
Preference "spamSubject=[SPAM]"         # { string } -> default:[SPAM]
Preference "statisticalSedation=5"      # { 0 - 10 } -> default:0
Preference "enableBNR=on"               # { on | off } -> default:off
Preference "enableWhitelist=on"         # { on | off } -> default:on
Preference "signatureLocation=headers"  # { message | headers } -> default:message
Preference "tagSpam=on"         # { on | off }
Preference "tagNonspam=off"             # { on | off }
Preference "showFactors=on"             # { on | off } -> default:off
Preference "optIn=off"                  # { on | off }
Preference "optOut=on"                  # { on | off }
Preference "whitelistThreshold=10"      # { Integer } -> default:10
Preference "makeCorpus=off"             # { on | off } -> default:off
Preference "storeFragments=off"         # { on | off } -> default:off
Preference "localStore="                # { on | off } -> default:username
Preference "processorBias=on"           # { on | off } -> default:on
Preference "fallbackDomain=off"         # { on | off } -> default:off
Preference "trainPristine=off"          # { on | off } -> default:off
Preference "optOutClamAV=on"            # { on | off } -> default:off
Preference "ignoreRBLLookups=off"       # { on | off } -> default:off
Preference "RBLInoculate=off"           # { on | off } -> default:off
Preference "notifications=off"          # { on | off } -> default:off

#
# Overrides: Specifies the user preferences which may override configuration
# and commandline defaults. Any other preferences supplied by an untrusted user
# will be ignored.
#
AllowOverride enableBNR
AllowOverride enableWhitelist
AllowOverride fallbackDomain
AllowOverride ignoreGroups
AllowOverride ignoreRBLLookups
AllowOverride localStore
AllowOverride makeCorpus
AllowOverride optIn
AllowOverride optOut
AllowOverride optOutClamAV
AllowOverride processorBias
AllowOverride RBLInoculate
AllowOverride showFactors
AllowOverride signatureLocation
AllowOverride spamAction
AllowOverride spamSubject
AllowOverride statisticalSedation
AllowOverride storeFragments
AllowOverride tagNonspam
AllowOverride tagSpam
AllowOverride trainPristine
AllowOverride trainingMode
AllowOverride whitelistThreshold
AllowOverride dailyQuarantineSummary
AllowOverride notifications

PgSQLServer             /tmp
PgSQLPort
PgSQLUser               dspam
PgSQLPass               PGSQL_PASS
PgSQLDb                 dspam
PgSQLConnectionCache    3
PgSQLUIDInSignature     on
PgSQLVirtualTable               dspam_virtual_uids
PgSQLVirtualUIDField            uid
PgSQLVirtualUsernameField       username

HashRecMax              98317
HashAutoExtend          on
HashMaxExtents          0
HashExtentSize          49157
HashPctIncrease         10
HashMaxSeek             10
#HashConcurrentUser     user
HashConnectionCache     10
#
IgnoreHeader X-Spam-Status
IgnoreHeader X-Spam-Scanned
IgnoreHeader X-Virus-Scanner-Result

Notifications   off
# specified on the commandline
#
PurgeSignatures 14      # Stale signatures
PurgeNeutral    90      # Tokens with neutralish probabilities
PurgeUnused     90      # Unused tokens
PurgeHapaxes    30      # Tokens with less than 5 hits (hapaxes)
PurgeHits1S     15      # Tokens with only 1 spam hit
PurgeHits1I     15      # Tokens with only 1 innocent hit

LocalMX 127.0.0.1
SystemLog       on
UserLog         on
TrainPristine off
Opt out
#TrackSources spam nonspam virus
ParseToHeaders off
ChangeModeOnParse off
ChangeUserOnParse off
MaxMessageSize 4194304
#ServerHost             127.0.0.1
#ServerPort             24
#ServerQueueSize        32
#ServerPID              /var/run/dspam/dspam.pid
#ServerMode auto
#ServerPass.Relay1      "secret"
#ServerDomainSocketPath "/var/run/dspam/dspam.sock"
#ClientHost     /var/run/dspam/dspam.sock
#ClientIdent    "secret@Relay1"
ProcessorURLContext on
ProcessorBias on
StripRcptDomain off



So I really hope that i have some configuration error that you can point to me.

Thank you in advance
Regards,
Svetozar Marinov