Hello List,
when activating policyd in main.cf users which send a lot of mails
(newsletters) to our mailserver, have to wait a long time the mails will send
by her client (f.e. outlook).
Sometimes the client gives a timeout. The mails were send via BCC header.
Send few mails will be fast.
# telnet MAILSERVER 25 is very fast
Sending may 100 mails (100 recipients per BCC) will be slow (ca 5minutes to
send with outlook).
200 mails round about 9 minutes
500 mails over 15 minutes
You can see our mail.log (delay)
Policy tracking message count by SASL Username. session_tracking table and
quaotas_tracking table are ok
session_tracking about 1.000.000 per 24h (in and out)
Without policyd all is fine.
incoming Mails are ok.
Systeminfos:
Postfix 2.5.5
Policyd 2.0.11
cluebringer.conf
# Protocols to load
protocols=<<EOT
Postfix
Bizanga
EOT
# Modules to load
modules=<<EOT
Core
Quotas
EOT
min_servers=8
min_spare_servers=8
max_spare_servers=16
max_servers=64
max_requests=1000
host=192.168.77.50
DSN=DBI:mysql:database=policyd;host=192.168.76.41
main.cf (Postfix)
relayhost = 192.168.77.90:26
smtpd_end_of_data_restrictions = check_policy_service inet:192.168.77.50:10031
smtpd_recipient_restrictions = permit_mynetworks,
reject_unknown_recipient_domain,
reject_unknown_sender_domain,
reject_unlisted_sender,
reject_unlisted_recipient,
reject_non_fqdn_recipient,
reject_non_fqdn_sender,
check_policy_service inet:192.168.77.50:10031,
permit_sasl_authenticated,
check_client_access
hash:/etc/postfix/pop-before-smtp,
check_recipient_access
hash:/etc/postfix/recipient_access,
reject_unverified_recipient,
reject_unauth_destination
In mail.log:
Dec 14 16:15:36 c50 postfix/qmgr[1479]: 0CA34868E8: from=<local_mail_adress>,
size=21165, nrcpt=325 (queue active)
Dec 14 16:15:36 c50 postfix/smtp[1063]: 0CA34868E8: to=<nnnnnnnnnnnnnn>,
relay=192.168.77.90[192.168.77.90]:26, delay=364, delays=364/0.02/0.03/0.04,
dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D040C6E5B9
Dec 14 16:15:36 c50 postfix/smtp[1063]: 0CA34868E8: to=< nnnnnnnnnnnnnn >,
relay=192.168.77.90[192.168.77.90]:26, delay=364, delays=364/0.02/0.03/0.04,
dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D040C6E5B
Dec 14 16:15:36 c50 postfix/smtp[1063]: 0CA34868E8: to=< nnnnnnnnnnnnnn >,
relay=192.168.77.90[192.168.77.90]:26, delay=364, delays=364/0.02/0.03/0.04,
dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D040C6E5
Dec 14 16:15:36 c50 postfix/smtp[1063]: 0CA34868E8: to=< nnnnnnnnnnnnnn >,
relay=192.168.77.90[192.168.77.90]:26, delay=364, delays=364/0.02/0.03/0.04,
dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D040C6E5B9)
Dec 14 16:15:36 c50 postfix/smtp[1063]: 0CA34868E8: to=< nnnnnnnnnnnnnn >,
relay=192.168.77.90[192.168.77.90]:26, delay=364, delays=364/0.02/0.03/0.04,
dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D040C6E5B
Dec 14 16:15:36 c50 postfix/smtp[1063]: 0CA34868E8: to=< nnnnnnnnnnnnnn >,
relay=192.168.77.90[192.168.77.90]:26, delay=364, delays=364/0.02/0.03/0.04,
dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D040C6E5B
Dec 14 16:15:36 c50 postfix/smtp[1063]: 0CA34868E8: to=< nnnnnnnnnnnnnn >,
relay=192.168.77.90[192.168.77.90]:26, delay=364, delays=364/0.02/0.03/0.04,
dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D040C6E5B9)
...and so on
with Loglevel3 i get:
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: Process Backgrounded
[2011/12/14-15:07:37 - 26762] [CBPOLICYD] NOTICE: Policyd v2 / Cluebringer -
v2.0.10
[2011/12/14-15:07:37 - 26762] [CBPOLICYD] NOTICE: Initializing system modules.
[2011/12/14-15:07:37 - 26762] [CBPOLICYD] NOTICE: System modules initialized.
[2011/12/14-15:07:37 - 26762] [CBPOLICYD] NOTICE: Module load started...
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: => Quotas: enabled
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: => Protocol(Postfix): enabled
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: => Protocol(Bizanga): enabled
[2011/12/14-15:07:37 - 26762] [CBPOLICYD] NOTICE: Module load done.
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: 2011/12/14-15:07:37 cbp (type
Net::Server::PreFork) starting! pid(26762)
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: Using default listen value of 128
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: Binding to TCP port 10031 on host
192.168.77.50
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: Setting gid to "105 105"
[2011/12/14-15:07:37 - 26762] [CORE] NOTICE: Setting uid to "102"
[2011/12/14-15:07:37 - 26762] [CORE] INFO: Setting up serialization via flock
[2011/12/14-15:07:37 - 26762] [CORE] INFO: Beginning prefork (8 processes)
[2011/12/14-15:07:37 - 26762] [CORE] INFO: Starting "8" children
[2011/12/14-15:07:38 - 26763] [CORE] INFO: 2011/12/14-15:07:38 CONNECT TCP
Peer: "192.168.77.50:40549" Local: "192.168.77.50:10031"
[2011/12/14-15:07:38 - 26762] [CORE] INFO: Starting "1" children
[2011/12/14-15:07:40 - 26765] [CORE] INFO: 2011/12/14-15:07:40 CONNECT TCP
Peer: "192.168.77.50:40554" Local: "192.168.77.50:10031"
[2011/12/14-15:07:42 - 26763] [CORE] INFO: 2011/12/14-15:07:42 CONNECT TCP
Peer: "192.168.77.50:40564" Local: "192.168.77.50:10031"
....
Any idea?
Thanks
Thanks
Martin
_______________________________________________
Users mailing list
[email protected]
http://lists.policyd.org/mailman/listinfo/users
