[Dovecot] Dovecot LDA LDAP lookups on samba4 server ends very often in timeouts

marco at carcano.ch marco at carcano.ch
Wed Feb 20 16:49:36 EET 2013


just to complete the informations of this thread, here is the log of a 
mail delivered succesfully

(trailing and leading spaces of AT charcater has been added by me)

############################## MAIL SUCCEFFULLY DELIVERED LOG 
#############################################

Feb 19 17:41:01 sng02 postfix/smtpd[4006]: connect from 
localhost[127.0.0.1]
Feb 19 17:41:28 sng02 postfix/smtpd[4006]: 95659407F5: 
client=localhost[127.0.0.1]
Feb 19 17:41:36 sng02 postfix/cleanup[4011]: 95659407F5: warning: 
header Subject: prova from localhost[127.0.0.1]; from=<marco @ 
senderdomain.tld> to=<mac @ mydomain.com> proto=SMTP 
helo=<senderdomain.tld>
Feb 19 17:41:36 sng02 postfix/cleanup[4011]: 95659407F5: 
message-id=<20130219164128.95659407F5 @ srv01.mydomain.local>
Feb 19 17:41:36 sng02 postfix/qmgr[3992]: 95659407F5: from=<marco @ 
senderdomain.tld>, size=371, nrcpt=1 (queue active)
Feb 19 17:41:36 sng02 dovecot: lda: Debug: Loading modules from 
directory: /usr/lib64/dovecot
Feb 19 17:41:36 sng02 dovecot: lda: Debug: Module loaded: 
/usr/lib64/dovecot/lib10_quota_plugin.so
Feb 19 17:41:36 sng02 dovecot: lda: Debug: Module loaded: 
/usr/lib64/dovecot/lib20_expire_plugin.so
Feb 19 17:41:36 sng02 dovecot: lda: Debug: Module loaded: 
/usr/lib64/dovecot/lib90_sieve_plugin.so
Feb 19 17:41:36 sng02 dovecot: auth: Debug: master in: 
USER#0111#011marco.carcano#011service=lda
Feb 19 17:41:36 sng02 dovecot: auth: Debug: password(marco.carcano): 
passdb doesn't support credential lookups
Feb 19 17:41:36 sng02 dovecot: auth: Error: static(marco.carcano): 
passdb doesn't support lookups, can't verify user's existence
Feb 19 17:41:36 sng02 dovecot: auth: Debug: ldap(marco.carcano): user 
search: base=DC=mydomain,DC=local scope=subtree 
filter=(sAMAccountname=marco.carcano) fields=Mailbox,dovecotMailQuota
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap(marco.carcano): 
Connection appears to be hanging, reconnecting
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_unbind
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_free_request (origid 
2, msgid 3)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_free_request (origid 
2, msgid 2)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_free_connection 1 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_unbind
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_free_connection: 
actually freed
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_free_connection 1 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_unbind
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_free_connection: 
actually freed
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_create
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_bind
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_simple_bind
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_sasl_bind
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_initial_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_new_connection 1 1 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_int_open_connection
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_connect_to_host: TCP 
localhost:389
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_new_socket: 16
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_prepare_socket: 16
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_connect_to_host: 
Trying ::1 389
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_pvt_connect: fd: 16 
tm: -1 async: 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_open_defconn: 
successful
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_server_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_result ld 0x666a60 
msgid -1
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg ld 0x666a60 msgid 
-1 (timeout 0 usec)
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg continue ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Connections:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: localhost  port: 
389  (default)
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 2  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Outstanding 
Requests:
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 1,  origid 1, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 request count 
1 (abandoned 0)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Response 
Queue:
Feb 19 17:41:36 sng02 dovecot: auth: Error:    Empty
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 response 
count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList 
returns ld 0x666a60 NULL
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_int_select
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
-1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
1 message type bind
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 0 new 
referrals
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg:  mark request 
completed, ld 0x666a60 msgid 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: request done: ld 0x666a60 
msgid 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: res_errno: 0, res_error: 
<>, res_matched: <>
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_free_request (origid 
1, msgid 1)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_parse_result
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_search
Feb 19 17:41:36 sng02 dovecot: auth: Error: put_filter: 
"(sAMAccountname=marco.carcano)"
Feb 19 17:41:36 sng02 dovecot: auth: Error: put_filter: simple
Feb 19 17:41:36 sng02 dovecot: auth: Error: put_simple_filter: 
"sAMAccountname=marco.carcano"
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_initial_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_server_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_search
Feb 19 17:41:36 sng02 dovecot: auth: Error: put_filter: 
"(sAMAccountname=marco.carcano)"
Feb 19 17:41:36 sng02 dovecot: auth: Error: put_filter: simple
Feb 19 17:41:36 sng02 dovecot: auth: Error: put_simple_filter: 
"sAMAccountname=marco.carcano"
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_initial_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_server_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_msgfree
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_result ld 0x666a60 
msgid -1
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg ld 0x666a60 msgid 
-1 (timeout 0 usec)
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg continue ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Connections:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: localhost  port: 
389  (default)
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 3  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Outstanding 
Requests:
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 3,  origid 3, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 2,  origid 2, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 request count 
2 (abandoned 0)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Response 
Queue:
Feb 19 17:41:36 sng02 dovecot: auth: Error:    Empty
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 response 
count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList 
returns ld 0x666a60 NULL
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_int_select
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_result ld 0x666a60 
msgid -1
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg ld 0x666a60 msgid 
-1 (timeout 0 usec)
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg continue ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Connections:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: localhost  port: 
389  (default)
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 3  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Outstanding 
Requests:
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 3,  origid 3, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 2,  origid 2, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 request count 
2 (abandoned 0)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Response 
Queue:
Feb 19 17:41:36 sng02 dovecot: auth: Error:    Empty
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 response 
count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList 
returns ld 0x666a60 NULL
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_int_select
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
-1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
2 message type search-entry
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_msgfree
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_result ld 0x666a60 
msgid -1
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg ld 0x666a60 msgid 
-1 (timeout 0 usec)
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg continue ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Connections:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: localhost  port: 
389  (default)
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 3  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Outstanding 
Requests:
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 3,  origid 3, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 2,  origid 2, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 request count 
2 (abandoned 0)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Response 
Queue:
Feb 19 17:41:36 sng02 dovecot: auth: Error:    Empty
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 response 
count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList ld 
0x666a60 msgid -1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList 
returns ld 0x666a60 NULL
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_int_select
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
-1 all 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
2 message type search-reference
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chase_v3referrals
Feb 19 17:41:36 sng02 dovecot: auth: Error: 
ldap_url_parse_ext(ldap://mydomain.local/CN=Configuration,DC=mydomain,DC=local)
Feb 19 17:41:36 sng02 dovecot: auth: Error: re_encode_request: new 
msgid 4, new dn <CN=Configuration,DC=mydomain,DC=local>
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chase_v3referral: 
msgid 2, url 
"ldap://mydomain.local/CN=Configuration,DC=mydomain,DC=local"
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_server_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_new_connection 0 1 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_int_open_connection
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_connect_to_host: TCP 
mydomain.local:389
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_new_socket: 18
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_prepare_socket: 18
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_connect_to_host: 
Trying 192.168.32.2:389
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_pvt_connect: fd: 18 
tm: -1 async: 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: anonymous rebind via 
ldap_sasl_bind("")
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_sasl_bind
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_initial_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_send_server_request
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_result ld 0x666a60 
msgid 5
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg ld 0x666a60 msgid 
5 (timeout 100000 usec)
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg continue ld 
0x666a60 msgid 5 all 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Connections:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: mydomain.local  
port: 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 2  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:   rebind in progress
Feb 19 17:41:36 sng02 dovecot: auth: Error:     queue is empty
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: localhost  port: 
389  (default)
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 4  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Outstanding 
Requests:
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 5,  origid 5, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 3,  origid 3, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 0, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:  * msgid 2,  origid 2, 
status InProgress
Feb 19 17:41:36 sng02 dovecot: auth: Error:    outstanding referrals 1, 
parent count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 request count 
3 (abandoned 0)
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Response 
Queue:
Feb 19 17:41:36 sng02 dovecot: auth: Error:    Empty
Feb 19 17:41:36 sng02 dovecot: auth: Error:   ld 0x666a60 response 
count 0
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList ld 
0x666a60 msgid 5 all 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_chkResponseList 
returns ld 0x666a60 NULL
Feb 19 17:41:36 sng02 dovecot: auth: Error: ldap_int_select
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
5 all 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 msgid 
2 message type search-result
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg: ld 0x666a60 0 new 
referrals
Feb 19 17:41:36 sng02 dovecot: auth: Error: read1msg:  mark request 
completed, ld 0x666a60 msgid 2
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg ld 0x666a60 0 s 
99954 us to go
Feb 19 17:41:36 sng02 dovecot: auth: Error: wait4msg continue ld 
0x666a60 msgid 5 all 1
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Connections:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: mydomain.local  
port: 0
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 2  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:   rebind in progress
Feb 19 17:41:36 sng02 dovecot: auth: Error:     queue is empty
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: * host: localhost  port: 
389  (default)
Feb 19 17:41:36 sng02 dovecot: auth: Error:   refcnt: 3  status: 
Connected
Feb 19 17:41:36 sng02 dovecot: auth: Error:   last used: Tue Feb 19 
17:41:36 2013
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error:
Feb 19 17:41:36 sng02 dovecot: auth: Error: ** ld 0x666a60 Outstanding 
Requests:
Feb 19 17:41:36 sng02 dovecot: lda: Debug: auth input: marco.carcano 
quota_rule=*:storage=8192M
Feb 19 17:41:36 sng02 dovecot: lda: Debug: Added userdb setting: 
plugin/quota_rule=*:storage=8192M
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Effective 
uid=8, gid=12, home=
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota root: 
name=User quota backend=maildir args=
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota rule: 
root=User quota mailbox=* bytes=8589934592 messages=0
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota rule: 
root=User quota mailbox=Trash bytes=+104857600 messages=0
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota 
warning: bytes=8160437862 (95%) messages=0 reverse=no 
command=quota-warning 95 marco.carcano
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota 
warning: bytes=7301444403 (85%) messages=0 reverse=no 
command=quota-warning 85 marco.carcano
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota 
warning: bytes=6442450944 (75%) messages=0 reverse=no 
command=quota-warning 75 marco.carcano
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota root: 
name=Shared quota backend=maildir args=ns=Public/
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota rule: 
root=Shared quota mailbox=* bytes=20971520000 messages=0
Feb 19 17:41:36 sng02 dovecot: lda: Error: user marco.carcano: Auth 
USER lookup failed
Feb 19 17:41:36 sng02 dovecot: lda: Debug: auth input:
Feb 19 17:41:36 sng02 dovecot: lda: Fatal: Internal error occurred. 
Refer to server log for more information.
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Namespace : 
type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes, 
subscriptions=yes 
location=maildir:/home/mailboxstore/marco.carcano/Maildir
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: maildir++: 
root=/home/mailboxstore/marco.carcano/Maildir, index=, control=, 
inbox=/home/mailboxstore/marco.carcano/Maildir
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Namespace : 
type=shared, prefix=shared/%u/, sep=/, inbox=no, hidden=no, 
list=children, subscriptions=no 
location=maildir:/home/mailboxstore/%Lu/Maildir:INDEX=/home/mailboxstore/marco.carcano/Maildir/shared/%Lu
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: shared: 
root=/var/run/dovecot, index=, control=, inbox=
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Namespace : 
type=public, prefix=Public/, sep=/, inbox=no, hidden=no, list=yes, 
subscriptions=no location=maildir:/home/mailboxstore/public
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: maildir++: 
root=/home/mailboxstore/public, index=, control=, inbox=
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: expire: No 
expire setting - plugin disabled
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota root: 
name=User quota backend=maildir args=
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota rule: 
root=User quota mailbox=* bytes=1073741824 messages=0
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota rule: 
root=User quota mailbox=Trash bytes=+104857600 messages=0
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota 
warning: bytes=1020054732 (95%) messages=0 reverse=no 
command=quota-warning 95 marco.carcano
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota 
warning: bytes=912680550 (85%) messages=0 reverse=no 
command=quota-warning 85 marco.carcano
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota 
warning: bytes=805306368 (75%) messages=0 reverse=no 
command=quota-warning 75 marco.carcano
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota root: 
name=Shared quota backend=maildir args=ns=Public/
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: Quota rule: 
root=Shared quota mailbox=* bytes=20971520000 messages=0
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: none: root=, 
index=, control=, inbox=
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Error: User 
marco.carcano doesn't have home dir set, disabling duplicate database
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: sieve: user's 
script path /home/mailboxstore/marco.carcano/.dovecot.sieve doesn't 
exist (using global script path in stead)
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: sieve: user 
has no valid personal script
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): Debug: sieve: no 
scripts to execute: reverting to default delivery.
Feb 19 17:41:36 sng02 postfix/pipe[3995]: 7D9AE407E7: to=<marco.carcano 
@ mydomain.local>, orig_to=<mac @ mydomain.com>, relay=dovecot, 
delay=17102, delays=17034/0.05/0/68, dsn=4.3.0, status=deferred 
(temporary failure)
Feb 19 17:41:36 sng02 dovecot: lda(marco.carcano): 
msgid=<20130219164128.95659407F5 @ srv01.mydomain.local>: saved mail to 
INBOX
Feb 19 17:41:36 sng02 postfix/pipe[4013]: 95659407F5: to=<marco.carcano 
@ mydomain.local>, orig_to=<mac @ mydomain.com>, relay=dovecot, 
delay=22, delays=22/0.02/0/0.14, dsn=2.0.0, status=sent (delivered via 
dovecot service)
Feb 19 17:41:36 sng02 postfix/qmgr[3992]: 95659407F5: removed
Feb 19 17:41:38 sng02 postfix/smtpd[4006]: disconnect from 
localhost[127.0.0.1]

############################## END OF MAIL SUCCEFFULLY DELIVERED LOG 
#############################################



More information about the dovecot mailing list