On 25/10/2012 15:11, Robert Anderson wrote:
Can you enable full debugging (if not enabled) and post a full log as
well as postconf?
Thank you very much for replying.
Below are the policyd log in debugging mode and postconf -n.
I hope the problem can be found.
P.V.Anthony
---------------- start debugging ----------------------------------
[2012/10/26-01:14:32 - 2832] [CORE] NOTICE: 2012/10/26-01:14:32 Server
closing!
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: Process Backgrounded
[2012/10/26-01:14:32 - 4125] [CBPOLICYD] NOTICE: Policyd v2 /
Cluebringer - v2.0.12
[2012/10/26-01:14:32 - 4125] [CBPOLICYD] NOTICE: Initializing system
modules.
[2012/10/26-01:14:32 - 4125] [CBPOLICYD] NOTICE: System modules initialized.
[2012/10/26-01:14:32 - 4125] [CBPOLICYD] NOTICE: Module load started...
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: => AccessControl: enabled
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: => CheckHelo: enabled
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: => CheckSPF: enabled
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: => Greylisting: enabled
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: => Quotas: enabled
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: => Protocol(Postfix): enabled
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: => Protocol(Bizanga): enabled
[2012/10/26-01:14:32 - 4125] [CBPOLICYD] NOTICE: Module load done.
[2012/10/26-01:14:32 - 4125] [CBPOLICYD] DEBUG: Opening syslog,
destination = 'unix', facility = 'mail'.
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: 2012/10/26-01:14:32 cbp
(type Net::Server::PreFork) starting! pid(4125)
[2012/10/26-01:14:32 - 4125] [CORE] NOTICE: Binding to TCP port 10031 on
host 127.0.0.1
[2012/10/26-01:14:32 - 4125] [CORE] WARNING: Group Not Defined.
Defaulting to EGID '0 0 1 2 3 4 6 10'
[2012/10/26-01:14:32 - 4125] [CORE] WARNING: User Not Defined.
Defaulting to EUID '0'
[2012/10/26-01:14:32 - 4125] [CORE] INFO: Setting up serialization via flock
[2012/10/26-01:14:32 - 4125] [CORE] INFO: Beginning prefork (4 processes)
[2012/10/26-01:14:32 - 4125] [CORE] INFO: Starting "4" children
[2012/10/26-01:14:32 - 4127] [CORE] DEBUG: Child Preforked (4127)
[2012/10/26-01:14:32 - 4127] [CBPOLICYD] DEBUG: Starting up caching engine
[2012/10/26-01:14:32 - 4128] [CORE] DEBUG: Child Preforked (4128)
[2012/10/26-01:14:32 - 4128] [CBPOLICYD] DEBUG: Starting up caching engine
[2012/10/26-01:14:32 - 4129] [CORE] DEBUG: Child Preforked (4129)
[2012/10/26-01:14:32 - 4129] [CBPOLICYD] DEBUG: Starting up caching engine
[2012/10/26-01:14:32 - 4125] [CORE] DEBUG: Parent ready for children.
[2012/10/26-01:14:32 - 4130] [CORE] DEBUG: Child Preforked (4130)
[2012/10/26-01:14:32 - 4130] [CBPOLICYD] DEBUG: Starting up caching engine
[2012/10/26-01:14:33 - 4125] [CORE] INFO: Starting "1" children
[2012/10/26-01:14:33 - 4128] [CORE] INFO: 2012/10/26-01:14:33 CONNECT
TCP Peer: "127.0.0.1:45009" Local: "127.0.0.1:10031"
[2012/10/26-01:14:33 - 4128] [CBPOLICYD] ERROR: Protocol data validation
error, required parameter 'sender' was not found or invalid format
[2012/10/26-01:14:33 - 4131] [CORE] DEBUG: Child Preforked (4131)
[2012/10/26-01:14:33 - 4131] [CBPOLICYD] DEBUG: Starting up caching engine
[2012/10/26-01:14:33 - 4131] [CBPOLICYD] DEBUG: Starting up caching engine
[2012/10/26-01:14:39 - 4130] [CORE] INFO: 2012/10/26-01:14:39 CONNECT
TCP Peer: "127.0.0.1:45011" Local: "127.0.0.1:10031"
[2012/10/26-01:14:42 - 4131] [CORE] INFO: 2012/10/26-01:14:42 CONNECT
TCP Peer: "127.0.0.1:45020" Local: "127.0.0.1:10031"
[2012/10/26-01:14:45 - 4130] [CORE] INFO: 2012/10/26-01:14:45 CONNECT
TCP Peer: "127.0.0.1:45021" Local: "127.0.0.1:10031"
[2012/10/26-01:14:48 - 4131] [CORE] INFO: 2012/10/26-01:14:48 CONNECT
TCP Peer: "127.0.0.1:45024" Local: "127.0.0.1:10031"
[2012/10/26-01:14:49 - 4130] [CORE] INFO: 2012/10/26-01:14:49 CONNECT
TCP Peer: "127.0.0.1:45026" Local: "127.0.0.1:10031"
[2012/10/26-01:14:49 - 4130] [CBPOLICYD] ERROR: Protocol data validation
error, required parameter 'sender' was not found or invalid format
[2012/10/26-01:14:50 - 4128] [CORE] INFO: 2012/10/26-01:14:50 CONNECT
TCP Peer: "127.0.0.1:45027" Local: "127.0.0.1:10031"
[2012/10/26-01:14:50 - 4128] [CBPOLICYD] ERROR: Protocol data validation
error, required parameter 'sender' was not found or invalid format
[2012/10/26-01:14:54 - 4127] [CORE] INFO: 2012/10/26-01:14:54 CONNECT
TCP Peer: "127.0.0.1:45033" Local: "127.0.0.1:10031"
[2012/10/26-01:15:08 - 4131] [CORE] INFO: 2012/10/26-01:15:08 CONNECT
TCP Peer: "127.0.0.1:45051" Local: "127.0.0.1:10031"
[2012/10/26-01:15:10 - 4129] [CORE] INFO: 2012/10/26-01:15:10 CONNECT
TCP Peer: "127.0.0.1:45059" Local: "127.0.0.1:10031"
[2012/10/26-01:15:13 - 4127] [CORE] INFO: 2012/10/26-01:15:13 CONNECT
TCP Peer: "127.0.0.1:45069" Local: "127.0.0.1:10031"
[2012/10/26-01:15:21 - 4128] [CORE] INFO: 2012/10/26-01:15:21 CONNECT
TCP Peer: "127.0.0.1:45083" Local: "127.0.0.1:10031"
[2012/10/26-01:15:24 - 4129] [CORE] INFO: 2012/10/26-01:15:24 CONNECT
TCP Peer: "127.0.0.1:45088" Local: "127.0.0.1:10031"
[2012/10/26-01:15:27 - 4127] [CORE] INFO: 2012/10/26-01:15:27 CONNECT
TCP Peer: "127.0.0.1:45099" Local: "127.0.0.1:10031"
[2012/10/26-01:15:40 - 4131] [CORE] INFO: 2012/10/26-01:15:40 CONNECT
TCP Peer: "127.0.0.1:45121" Local: "127.0.0.1:10031"
[2012/10/26-01:15:40 - 4128] [CORE] INFO: 2012/10/26-01:15:40 CONNECT
TCP Peer: "127.0.0.1:45125" Local: "127.0.0.1:10031"
[2012/10/26-01:15:41 - 4131] [CORE] INFO: 2012/10/26-01:15:41 CONNECT
TCP Peer: "127.0.0.1:45126" Local: "127.0.0.1:10031"
[2012/10/26-01:15:42 - 4128] [CORE] INFO: 2012/10/26-01:15:42 CONNECT
TCP Peer: "127.0.0.1:45130" Local: "127.0.0.1:10031"
[2012/10/26-01:15:42 - 4131] [CORE] INFO: 2012/10/26-01:15:42 CONNECT
TCP Peer: "127.0.0.1:45131" Local: "127.0.0.1:10031"
[2012/10/26-01:15:42 - 4125] [CORE] INFO: Starting "1" children
[2012/10/26-01:15:42 - 4310] [CORE] DEBUG: Child Preforked (4310)
[2012/10/26-01:15:42 - 4310] [CBPOLICYD] DEBUG: Starting up caching engine
[2012/10/26-01:15:43 - 4129] [CORE] INFO: 2012/10/26-01:15:43 CONNECT
TCP Peer: "127.0.0.1:45133" Local: "127.0.0.1:10031"
[2012/10/26-01:15:43 - 4127] [CORE] INFO: 2012/10/26-01:15:43 CONNECT
TCP Peer: "127.0.0.1:45134" Local: "127.0.0.1:10031"
[2012/10/26-01:15:45 - 4129] [CORE] INFO: 2012/10/26-01:15:45 CONNECT
TCP Peer: "127.0.0.1:45140" Local: "127.0.0.1:10031"
[2012/10/26-01:15:46 - 4128] [CORE] INFO: 2012/10/26-01:15:46 CONNECT
TCP Peer: "127.0.0.1:45144" Local: "127.0.0.1:10031"
[2012/10/26-01:15:46 - 4131] [CORE] INFO: 2012/10/26-01:15:46 CONNECT
TCP Peer: "127.0.0.1:45146" Local: "127.0.0.1:10031"
[2012/10/26-01:15:47 - 4128] [CORE] INFO: 2012/10/26-01:15:47 CONNECT
TCP Peer: "127.0.0.1:45150" Local: "127.0.0.1:10031"
[2012/10/26-01:15:48 - 4310] [CORE] INFO: 2012/10/26-01:15:48 CONNECT
TCP Peer: "127.0.0.1:45154" Local: "127.0.0.1:10031"
[2012/10/26-01:15:51 - 4128] [CORE] INFO: 2012/10/26-01:15:51 CONNECT
TCP Peer: "127.0.0.1:45163" Local: "127.0.0.1:10031"
[2012/10/26-01:16:00 - 4127] [CORE] INFO: 2012/10/26-01:16:00 CONNECT
TCP Peer: "127.0.0.1:45181" Local: "127.0.0.1:10031"
[2012/10/26-01:16:01 - 4131] [CORE] INFO: 2012/10/26-01:16:01 CONNECT
TCP Peer: "127.0.0.1:45183" Local: "127.0.0.1:10031"
[2012/10/26-01:16:03 - 4310] [CORE] INFO: 2012/10/26-01:16:03 CONNECT
TCP Peer: "127.0.0.1:45190" Local: "127.0.0.1:10031"
[2012/10/26-01:16:04 - 4131] [CORE] INFO: 2012/10/26-01:16:04 CONNECT
TCP Peer: "127.0.0.1:45192" Local: "127.0.0.1:10031"
[2012/10/26-01:16:06 - 4310] [CORE] INFO: 2012/10/26-01:16:06 CONNECT
TCP Peer: "127.0.0.1:45202" Local: "127.0.0.1:10031"
--------------------- end -----------------------------------------
------------------- start postconf -n -----------------------------
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases, hash:/etc/mailman/aliases
body_checks = regexp:/etc/postfix/body_checks
broken_sasl_auth_clients = yes
command_directory = /usr/sbin
config_directory = /etc/postfix
content_filter = amavis:[127.0.0.1]:10024
daemon_directory = /usr/libexec/postfix
data_directory = /var/lib/postfix
debug_peer_level = 2
disable_vrfy_command = yes
header_checks = regexp:/etc/postfix/header_checks
html_directory = no
inet_interfaces = all
inet_protocols = all
mail_owner = postfix
mailbox_size_limit = 0
mailq_path = /usr/bin/mailq.postfix
manpage_directory = /usr/share/man
message_size_limit = 33554432
mime_header_checks = regexp:/etc/postfix/mime_header_checks
mydestination = hostname.example.com, localhost, localhost.localdomain
myhostname = hostname.example.com
mynetworks = 127.0.0.0/8 [::1]/128
nested_header_checks = regexp:/etc/postfix/nested_header_checks
newaliases_path = /usr/bin/newaliases.postfix
parent_domain_matches_subdomains = debug_peer_list,
fast_flush_domains, mynetworks, permit_mx_backup_networks,
qmqpd_authorized_clients, relay_domains
proxy_read_maps = $local_recipient_maps $mydestination
$virtual_alias_maps $virtual_alias_domains $virtual_mailbox_maps
$virtual_mailbox_domains $relay_recipient_maps $relay_domains
$canonical_maps $sender_canonical_maps $recipient_canonical_maps
$relocated_maps $transport_maps $mynetworks $virtual_mailbox_limit_maps
queue_directory = /var/spool/postfix
readme_directory = /usr/share/doc/postfix-2.6.6/README_FILES
receive_override_options = no_address_mappings
relay_domains = mysql:/etc/postfix/mysql-virtual_relaydomains.cf
relay_recipient_maps =
mysql:/etc/postfix/mysql-virtual_relayrecipientmaps.cf
relayhost =
sample_directory = /usr/share/doc/postfix-2.6.6/samples
sendmail_path = /usr/sbin/sendmail.postfix
setgid_group = postdrop
smtpd_client_restrictions = permit_mynetworks,
permit_sasl_authenticated, check_client_access
mysql:/etc/postfix/mysql-virtual_client.cf
smtpd_data_restrictions = reject_unauth_pipelining
smtpd_delay_reject = yes
smtpd_end_of_data_restrictions = check_policy_service inet:127.0.0.1:10031
smtpd_helo_required = yes
smtpd_helo_restrictions = permit_mynetworks,
permit_sasl_authenticated, check_helo_access
hash:/etc/postfix/helo_check_bypassed,
reject_non_fqdn_helo_hostname, reject_invalid_helo_hostname
smtpd_recipient_limit = 100
smtpd_recipient_restrictions = check_policy_service
inet:127.0.0.1:10031, permit_mynetworks,
permit_sasl_authenticated, check_recipient_access
mysql:/etc/postfix/mysql-virtual_recipient.cf,
reject_unauth_destination, check_recipient_access
hash:/etc/postfix/anti_spam_bypassed,
reject_non_fqdn_recipient, reject_non_fqdn_sender,
reject_unknown_sender_domain, reject_unknown_recipient_domain,
check_client_access hash:/etc/postfix/rbl_check_bypassed,
reject_rbl_client zen.spamhaus.org, reject_rbl_client bl.spamcop.net
smtpd_sasl_auth_enable = yes
smtpd_sasl_authenticated_header = yes
smtpd_sasl_path = private/auth
smtpd_sasl_type = dovecot
smtpd_sender_restrictions = reject_unknown_sender_domain,
check_sender_access mysql:/etc/postfix/mysql-virtual_sender.cf
smtpd_tls_CAfile = /usr/local/ispconfig/interface/ssl/ca.pem
smtpd_tls_cert_file = /etc/postfix/smtpd.cert
smtpd_tls_key_file = /etc/postfix/smtpd.key
smtpd_tls_security_level = may
smtpd_use_tls = yes
strict_rfc821_envelopes = yes
transport_maps = proxy:mysql:/etc/postfix/mysql-virtual_transports.cf
unknown_address_reject_code = 554
unknown_client_reject_code = 550
unknown_hostname_reject_code = 554
unknown_local_recipient_reject_code = 550
unverified_sender_reject_code = 554
virtual_alias_domains =
virtual_alias_maps =
proxy:mysql:/etc/postfix/mysql-virtual_forwardings.cf,
mysql:/etc/postfix/mysql-virtual_email2email.cf,
hash:/etc/mailman/virtual-mailman
virtual_gid_maps = static:5000
virtual_mailbox_base = /var/vmail
virtual_mailbox_domains = proxy:mysql:/etc/postfix/mysql-virtual_domains.cf
virtual_mailbox_maps = proxy:mysql:/etc/postfix/mysql-virtual_mailboxes.cf
virtual_transport = dovecot
virtual_uid_maps = static:5000
-------------------- end ------------------------------------------
_______________________________________________
Users mailing list
[email protected]
http://lists.policyd.org/mailman/listinfo/users_lists.policyd.org
