Hello Timo,

We have installed dovecot 2.0.10. With LDAP authentication. Users authenticate successfully but in the authentication process there are errors that I don't understand because it's everything all right:

May 10 18:00:49 carpe3 dovecot: auth: Error: ldap_unbind May 10 18:00:49 carpe3 dovecot: auth: Error: ldap_free_connection 1 1 May 10 18:00:49 carpe3 dovecot: auth: Error: ldap_send_unbind May 10 18:00:49 carpe3 dovecot: auth: Error: ldap_free_connection: actually freed May 10 18:02:02 carpe3 dovecot: master: Dovecot v2.0.10 starting up (core dumps disabled) May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_bind May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_simple_bind May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_sasl_bind May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_send_initial_request May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_new_connection 1 1 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_int_open_connection May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_connect_to_host: TCP ldap_server:389 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_new_socket: 16 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_prepare_socket: 16 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_connect_to_host: Trying xxx.xxx.xxx.xxx:389 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_connect_timeout: fd: 16 tm: -1 async: 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_open_defconn: successful May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_send_server_request May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:02 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:02 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:02 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:02 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:02 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:02 2011 May 10 18:02:02 carpe3 dovecot: auth: Error: May 10 18:02:02 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:02 carpe3 dovecot: auth: Error: * msgid 1, origid 1, status InProgress May 10 18:02:02 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:02 carpe3 dovecot: auth: Error: Empty May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:02 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:02 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid 1 message type bind May 10 18:02:02 carpe3 dovecot: auth: Error: new result: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:02 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 0 new referrals May 10 18:02:02 carpe3 dovecot: auth: Error: read1msg: mark request completed, ld 0x1c8e6df0 msgid 1 May 10 18:02:02 carpe3 dovecot: auth: Error: request done: ld 0x1c8e6df0 msgid 1 May 10 18:02:02 carpe3 dovecot: auth: Error: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_free_request (origid 1, msgid 1) May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_free_connection 0 1 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_free_connection: refcnt 1 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_parse_result May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_msgfree May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:02 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:02 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:02 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:02 carpe3 dovecot: auth: Error: refcnt: 1 status: Connected May 10 18:02:02 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:02 2011 May 10 18:02:02 carpe3 dovecot: auth: Error: May 10 18:02:02 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:02 carpe3 dovecot: auth: Error: Empty May 10 18:02:02 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:02 carpe3 dovecot: auth: Error: Empty May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:02 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_search May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(&(objectClass=qmailUser)(uid=USERID)(accountActive=TRUE))" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: AND May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter_list "(objectClass=qmailUser)(uid=USERID)(accountActive=TRUE)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(objectClass=qmailUser)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "objectClass=qmailUser" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(uid=USERID)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "uid= USERID " May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(accountActive=TRUE)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "accountActive=TRUE" May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_build_search_req ATTRS: May 10 18:02:13 carpe3 dovecot: auth: Error: uid May 10 18:02:13 carpe3 dovecot: auth: Error: mailMessageStore May 10 18:02:13 carpe3 dovecot: auth: Error: mailQuotaSize May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_initial_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_server_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 2, origid 2, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid 2 message type search-entry May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_first_attribute May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_get_values May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_next_attribute May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_get_values May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_next_attribute May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_get_values May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_next_attribute May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_get_dn May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_msgfree May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 2, origid 2, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid 2 message type search-result May 10 18:02:13 carpe3 dovecot: auth: Error: new result: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 0 new referrals May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: mark request completed, ld 0x1c8e6df0 msgid 2 May 10 18:02:13 carpe3 dovecot: auth: Error: request done: ld 0x1c8e6df0 msgid 2 May 10 18:02:13 carpe3 dovecot: auth: Error: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_request (origid 2, msgid 2) May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection 0 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection: refcnt 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_parse_result May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_bind May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_simple_bind May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_sasl_bind May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_initial_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_server_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_msgfree May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 3, origid 3, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 3, origid 3, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid 3 message type bind May 10 18:02:13 carpe3 dovecot: auth: Error: new result: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 0 new referrals May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: mark request completed, ld 0x1c8e6df0 msgid 3 May 10 18:02:13 carpe3 dovecot: auth: Error: request done: ld 0x1c8e6df0 msgid 3 May 10 18:02:13 carpe3 dovecot: auth: Error: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_request (origid 3, msgid 3) May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection 0 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection: refcnt 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_parse_result May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_parse_result May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_msgfree May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 1 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_bind May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_simple_bind May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_sasl_bind May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_initial_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_server_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 4, origid 4, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid 4 message type bind May 10 18:02:13 carpe3 dovecot: auth: Error: new result: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 0 new referrals May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: mark request completed, ld 0x1c8e6df0 msgid 4 May 10 18:02:13 carpe3 dovecot: auth: Error: request done: ld 0x1c8e6df0 msgid 4 May 10 18:02:13 carpe3 dovecot: auth: Error: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_request (origid 4, msgid 4) May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection 0 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection: refcnt 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_parse_result May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_search May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(&(objectClass=qmailUser)(|(mailAlternateAddress= USERID)(mail= USERID)(uid= USERID))(accountActive=TRUE))" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: AND May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter_list "(objectClass=qmailUser)(|(mailAlternateAddress= USERID)(mail= USERID)(uid= USERID))(accountActive=TRUE)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(objectClass=qmailUser)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "objectClass=qmailUser" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(|(mailAlternateAddress= USERID)(mail= USERID)(uid= USERID))" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: OR May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter_list "(mailAlternateAddress= USERID)(mail= USERID)(uid= USERID)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(mailAlternateAddress= USERID)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "mailAlternateAddress= USERID " May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(mail= USERID)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "mail= USERID " May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(uid= USERID)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "uid= USERID " May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: "(accountActive=TRUE)" May 10 18:02:13 carpe3 dovecot: auth: Error: put_filter: simple May 10 18:02:13 carpe3 dovecot: auth: Error: put_simple_filter: "accountActive=TRUE" May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_build_search_req ATTRS: May 10 18:02:13 carpe3 dovecot: auth: Error: mailMessageStore May 10 18:02:13 carpe3 dovecot: auth: Error: mailQuotaSize May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_initial_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_send_server_request May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_msgfree May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 5, origid 5, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 5, origid 5, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid 5 message type search-entry May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_first_attribute May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_get_values May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_next_attribute May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_get_values May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_next_attribute May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_msgfree May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 2 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: * msgid 5, origid 5, status InProgress May 10 18:02:13 carpe3 dovecot: auth: Error: outstanding referrals 0, parent count 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 msgid 5 message type search-result May 10 18:02:13 carpe3 dovecot: auth: Error: new result: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: ld 0x1c8e6df0 0 new referrals May 10 18:02:13 carpe3 dovecot: auth: Error: read1msg: mark request completed, ld 0x1c8e6df0 msgid 5 May 10 18:02:13 carpe3 dovecot: auth: Error: request done: ld 0x1c8e6df0 msgid 5 May 10 18:02:13 carpe3 dovecot: auth: Error: res_errno: 0, res_error: <>, res_matched: <> May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_request (origid 5, msgid 5) May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection 0 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_free_connection: refcnt 1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_parse_result May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_msgfree May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_result ld 0x1c8e6df0 msgid -1 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg ld 0x1c8e6df0 msgid -1 (timeout 0 usec) May 10 18:02:13 carpe3 dovecot: auth: Error: wait4msg continue ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Connections: May 10 18:02:13 carpe3 dovecot: auth: Error: * host: ldap_server port: 389 (default) May 10 18:02:13 carpe3 dovecot: auth: Error: refcnt: 1 status: Connected May 10 18:02:13 carpe3 dovecot: auth: Error: last used: Tue May 10 18:02:13 2011 May 10 18:02:13 carpe3 dovecot: auth: Error: May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Outstanding Requests: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ** ld 0x1c8e6df0 Response Queue: May 10 18:02:13 carpe3 dovecot: auth: Error: Empty May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList ld 0x1c8e6df0 msgid -1 all 0 May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_chkResponseList returns ld 0x1c8e6df0 NULL May 10 18:02:13 carpe3 dovecot: auth: Error: ldap_int_select May 10 18:02:13 carpe3 dovecot: imap-login: Login: user=< USERID >, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=11362, secured May 10 18:02:25 carpe3 dovecot: imap(USERID): Disconnected: Logged out bytes=29/655

