Hello, I'm using Cluebringer with Postfix and I have some troubles. When I try to send a mail from Thunderbird, I get this error : "Sender address rejected, try again later".
My server is a Debian Squeeze, and I'm trying to use Policyd for limit the number of mail sended by my user (quota). I turned on both verbosity and debug mode on cluebringer and postfix and I get that in my log went I send a mail : [Mail.log] ================================================== Aug 30 09:18:06 testing-puppet postfix/pickup[7221]: B57A0240C4: uid=0 from=<root> Aug 30 09:18:06 testing-puppet postfix/cleanup[7326]: B57A0240C4: message-id=<[email protected]> Aug 30 09:18:06 testing-puppet postfix/qmgr[1022]: B57A0240C4: from=<[email protected]>, size=681, nrcpt=1 (queue active) Aug 30 09:18:06 testing-puppet postfix/local[7328]: B57A0240C4: to=<[email protected]>, orig_to=<root>, relay=local, delay=0.13, delays=0.07/0.02/0/0.04, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") Aug 30 09:18:06 testing-puppet postfix/qmgr[1022]: B57A0240C4: removed Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const mail Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const ipv4 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: name_mask: ipv4 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const testing-puppet.domain.ch Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const domain.ch Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Postfix Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand ${multi_instance_name:postfix}${multi_instance_name?$multi_instance_name} -> postfix Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const postfix Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const postdrop Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const testing-puppet.domain.ch, localhost.domain.ch, , localhost Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const /etc/mailname Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const /usr/lib/postfix Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const /var/lib/postfix Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const /usr/sbin Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const /var/spool/postfix Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const pid Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const all Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const double-bounce Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const nobody Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const hash:/etc/aliases Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 20100608 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 2.7.1 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const hash Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const deferred, defer Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const + Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $mydestination -> testing-puppet.domain.ch, localhost.domain.ch, , localhost Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $relay_domains -> testing-puppet.domain.ch, localhost.domain.ch, , localhost Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const TZ MAIL_CONFIG LANG Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const MAIL_CONFIG MAIL_DEBUG MAIL_LOGTAG TZ XAUTHORITY DISPLAY LANG=C Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const subnet Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const += Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const -=+ Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const debug_peer_list,fast_flush_domains,mynetworks,permit_mx_backup_networks,qmqpd_authorized_clients,smtpd_access_maps Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const bounce Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const cleanup Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const defer Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const pickup Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const qmgr Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const rewrite Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const showq Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const error Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const flush Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const verify Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const trace Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const proxymap Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const proxywrite Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 2 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 3600s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 3600s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 5s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 5s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1000s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1000s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 10s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 10s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 500s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 500s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 18000s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 18000s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.170.0/24 192.168.254.0/24 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: inet_addr_local: configured 2 IPv4 addresses Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 10 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand ${stress?1}${stress:20} -> 20 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand ${stress?1}${stress:100} -> 100 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand ${stress?1}${stress:3} -> 3 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $myhostname ESMTP $mail_name (Debian/GNU) -> testing-puppet.domain.ch ESMTP Postfix (Debian/GNU) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const resource, software Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const check_policy_service inet:127.0.0.1:10031 defer Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const permit_mynetworks, reject_unauth_destination Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const postmaster Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $virtual_maps -> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const hash:/etc/aliases Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand proxy:unix:passwd.byname $alias_maps -> proxy:unix:passwd.byname hash:/etc/aliases Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const noanonymous Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const smtpd Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const CONNECT GET POST Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const <> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $double_bounce_sender -> double-bounce Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $authorized_verp_clients -> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $myhostname -> testing-puppet.domain.ch Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand ${smtpd_client_connection_limit_exceptions:$mynetworks} -> 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.170.0/24 192.168.254.0/24 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const permit_inet_interfaces Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $smtpd_sasl_security_options -> noanonymous Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const /etc/ssl/certs/ssl-cert-snakeoil.pem Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const /etc/ssl/private/ssl-cert-snakeoil.key Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $smtpd_tls_dcert_file -> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $smtpd_tls_eccert_file -> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const export Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const medium Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const SSLv3, TLSv1 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const none Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const md5 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const cyrus Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const j {daemon_name} v Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const {tls_version} {cipher} {cipher_bits} {cert_subject} {cert_issuer} Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const i {auth_type} {auth_authen} {auth_author} {mail_addr} {mail_host} {mail_mailer} Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const i {rcpt_addr} {rcpt_host} {rcpt_mailer} Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const i Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const i Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const i Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 6 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const tempfail Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $myhostname -> testing-puppet.domain.ch Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $mail_name $mail_version -> Postfix 2.7.1 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $reject_tempfail_action -> defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $reject_tempfail_action -> defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $reject_tempfail_action -> defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand $reject_tempfail_action -> defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const yes Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand ${stress?10}${stress:300}s -> 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: expand ${stress?10}${stress:300}s -> 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 3s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 3s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 100s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1000s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 1000s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 3600s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 3600s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 30s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 30s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 30s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 30s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const 300s Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: process generation: 104 (104) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: mynetworks ~? debug_peer_list Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: mynetworks ~? fast_flush_domains Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: mynetworks ~? mynetworks Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: relay_domains ~? debug_peer_list Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: relay_domains ~? fast_flush_domains Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: relay_domains ~? mynetworks Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: relay_domains ~? permit_mx_backup_networks Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: relay_domains ~? qmqpd_authorized_clients Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: relay_domains ~? smtpd_access_maps Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_list_match: relay_domains: no match Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: permit_mx_backup_networks ~? debug_peer_list Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: permit_mx_backup_networks ~? fast_flush_domains Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: permit_mx_backup_networks ~? mynetworks Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: permit_mx_backup_networks ~? permit_mx_backup_networks Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: connect to subsystem private/proxymap Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr request = open Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr table = unix:passwd.byname Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr flags = 16448 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/proxymap socket: wanted attribute: status Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: status Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/proxymap socket: wanted attribute: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 16464 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/proxymap socket: wanted attribute: (list terminator) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: (end) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_proxy_open: connect to map=unix:passwd.byname status=0 server_flags=fixed|lock|fold_fix Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_open: proxy:unix:passwd.byname Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: Compiled against Berkeley DB: 4.8.30? Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: Run-time linked against Berkeley DB: 4.8.30? Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_open: hash:/etc/aliases Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: smtpd_access_maps ~? debug_peer_list Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: smtpd_access_maps ~? fast_flush_domains Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: smtpd_access_maps ~? mynetworks Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: smtpd_access_maps ~? permit_mx_backup_networks Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: smtpd_access_maps ~? qmqpd_authorized_clients Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: smtpd_access_maps ~? smtpd_access_maps Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: auto_clnt_create: transport=inet endpoint=127.0.0.1:10031 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: unknown_helo_hostname_tempfail_action = defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: unknown_address_tempfail_action = defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: unverified_recipient_tempfail_action = defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: unverified_sender_tempfail_action = defer_if_permit Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const ALL:!EXPORT:!LOW:!MEDIUM:+RC4:@STRENGTH Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const ALL:!EXPORT:!LOW:+RC4:@STRENGTH Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const ALL:!EXPORT:+RC4:@STRENGTH Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const ALL:+RC4:@STRENGTH Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const eNULL:!aNULL Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const prime256v1 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: dict_eval: const secp384r1 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: auto_clnt_create: transport=local endpoint=private/tlsmgr Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: auto_clnt_open: connected to private/tlsmgr Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr request = seed Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr size = 32 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/tlsmgr: wanted attribute: status Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: status Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/tlsmgr: wanted attribute: seed Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: seed Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 7I9PUX/bpMlJV9fvDs6Pu+GbI1MDP9k4yUc4VctxkQA= Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/tlsmgr: wanted attribute: (list terminator) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: (end) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr request = policy Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr cache_type = smtpd Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/tlsmgr: wanted attribute: status Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: status Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/tlsmgr: wanted attribute: cachable Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: cachable Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 1 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/tlsmgr: wanted attribute: (list terminator) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: (end) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: fast_flush_domains ~? debug_peer_list Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_string: fast_flush_domains ~? fast_flush_domains Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: auto_clnt_create: transport=local endpoint=private/anvil Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: connection established Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: master_notify: status 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: name_mask: resource Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: name_mask: software Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: connect from unknown[192.168.170.85] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_list_match: unknown: no match Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_list_match: 192.168.170.85: no match Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_list_match: unknown: no match Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_list_match: 192.168.170.85: no match Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? 127.0.0.0/8 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? 127.0.0.0/8 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? [::ffff:127.0.0.0]/104 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? [::ffff:127.0.0.0]/104 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? [::1]/128 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? [::1]/128 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? 192.168.170.0/24 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? 192.168.170.0/24 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 220 testing-puppet.domain.ch ESMTP Postfix (Debian/GNU) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: < unknown[192.168.170.85]: EHLO [192.168.170.85] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-testing-puppet.domain.ch Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-PIPELINING Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-SIZE 10240000 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-VRFY Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-ETRN Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_list_match: unknown: no match Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: match_list_match: 192.168.170.85: no match Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-STARTTLS Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-ENHANCEDSTATUSCODES Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250-8BITMIME Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250 DSN Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: < unknown[192.168.170.85]: MAIL FROM:<[email protected]> SIZE=365 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: extract_addr: input: <[email protected]> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: smtpd_check_addr: [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: connect to subsystem private/rewrite Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr request = rewrite Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr rule = local Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr address = [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: address Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: address Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: (list terminator) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: (end) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: rewrite_clnt: local: [email protected] -> [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr request = resolve Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr sender = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr address = [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: transport Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: transport Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: smtp Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: nexthop Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: nexthop Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: gmail.com Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: recipient Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: recipient Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 4096 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: (list terminator) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: (end) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: resolve_clnt: `' -> `[email protected]' -> transp=`smtp' host=`gmail.com' rcpt=`[email protected]' flags= class=default Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: ctable_locate: install entry key [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: extract_addr: in: <[email protected]>, result: [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: fsspace: .: block size 4096, blocks free 4428324 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: smtpd_check_queue: blocks 4096 avail 4428324 min_free 0 msg_size_limit 10240000 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 250 2.1.0 Ok Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: < unknown[192.168.170.85]: RCPT TO:<[email protected]> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: extract_addr: input: <[email protected]> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: smtpd_check_addr: [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: ctable_locate: leave existing entry key [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: extract_addr: in: <[email protected]>, result: [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr request = rewrite Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr rule = local Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr address = double-bounce Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: flags Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: address Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: address Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: private/rewrite socket: wanted attribute: (list terminator) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: (end) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: rewrite_clnt: local: double-bounce -> [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: >>> START Sender address RESTRICTIONS <<< Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: generic_checks: name=check_policy_service Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: trying... [127.0.0.1] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: auto_clnt_open: connected to 127.0.0.1:10031 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr request = smtpd_access_policy Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr protocol_state = RCPT Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr protocol_name = ESMTP Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr client_address = 192.168.170.85 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr client_name = unknown Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr reverse_client_name = unknown Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr helo_name = [192.168.170.85] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr sender = [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr recipient = [email protected] Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr recipient_count = 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr queue_id = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr instance = 1ca3.4e5c8eca.9e7c7.0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr size = 365 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr etrn_domain = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr stress = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr sasl_method = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr sasl_username = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr sasl_sender = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr ccert_subject = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr ccert_issuer = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr ccert_fingerprint = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr encryption_protocol = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr encryption_cipher = Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: send attr encryption_keysize = 0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: 127.0.0.1:10031: wanted attribute: action Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: action Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute value: DUNNO Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: 127.0.0.1:10031: wanted attribute: (list terminator) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: input attribute name: (end) Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: check_table_result: inet:127.0.0.1:10031 DUNNO policy query Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: generic_checks: name=check_policy_service status=0 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: generic_checks: name=defer Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: NOQUEUE: reject: RCPT from unknown[192.168.170.85]: 450 4.3.2 <[email protected]>: Sender address rejected: Try again later; from=<[email protected]> to=<[email protected]> proto=ESMTP helo=<[192.168.170.85]> Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: generic_checks: name=defer status=2 Aug 30 09:18:34 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 450 4.3.2 <[email protected]>: Sender address rejected: Try again later Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: < unknown[192.168.170.85]: QUIT Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: > unknown[192.168.170.85]: 221 2.0.0 Bye Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? 127.0.0.0/8 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? 127.0.0.0/8 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? [::ffff:127.0.0.0]/104 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? [::ffff:127.0.0.0]/104 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? [::1]/128 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? [::1]/128 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostname: unknown ~? 192.168.170.0/24 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: match_hostaddr: 192.168.170.85 ~? 192.168.170.0/24 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: disconnect from unknown[192.168.170.85] Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: master_notify: status 1 Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: connection closed Aug 30 09:18:36 testing-puppet postfix/smtpd[7331]: auto_clnt_close: disconnect 127.0.0.1:10031 stream Aug 30 09:18:39 testing-puppet postfix/smtpd[7331]: proxymap stream disconnect Aug 30 09:18:39 testing-puppet postfix/smtpd[7331]: auto_clnt_close: disconnect private/tlsmgr stream Aug 30 09:18:39 testing-puppet postfix/smtpd[7331]: rewrite stream disconnect [cbpolicyd.log] ============================================= [2011/08/30-09:18:34 - 1659] [CORE] INFO: Starting "1" children [2011/08/30-09:18:34 - 1661] [CORE] INFO: 2011/08/30-09:18:34 CONNECT TCP Peer: "127.0.0.1:44927" Local: "127.0.0.1:10031" [2011/08/30-09:18:34 - 1661] [PROTOCOLS/Postfix] DEBUG: Possible Postfix protocol [2011/08/30-09:18:34 - 1661] [PROTOCOLS/Postfix] INFO: Identified Postfix protocol [2011/08/30-09:18:34 - 7333] [CORE] DEBUG: Child Preforked (7333) [2011/08/30-09:18:34 - 7333] [CBPOLICYD] DEBUG: Starting up caching engine [2011/08/30-09:18:34 - 1661] [TRACKING] DEBUG: No session tracking data exists for request: $VAR1 = { 'ccert_fingerprint' => '', 'sasl_method' => '', 'sasl_sender' => '', 'size' => '365', '_timestamp' => 1314688714, 'helo_name' => '[192.168.170.85]', 'reverse_client_name' => 'unknown', 'queue_id' => '', 'encryption_cipher' => '', 'encryption_protocol' => '', 'etrn_domain' => '', 'ccert_subject' => '', 'request' => 'smtpd_access_policy', 'protocol_state' => 'RCPT', 'stress' => '', 'recipient' => '[email protected]', 'sasl_username' => '', 'instance' => '1ca3.4e5c8eca.9e7c7.0', 'protocol_name' => 'ESMTP', 'encryption_keysize' => '0', 'recipient_count' => '0', 'ccert_issuer' => '', 'sender' => '[email protected]', 'client_name' => 'unknown', 'client_address' => '192.168.170.85', '_protocol_transport' => 'Postfix' }; [2011/08/30-09:18:34 - 1661] [TRACKING] DEBUG: Added session tracking information for: $VAR1 = { 'ccert_fingerprint' => '', 'sasl_method' => '', 'sasl_sender' => '', 'size' => '365', '_timestamp' => 1314688714, 'helo_name' => '[192.168.170.85]', 'reverse_client_name' => 'unknown', 'queue_id' => '', 'encryption_cipher' => '', 'encryption_protocol' => '', 'etrn_domain' => '', 'ccert_subject' => '', 'request' => 'smtpd_access_policy', 'protocol_state' => 'RCPT', 'stress' => '', 'recipient' => '[email protected]', 'sasl_username' => '', 'instance' => '1ca3.4e5c8eca.9e7c7.0', 'protocol_name' => 'ESMTP', 'encryption_keysize' => '0', 'recipient_count' => '0', 'ccert_issuer' => '', 'sender' => '[email protected]', 'client_name' => 'unknown', 'client_address' => '192.168.170.85', '_protocol_transport' => 'Postfix' }; [2011/08/30-09:18:34 - 1661] [TRACKING] DEBUG: Protocol state is 'RCPT', resolving policy... [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: Going to resolve session data into policy: $VAR1 = { 'Recipient' => '[email protected]', 'SASLUsername' => '', 'QueueID' => '', 'RecipientData' => '', 'Instance' => '1ca3.4e5c8eca.9e7c7.0', 'EncryptionCipher' => '', 'Size' => '365', 'EncryptionKeySize' => '0', 'EncryptionProtocol' => '', 'Helo' => '[192.168.170.85]', 'ClientAddress' => '192.168.170.85', 'ClientName' => 'unknown', 'Sender' => '[email protected]', 'SASLSender' => '', 'Protocol' => 'ESMTP', 'ClientReverseName' => 'unknown', 'SASLMethod' => '' }; [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: Found policy member with ID '2' in policy 'Default Outbound' [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]: Main policy sources '%internal_ips,%internal_domains' [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]: Group 'internal_ips' has 3 source(s) => 10.0.0.0/8,192.168.170.0/24,192.168.254.0/24 [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]=>(group:internal_ips): - Resolved source '10.0.0.0/8' to a IP/CIDR specification, match = 0 [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]=>(group:internal_ips): - Resolved source '192.168.170.0/24' to a IP/CIDR specification, match = 1 [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]=>(group:internal_ips): Source group result: matched=1 [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]: Group 'internal_domains' has 2 source(s) => @gmail.com,@domain.ch [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]=>(group:internal_domains): - Resolved source '@gmail.com' to a email address specification, match = 1 [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]=>(group:internal_domains): Source group result: matched=1 [2011/08/30-09:18:34 - 1661] [POLICIES] INFO: [ID:2/Name:Default Outbound]: Source matching result: matched=1 [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]: Main policy destinations '!%internal_domains' [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]: Group 'internal_domains' has 2 destination(s) => @gmail.com,@domain.ch [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]=>(group:internal_domains): - Resolved destination '@gmail.com' to a email address specification, match = 1 [2011/08/30-09:18:34 - 1661] [POLICIES] DEBUG: [ID:2/Name:Default Outbound]=>(group:internal_domains): Destination group result: matched=1 [2011/08/30-09:18:34 - 1661] [POLICIES] INFO: [ID:2/Name:Default Outbound]: Destination matching result: matched=0 [2011/08/30-09:18:34 - 1661] [TRACKING] DEBUG: Policy resolved into: $VAR1 = {}; [2011/08/30-09:18:34 - 1661] [TRACKING] DEBUG: Request translated into session data: $VAR1 = { 'Recipient' => '[email protected]', 'SASLUsername' => '', 'QueueID' => '', 'RecipientData' => '', 'Instance' => '1ca3.4e5c8eca.9e7c7.0', 'EncryptionCipher' => '', 'Size' => '365', 'EncryptionKeySize' => '0', 'ParsedClientAddress' => { 'Broadcast_Long' => 3232279125, 'Network' => '192.168.170.85', 'IP_Long' => 3232279125, 'Broadcast' => '192.168.170.85', 'IP' => '192.168.170.85', 'Mask_Long' => 4294967295, 'Network_Long' => 3232279125 }, 'ProtocolTransport' => 'Postfix', 'EncryptionProtocol' => '', 'Helo' => '[192.168.170.85]', 'ClientAddress' => '192.168.170.85', 'ClientName' => 'unknown', 'Sender' => '[email protected]', 'SASLSender' => '', 'Timestamp' => 1314688714, 'ProtocolState' => 'RCPT', 'Policy' => {}, 'Protocol' => 'ESMTP', 'ClientReverseName' => 'unknown', 'SASLMethod' => '' }; [2011/08/30-09:18:34 - 1661] [CBPOLICYD] DEBUG: Got request, running modules... [2011/08/30-09:18:34 - 1661] [CBPOLICYD] DEBUG: Running module: Access Control Plugin [2011/08/30-09:18:34 - 1661] [CBPOLICYD] DEBUG: Running module: HELO/EHLO Check Plugin [2011/08/30-09:18:34 - 1661] [CBPOLICYD] DEBUG: Running module: SPF Check Plugin [2011/08/30-09:18:34 - 1661] [CBPOLICYD] DEBUG: Running module: Greylisting Plugin [2011/08/30-09:18:34 - 1661] [CBPOLICYD] DEBUG: Running module: Quotas Plugin [2011/08/30-09:18:34 - 1661] [CBPOLICYD] DEBUG: Done with modules [2011/08/30-09:19:04 - 1659] [CORE] INFO: Killing "1" children [2011/08/30-09:19:04 - 1661] [CBPOLICYD] DEBUG: Shutting down caching engine (1661) ================================ Now, there is my conf file : [cluebringer.conf] ================================ # #server configuration # [server] # Protocols to load protocols=<<EOT Postfix #Bizanga EOT # Modules to load modules=<<EOT Core AccessControl #Accounting #Amavis CheckHelo CheckSPF Greylisting Quotas EOT # User to run this daemon as user=policyd group=policyd # Filename to store pid of parent process #pid_file=/var/run/cbpolicyd.pid # Uncommenting the below option will prevent cbpolicyd going into the background #background=no # Preforking configuration # # min_server - Minimum servers to keep around # min_spare_servers - Minimum spare servers to keep around ready to # handle requests # max_spare_servers - Maximum spare servers to have around doing nothing # max_servers - Maximum servers alltogether # max_requests - Maximum number of requests each child will serve # # One may want to use the following as a rough guideline... # Small mailserver: 2, 2, 4, 10, 1000 # Medium mailserver: 4, 4, 12, 25, 1000 # Large mailserver: 8, 8, 16, 64, 1000 # #min_servers=4 #min_spare_servers=4 #max_spare_servers=12 #max_servers=25 #max_requests=1000 # Log level: # 0 - Errors only # 1 - Warnings and errors # 2 - Notices, warnings, errors # 3 - Info, notices, warnings, errors # 4 - Debugging log_level=4 # File to log to instead of stdout #log_file=/var/log/cbpolicyd.log # Log destination for mail logs... # main - Default. Log to policyd's main log mechanism, accepts NO args # syslog - log mail via syslog # format: log_mail=facility@method,args # # Valid methods for syslog: # native - Let Sys::Syslog decide # unix - Unix socket # udp - UDP socket # stream - Stream (for Solaris) # # Example: unix native #log_mail=mail@syslog:native # # Example: unix socket #log_mail=mail@syslog:unix # # Example: udp #log_mail=mail@syslog:udp,127.0.0.1 # # Example: Solaris #log_mail=local0@syslog:stream,/dev/log log_mail=maillog # Things to log in extreme detail # modules - Log detailed module running information # tracking - Log detailed tracking information # policies - Log policy resolution # protocols - Log general protocol info, but detailed # bizanga - Log the bizanga protocol # cache - Log cache usage on client shutdown # # There is no default for this configuration option. Options can be # separated by commas. ie. protocols,modules # log_detail=modules,tracking,policies,protocols # Protocol to use "tcp" or "unix", defaults to "tcp" #proto=tcp # IP to listen on, * for all. Blank for unix sockets #host=* # Port to run on, in the case of a unix socket it would be the path # eg. 10031 # eg. /var/run/cbpolicyd/policyd.sock #port=10031 # Timeout in communication with clients, defaults to 120s #timeout=120 # cidr_allow/cidr_deny # Comma, whitespace or semi-colon separated. Contains a CIDR block to # compare the clients IP to. If cidr_allow or cidr_deny options are # given, the incoming client must match a cidr_allow and not match a # cidr_deny or the client connectio will be closed. #cidr_allow=0.0.0.0/0 #cidr_deny= #cidr_allow=192.168.170.0/24 [database] #DSN=DBI:SQLite:dbname=policyd.sqlite DSN=DBI:mysql:database=policyd;host=127.0.0.1:3306 Username=policyd2 Password=postfix # # What do we do when we have a database connection problem # tempfail - Return temporary failure # pass - Return success bypass_mode=pass # How many seconds before we retry a DB connection bypass_timeout=30 # Table prefix to use, be sure to generate the schema with the table # prefix aswell! #table_prefix= # Access Control module [AccessControl] enable=0 # Accounting module [Accounting] enable=0 # Amavis module [Amavis] enable=0 # Disabled by default # CheckHelo module [CheckHelo] enable=0 # CheckSPF module [CheckSPF] enable=0 # Greylisting module [Greylisting] enable=0 #training_mode=1 #defer_message=Greylisting in effect, please come back later #blacklist_message=Greylisting in effect, sending server blacklisted # Quotas module [Quotas] enable=1 [main.cf] ================================== # See /usr/share/postfix/main.cf.dist for a commented, more complete version # Debian specific: Specifying a file name will cause the first # line of that file to be used as the name. The Debian default # is /etc/mailname. #myorigin = /etc/mailname debug_peer_level = 2 smtpd_banner = $myhostname ESMTP $mail_name (Debian/GNU) biff = no # appending .domain is the MUA's job. append_dot_mydomain = no # Uncomment the next line to generate "delayed mail" warnings #delay_warning_time = 4h readme_directory = no # TLS parameters smtpd_tls_cert_file=/etc/ssl/certs/ssl-cert-snakeoil.pem smtpd_tls_key_file=/etc/ssl/private/ssl-cert-snakeoil.key smtpd_use_tls=yes smtpd_tls_session_cache_database = btree:${data_directory}/smtpd_scache smtp_tls_session_cache_database = btree:${data_directory}/smtp_scache # See /usr/share/doc/postfix/TLS_README.gz in the postfix-doc package for # information on enabling SSL in the smtp client. myhostname = testing-puppet.domain.ch alias_maps = hash:/etc/aliases alias_database = hash:/etc/aliases myorigin = /etc/mailname mydestination = testing-puppet.domain.ch, localhost.domain.ch, , localhost relayhost = mynetworks = 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.170.0/24 192.168.254.0/24 mailbox_command = procmail -a "$EXTENSION" mailbox_size_limit = 0 recipient_delimiter = + inet_interfaces = all #policyd rules smtpd_sender_restrictions = check_policy_service inet:127.0.0.1:10031 defer #smtpd_recipient_restrictions = check_policy_service inet:192.186.254.242:10031 defer #smtpd_end_of_data_restrictions = check_policy_service inet:192.168.254.242:10031 defer [master.cf] ===================================== # # Postfix master process configuration file. For details on the format # of the file, see the master(5) manual page (command: "man 5 master"). # # Do not forget to execute "postfix reload" after editing this file. # # ========================================================================== # service type private unpriv chroot wakeup maxproc command + args # (yes) (yes) (yes) (never) (100) # ========================================================================== smtp inet n - - - - smtpd -v #submission inet n - - - - smtpd # -o smtpd_tls_security_level=encrypt # -o smtpd_sasl_auth_enable=yes # -o smtpd_client_restrictions=permit_sasl_authenticated,reject # -o milter_macro_daemon_name=ORIGINATING #smtps inet n - - - - smtpd # -o smtpd_tls_wrappermode=yes # -o smtpd_sasl_auth_enable=yes # -o smtpd_client_restrictions=permit_sasl_authenticated,reject # -o milter_macro_daemon_name=ORIGINATING #628 inet n - - - - qmqpd pickup fifo n - - 60 1 pickup cleanup unix n - - - 0 cleanup qmgr fifo n - n 300 1 qmgr #qmgr fifo n - - 300 1 oqmgr tlsmgr unix - - - 1000? 1 tlsmgr rewrite unix - - - - - trivial-rewrite bounce unix - - - - 0 bounce defer unix - - - - 0 bounce trace unix - - - - 0 bounce verify unix - - - - 1 verify flush unix n - - 1000? 0 flush proxymap unix - - n - - proxymap proxywrite unix - - n - 1 proxymap smtp unix - - - - - smtp # When relaying mail as backup MX, disable fallback_relay to avoid MX loops relay unix - - - - - smtp -o smtp_fallback_relay= # -o smtp_helo_timeout=5 -o smtp_connect_timeout=5 showq unix n - - - - showq error unix - - - - - error retry unix - - - - - error discard unix - - - - - discard local unix - n n - - local virtual unix - n n - - virtual lmtp unix - - - - - lmtp anvil unix - - - - 1 anvil scache unix - - - - 1 scache # # ==================================================================== # Interfaces to non-Postfix software. Be sure to examine the manual # pages of the non-Postfix software to find out what options it wants. # # Many of the following services use the Postfix pipe(8) delivery # agent. See the pipe(8) man page for information about ${recipient} # and other message envelope options. # ==================================================================== # # maildrop. See the Postfix MAILDROP_README file for details. # Also specify in main.cf: maildrop_destination_recipient_limit=1 # maildrop unix - n n - - pipe flags=DRhu user=vmail argv=/usr/bin/maildrop -d ${recipient} # # ==================================================================== # # Recent Cyrus versions can use the existing "lmtp" master.cf entry. # # Specify in cyrus.conf: # lmtp cmd="lmtpd -a" listen="localhost:lmtp" proto=tcp4 # # Specify in main.cf one or more of the following: # mailbox_transport = lmtp:inet:localhost # virtual_transport = lmtp:inet:localhost # # ==================================================================== # # Cyrus 2.1.5 (Amos Gouaux) # Also specify in main.cf: cyrus_destination_recipient_limit=1 # #cyrus unix - n n - - pipe # user=cyrus argv=/cyrus/bin/deliver -e -r ${sender} -m ${extension} ${user} # # ==================================================================== # Old example of delivery via Cyrus. # #old-cyrus unix - n n - - pipe # flags=R user=cyrus argv=/cyrus/bin/deliver -e -m ${extension} ${user} # # ==================================================================== # # See the Postfix UUCP_README file for configuration details. # uucp unix - n n - - pipe flags=Fqhu user=uucp argv=uux -r -n -z -a$sender - $nexthop!rmail ($recipient) # # Other external delivery methods. # ifmail unix - n n - - pipe flags=F user=ftn argv=/usr/lib/ifmail/ifmail -r $nexthop ($recipient) bsmtp unix - n n - - pipe flags=Fq. user=bsmtp argv=/usr/lib/bsmtp/bsmtp -t$nexthop -f$sender $recipient scalemail-backend unix - n n - 2 pipe flags=R user=scalemail argv=/usr/lib/scalemail/bin/scalemail-store ${nexthop} ${user} ${extension} mailman unix - n n - - pipe flags=FR user=list argv=/usr/lib/mailman/bin/postfix-to-mailman.py ${nexthop} ${user} It's very frustrating because when I unlink Policyd from Postfix, my platform works well... My policies are (I think) seted well. I use only Default Outbound and I set everything to disabled=no and I didn't forget to add IP / domain name in GROUPS. I'm on this problem from a long time, I'm desperate... Rvdebian _______________________________________________ Users mailing list [email protected] http://lists.policyd.org/mailman/listinfo/users
