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

postfix 2.5 vmail hosting - Resource temporarily unavailable + mail transport unavailable

Expand Messages
  • Éliás Tamás
    Udv / Greetings! I have a classic virtual mail hosting setup, with postfix 2.5, dovecot, maildrop, ldap and sasl authentication. I ve just setup quotas and
    Message 1 of 6 , Oct 25, 2008
    • 0 Attachment
      Udv / Greetings!

      I have a classic virtual mail hosting setup, with postfix 2.5,
      dovecot, maildrop, ldap and sasl authentication. I've just setup
      quotas and upgraded he server from posfix 2.3. All is is working fine,
      but. I'm starting to receive the following messages:

      Oct 24 22:09:24 ** postfix/master[27379]: warning: master_wakeup_timer_event: service tlsmgr(private/tlsmgr): Resource temporarily unavailable
      Oct 24 22:33:54 *** postfix/qmgr[741]: warning: connect to transport maildrop: Resource temporarily unavailable
      Oct 24 22:33:54 *** postfix/qmgr[741]: warning: connect to transport retry: Resource temporarily unavailable
      Oct 24 22:33:54 *** postfix/qmgr[741]: D2CA1100BC1: to=<bellak.gabor@****.hu>, orig_to=<hiba@***.hu>, relay=none, delay=907,
      delays=907/0.17/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
      Oct 24 22:33:54 *** postfix/qmgr[741]: D2CA1100BC1: to=<elias.tamas@***.hu>, orig_to=<hiba@***.hu>, relay=none, delay=908,
      delays=907/0.23/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
      Oct 24 22:33:54 *** postfix/qmgr[741]: D2CA1100BC1: to=<hegedus.andras@***.hu>, orig_to=<hiba@***.hu>, relay=none, delay=908,
      delays=907/0.25/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)

      I've googled but no useable answer found. (tlsmgr -v startup simply
      shows everything ok) These messages are starting to popup when there is a mail alias, wich
      has multiple maildrops. So in general, mail send/receive is working
      when it addresses an existing account, or a simple alias. In my case:
      elias.tamas@***.hu is OK.
      eliast@***.hu -redirected to- elias.tamas@***.hu is OK.
      hiba@***.hu -redirected to MULTIPLE EXISTING accounts- is NOT OK.

      An example ldap entry:

      dn: mail=hiba@***.hu,vd=***.hu,o=hosting,dc=***,dc=hu
      accountActive: TRUE
      lastChange: 1165829161
      mail: hiba@***.hu
      objectClass: top
      objectClass: VirtualMailAlias
      cn: hiba
      sn: hiba
      maildrop: elias.tamas@****.hu
      maildrop: hegedus.andras@***.hu
      maildrop: bellak.gabor@***.hu

      I roughly tested the problem, and I could state the following:

      ldap connection fine. Entrys got fine. since standard and mails with
      only one alias wrking fine, it must be some timing or bottleneck
      issue.

      Let me show you a normal connection (mail is sent to a mail alias,
      wich has been redirected to a normal address eliast@->elias.tamas@)
      I can see the following in the log (qmgr -v), and also the courier
      authdaemon's logging set to "2":

      Oct 24 23:19:47 *** postfix/smtpd[4455]: connect from fibhost-12-130.fibernet.bacs-net.hu[85.66.12.130]
      Oct 24 23:19:48 *** postfix/smtpd[4455]: 9FB78100BC1: client=fibhost-12-130.fibernet.bacs-net.hu[85.66.12.130], sasl_method=PLAIN, sasl_username=
      elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/cleanup[4458]: 9FB78100BC1: message-id=<1851172576.20081024212415@***.hu>
      Oct 24 23:19:48 *** postfix/qmgr[4149]: trigger_server_accept_fifo: trigger arrived
      Oct 24 23:19:48 *** postfix/qmgr[4149]: master_notify: status 0
      Oct 24 23:19:48 *** postfix/qmgr[4149]: request: 87 (W)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_scan_start: start incoming queue scan
      Oct 24 23:19:48 *** postfix/qmgr[4149]: master_notify: status 1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_active_feed: queue incoming
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_active_feed: incoming/9/F/9FB78100BC1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_message_alloc: active 9FB78100BC1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: 9FB78100BC1: recipient limit 5000
      Oct 24 23:19:48 *** postfix/qmgr[4149]: 9FB78100BC1: from=<elias.tamas@***.hu>, size=1535, nrcpt=1 (queue active)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: start sorted recipient list
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_message_sort: elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: end sorted recipient list
      Oct 24 23:19:48 *** postfix/qmgr[4149]: connect to subsystem private/rewrite
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr request = resolve
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr sender = elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr address = elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: 0
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: transport
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: transport
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: maildrop
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: nexthop
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: nexthop
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: ***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: recipient
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: recipient
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: 256
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: (list terminator)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: resolve_clnt: `elias.tamas@***.hu' -> `elias.tamas@***.hu' -> transp=`maildrop' host=`***.hu' rcpt=
      `elias.tamas@***.hu' flags= class=local
      Oct 24 23:19:48 *** postfix/qmgr[4149]: start sorted recipient list
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_message_sort: elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: end sorted recipient list
      Oct 24 23:19:48 *** postfix/qmgr[4149]: mail_flow_put: 1 1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_transport_select: maildrop
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_active_drain: allocate maildrop
      Oct 24 23:19:48 *** postfix/qmgr[4149]: connect to subsystem private/maildrop
      Oct 24 23:19:48 *** postfix/qmgr[4149]: done incoming queue scan
      Oct 24 23:19:48 *** postfix/qmgr[4149]: transport_event: maildrop
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: status
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: status
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: 0
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: (list terminator)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_peer_select: 9FB78100BC1 maildrop elias.tamas@***.hu (1 of 1)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_job_retire: 9FB78100BC1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr flags = 3
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr queue_name = active
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr queue_id = 9FB78100BC1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr offset = 766
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr size = 1535
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr nexthop = ***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr encoding =
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr sender = elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr envelope_id =
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr ret_flags = 0
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr time = [data 44 bytes]
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr log_client_name = fibhost-12-130.fibernet.bacs-net.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr log_client_address = 85.66.12.130
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr log_client_port = 63241
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr log_protocol_name = ESMTP
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr log_helo_name = ET.mshome.net
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr sasl_method = PLAIN
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr sasl_username = elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr sasl_sender =
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr rewrite_context = remote
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr recipient_count = 1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr original_recipient = eliast@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr recipient = elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr offset = 740
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr dsn_orig_rcpt = rfc822;eliast@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: send attr notify_flags = 0
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_deliver: site `elias.tamas@***.hu'
      Oct 24 23:19:48 *** authdaemond: received userid lookup request: elias.tamas@***.hu
      Oct 24 23:19:48 *** authdaemond: authldap: trying this module
      Oct 24 23:19:48 *** authdaemond: selected ldap protocol version 3
      Oct 24 23:19:48 *** authdaemond: binding to LDAP server as DN 'cn=postfix,o=hosting,dc=***,dc=hu', password '***'
      Oct 24 23:19:48 *** authdaemond: using search filter: (&(accountActive=TRUE)(mail=elias.tamas@***.hu))
      Oct 24 23:19:48 *** authdaemond: one entry returned, DN: mail=elias.tamas@***.hu,vd=***.hu,o=hosting,dc=***,dc=hu
      Oct 24 23:19:48 *** authdaemond: raw ldap entry returned:
      Oct 24 23:19:48 *** authdaemond: | mail: elias.tamas@***.hu
      Oct 24 23:19:48 *** authdaemond: | quota: 52428800S
      Oct 24 23:19:48 *** authdaemond: | vdHome: /data/vmail.INBOX/
      Oct 24 23:19:48 *** authdaemond: | cn: elias.tamas
      Oct 24 23:19:48 *** authdaemond: | mailbox: ***.hu/elias.tamas/
      Oct 24 23:19:48 *** authdaemond: | userPassword: {CRYPT}***
      Oct 24 23:19:48 *** authdaemond: authldaplib: sysusername=<null>, sysuserid=113, sysgroupid=113, homedir=/data/vmail.INBOX/, address=elias.tamas@***.hu,
      fullname=elias.tamas, maildir=***.hu/elias.tamas/, quota=52428800S, options=<null>
      Oct 24 23:19:48 *** authdaemond: authldaplib: clearpasswd=<null>, passwd={CRYPT}***
      Oct 24 23:19:48 *** authdaemond: Authenticated: sysusername=<null>, sysuserid=113, sysgroupid=113, homedir=/data/vmail.INBOX/, address=elias.tamas@***.hu
      , fullname=elias.tamas, maildir=***.hu/elias.tamas/, quota=52428800S, options=<null>
      Oct 24 23:19:48 *** authdaemond: Authenticated: clearpasswd=<null>, passwd={CRYPT}***
      Oct 24 23:19:48 *** postfix/smtpd[4455]: disconnect from fibhost-12-130.fibernet.bacs-net.hu[85.66.12.130]
      Oct 24 23:19:48 *** postfix/pipe[4459]: 9FB78100BC1: to=<elias.tamas@***.hu>, orig_to=<eliast@***.hu>, relay=maildrop, delay=0.4, delays=0.27/0.06/0/0.06
      , dsn=2.0.0, status=sent (delivered via maildrop service)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: status
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: status
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: diag_type
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: diag_type
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: diag_text
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: mta_type
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: mta_type
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: mta_mname
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: mta_mname
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: action
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: action
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: reason
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: reason
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: status
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: status
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute value: 0
      Oct 24 23:19:48 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: (list terminator)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: input attribute name: (end)
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_queue_unthrottle: queue elias.tamas@***.hu
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_active_done: 9FB78100BC1
      Oct 24 23:19:48 *** postfix/qmgr[4149]: 9FB78100BC1: removed
      Oct 24 23:19:48 *** postfix/qmgr[4149]: qmgr_job_free: 9FB78100BC1 maildrop
      Oct 24 23:19:53 *** postfix/qmgr[4149]: rewrite stream disconnect

      It's OK.
      Let's see the other case:


      Oct 24 23:19:54 *** postfix/smtpd[4455]: connect from fibhost-12-130.fibernet.bacs-net.hu[85.66.12.130]
      Oct 24 23:19:55 *** postfix/smtpd[4455]: A03C6100BC1: client=fibhost-12-130.fibernet.bacs-net.hu[85.66.12.130], sasl_method=PLAIN, sasl_username=
      elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/cleanup[4458]: A03C6100BC1: message-id=<1707356200.20081024010024@***.hu>
      Oct 24 23:19:55 *** postfix/qmgr[4149]: trigger_server_accept_fifo: trigger arrived
      Oct 24 23:19:55 *** postfix/qmgr[4149]: master_notify: status 0
      Oct 24 23:19:55 *** postfix/qmgr[4149]: request: 87 (W)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_scan_start: start incoming queue scan
      Oct 24 23:19:55 *** postfix/qmgr[4149]: master_notify: status 1
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_active_feed: queue incoming
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_active_feed: incoming/A/0/A03C6100BC1
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_message_alloc: active A03C6100BC1
      Oct 24 23:19:55 *** postfix/qmgr[4149]: A03C6100BC1: recipient limit 5000
      Oct 24 23:19:55 *** postfix/qmgr[4149]: A03C6100BC1: from=<elias.tamas@***.hu>, size=1854, nrcpt=3 (queue active)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: start sorted recipient list
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_message_sort: bellak.gabor@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_message_sort: elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_message_sort: hegedus.andras@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: end sorted recipient list
      Oct 24 23:19:55 *** postfix/qmgr[4149]: connect to subsystem private/rewrite
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr request = resolve
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr sender = elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr address = bellak.gabor@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: 0
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: transport
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: transport
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: nexthop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: nexthop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: ***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: recipient
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: recipient
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: bellak.gabor@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: 256
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: (list terminator)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: (end)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: resolve_clnt: `elias.tamas@***.hu' -> `bellak.gabor@***.hu' -> transp=`maildrop' host=`***.hu' rcpt=
      `bellak.gabor@***.hu' flags= class=local
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr request = resolve
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr sender = elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr address = elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: 0
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: transport
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: transport
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: nexthop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: nexthop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: ***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: recipient
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: recipient
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: 256
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: (list terminator)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: (end)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: resolve_clnt: `elias.tamas@***.hu' -> `elias.tamas@***.hu' -> transp=`maildrop' host=`***.hu' rcpt=
      `elias.tamas@***.hu' flags= class=local
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr request = resolve
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr sender = elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr address = hegedus.andras@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: 0
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: transport
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: transport
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: nexthop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: nexthop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: ***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: recipient
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: recipient
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: hegedus.andras@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: flags
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: 256
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/rewrite socket: wanted attribute: (list terminator)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: (end)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: resolve_clnt: `elias.tamas@***.hu' -> `hegedus.andras@***.hu' -> transp=`maildrop' host=`***.hu' rcpt=
      `hegedus.andras@***.hu' flags= class=local
      Oct 24 23:19:55 *** postfix/qmgr[4149]: start sorted recipient list
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_message_sort: bellak.gabor@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_message_sort: elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_message_sort: hegedus.andras@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: end sorted recipient list
      Oct 24 23:19:55 *** postfix/qmgr[4149]: mail_flow_put: 1 1
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_transport_select: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_active_drain: allocate maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: connect to subsystem private/maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_transport_select: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_active_drain: allocate maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: connect to subsystem private/maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: done incoming queue scan
      Oct 24 23:19:55 *** postfix/qmgr[4149]: transport_event: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: status
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: status
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute value: 0
      Oct 24 23:19:55 *** postfix/qmgr[4149]: private/maildrop socket: wanted attribute: (list terminator)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: input attribute name: (end)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_peer_select: A03C6100BC1 maildrop bellak.gabor@***.hu (1 of 1)
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr flags = 3
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr queue_name = active
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr queue_id = A03C6100BC1
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr offset = 924
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr size = 1854
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr nexthop = ***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr encoding =
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr sender = elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr envelope_id =
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr ret_flags = 0
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr time = [data 44 bytes]
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr log_client_name = fibhost-12-130.fibernet.bacs-net.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr log_client_address = 85.66.12.130
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr log_client_port = 63242
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr log_protocol_name = ESMTP
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr log_helo_name = ET.mshome.net
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr sasl_method = PLAIN
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr sasl_username = elias.tamas@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr sasl_sender =
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr rewrite_context = remote
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr recipient_count = 1
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr original_recipient = hiba@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr recipient = bellak.gabor@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr offset = 897
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr dsn_orig_rcpt = rfc822;hiba@***.hu
      Oct 24 23:19:55 *** postfix/qmgr[4149]: send attr notify_flags = 0
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_deliver: site `bellak.gabor@***.hu'
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_transport_select: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_active_drain: allocate maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: connect to subsystem private/maildrop: Resource temporarily unavailable
      Oct 24 23:19:55 *** postfix/qmgr[4149]: warning: connect to transport maildrop: Resource temporarily unavailable
      Oct 24 23:19:55 *** postfix/qmgr[4149]: transport_event: maildrop
      Oct 24 23:19:55 *** postfix/qmgr[4149]: qmgr_transport_throttle: transport maildrop: status: 4.3.0 reason: mail transport unavailable
      Oct 24 23:19:55 *** postfix/qmgr[4149]: defer transport maildrop: 4.3.0 mail transport unavailable

      ... and I think here is no need to paste the other... After the
      message "qmgr_active_drain: allocate maildrop" I instantly receive the
      connect to subsystem private/maildrop: Resource temporarily
      unavailable. And I really have no idea, why.

      anyway:
      lsof|wc -l
      4341

      This is not hitting any barrier, I assume...

      Any ideas?

      --
      Éliás Tamás / Thomas Elias
      Okleveles mérnök-informatikus / Master of Science in Information Technology (MSC)
      Vizsgázott Cisco hálózati mérnök / Certified Cisco Network Engineer
      Vizsgázott IBM UDB DB2 Adatbázis Adminisztrátor / Certified IBM UDB DB2 Database Administrator
      Rendszerintegrátor - Rendszergazda / IT System Integrator - System administrator

      mailto: elias.tamas@...
      Tel.: +3630/4971626 ; ICQ UIN: 206-714-459 ; SKYPE: "elias.tamas"
      OpenPGP public key: http://pszinfo.hu/elias.tamas.asc
      Quote: "Too many people making too many problems!"
    • Éliás Tamás
      Udv / Greetings! Attachment dod not go through. I post my master.cf here: # ========================================================================== #
      Message 2 of 6 , Oct 29, 2008
      • 0 Attachment
        Udv / Greetings!

        Attachment dod not go through. I post my master.cf here:

        # ==========================================================================
        # service type private unpriv chroot wakeup maxproc command + args
        # (yes) (yes) (yes) (never) (100)
        # ==========================================================================
        smtp inet n - - - 30 smtpd
        -o smtpd_client_connection_count_limit=20
        smtps inet n - - - 30 smtpd
        -o smtpd_tls_wrappermode=yes
        -o smtpd_sasl_auth_enable=yes
        -o smtpd_client_connection_count_limit=20
        pickup fifo n - - 60 1 pickup
        cleanup unix n - - - 0 cleanup
        qmgr fifo n - n 300 1 qmgr -v
        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 fallback_relay=
        -o smtp_helo_timeout=5 -o smtp_connect_timeout=5
        showq unix n - - - - showq
        error 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
        retry unix - - - - - error
        error unix - - n - - error

        maildrop unix - n n - - pipe
        flags=DRhu user=vmail argv=/usr/bin/maildrop -V 10 -w 91 -d ${recipient} ${recipient} ${user} ${nexthop} ${sender}

        gnarwl unix - n n - - pipe
        flags=F user=vmail argv=/usr/bin/gnarwl -a ${user}@${nexthop} -s ${sender}

        ##
        # BLD - BlackList Daemon
        ##

        bld-policy unix - n n - - spawn
        user=nobody argv=/usr/sbin/bld-pf_policy


        ##
        # ESET anti-malware
        ##

        127.0.0.1:2525 inet n - n - - smtpd
        -o content_filter=
        -o myhostname=pszinfo
        -o local_recipient_maps=
        -o relay_recipient_maps=
        -o receive_override_options=no_unknown_recipient_checks,no_header_body_checks
        -o smtpd_helo_restrictions=
        -o smtpd_client_restrictions=
        -o smtpd_sender_restrictions=
        -o smtpd_recipient_restrictions=permit_mynetworks,reject
        -o mynetworks=127.0.0.0/8
        -o smtp_send_xforward_command=yes
        -o smtpd_authorized_xforward_hosts=127.0.0.0/8
        -o disable_mime_output_conversion=yes
        -o smtp_generic_maps=
        -o smtpd_error_sleep_time=10s


        My /etc/maildroprc:

        logfile "/data/logs/mail/maildrop.log"

        RECIPIENT=tolower("$1")
        USER=tolower("$2")
        HOST=tolower("$3")
        SENDER=tolower("$4")

        if (!$SENDER)
        {
        SENDER = ""
        }

        #
        # Autocreate maildir, if not existant
        #

        `test -e /data/vmail.INBOX/$HOST`
        if ( $RETURNCODE != 0 )
        {
        `mkdir /data/vmail.INBOX/$HOST`
        }

        `test -e /data/vmail.INBOX/$HOST/$USER`
        if ( $RETURNCODE != 0 )
        {
        `/usr/bin/maildirmake /data/vmail.INBOX/$HOST/$USER`
        `chmod -R 0600 /data/vmail.INBOX/$HOST`
        }


        --
        Éliás Tamás / Thomas Elias
        *NIX System administrator, Certified Cisco Network Engineer, Pascal/Bash/C++ programmer, Certified IBM UDB DB2 Database Administrator
        mailto: elias.tamas@...
        Tel.: +3630/4971626 ; ICQ UIN: 206-714-459 ; SKYPE: "elias.tamas"
        OpenPGP public key: http://pszinfo.hu/elias.tamas.asc
        Quote: "Non Omnis Moriar"
      • Wietse Venema
        ... You need to scale up your kernel, or reduce the number of processes (with the default_process_limit parameter in main.cf, or with the process limit fields
        Message 3 of 6 , Oct 29, 2008
        • 0 Attachment
          ?li?s Tam?s:
          > Oct 24 22:09:24 ** postfix/master[27379]: warning: master_wakeup_timer_event: service tlsmgr(private/tlsmgr): Resource temporarily unavailable
          > Oct 24 22:33:54 *** postfix/qmgr[741]: warning: connect to transport maildrop: Resource temporarily unavailable
          > Oct 24 22:33:54 *** postfix/qmgr[741]: warning: connect to transport retry: Resource temporarily unavailable

          You need to scale up your kernel, or reduce the number of processes
          (with the default_process_limit parameter in main.cf, or with the
          process limit fields in master.cf).

          Wietse
        • Éliás Tamás
          Udv / Greetings! it is already set to 30 with default_process_limit = 30 I constantly get the errors: Oct 31 16:25:20 *** postfix/qmgr[7260]: 870C2100BC0:
          Message 4 of 6 , Oct 31, 2008
          • 0 Attachment
            Udv / Greetings!

            it is already set to 30 with

            default_process_limit = 30

            I constantly get the errors:

            Oct 31 16:25:20 *** postfix/qmgr[7260]: 870C2100BC0: from=<eszter.david@plasticart.t-online.hu>, size=7595, nrcpt=2 (queue active)
            Oct 31 16:25:20 *** postfix/qmgr[7260]: warning: connect to transport maildrop: Resource temporarily unavailable
            Oct 31 16:25:20 *** postfix/qmgr[7260]: warning: connect to transport retry: Resource temporarily unavailable
            Oct 31 16:25:20 *** postfix/qmgr[7260]: 870C2100BC0:to=<szabolcs.fi@****.hu>, relay=none, delay=1.8, delays=1.7/0.13/0/0, dsn=4.3.0,
            status=deferred (mail transport unavailable)
            Oct 31 16:25:20 *** postfix/qmgr[7260]: 870C2100BC0: to=<viktoria.horvath@...>, relay=none, delay=1.9, delays=1.7/0.17/0/0, dsn=4.3.0,
            status=deferred (mail transport unavailable)
            Oct 31 16:28:40 *** postfix/anvil[10453]: statistics: max connection rate 1/60s for (smtp:84.2.40.7) at Oct 31 16:25:18
            Oct 31 16:28:40 *** postfix/anvil[10453]: statistics: max connection count 1 for (smtp:84.2.40.7) at Oct 31 16:25:18
            Oct 31 16:28:40 *** postfix/anvil[10453]: statistics: max cache size 1 at Oct 31 16:25:18
            Oct 31 16:31:14 *** postfix/qmgr[7260]: 870C2100BC0: from=<eszter.david@plasticart.t-online.hu>, size=7595, nrcpt=2 (queue active)
            Oct 31 16:31:14 *** postfix/qmgr[7260]: warning: connect to transport maildrop: Resource temporarily unavailable
            Oct 31 16:31:14 *** postfix/qmgr[7260]: warning: connect to transport retry: Resource temporarily unavailable



            Wednesday, October 29, 2008, 1:20:30 PM, you wrote:
            > ?li?s Tam?s:
            >> Oct 24 22:09:24 ** postfix/master[27379]: warning: master_wakeup_timer_event: service tlsmgr(private/tlsmgr): Resource temporarily unavailable
            >> Oct 24 22:33:54 *** postfix/qmgr[741]: warning: connect to transport maildrop: Resource temporarily unavailable
            >> Oct 24 22:33:54 *** postfix/qmgr[741]: warning: connect to transport retry: Resource temporarily unavailable

            > You need to scale up your kernel, or reduce the number of processes
            > (with the default_process_limit parameter in main.cf, or with the
            > process limit fields in master.cf).

            > Wietse


            --
            Éliás Tamás / Thomas Elias
            *NIX System administrator, Certified Cisco Network Engineer, Pascal/Bash/C++ programmer, Certified IBM UDB DB2 Database Administrator
            mailto: elias.tamas@...
            Tel.: +3630/4971626 ; ICQ UIN: 206-714-459 ; SKYPE: "elias.tamas"
            OpenPGP public key: http://pszinfo.hu/elias.tamas.asc
            Quote: "Non Omnis Moriar"
          • Wietse Venema
            ... Ask your service provider for more resources, or reduce the process limit further. Wietse
            Message 5 of 6 , Oct 31, 2008
            • 0 Attachment
              ?li?s Tam?s:
              > Udv / Greetings!
              >
              > it is already set to 30 with
              >
              > default_process_limit = 30
              >
              > I constantly get the errors:
              >
              > Oct 31 16:25:20 *** postfix/qmgr[7260]: warning: connect to transport maildrop: Resource temporarily unavailable
              > Oct 31 16:25:20 *** postfix/qmgr[7260]: warning: connect to transport retry: Resource temporarily unavailable
              > Oct 31 16:28:40 *** postfix/anvil[10453]: statistics: max connection rate 1/60s for (smtp:84.2.40.7) at Oct 31 16:25:18
              > Oct 31 16:28:40 *** postfix/anvil[10453]: statistics: max connection count 1 for (smtp:84.2.40.7) at Oct 31 16:25:18
              > Oct 31 16:31:14 *** postfix/qmgr[7260]: warning: connect to transport maildrop: Resource temporarily unavailable
              > Oct 31 16:31:14 *** postfix/qmgr[7260]: warning: connect to transport retry: Resource temporarily unavailable

              Ask your service provider for more resources, or reduce the process
              limit further.

              Wietse
            • Éliás Tamás
              Udv / Greetings! Hm. I think process limit does not count here. I reinstalled it from the very basics. I tried it with a mail alias, that have 3 recipients,
              Message 6 of 6 , Nov 1, 2008
              • 0 Attachment
                Udv / Greetings!

                Hm. I think process limit does not count here. I reinstalled it from
                the very basics.

                I tried it with a mail alias, that have 3 recipients, and I received
                the error. there were no other load on the mail server.

                It is a P3 dual 1GHZ, 76B U320SCSI. It shouldn't hang up on 3 mails.

                Any recommendations on what resources you mean?

                what kernel options should be touched or compiled?

                What kind of resource is running out?

                Friday, October 31, 2008, 11:06:38 PM, you wrote:
                > ?li?s Tam?s:
                >> Udv / Greetings!
                >>
                >> it is already set to 30 with
                >>
                >> default_process_limit = 30
                >>
                >> I constantly get the errors:
                >>
                >> Oct 31 16:25:20 *** postfix/qmgr[7260]: warning: connect to transport maildrop: Resource temporarily unavailable
                >> Oct 31 16:25:20 *** postfix/qmgr[7260]: warning: connect to transport retry: Resource temporarily unavailable
                >> Oct 31 16:28:40 *** postfix/anvil[10453]: statistics: max connection rate 1/60s for (smtp:84.2.40.7) at Oct 31 16:25:18
                >> Oct 31 16:28:40 *** postfix/anvil[10453]: statistics: max connection count 1 for (smtp:84.2.40.7) at Oct 31 16:25:18
                >> Oct 31 16:31:14 *** postfix/qmgr[7260]: warning: connect to transport maildrop: Resource temporarily unavailable
                >> Oct 31 16:31:14 *** postfix/qmgr[7260]: warning: connect to transport retry: Resource temporarily unavailable

                > Ask your service provider for more resources, or reduce the process
                > limit further.

                > Wietse


                --
                Éliás Tamás / Thomas Elias
                *NIX System administrator, Certified Cisco Network Engineer, Pascal/Bash/C++ programmer, Certified IBM UDB DB2 Database Administrator
                mailto: elias.tamas@...
                Tel.: +3630/4971626 ; ICQ UIN: 206-714-459 ; SKYPE: "elias.tamas"
                OpenPGP public key: http://pszinfo.hu/elias.tamas.asc
                Quote: "Non Omnis Moriar"
              Your message has been successfully submitted and would be delivered to recipients shortly.