Here is my dovecot -n output:

# OS: Linux 2.6.18-128.1.1.el5 x86_64 Scientific Linux SL release 5.2 (Boron) auth_cache_size = 500 k auth_cache_ttl = 1000 secs disable_plaintext_auth = no first_valid_uid = 501 lock_method = dotlock mail_fsync = always mail_gid = vmail mail_location = maildir:%h/Maildir mail_nfs_index = yes mail_nfs_storage = yes mail_uid = vmail mmap_disable = yes namespace { inbox = yes location = prefix = INBOX. type = private } passdb { args = /etc/dovecot/dovecot-ldap.conf driver = ldap } plugin/quota = maildir plugin/quota_warning = storage=75%% /usr/local/dovecot/bin/quota-warning.sh 75 plugin/quota_warning2 = storage=90%% /usr/local/dovecot/bin/quota-warning.sh 90 protocols = imap pop3 service auth { unix_listener auth-master { group = vmail mode = 0700 user = vmail } user = root vsz_limit = 4 G } service imap-login { executable = /usr/local/dovecot/libexec/dovecot/imap-login inet_listener imap { address = * port = 143 } inet_listener imaps { address = * port = 993 } process_limit = 2048 process_min_avail = 20 user = dovecot } service imap { executable = /usr/local/dovecot/libexec/dovecot/imap process_limit = 2048 } service pop3-login { executable = /usr/local/dovecot/libexec/dovecot/pop3-login inet_listener pop3 { address = * port = 110 } inet_listener pop3s { address = * port = 995 } process_limit = 2048 process_min_avail = 20 user = dovecot } service pop3 { executable = /usr/local/dovecot/libexec/dovecot/pop3 process_limit = 2048 } ssl_cert = </etc/ssl/correo_domain.crt ssl_key = </etc/ssl/correo_domain.pem syslog_facility = local3 userdb { args = /etc/dovecot/dovecot-ldap.conf driver = ldap } valid_chroot_dirs = /buzones/ protocol imap { imap_client_workarounds = mail_plugin_dir = /usr/local/dovecot/lib/dovecot mail_plugins = quota imap_quota } protocol pop3 { mail_plugin_dir = /usr/local/dovecot/lib/dovecot mail_plugins = quota pop3_uidl_format = %08Xu%08Xv } protocol lda { auth_socket_path = /usr/local/dovecot/var/run/dovecot/auth-master hostname = hostname.domain.es mail_plugin_dir = /usr/local/dovecot/lib/dovecot mail_plugins = quota postmaster_address = postmaster@domain.es quota_full_tempfail = no rejection_reason = Su mensaje para <%t> fue rechazado automaticamente por nuestro sistema :%n%r rejection_subject = Rechazado: %s sendmail_path = /usr/sbin/exim }

