#709 SSSD blocks for 80 seconds trying to connect to LDAP
Closed: Invalid None Opened 13 years ago by dpal.

Was working semi-offline i.e. had internet connection but not VPN.

Every several minutes SSSD would block to try to establish LDAP connection and wait for 80 seconds:

(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.baz.foobar.com'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [be_resolve_server_done] (4): Found address for server ldap.baz.foobar.com: [xxx.xxx.xxx.xxx]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=*)][].
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [*]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]


<====== Here! It is 80 sec timeout (see more of those repeating below =======>



(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x8914460], connected[1], ops[(nil)], fde[0x8919578], ldap[0x81accc0]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.baz.foobar.com' as 'not working'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_handle_release] (8): Trace: sh[0x8914460], connected[1], ops[(nil)], ldap[0x81accc0], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:12:46 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:12:46 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.baz.foobar.com'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [be_resolve_server_done] (4): Found address for server ldap.baz.foobar.com: [xxx.xxx.xxx.xxx]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=*)][].
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [*]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x89144b0], connected[1], ops[(nil)], fde[0x89167e0], ldap[0x81accc0]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.baz.foobar.com' as 'not working'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_handle_release] (8): Trace: sh[0x89144b0], connected[1], ops[(nil)], ldap[0x81accc0], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][name=dpal]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.baz.foobar.com'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [be_resolve_server_done] (4): Found address for server ldap.baz.foobar.com: [xxx.xxx.xxx.xxx]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=*)][].
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [*]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x81acd40], connected[1], ops[(nil)], fde[0x89167e0], ldap[0x8919680]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.baz.foobar.com' as 'not working'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_handle_release] (8): Trace: sh[0x81acd40], connected[1], ops[(nil)], ldap[0x8919680], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:21 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:19:21 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.FOOBAR.COM], [2][No such file or directory]

I am using latest 1.5 scratch build: 0.2010120820git583a018.el5

It seems to happen every 6 minutes. It freezes the machine.
It might be the same issue I reported yesterday.

Fields changed

description: Was working semi-offline i.e. had internet connection but not VPN.

Every several minutes SSSD would block to try to establish LDAP connection and wait for 80 seconds:

{{{
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.bos.redhat.com' is 'not working'
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.bos.redhat.com'
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [be_resolve_server_done] (4): Found address for server ldap.bos.redhat.com: [10.16.255.3]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=)][].
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [
]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:11:25 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]

