Received E-Mails (from one address) don't appear in inbox

Alain Spineux aspineux at gmail.com
Tue Jun 10 18:25:01 CEST 2008


On Tue, Jun 10, 2008 at 3:46 PM, Volker Stoppe <grenzlaeufer at gmx.net> wrote:
> Hallo togehter!
>
> I have a big problem with mail delivery / recieving in Kolab. Let me
> discribe it in Form of a fable. The rabbit sends the fox a letter. But the
> fox does not recieve any letter. The fox watches the postman putting the
> mail in his letterbox, but when he opens it, there is no letter.
> My postfix says that the receipient has received a mail, but it never
> reaches his mailbox. The reciepient recieves mails from every other
> domain/mailaccount, but not from this special account. This is definitely
> reproduceable. Dozen of other users use this mailserver without
> complaining. Maybe somebody could have a look over the postfix.log and
> gets a clue. I couldn't find anything else in other log-files I looked in
> (all cyrus-logs).
> I use the Debian binaries of Kolab 2.1 with Debian Sarge.
>
> Thanks for having a look and posting ideas in advance
>
> Volker Stoppe
>
You should have a file called something like "res*.log".
Do you see any erro in it ?
Any error in amavis  log ?
Can someone else in the same sender domain send an email to fox or
someone else in fox domain ?