An here is my dovecot-ldap.conf:

# INFORMACIÓN DE CONEXIÓN AL LDAP hosts = virt_ldap auth_bind = yes ldap_version = 3 dnpass = passwd dn = cn=XXXXXXXX,dc=domain,dc=es debug_level = -1 base = dc=domain,dc=es deref = never scope = subtree

## CONSULTA AL LDAP PARA AUTENTICACION pass_filter = (&(objectClass=qmailUser)(uid=%u)(accountActive=TRUE)) pass_attrs = uid=user, mailMessageStore=home, userPassword=password, mailQuotaSize=quota_rule=*:bytes=%$

## CONSULTA AL LDAP COMO BBDD user_attrs = mailMessageStore=home, mailQuotaSize=quota_rule=*:bytes=%$ user_filter = (&(objectClass=qmailUser)(|(mailAlternateAddress=%u)(mail=%u)(uid=%u))(accountActive=TRUE))

Thank you very much in advanced

Best regards, Héctor Moreno Blanco.

This message including any attachments may contain confidential information, according to our Information Security Management System, and intended solely for a specific individual to whom they are addressed. Any unauthorised copy, disclosure or distribution of this message is strictly forbidden. If you have received this transmission in error, please notify the sender immediately and delete it.

Este mensaje, y en su caso, cualquier fichero anexo al mismo, puede contener informacion clasificada por su emisor como confidencial en el marco de su Sistema de Gestion de Seguridad de la Informacion siendo para uso exclusivo del destinatario, quedando prohibida su divulgacion copia o distribucion a terceros sin la autorizacion expresa del remitente. Si Vd. ha recibido este mensaje erroneamente, se ruega lo notifique al remitente y proceda a su borrado. Gracias por su colaboracion.