<====== Here! It is 80 sec timeout (see more of those repeating below =======>

(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x8914460], connected[1], ops[(nil)], fde[0x8919578], ldap[0x81accc0]
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.bos.redhat.com' as 'not working'
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sdap_handle_release] (8): Trace: sh[0x8914460], connected[1], ops[(nil)], ldap[0x81accc0], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.bos.redhat.com' is 'not working'
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:12:45 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:12:46 2010) [sssd[be[redhat.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.REDHAT.COM], [2][No such file or directory]
(Sat Dec 11 14:12:46 2010) [sssd[be[redhat.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.REDHAT.COM], [2][No such file or directory]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.bos.redhat.com' is 'not working'
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.bos.redhat.com'
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [be_resolve_server_done] (4): Found address for server ldap.bos.redhat.com: [10.16.255.3]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=)][].
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [
]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:15:17 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x89144b0], connected[1], ops[(nil)], fde[0x89167e0], ldap[0x81accc0]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.bos.redhat.com' as 'not working'
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sdap_handle_release] (8): Trace: sh[0x89144b0], connected[1], ops[(nil)], ldap[0x81accc0], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.bos.redhat.com' is 'not working'
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][name=dpal]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.REDHAT.COM], [2][No such file or directory]
(Sat Dec 11 14:16:37 2010) [sssd[be[redhat.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.REDHAT.COM], [2][No such file or directory]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:17:11 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:17:11 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:17:11 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:17:11 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:17:11 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.bos.redhat.com' is 'not working'
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.bos.redhat.com'
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [be_resolve_server_done] (4): Found address for server ldap.bos.redhat.com: [10.16.255.3]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=)][].
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [
]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:18:00 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x81acd40], connected[1], ops[(nil)], fde[0x89167e0], ldap[0x8919680]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.bos.redhat.com' as 'not working'
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sdap_handle_release] (8): Trace: sh[0x81acd40], connected[1], ops[(nil)], ldap[0x8919680], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [get_server_status] (7): Status of server 'ldap.bos.redhat.com' is 'working'
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.bos.redhat.com' is 'not working'
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[redhat.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:21 2010) [sssd[be[redhat.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.REDHAT.COM], [2][No such file or directory]
(Sat Dec 11 14:19:21 2010) [sssd[be[redhat.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.REDHAT.COM], [2][No such file or directory]

}}} => Was working semi-offline i.e. had internet connection but not VPN.

Every several minutes SSSD would block to try to establish LDAP connection and wait for 80 seconds:

{{{
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.baz.foobar.com'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [be_resolve_server_done] (4): Found address for server ldap.baz.foobar.com: [xxx.xxx.xxx.xxx]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=)][].
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [
]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:11:25 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]

<====== Here! It is 80 sec timeout (see more of those repeating below =======>

(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x8914460], connected[1], ops[(nil)], fde[0x8919578], ldap[0x81accc0]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.baz.foobar.com' as 'not working'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_handle_release] (8): Trace: sh[0x8914460], connected[1], ops[(nil)], ldap[0x81accc0], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:12:45 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:12:46 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:12:46 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.baz.foobar.com'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [be_resolve_server_done] (4): Found address for server ldap.baz.foobar.com: [xxx.xxx.xxx.xxx]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=)][].
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [
]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:15:17 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x89144b0], connected[1], ops[(nil)], fde[0x89167e0], ldap[0x81accc0]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.baz.foobar.com' as 'not working'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_handle_release] (8): Trace: sh[0x89144b0], connected[1], ops[(nil)], ldap[0x81accc0], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][name=dpal]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:16:37 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:48 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4099][1][name=dpal]
(Sat Dec 11 14:16:50 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:17:11 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_step] (9): beginning to connect
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_port_status] (4): Reseting the status of port 389 for server 'ldap.baz.foobar.com'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [be_resolve_server_done] (4): Found address for server ldap.baz.foobar.com: [xxx.xxx.xxx.xxx]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [setup_ldap_connection_callbacks] (9): LDAP connection callbacks are not supported.
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_rootdse_send] (9): Getting rootdse
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(objectclass=)][].
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [
]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [altServer]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [namingContexts]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedControl]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedLDAPVersion]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [supportedSASLMechanisms]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [defaultNamingContext]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [lastUSN]
(Sat Dec 11 14:18:00 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): ldap_search_ext failed: Can't contact LDAP server
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_get_generic_send] (3): Connection error: (null)
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_install_ldap_callbacks] (8): Trace: sh[0x81acd40], connected[1], ops[(nil)], fde[0x89167e0], ldap[0x8919680]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [fo_set_port_status] (4): Marking port 389 of server 'ldap.baz.foobar.com' as 'not working'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_handle_release] (8): Trace: sh[0x81acd40], connected[1], ops[(nil)], ldap[0x8919680], destructor_lock[0], release_memory[0]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [get_server_status] (7): Status of server 'ldap.baz.foobar.com' is 'working'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [get_port_status] (7): Port status of port 389 for server 'ldap.baz.foobar.com' is 'not working'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP'
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (1): Failed to connect, going offline (5 [Input/output error])
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_mark_offline] (8): Going offline!
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_run_offline_cb] (3): Going offline. Running callbacks.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_id_op_connect_done] (9): notify offline to op #1
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sdap_id_release_conn_data] (9): releasing unused connection
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): dbus conn: 817EF68
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_dispatch] (9): Dispatching.
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Got request for [4097][1][idnumber=12785]
(Sat Dec 11 14:19:20 2010) [sssd[be[foobar.com]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline
(Sat Dec 11 14:19:21 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kdcinfo.FOOBAR.COM], [2][No such file or directory]
(Sat Dec 11 14:19:21 2010) [sssd[be[foobar.com]]] [remove_krb5_info_files] (5): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.FOOBAR.COM], [2][No such file or directory]

}}}

I'm pretty sure that this is the same issue as #664

Fields changed

milestone: NEEDS_TRIAGE => SSSD 1.5.1

Fields changed

component: SSSD => LDAP Provider
coverity: =>
owner: somebody => sbose

Fields changed

milestone: SSSD 1.5.1 => SSSD 1.5.2
upgrade: => 0

Fields changed

resolution: => worksforme
status: new => closed

Fields changed

rhbz: => 0

Metadata Update from @dpal:
- Issue assigned to sbose
- Issue set to the milestone: SSSD 1.5.2

7 years ago

SSSD is moving from Pagure to Github. This means that new issues and pull requests
will be accepted only in SSSD's github repository.

This issue has been cloned to Github and is available here:
- https://github.com/SSSD/sssd/issues/1751

If you want to receive further updates on the issue, please navigate to the github issue
and click on subscribe button.

Thank you for understanding. We apologize for all inconvenience.

Login to comment on this ticket.

Metadata