>
>
> postfix.log:
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: connection established
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: master_notify: status 0
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: name_mask: resource
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: name_mask: software
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: name_mask: noanonymous
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: connect from
> relay02.par.totalbanal.net[141.227.0.1]
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> relay02.par.totalbanal.net: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> 141.227.0.1: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> relay02.par.totalbanal.net: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> 141.227.0.1: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 127.0.0.0/8
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 127.0.0.0/8
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.6
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.6
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.4
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.4
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.11
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.11
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.252
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.252
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> relay02.par.totalbanal.net: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> 141.227.0.1: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: send attr request =
> connect
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: send attr ident =
> smtp:141.227.0.1
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: private/anvil: wanted
> attribute: status
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: input attribute name:
> status
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: input attribute value: 0
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: private/anvil: wanted
> attribute: count
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: input attribute name:
> count
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: input attribute value: 1
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: private/anvil: wanted
> attribute: rate
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: input attribute name: rate
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: input attribute value: 1
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: private/anvil: wanted
> attribute: (list terminator)
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 220 mail.magicwood.mgw ESMTP
> Postfix
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: <
> relay02.par.totalbanal.net[141.227.0.1]: EHLO relay02.par.totalbanal.net
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-mail.magicwood.mgw
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-PIPELINING
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-SIZE 20971520
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-VRFY
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-ETRN
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-STARTTLS
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-AUTH LOGIN PLAIN
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> relay02.par.totalbanal.net: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: match_list_match:
> 141.227.0.1: no match
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250-AUTH=LOGIN PLAIN
> Jun 10 11:13:00 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250 8BITMIME
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: <
> relay02.par.totalbanal.net[141.227.0.1]: MAIL FROM:<rabbit at mapa.de>
> SIZE=1078
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: extract_addr: input:
> <rabbit at mapa.de>
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: smtpd_check_addr:
> addr=rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr request =
> rewrite
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr rule = local
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr address =
> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value: 0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: address
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> address
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: rewrite_clnt: local:
> rabbit at mapa.de -> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr request =
> resolve
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr address =
> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value: 0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: transport
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> transport
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> smtp
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: nexthop
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> nexthop
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: recipient
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> recipient
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> 4096
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: resolve_clnt:
> `rabbit at mapa.de' -> transp=`smtp' host=`mapa.de' rcpt=`rabbit at mapa.de'
> flags= class=default
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: ctable_locate: install
> entry key rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: extract_addr: result:
> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: fsspace: .: block size
> 4096, blocks free 1623541
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: smtpd_check_size: blocks
> 4096 avail 1623541 min_free 0 msg_size_limit 20971520
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250 Ok
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: <
> relay02.par.totalbanal.net[141.227.0.1]: RCPT TO:<fox at magicwood.mgw>
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: extract_addr: input:
> <fox at magicwood.mgw>
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: smtpd_check_addr:
> addr=fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr request =
> rewrite
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr rule = local
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr address =
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value: 0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: address
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> address
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: rewrite_clnt: local:
> fox at magicwood.mgw -> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr request =
> resolve
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr address =
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value: 0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: transport
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> transport
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> local
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: nexthop
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> nexthop
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> mail.magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: recipient
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> recipient
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> flags
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value: 256
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/rewrite socket:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: resolve_clnt:
> `fox at magicwood.mgw' -> transp=`local' host=`mail.magicwood.mgw'
> rcpt=`fox at magicwood.mgw' flags= class=local
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: ctable_locate: install
> entry key fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: extract_addr: result:
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >>> START Sender address
> RESTRICTIONS <<<
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=permit_mynetworks
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: permit_mynetworks:
> relay02.par.totalbanal.net 141.227.0.1
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 127.0.0.0/8
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 127.0.0.0/8
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.6
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.6
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.4
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.4
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.11
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.11
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.252
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.252
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_list_match:
> relay02.par.totalbanal.net: no match
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_list_match:
> 141.227.0.1: no match
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=permit_mynetworks status=0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=check_policy_service
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr request =
> smtpd_access_policy
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr protocol_state
> = RCPT
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr protocol_name =
> ESMTP
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr client_address
> = 141.227.0.1
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr client_name =
> relay02.par.totalbanal.net
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr helo_name =
> relay02.par.totalbanal.net
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sender =
> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr recipient =
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr queue_id =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr instance =
> 4d7.484e459d.0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr size = 1078
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sasl_method =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sasl_username =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sasl_sender =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr ccert_subject =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr ccert_issuer =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr
> ccert_fingerprint =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/kolabpolicy:
> wanted attribute: action
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> action
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> DUNNO
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/kolabpolicy:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: check_table_result:
> unix:private/kolabpolicy DUNNO policy query
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=check_policy_service status=0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >>> END Sender address
> RESTRICTIONS <<<
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >>> START Recipient
> address RESTRICTIONS <<<
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=permit_mynetworks
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: permit_mynetworks:
> relay02.par.totalbanal.net 141.227.0.1
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 127.0.0.0/8
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 127.0.0.0/8
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.6
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.6
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.4
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.4
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.11
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.11
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.252
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.252
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_list_match:
> relay02.par.totalbanal.net: no match
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: match_list_match:
> 141.227.0.1: no match
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=permit_mynetworks status=0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=permit_sasl_authenticated
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=permit_sasl_authenticated status=0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=reject_unauth_destination
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]:
> reject_unauth_destination: fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: permit_auth_destination:
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: ctable_locate: leave
> existing entry key fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=reject_unauth_destination status=0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=reject_unlisted_recipient
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >>> CHECKING RECIPIENT
> MAPS <<<
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: ctable_locate: leave
> existing entry key fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: maps_find:
> recipient_canonical_maps: fox at magicwood.mgw: not found
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: maps_find:
> recipient_canonical_maps: fox: not found
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: maps_find:
> recipient_canonical_maps: @magicwood.mgw: not found
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: mail_addr_find:
> fox at magicwood.mgw -> (not found)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: maps_find:
> canonical_maps: fox at magicwood.mgw: not found
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: maps_find:
> canonical_maps: fox: not found
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: maps_find:
> canonical_maps: @magicwood.mgw: not found
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: mail_addr_find:
> fox at magicwood.mgw -> (not found)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup: In
> dict_ldap_lookup
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup: Using
> existing connection for LDAP source /kolab/etc/postfix/ldapdistlist.cf
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup:
> /kolab/etc/postfix/ldapdistlist.cf: Searching with filter
> (&(objectClass=kolabGroupOfNames)(!(kolabDeleteFlag=*))(mail=fox at magicwood.mgw))
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_get_values[1]:
> Search found 0 match(es)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_get_values[1]:
> Leaving dict_ldap_get_values
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup: Search
> returned nothing
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup: In
> dict_ldap_lookup
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup: Using
> existing connection for LDAP source /kolab/etc/postfix/ldapvirtual.cf
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup:
> /kolab/etc/postfix/ldapvirtual.cf: Searching with filter
> (&(!(kolabDeleteFlag=*))(|(alias=fox at magicwood.mgw)(mail=fox at magicwood.mgw)))
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_get_values[1]:
> Search found 1 match(es)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_get_values[1]:
> search returned 1 value(s) for requested result attribute mail
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_get_values[1]:
> Leaving dict_ldap_get_values
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: dict_ldap_lookup: Search
> returned fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: maps_find:
> virtual_alias_maps: ldap:/kolab/etc/postfix/ldapvirtual.cf(0,100):
> fox at magicwood.mgw = fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: mail_addr_find:
> fox at magicwood.mgw -> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=reject_unlisted_recipient status=0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=check_policy_service
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr request =
> smtpd_access_policy
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr protocol_state
> = RCPT
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr protocol_name =
> ESMTP
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr client_address
> = 141.227.0.1
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr client_name =
> relay02.par.totalbanal.net
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr helo_name =
> relay02.par.totalbanal.net
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sender =
> rabbit at mapa.de
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr recipient =
> fox at magicwood.mgw
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr queue_id =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr instance =
> 4d7.484e459d.0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr size = 1078
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sasl_method =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sasl_username =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr sasl_sender =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr ccert_subject =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr ccert_issuer =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr
> ccert_fingerprint =
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/kolabpolicy:
> wanted attribute: action
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> action
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> DUNNO
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: private/kolabpolicy:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: check_table_result:
> unix:private/kolabpolicy DUNNO policy query
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: generic_checks:
> name=check_policy_service status=0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >>> END Recipient address
> RESTRICTIONS <<<
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: smtpd_check_rewrite:
> trying: permit_inet_interfaces
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: permit_inet_interfaces:
> relay02.par.totalbanal.net 141.227.0.1
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: before
> input_transp_cleanup: cleanup flags = enable_header_body_filter
> enable_automatic_bcc enable_address_mapping
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: after
> input_transp_cleanup: cleanup flags = enable_header_body_filter
> enable_automatic_bcc enable_address_mapping
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: connect to subsystem
> public/cleanup
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: public/cleanup socket:
> wanted attribute: queue_id
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> queue_id
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> 11714128067
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: public/cleanup socket:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: send attr flags = 50
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: 11714128067:
> client=relay02.par.totalbanal.net[141.227.0.1]
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250 Ok
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: <
> relay02.par.totalbanal.net[141.227.0.1]: DATA
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 354 End data with
> <CR><LF>.<CR><LF>
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: public/cleanup socket:
> wanted attribute: status
> Jun 10 11:13:01 mail <info> postfix/cleanup[1221]: 11714128067: message-id=
> Jun 10 11:13:01 mail <info> postfix/qmgr[1208]: 11714128067:
> from=<rabbit at mapa.de>, size=1544, nrcpt=1 (queue active)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> status
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value: 0
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: public/cleanup socket:
> wanted attribute: reason
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> reason
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute value:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: public/cleanup socket:
> wanted attribute: (list terminator)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 250 Ok: queued as 11714128067
> Jun 10 11:13:01 mail <info> postfix/smtpd[1226]: connect from
> localhost[127.0.0.1]
> Jun 10 11:13:01 mail <info> postfix/smtpd[1226]: 327E412806D:
> client=localhost[127.0.0.1]
> Jun 10 11:13:01 mail <info> postfix/cleanup[1227]: 327E412806D: message-id=
> Jun 10 11:13:01 mail <info> postfix/qmgr[1208]: 327E412806D:
> from=<rabbit at mapa.de>, size=1722, nrcpt=1 (queue active)
> Jun 10 11:13:01 mail <info> postfix/smtpd[1226]: disconnect from
> localhost[127.0.0.1]
> Jun 10 11:13:01 mail <info> postfix/pipe[1222]: 11714128067:
> to=<fox at magicwood.mgw>, relay=kolabfilter, delay=0, status=sent
> (mail.magicwood.mgw)
> Jun 10 11:13:01 mail <info> postfix/qmgr[1208]: 11714128067: removed
> Jun 10 11:13:01 mail <info> postfix/pipe[1234]: 327E412806D:
> to=<fox at magicwood.mgw>, relay=kolabmailboxfilter, delay=0, status=sent
> (mail.magicwood.mgw)
> Jun 10 11:13:01 mail <info> postfix/qmgr[1208]: 327E412806D: removed
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: <
> relay02.par.totalbanal.net[141.227.0.1]: QUIT
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: >
> relay02.par.totalbanal.net[141.227.0.1]: 221 Bye
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 127.0.0.0/8
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 127.0.0.0/8
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.6
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.6
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.4
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.4
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.1.11
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.1.11
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostname:
> relay02.par.totalbanal.net ~? 192.168.2.252
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_hostaddr:
> 141.227.0.1 ~? 192.168.2.252
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_list_match:
> relay02.par.totalbanal.net: no match
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: match_list_match:
> 141.227.0.1: no match
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: send attr request =
> disconnect
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: send attr ident =
> smtp:141.227.0.1
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: private/anvil: wanted
> attribute: status
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: input attribute name:
> status
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: input attribute value: 0
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: private/anvil: wanted
> attribute: (list terminator)
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: input attribute name:
> (end)
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: disconnect from
> relay02.par.totalbanal.net[141.227.0.1]
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: master_notify: status 1
> Jun 10 11:13:06 mail <info> postfix/smtpd[1239]: connection closed
>
> _______________________________________________
> Kolab-users mailing list
> Kolab-users at kolab.org
> https://kolab.org/mailman/listinfo/kolab-users
>



-- 
Alain Spineux
aspineux gmail com
May the sources be with you




More information about the users mailing list