Loading ...
Sorry, an error occurred while loading the content.

Maildir Delivery Problem

Expand Messages
  • Sérgio Ferreira
    Hi list, I need any help with Maildir delivery process. When a message is received It isn´t delivered to Maildir, but It is send back to sender and postfix
    Message 1 of 5 , Nov 22, 2005
    • 0 Attachment
      Hi list,

      I need any help with Maildir delivery process. When a message is received It
      isn´t delivered to Maildir, but It is send back to sender and postfix log It
      as success process. See the log below:

      Nov 22 16:12:41 gaia postfix/smtp[12696]: 67C304C09C:
      to=<sergio.ferreira@...>, relay=mx1.minc.gov.br[200.198.204.69],
      delay=0,

      status=sent (250 Requested mail action okay, completed.)

      The message into (brackets) above should be "delivered to maildir" instead
      of (250 .....)

      I belive there is an configuration error with Postfix setup. I am guessing,
      perhaps with the path of user Maildir. It is stored at LDAP directory in the
      "mailMessageStore" attribute (/home/vmail/"username"/Maildir).

      My setup involves Postfix + LDAP + Courier IMAP + Courier Maildrop + Virtual
      Domains.

      I pasted the main.cf below:

      myhostname = localhost
      mydomain = cultura.gov.br
      mynetworks = 10.0.0.0, 127.0.0.0
      inet_interfaces = all
      alias_maps = ldap:ldapalias
      recipient_delimiter = +
      virtual_mailbox_base = /
      virtual_mailbox_maps = ldap:ldapvirtual
      virtual_uid_maps = static:10010
      virtual_gid_maps = static:15000
      virtual_minimum_uid = 10000
      virtual_alias_maps = ldap:ldapalias
      virtual_mailbox_domains = $mydomain monumenta.gov.br
      ldapvirtual_server_host = $myhostname
      ldapvirtual_server_port = 389
      ldapvirtual_bind = yes
      ldapvirtual_bind_dn = cn=admin,dc=cultura,dc=gov,dc=br
      ldapvirtual_bind_pw = temppass
      ldapvirtual_search_base = ou=Users,dc=cultura,dc=gov,dc=br
      ldapvirtual_query_filter = (&(|(mail=%s)(mailAlternateAddress=%s)))
      ldapvirtual_result_attribute = mailMessageStore
      virtual_alias_domains = $virtual_alias_maps
      virtual_maps = ldap:ldapalias
      ldapalias_server_host = $myhostname
      ldapalias_server_port = 389
      ldapalias_bind = yes
      ldapalias_bind_dn = cn=replica,dc=cultura,dc=gov,dc=br
      ldapalias_bind_pw = temppass
      ldapalias_search_base = ou=Users,dc=cultura,dc=gov,dc=br
      ldapalias_query_filter = (&(|(mail=%s)(mailAlternateAddress=%s)))
      ldapalias_result_attribute = mail
      local_recipient_maps = $alias_maps $virtual_mailbox_maps unix:passwd.byname
      local_recipient_maps = $alias_maps
      home_mailbox = Maildir/
      mailbox_command = /usr/bin/maildrop
      mailbox_transport = maildrop
      fallback_transport = maildrop
      virtual_transport = maildrop
      maildrop_destination_recipient_limit = 1

      and master.cf:


      smtp inet n - - - - smtpd -v
      pickup fifo n - - 60 1 pickup -v
      cleanup unix n - - - 0 cleanup -v
      qmgr fifo n - - 300 1 qmgr -v
      rewrite unix - - - - - trivial-rewrite
      bounce unix - - - - 0 bounce -v
      defer unix - - - - 0 bounce -v
      trace unix - - - - 0 bounce -v
      verify unix - - - - 1 verify -v
      flush unix n - - 1000? 0 flush -v
      proxymap unix - - n - - proxymap -v
      smtp unix - - - - - smtp -v
      relay unix - - - - - smtp -v
      showq unix n - - - - showq -v
      error unix - - - - - error -v
      local unix - n n - - local
      virtual unix - n n - - virtual
      lmtp unix - - n - - lmtp
      anvil unix - - n - 1 anvil
      maildrop unix - n n - - pipe -v
      flags=DRhu user=mailadmin argv=/usr/bin/maildrop -d ${user}@${nexthop}
      ${extension} ${recipient} ${user} ${nexthop}
      uucp unix - n n - - pipe
      flags=Fqhu user=uucp argv=uux -r -n -z -a$sender - $nexthop!rmail
      ($recipient)
      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 -d -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}


      Thanks,

      Sergio
    • Ralf Hildebrandt
      ... Postfix doesn t work that way. Check your logs to see what happened with 67C304C09C Show complete logs for a delivery of a mail that should go to a local
      Message 2 of 5 , Nov 22, 2005
      • 0 Attachment
        * S?rgio Ferreira <sergio.ferreira@...>:
        > Hi list,
        >
        > I need any help with Maildir delivery process. When a message is received It
        > isn?t delivered to Maildir, but It is send back to sender and postfix log It
        > as success process. See the log below:
        >
        > Nov 22 16:12:41 gaia postfix/smtp[12696]: 67C304C09C:
        > to=<sergio.ferreira@...>, relay=mx1.minc.gov.br[200.198.204.69],
        > delay=0,
        >
        > status=sent (250 Requested mail action okay, completed.)
        >
        > The message into (brackets) above should be "delivered to maildir" instead
        > of (250 .....)

        Postfix doesn't work that way. Check your logs to see what happened
        with 67C304C09C

        Show complete logs for a delivery of a mail that should go to a local
        Maildir/

        --
        Ralf Hildebrandt (Ralf.Hildebrandt@...) spamtrap@...
        Postfix - Einrichtung, Betrieb und Wartung Tel. +49 (0)30-450 570-155
        http://www.postfix-buch.com
        Given the opacity of the product, how could a Windows admin ever know
        as much about Windows as a UNIX admin does about UNIX?! (Roger B. A.
        Klorese on Postfix Mailing List)
      • Keith Matthews
        On Tue, 22 Nov 2005 17:01:00 -0200 ... Try /home/vmail/ username /Maildir/ - note the final / . -- Due to excessive spam as a result of archiving of this
        Message 3 of 5 , Nov 22, 2005
        • 0 Attachment
          On Tue, 22 Nov 2005 17:01:00 -0200
          Sérgio Ferreira <sergio.ferreira@...> wrote:

          > Hi list,
          >
          > I need any help with Maildir delivery process. When a message is received It
          > isn´t delivered to Maildir, but It is send back to sender and postfix log It
          > as success process. See the log below:
          >
          > Nov 22 16:12:41 gaia postfix/smtp[12696]: 67C304C09C:
          > to=<sergio.ferreira@...>, relay=mx1.minc.gov.br[200.198.204.69],
          > delay=0,
          >
          > status=sent (250 Requested mail action okay, completed.)
          >
          > The message into (brackets) above should be "delivered to maildir" instead
          > of (250 .....)
          >
          > I belive there is an configuration error with Postfix setup. I am guessing,
          > perhaps with the path of user Maildir. It is stored at LDAP directory in the
          > "mailMessageStore" attribute (/home/vmail/"username"/Maildir).
          >


          Try /home/vmail/"username"/Maildir/ - note the final '/'.


          --
          Due to excessive spam as a result of archiving of this list I only accept mail through the list server.
        • Sérgio Ferreira
          Hi Ralf, ... I thought that because I changed the transport either virtual or local and the output was like I wrote above. ... Below, It is the log concerning
          Message 4 of 5 , Nov 22, 2005
          • 0 Attachment
            Hi Ralf,

            >>>>>> I need any help with Maildir delivery process. When a message is
            >>>>>> received It isn?t delivered to Maildir, but It is send
            >>>>>back to sender
            >>>>>> and postfix log It as success process. See the log below:
            >>>>>>
            >>>>>> Nov 22 16:12:41 gaia postfix/smtp[12696]: 67C304C09C:
            >>>>>> to=<sergio.ferreira@...>,
            >>>>>> relay=mx1.minc.gov.br[200.198.204.69],
            >>>>>> delay=0,
            >>>>>>
            >>>>>> status=sent (250 Requested mail action okay, completed.)
            >>>>>>
            >>>>>> The message into (brackets) above should be "delivered
            >>>>>to maildir"
            >>>>>> instead of (250 .....)
            >>>>>
            >>>>>Postfix doesn't work that way.

            I thought that because I changed the transport either virtual or local and
            the output was like I wrote above.

            >>>>>Check your logs to see what
            >>>>>happened with 67C304C09C
            >>>>>

            Below, It is the log concerning the message 67C304C09C:

            Nov 22 16:12:41 gaia postfix/cleanup[12692]: open incoming/6/67C304C09C
            Nov 22 16:12:41 gaia postfix/cleanup[12692]: cleanup_open: open
            incoming/6/67C304C09C
            Nov 22 16:12:41 gaia postfix/cleanup[12692]: send attr queue_id = 67C304C09C
            Nov 22 16:12:41 gaia postfix/bounce[12695]: input attribute value:
            67C304C09C
            Nov 22 16:12:41 gaia postfix/cleanup[12692]: cleanup_header_callback:
            'Received: by localhost (Postfix)??id 67C304C09C; Tue, 22 Nov 2005 16:12:41
            -0200 (BRST)'
            Nov 22 16:12:41 gaia postfix/cleanup[12692]: 67C304C09C:
            message-id=<20051122181241.67C304C09C@localhost>
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: qmgr_active_feed:
            incoming/6/67C304C09C
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: qmgr_message_alloc: active
            67C304C09C
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: 67C304C09C: from=<>, size=2683,
            nrcpt=1 (queue active)
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: qmgr_peer_select: 67C304C09C smtp
            minc.gov.br (1 of 5)
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: qmgr_job_retire: 67C304C09C
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: send attr queue_id = 67C304C09C
            Nov 22 16:12:41 gaia postfix/smtp[12696]: input attribute value: 67C304C09C
            Nov 22 16:12:41 gaia postfix/smtp[12696]: deliver_request_get: file
            active/6/67C304C09C
            Nov 22 16:12:41 gaia postfix/smtp[12696]: 67C304C09C:
            to=<sergio.ferreira@...>, relay=mx1.minc.gov.br[200.198.204.69],
            delay=0, status=sent (250 Requested mail action okay, completed.)
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: qmgr_active_done: 67C304C09C
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: 67C304C09C: removed
            Nov 22 16:12:41 gaia postfix/qmgr[12688]: qmgr_job_free: 67C304C09C smtp


            >>>>>Show complete logs for a delivery of a mail that should go
            >>>>>to a local Maildir/
            >>>>>

            I pasted the whole process of a message, only smtpd and maildrop are
            verbose.

            Nov 22 17:37:02 gaia postfix/smtpd[12982]: connection established
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: master_notify: status 0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: name_mask: resource
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: name_mask: software
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: connect from
            mx1.minc.gov.br[200.198.204.69]
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_list_match:
            mx1.minc.gov.br: no match
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_list_match: 200.198.204.69:
            no match
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_list_match:
            mx1.minc.gov.br: no match
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_list_match: 200.198.204.69:
            no match
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >
            mx1.minc.gov.br[200.198.204.69]: 220 localhost ESMTP Postfix
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: watchdog_pat: 0x806a7e0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: <
            mx1.minc.gov.br[200.198.204.69]: HELO mx1.minc.gov.br
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >
            mx1.minc.gov.br[200.198.204.69]: 250 localhost
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: watchdog_pat: 0x806a7e0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: <
            mx1.minc.gov.br[200.198.204.69]: MAIL FROM:<sergio.ferreira@...>
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: extract_addr: input:
            <sergio.ferreira@...>
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: smtpd_check_addr:
            addr=sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: ctable_locate: move existing
            entry key sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: extract_addr: result:
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: fsspace: .: block size 4096,
            blocks free 11350962
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: smtpd_check_size: blocks 4096
            avail 11350962 min_free 0 msg_size_limit 10240000
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >
            mx1.minc.gov.br[200.198.204.69]: 250 Ok
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: watchdog_pat: 0x806a7e0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: <
            mx1.minc.gov.br[200.198.204.69]: RCPT TO:<sergio.ferreira@...>
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: extract_addr: input:
            <sergio.ferreira@...>
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: smtpd_check_addr:
            addr=sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: ctable_locate: move existing
            entry key sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: extract_addr: result:
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >>> START Recipient address
            RESTRICTIONS <<<
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: generic_checks:
            name=permit_mynetworks
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: permit_mynetworks:
            mx1.minc.gov.br 200.198.204.69
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_hostname: mx1.minc.gov.br
            ~? 10.0.0.0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_hostaddr: 200.198.204.69 ~?
            10.0.0.0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_hostname: mx1.minc.gov.br
            ~? 127.0.0.0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_hostaddr: 200.198.204.69 ~?
            127.0.0.0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_hostname: mx1.minc.gov.br
            ~? 200.198.204.64/27
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_hostaddr: 200.198.204.69 ~?
            200.198.204.64/27
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: generic_checks:
            name=permit_mynetworks status=1
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >>> CHECKING RECIPIENT MAPS <<<
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: ctable_locate: leave existing
            entry key sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: maps_find:
            recipient_canonical_maps: sergio.ferreira@...: not found
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_string: cultura.gov.br ~?
            localhost
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_string: cultura.gov.br ~?
            localhost.cultura.gov.br
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_string: cultura.gov.br ~?
            localhost
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_list_match: cultura.gov.br:
            no match
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: maps_find:
            recipient_canonical_maps: @...: not found
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: mail_addr_find:
            sergio.ferreira@... -> (not found)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: maps_find: canonical_maps:
            sergio.ferreira@...: not found
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_string: cultura.gov.br ~?
            localhost
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_string: cultura.gov.br ~?
            localhost.cultura.gov.br
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_string: cultura.gov.br ~?
            localhost
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: match_list_match: cultura.gov.br:
            no match
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: maps_find: canonical_maps:
            @...: not found
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: mail_addr_find:
            sergio.ferreira@... -> (not found)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: dict_ldap_lookup: In
            dict_ldap_lookup
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: dict_ldap_lookup: Using existing
            connection for LDAP source ldapalias
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: dict_ldap_lookup: Searching with
            filter
            (&(|(mail=sergio.ferreira@...)(mailAlternateAddress=sergio.ferrei
            ra@...)))
            Nov 22 17:37:02 gaia slapd[2677]: conn=1383 op=2 SRCH
            base="ou=Users,dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(|(mail=sergio.ferreira@...)(mailAlternateAddress=sergi
            o.ferreira@...)))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1383 op=2 SRCH attr=mail
            Nov 22 17:37:02 gaia slapd[2677]: conn=1383 op=2 SEARCH RESULT tag=101 err=0
            nentries=1 text=
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: dict_ldap_get_values[1]: Search
            found 1 match(es)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: dict_ldap_get_values[1]: search
            returned 1 value(s) for requested result attribute mail
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: dict_ldap_get_values[1]: Leaving
            dict_ldap_get_values
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: dict_ldap_lookup: Search returned
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: maps_find: virtual_alias_maps:
            ldap:ldapalias(0,100): sergio.ferreira@... =
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: mail_addr_find:
            sergio.ferreira@... -> sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: connect to subsystem
            public/cleanup
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: public/cleanup socket: wanted
            attribute: queue_id
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute name: queue_id
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute value: AB4204C095
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: public/cleanup socket: wanted
            attribute: (list terminator)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute name: (end)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: send attr flags = 50
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: AB4204C095:
            client=mx1.minc.gov.br[200.198.204.69]
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >
            mx1.minc.gov.br[200.198.204.69]: 250 Ok
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: watchdog_pat: 0x806a7e0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: <
            mx1.minc.gov.br[200.198.204.69]: DATA
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >
            mx1.minc.gov.br[200.198.204.69]: 354 End data with <CR><LF>.<CR><LF>
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=4 SRCH
            base="ou=Users,dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(|(mail=sergio.ferreira@...)(mailAlternateAddress=sergi
            o.ferreira@...)))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=4 SRCH attr=mail
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=4 SEARCH RESULT tag=101 err=0
            nentries=1 text=
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: public/cleanup socket: wanted
            attribute: status
            Nov 22 17:37:02 gaia postfix/cleanup[12984]: AB4204C095:
            message-id=<20051122193702.AB4204C095@localhost>
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute name: status
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute value: 0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: public/cleanup socket: wanted
            attribute: reason
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute name: reason
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute value: (end)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: public/cleanup socket: wanted
            attribute: (list terminator)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: input attribute name: (end)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >
            mx1.minc.gov.br[200.198.204.69]: 250 Ok: queued as AB4204C095
            Nov 22 17:37:02 gaia postfix/qmgr[12980]: AB4204C095:
            from=<sergio.ferreira@...>, size=988, nrcpt=1 (queue active)
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: watchdog_pat: 0x806a7e0
            Nov 22 17:37:02 gaia slapd[2677]: conn=1382 op=5 SRCH
            base="ou=Users,dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(|(mail=cultura.gov.br)(mailAlternateAddress=cultura.gov.br)))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1382 op=5 SRCH attr=mail
            Nov 22 17:37:02 gaia slapd[2677]: conn=1382 op=5 SEARCH RESULT tag=101 err=0
            nentries=0 text=
            Nov 22 17:37:02 gaia postfix/pipe[12985]: connection established
            Nov 22 17:37:02 gaia postfix/pipe[12985]: master_notify: status 0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: deliver_request_initial: send
            initial status
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr status = 0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            flags
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: flags
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: 3
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            queue_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: queue_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: active
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            queue_id
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: queue_id
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: AB4204C095
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            offset
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: offset
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: 327
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            size
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: size
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: 988
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            nexthop
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: nexthop
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            cultura.gov.br
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            encoding
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: encoding
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: (end)
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            sender
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: sender
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            errors-to
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: errors-to
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            return-receipt
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name:
            return-receipt
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: (end)
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            time
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: time
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: 1132688222
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            client_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: client_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            mx1.minc.gov.br
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            client_address
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name:
            client_address
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            200.198.204.69
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            protocol_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name:
            protocol_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: SMTP
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            helo_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: helo_name
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            mx1.minc.gov.br
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            offset
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: offset
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: 293
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            original_recipient
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name:
            original_recipient
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            recipient
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: recipient
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: <
            mx1.minc.gov.br[200.198.204.69]: QUIT
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value:
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: >
            mx1.minc.gov.br[200.198.204.69]: 221 Bye
            Nov 22 17:37:02 gaia postfix/pipe[12985]: maildrop socket: wanted attribute:
            offset
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: disconnect from
            mx1.minc.gov.br[200.198.204.69]
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: offset
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: 0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: master_notify: status 1
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: connection closed
            Nov 22 17:37:02 gaia postfix/pipe[12985]: deliver_request_get: file
            active/A/AB4204C095
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: watchdog_stop: 0x806a7e0
            Nov 22 17:37:02 gaia postfix/smtpd[12982]: watchdog_start: 0x806a7e0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: deliver_message: from
            <sergio.ferreira@...>
            Nov 22 17:37:02 gaia authdaemond: received userid lookup request:
            sergio.ferreira@...
            Nov 22 17:37:02 gaia authdaemond: authldap: trying this module
            Nov 22 17:37:02 gaia authdaemond: using search filter:
            (&(objectClass=posixAccount)(uid=sergio.ferreira@...))
            Nov 22 17:37:02 gaia slapd[2677]: conn=1387 op=2 SRCH
            base="ou=Users,dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(objectClass=posixAccount)(uid=sergio.ferreira@...))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1387 op=2 SRCH attr=mailMessageStore
            mailMessageStore cn userPassword uid
            Nov 22 17:37:02 gaia slapd[2677]: conn=1387 op=2 SEARCH RESULT tag=101 err=0
            nentries=0 text=
            Nov 22 17:37:02 gaia authdaemond: number of entries returned: 0 (but we need
            exactly 1)
            Nov 22 17:37:02 gaia authdaemond: authldap: REJECT - try next module
            Nov 22 17:37:02 gaia authdaemond: FAIL, all modules rejected
            Nov 22 17:37:02 gaia slapd[2677]: conn=1391 fd=32 ACCEPT from
            IP=127.0.0.1:34250 (IP=0.0.0.0:389)
            Nov 22 17:37:02 gaia slapd[2677]: conn=1391 op=0 BIND dn="" method=128
            Nov 22 17:37:02 gaia slapd[2677]: conn=1391 op=0 RESULT tag=97 err=0 text=
            Nov 22 17:37:02 gaia slapd[2677]: conn=1391 op=1 SRCH
            base="dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(objectClass=posixAccount)(uid=sergio.ferreira@...))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1391 op=1 SRCH attr=uid userPassword
            uidNumber gidNumber cn homeDirectory loginShell gecos description
            objectClass
            Nov 22 17:37:02 gaia slapd[2677]: conn=1391 op=1 SEARCH RESULT tag=101 err=0
            nentries=0 text=
            Nov 22 17:37:02 gaia slapd[2677]: conn=1391 fd=32 closed
            Nov 22 17:37:02 gaia postfix/pipe[12985]: connect to subsystem
            private/bounce
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr nrequest = 0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr flags = 0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr queue_id = AB4204C095
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr original_recipient =
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr recipient =
            sergio.ferreira@...
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr offset = 293
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr status = 5.0.0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr action = failed
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr reason = user unknown.
            Command output: Invalid user specified.
            Nov 22 17:37:02 gaia postfix/pipe[12985]: private/bounce socket: wanted
            attribute: status
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: status
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute value: 0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: private/bounce socket: wanted
            attribute: (list terminator)
            Nov 22 17:37:02 gaia postfix/pipe[12985]: input attribute name: (end)
            Nov 22 17:37:02 gaia postfix/pipe[12985]: AB4204C095:
            to=<sergio.ferreira@...>, relay=maildrop, delay=0, status=bounced
            (user unknown. Command output: Invalid user specified. )
            Nov 22 17:37:02 gaia postfix/pipe[12985]: deliver_request_final: send: "" 0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr reason =
            Nov 22 17:37:02 gaia postfix/pipe[12985]: send attr status = 0
            Nov 22 17:37:02 gaia postfix/pipe[12985]: master_notify: status 1
            Nov 22 17:37:02 gaia postfix/pipe[12985]: connection closed
            Nov 22 17:37:02 gaia postfix/pipe[12985]: watchdog_stop: 0x80547c8
            Nov 22 17:37:02 gaia postfix/pipe[12985]: watchdog_start: 0x80547c8
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=5 SRCH
            base="ou=Users,dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(|(mail=sergio.ferreira@...)(mailAlternateAddress=sergio.f
            erreira@...)))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=5 SRCH attr=mail
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=5 SEARCH RESULT tag=101 err=0
            nentries=0 text=
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=6 SRCH
            base="ou=Users,dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(|(mail=@...)(mailAlternateAddress=@...)))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=6 SRCH attr=mail
            Nov 22 17:37:02 gaia slapd[2677]: conn=1385 op=6 SEARCH RESULT tag=101 err=0
            nentries=0 text=
            Nov 22 17:37:02 gaia postfix/cleanup[12984]: BB1B94C097:
            message-id=<20051122193702.BB1B94C097@localhost>
            Nov 22 17:37:02 gaia postfix/qmgr[12980]: BB1B94C097: from=<>, size=2682,
            nrcpt=1 (queue active)
            Nov 22 17:37:02 gaia slapd[2677]: conn=1382 op=6 SRCH
            base="ou=Users,dc=cultura,dc=gov,dc=br" scope=2 deref=0
            filter="(&(|(mail=minc.gov.br)(mailAlternateAddress=minc.gov.br)))"
            Nov 22 17:37:02 gaia slapd[2677]: conn=1382 op=6 SRCH attr=mail
            Nov 22 17:37:02 gaia slapd[2677]: conn=1382 op=6 SEARCH RESULT tag=101 err=0
            nentries=0 text=
            Nov 22 17:37:02 gaia postfix/qmgr[12980]: AB4204C095: removed
            Nov 22 17:37:03 gaia postfix/smtp[12988]: BB1B94C097:
            to=<sergio.ferreira@...>, relay=mx1.minc.gov.br[200.198.204.69],
            delay=1, status=sent (250 Requested mail action okay, completed.)
            Nov 22 17:37:03 gaia postfix/qmgr[12980]: BB1B94C097: removed
            Nov 22 17:37:12 gaia postfix/smtpd[12982]: rewrite stream disconnect
            Nov 22 17:37:12 gaia postfix/smtpd[12982]: watchdog_stop: 0x806a7e0
            Nov 22 17:37:12 gaia postfix/smtpd[12982]: watchdog_start: 0x806a7e0


            Thanks,

            Sergio


            >>>>>--
            >>>>>Ralf Hildebrandt (Ralf.Hildebrandt@...)
            >>>>>spamtrap@...
            >>>>>Postfix - Einrichtung, Betrieb und Wartung Tel. +49
            >>>>>(0)30-450 570-155
            >>>>>http://www.postfix-buch.com
            >>>>>Given the opacity of the product, how could a Windows
            >>>>>admin ever know as much about Windows as a UNIX admin does
            >>>>>about UNIX?! (Roger B. A.
            >>>>>Klorese on Postfix Mailing List)
          • Ralf Hildebrandt
            ... There s your problem maildrop doesn t know the user. -- Ralf Hildebrandt (Ralf.Hildebrandt@charite.de) spamtrap@charite.de Postfix - Einrichtung,
            Message 5 of 5 , Nov 22, 2005
            • 0 Attachment
              * S?rgio Ferreira <sergio.ferreira@...>:

              > Nov 22 17:37:02 gaia postfix/pipe[12985]: AB4204C095:
              > to=<sergio.ferreira@...>, relay=maildrop, delay=0, status=bounced
              > (user unknown. Command output: Invalid user specified. )

              There's your problem
              maildrop doesn't know the user.

              --
              Ralf Hildebrandt (Ralf.Hildebrandt@...) spamtrap@...
              Postfix - Einrichtung, Betrieb und Wartung Tel. +49 (0)30-450 570-155
              http://www.postfix-buch.com
              Never underestimate the bandwidth of a station wagon full of tapes.
              -- Dr. Warren Jackson, Director, UTCS
            Your message has been successfully submitted and would be delivered to recipients shortly.