sssd-devel May 2011

sssd-devel@lists.fedorahosted.org

9 participants
49 discussions

[PATCH] Added a kerberos wrapper for building compatibility
by Jan Zelený 05 May '11

05 May '11

Function sss_krb5_unparse_name_flags and some of its supporting functions have been added in order to ensure compilation on systems having kerberos < 1.8. Currently I don't have any machine with RHEL5, so please be sure to test the patch on it. Thanks Jan

4 7

[PATCH] Include manpage for sss_cache
by Stephen Gallagher 04 May '11

04 May '11

The spec file was missing the manpage entry, causing automated build-machine breakage. Pushed to master under the one-liner and unbreak-the-build rules.

1 0

[PATCH] Cache cleaning utility
by Jan Zelený 04 May '11

04 May '11

I'm sending three patches with the cache-cleaning utility and some updates in sysdb which this utility depends on. Thanks Jan

4 15

[PATCH] fix two memory leaks
by Jakub Hrozek 04 May '11

04 May '11

Please see the attached patches.

2 4

[PATCH] Last USN patches
by Jan Zelený 04 May '11

04 May '11

I'm sending two patches related to the last USN detection (ticket #734). I did some testing and they seem to work just fine. The only thing I'm not sure about is if I got right what Simo exactly meant by the ticket, but I hope I got it right. Thanks Jan

4 16

[PATCH] Override config file debug_level with command-line
by Stephen Gallagher 04 May '11

04 May '11

Running the SSSD from the command-line with -d N would not override a value set in the sssd.conf. This was due to a few bad architecture decisions around how to handle the debug_level. This patch also makes the following changes: 1) The [sssd] debug_level setting no longer acts as a default for all other sections. This was always accidental, and was never documented to behave this way, so I think it's an acceptable change, even if it is a backwards-compatibility break. 2) We will now skip passing the debug argument to the child processes from the master unless the SSSD was run with a command-line argument for the debug level. https://fedorahosted.org/sssd/ticket/764

2 2

Fwd: #862: bigger sssd load: return (1, 11, Fast reply - offline)
by Dmitri Pal 04 May '11

04 May '11

This seems to be a use case when the delay might be ok instead of the fast reply. The back end gets overloaded (the actual LDAP stops responding or the LDAP back end is slow) but the client might be OK to block for several seconds waiting for the user info to arrive. -------- Original Message -------- Subject: [SSSD] #862: bigger sssd load: return (1, 11, Fast reply - offline) Date: Wed, 04 May 2011 09:39:50 -0000 From: SSSD <trac(a)fedorahosted.org> Reply-To: nobody(a)fedoraproject.org To: undisclosed-recipients:; #862: bigger sssd load: return (1, 11, Fast reply - offline) -------------------------+-------------------------------------------------- Reporter: fhanzlik | Owner: somebody Type: defect | Status: new Priority: major | Milestone: NEEDS_TRIAGE Component: SSSD | Version: 1.5.7 Keywords: | Tests: 0 Testsupdated: 0 | Coverity: Upgrade: 0 | Patch: 0 -------------------------+-------------------------------------------------- I use sssd with openldap db for authentication and account services, slapd run on same machine, which act as small mailserver (~600 accounts). Problem occurs, when sending mass e-mail for bigger group of local users - multiple getpwnam calls at same time from mail system causes successful result for only some part of them, and fail for remains, which ends as "User unknown" for these. Same result I achieve when run command "id user1&id user2&id user3&..." for ~200 users - for lot of them id return "No such user". Inspecting sssd logs it sees that sssd ldap backend switch for some time (>60 seconds) to offline mode, which is unacceptable. How I can avoid this? In previous configuration (Fedora 10/openldap/pam_ldap+nss_ldap) were no problems. part of sssd ldap domain log (sorry for its length): {{{ (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_initgr_user] (9): Process user's groups (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(&(memberuid=zplanicga)(objectclass=posixGroup)(cn=*)(gidNumber=*))][ou=users,dc=nekde,dc=cz]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [objectClass] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [cn] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [userPassword] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [gidNumber] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [memberuid] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [modifyTimestamp] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [modifyTimestamp] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_send] (8): ldap_search_ext called, msgid = 14559 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9fef2f0], ldap[0x9e23798] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_parse_entry] (9): OriginalDN: [uid=llessek,ou=users,dc=nekde,dc=cz]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9fef2f0], ldap[0x9e23798] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_users_process] (6): Search for users, returned 1 results. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (9): Save user (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Adding original DN [uid=llessek,ou=users,dc=nekde,dc=cz] to attributes of [llessek]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Original memberOf is not available for [llessek]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Original USN value is not available for [llessek]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): User principal is not available for [llessek]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (6): Storing info for user llessek (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 1) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39d68 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39e30 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39e30 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39d68 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f06268 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f06330 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f06330 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f06268 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [userPrincipalName] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f066c0 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f07c20 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f07c20 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f066c0 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowLastChange] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f06650 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f076e8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f076e8 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f06650 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowMin] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f076e8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f07980 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f07980 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f076e8 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowMax] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39d68 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f07b58 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f07b58 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39d68 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowWarning] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f3a528 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f07c18 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f07c18 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f3a528 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowInactive] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39d68 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f3a528 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f3a528 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39d68 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowExpire] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f07c18 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39d68 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39d68 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f07c18 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowFlag] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f07660 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39ae8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39ae8 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f07660 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [krbLastPwdChange] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f07be0 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f07a00 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f07a00 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f07be0 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [krbPasswordExpiration] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f07be0 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39ae8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39ae8 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f07be0 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [pwdAttribute] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39ae8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39d68 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39d68 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39ae8 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [authorizedService] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39ae8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e42968 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e42968 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39ae8 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [adAccountExpires] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e41670 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e42b10 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e42b10 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e41670 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [adUserAccountControl] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f05d08 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e41670 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e41670 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f05d08 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [nsAccountLock] from [llessek] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f06778 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f07420 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f07420 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f06778 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 1) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_users] (9): User 0 processed! (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_users_process] (9): Saving 1 Users - Done (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:24 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9fef2f0], ldap[0x9e23798] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_parse_entry] (9): OriginalDN: [uid=pbia,ou=users,dc=nekde,dc=cz]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9fef2f0], ldap[0x9e23798] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_users_process] (6): Search for users, returned 1 results. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (9): Save user (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Adding original DN [uid=pbia,ou=users,dc=nekde,dc=cz] to attributes of [pbia]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Original memberOf is not available for [pbia]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Original USN value is not available for [pbia]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): User principal is not available for [pbia]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (6): Storing info for user pbia (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 1) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f3a660 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9feff90 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9feff90 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f3a660 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_search_user_by_name] (6): Error: 2 (Adresář nebo soubor neexistuje) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9fef4d8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ff0468 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ff0468 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9fef4d8 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_search_user_by_uid] (6): Error: 2 (Adresář nebo soubor neexistuje) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53230 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f532f8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f532f8 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53230 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f08e10 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53128 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53128 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f08e10 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 1) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_users] (9): User 0 processed! (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_users_process] (9): Saving 1 Users - Done (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:24 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9fef2f0], ldap[0x9e23798] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_parse_entry] (9): OriginalDN: [uid=mstrnada,ou=users,dc=nekde,dc=cz]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9fef2f0], ldap[0x9e23798] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_initgr_user] (9): Receiving info for the user (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_initgr_user] (9): Storing the user (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (9): Save user (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Adding original DN [uid=mstrnada,ou=users,dc=nekde,dc=cz] to attributes of [mstrnada]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Original memberOf is not available for [mstrnada]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): Original USN value is not available for [mstrnada]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (7): User principal is not available for [mstrnada]. (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_save_user] (6): Storing info for user mstrnada (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 1) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e45fe8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9fefd90 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9fefd90 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e45fe8 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39ac8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39b90 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39b90 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39ac8 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [userPrincipalName] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f37730 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39dc8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39dc8 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f37730 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowLastChange] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f07ec0 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39cb8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39cb8 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f07ec0 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowMin] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53108 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53108 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53780 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowMax] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53108 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53780 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53108 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowWarning] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39938 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53230 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53230 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39938 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowInactive] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39900 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39900 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53780 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowExpire] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39900 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53780 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39900 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [shadowFlag] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f399a0 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f399a0 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53780 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [krbLastPwdChange] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f52de0 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f52de0 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53780 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [krbPasswordExpiration] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53080 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53080 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53780 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [pwdAttribute] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53080 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53780 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53080 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [authorizedService] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ff0330 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f375a8 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f375a8 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ff0330 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [adAccountExpires] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53440 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39880 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39880 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53440 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [adUserAccountControl] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f52e60 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f08098 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f08098 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f52e60 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sysdb_remove_attrs] (8): Removing attribute [nsAccountLock] from [mstrnada] (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53780 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f07fb0 (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f07fb0 "ltdb_timeout" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53780 "ltdb_callback" (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): cancel ldb transaction (nesting: 3) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 2) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 1) (Tue May 3 11:35:24 2011) [sssd[be[default]]] [sdap_get_initgr_user] (9): Commit change (Tue May 3 11:35:24 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_initgr_user] (9): Process user's groups (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (6): calling ldap_search_ext with [(&(memberuid=mstrnada)(objectclass=posixGroup)(cn=*)(gidNumber=*))][ou=users,dc=nekde,dc=cz]. (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [objectClass] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [cn] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [userPassword] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [gidNumber] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [memberuid] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [modifyTimestamp] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (7): Requesting attrs: [modifyTimestamp] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_send] (8): ldap_search_ext called, msgid = 14560 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9ee0b30], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_parse_entry] (9): OriginalDN: [uid=jheinza,ou=users,dc=nekde,dc=cz]. (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9ee0b30], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_users_process] (6): Search for users, returned 1 results. (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_save_user] (9): Save user (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_save_user] (7): Adding original DN [uid=jheinza,ou=users,dc=nekde,dc=cz] to attributes of [jheinza]. (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_save_user] (7): Original memberOf is not available for [jheinza]. (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_save_user] (7): Original USN value is not available for [jheinza]. (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_save_user] (7): User principal is not available for [jheinza]. (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_save_user] (6): Storing info for user jheinza (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 1) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53208 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f532d0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f532d0 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53208 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sysdb_search_user_by_name] (6): Error: 2 (Adresář nebo soubor neexistuje) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 2) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f52ec0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f52f88 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f52f88 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f52ec0 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sysdb_search_user_by_uid] (6): Error: 2 (Adresář nebo soubor neexistuje) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f05de8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f05eb0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f05eb0 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f05de8 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 3) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 3) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f06240 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f05ff8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f05ff8 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f06240 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 3) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 2) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 1) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_save_users] (9): User 0 processed! (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_users_process] (9): Saving 1 Users - Done (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9ee0b30], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f52f60 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53028 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53028 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f52f60 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_initgr_common_store] (8): Updating memberships for jhalek (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_initgr_done] (9): Initgroups done (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_connect_step] (9): reusing cached connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_destroy] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9ee0b30], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0xa030778 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0xa030098 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0xa030098 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0xa030778 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_initgr_common_store] (8): Updating memberships for rdoubrava (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_initgr_done] (9): Initgroups done (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_connect_step] (9): reusing cached connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_destroy] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9ee0b30], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ee28c0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0xa030098 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0xa030098 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ee28c0 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_initgr_common_store] (8): Updating memberships for bla\1 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_initgr_done] (9): Initgroups done (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_connect_step] (9): reusing cached connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_destroy] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9ee0b30], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ee28c0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0xa030098 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0xa030098 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ee28c0 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_initgr_common_store] (8): Updating memberships for zplanicga (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_initgr_done] (9): Initgroups done (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_connect_step] (9): reusing cached connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_destroy] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[0x9ee0b30], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_generic_done] (6): Search result: Success(0), (null) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ed80b8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f115d8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f115d8 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ed80b8 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_initgr_common_store] (8): Updating memberships for mstrnada (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_get_initgr_done] (9): Initgroups done (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_connect_step] (9): reusing cached connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_destroy] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_id_op_done] (9): releasing operation connection (Tue May 3 11:35:25 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 0,0,Success (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: sh[0x9fe6c48], connected[1], ops[(nil)], ldap[0x9e23798] (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sdap_process_result] (8): Trace: ldap_result found nothing! (Tue May 3 11:35:25 2011) [sssd[be[default]]] [cleanup_users] (9): Cache expiration is set to 1 days (Tue May 3 11:35:25 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(&(!(dataExpireTimestamp=0))(dataExpireTimestamp<=1304415325)(|(!(lastLogin=*))(lastLogin<=1304328925)))) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ee1a48 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ee28c0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ee28c0 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ee1a48 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [cleanup_users] (4): Found 12 expired user entries! (Tue May 3 11:35:25 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user hkulhanga (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0xa02f7e8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e895b8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e895b8 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0xa02f7e8 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f9d1e0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9feccb0 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e460f8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f52d58 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9feccb0 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f9d1e0 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f52d58 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e460f8 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user evlacina (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f52d58 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ecd140 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ecd140 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f52d58 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f5bce8 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e86748 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e75078 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffac18 (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e86748 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f5bce8 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffac18 "ltdb_timeout" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e75078 "ltdb_callback" (Tue May 3 11:35:25 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:26 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user hkantoj (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0xa0301a0 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffc220 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffc220 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0xa0301a0 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9fb97f0 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f12dd8 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9febbf8 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e750f8 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f12dd8 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9fb97f0 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e750f8 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9febbf8 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:26 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user hkoziaga (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39218 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9fefe48 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9fefe48 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39218 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f11530 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9fbd260 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ee1080 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ed8138 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9fbd260 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f11530 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ed8138 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ee1080 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:26 2011) [sssd[be[default]]] [cleanup_users] (5): User vruzicga is still logged in or a dummy entry, keeping data (Tue May 3 11:35:26 2011) [sssd[be[default]]] [cleanup_users] (5): User lkucej is still logged in or a dummy entry, keeping data (Tue May 3 11:35:26 2011) [sssd[be[default]]] [cleanup_users] (5): User mpapeza is still logged in or a dummy entry, keeping data (Tue May 3 11:35:26 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user hcapga (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9fbd260 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f39218 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f39218 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9fbd260 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f12dc8 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9fefe70 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e45250 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9fef6d8 (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9fefe70 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f12dc8 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9fef6d8 "ltdb_timeout" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e45250 "ltdb_callback" (Tue May 3 11:35:26 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user hmarga (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f39218 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0xa021160 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0xa021160 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f39218 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e866e0 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f12d70 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e88f98 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f52c10 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f12d70 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e866e0 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f52c10 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e88f98 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_users] (5): User kpetrzal is still logged in or a dummy entry, keeping data (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user fboucof (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e866e0 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f12d70 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f12d70 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e866e0 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f113e8 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f12d70 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ed8138 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffabb0 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f12d70 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f113e8 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffabb0 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ed8138 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_users] (5): User jnovak is still logged in or a dummy entry, keeping data (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_groups] (6): Search groups with filter: (&(objectclass=group)(&(!(dataExpireTimestamp=0))(dataExpireTimestamp<=1304415327))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ffabb0 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f12d70 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f12d70 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ffabb0 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_groups] (4): Found 7 expired group entries! (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=vruzicga,cn=groups,cn=default,cn=sysdb)(gidNumber=10319))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9febd20 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0xa0302e8 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0xa0302e8 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9febd20 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=lkucej,cn=groups,cn=default,cn=sysdb)(gidNumber=10283))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e47d00 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e76458 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e76458 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e47d00 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=mpapeza,cn=groups,cn=default,cn=sysdb)(gidNumber=10180))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e76458 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e47d00 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e47d00 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e76458 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=mrabasa,cn=groups,cn=default,cn=sysdb)(gidNumber=10415))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e47d00 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e76458 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e76458 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e47d00 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=kpetrzal,cn=groups,cn=default,cn=sysdb)(gidNumber=10036))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e76458 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e47d00 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e47d00 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e76458 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=llessek,cn=groups,cn=default,cn=sysdb)(gidNumber=10349))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e47d00 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e76458 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e76458 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e47d00 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=jnovak,cn=groups,cn=default,cn=sysdb)(gidNumber=10431))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e76458 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9edaf38 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9edaf38 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e76458 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldap_id_cleanup_set_timer] (6): Scheduling next cleanup at 1304415326.854176 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_users] (9): Cache expiration is set to 1 days (Tue May 3 11:35:27 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(&(!(dataExpireTimestamp=0))(dataExpireTimestamp<=1304415327)(|(!(lastLogin=*))(lastLogin<=1304328927)))) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e4a008 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e44ec0 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e44ec0 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e4a008 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_users] (4): Found 9 expired user entries! (Tue May 3 11:35:27 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user hpospichana (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ffc220 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0xa02f7e8 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0xa02f7e8 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ffc220 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ee17f8 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f9d1e0 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0xa03acd0 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f52fa8 (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f9d1e0 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ee17f8 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f52fa8 "ltdb_timeout" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0xa03acd0 "ltdb_callback" (Tue May 3 11:35:27 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:28 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user evymazana (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ee2900 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f0dfb0 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f0dfb0 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ee2900 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9edac38 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f52ce0 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9ed81c0 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0xa0302d0 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f52ce0 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9edac38 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0xa0302d0 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9ed81c0 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:28 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user hrandaga (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f535d8 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f0dfb0 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f0dfb0 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f535d8 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f397c8 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e86748 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9febf40 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f53038 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e86748 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f397c8 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f53038 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9febf40 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:28 2011) [sssd[be[default]]] [cleanup_users] (9): About to delete user lrandusa (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f53038 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9febf40 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9febf40 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f53038 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): start ldb transaction (nesting: 0) (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f397c8 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9e76380 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e750f0 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ff03c8 (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9e76380 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f397c8 "ltdb_callback" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ff03c8 "ltdb_timeout" (Tue May 3 11:35:28 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e750f0 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): commit ldb transaction (nesting: 0) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [cleanup_users] (5): User vruzicga is still logged in or a dummy entry, keeping data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [cleanup_users] (5): User lkucej is still logged in or a dummy entry, keeping data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [cleanup_users] (5): User mpapeza is still logged in or a dummy entry, keeping data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [cleanup_users] (5): User kpetrzal is still logged in or a dummy entry, keeping data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [cleanup_users] (5): User jnovak is still logged in or a dummy entry, keeping data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_groups] (6): Search groups with filter: (&(objectclass=group)(&(!(dataExpireTimestamp=0))(dataExpireTimestamp<=1304415329))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9e750f0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffd978 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffd978 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9e750f0 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [cleanup_groups] (4): Found 7 expired group entries! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=vruzicga,cn=groups,cn=default,cn=sysdb)(gidNumber=10319))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f115d8 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffd978 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffd978 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f115d8 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=lkucej,cn=groups,cn=default,cn=sysdb)(gidNumber=10283))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9eccf38 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffd978 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffd978 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9eccf38 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=mpapeza,cn=groups,cn=default,cn=sysdb)(gidNumber=10180))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f115d8 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffd978 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffd978 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f115d8 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=mrabasa,cn=groups,cn=default,cn=sysdb)(gidNumber=10415))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9eccf38 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffd978 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffd978 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9eccf38 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=kpetrzal,cn=groups,cn=default,cn=sysdb)(gidNumber=10036))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9f115d8 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffd978 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffd978 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9f115d8 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=llessek,cn=groups,cn=default,cn=sysdb)(gidNumber=10349))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9eccf38 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9ffd978 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9ffd978 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9eccf38 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sysdb_search_users] (6): Search users with filter: (&(objectclass=user)(|(memberOf=name=jnovak,cn=groups,cn=default,cn=sysdb)(gidNumber=10431))) (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x9eccf38 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x9f115d8 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Destroying timer event 0x9f115d8 "ltdb_timeout" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldb] (9): tevent: Ending timer event 0x9eccf38 "ltdb_callback" (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldap_id_cleanup_set_timer] (6): Scheduling next cleanup at 1304415328.1444826 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_handle_release] (8): Trace: sh[0x9ed01d0], connected[1], ops[(nil)], ldap[0x9e754e0], destructor_lock[0], release_memory[0] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [remove_connection_callback] (9): Successfully removed connection callback. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_set_port_status] (4): Marking port 389 of server 'mail.nekde.cz' as 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_server_status] (7): Status of server 'mail.nekde.cz' is 'working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_port_status] (7): Port status of port 389 for server 'mail.nekde.cz' is 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_server_status] (7): Status of server 'mail.nekde.cz' is 'working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_port_status] (7): Port status of port 389 for server 'mail.nekde.cz' is 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_mark_offline] (8): Going offline! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_run_offline_cb] (3): Going offline. Running callbacks. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_handle_release] (8): Trace: sh[0x9f0f038], connected[1], ops[(nil)], ldap[0x9ee0ed0], destructor_lock[0], release_memory[0] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [remove_connection_callback] (9): Successfully removed connection callback. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_set_port_status] (4): Marking port 389 of server 'mail.nekde.cz' as 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_server_status] (7): Status of server 'mail.nekde.cz' is 'working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_port_status] (7): Port status of port 389 for server 'mail.nekde.cz' is 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_mark_offline] (8): Going offline! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_run_offline_cb] (3): Going offline. Running callbacks. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_handle_release] (8): Trace: sh[0x9ffd410], connected[1], ops[(nil)], ldap[0x9ee51e8], destructor_lock[0], release_memory[0] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [remove_connection_callback] (9): Successfully removed connection callback. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_set_port_status] (4): Marking port 389 of server 'mail.nekde.cz' as 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_server_status] (7): Status of server 'mail.nekde.cz' is 'working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_port_status] (7): Port status of port 389 for server 'mail.nekde.cz' is 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_mark_offline] (8): Going offline! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_run_offline_cb] (3): Going offline. Running callbacks. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_handle_release] (8): Trace: sh[0x9f39278], connected[1], ops[(nil)], ldap[0x9f392b0], destructor_lock[0], release_memory[0] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [remove_connection_callback] (9): Successfully removed connection callback. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_set_port_status] (4): Marking port 389 of server 'mail.nekde.cz' as 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_server_status] (7): Status of server 'mail.nekde.cz' is 'working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [get_port_status] (7): Port status of port 389 for server 'mail.nekde.cz' is 'not working' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [fo_resolve_service_send] (1): No available servers for service 'LDAP' (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_mark_offline] (8): Going offline! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_run_offline_cb] (3): Going offline. Running callbacks. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [auth_bind_user_done] (9): Found ppolicy data, assuming LDAP password policies are active. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_handle_release] (8): Trace: sh[0x9e86918], connected[1], ops[(nil)], ldap[0x9ee1378], destructor_lock[0], release_memory[0] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [remove_connection_callback] (9): Successfully removed connection callback. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_mark_offline] (8): Going offline! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_run_offline_cb] (3): Going offline. Running callbacks. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldap_id_cleanup_timer] (4): Backend is marked offline, retry later! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [ldap_id_cleanup_set_timer] (6): Scheduling next cleanup at 1304415330.538520 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Got request for [3][1][name=lmerinek] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 1,11,Offline (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Got request for [3][1][name=pbia] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 1,11,Offline (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler] (4): Got request with the following data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): command: PAM_ACCT_MGMT (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): domain: default (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): user: jhalek (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): service: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): tty: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): ruser: jhalek (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): rhost: 88.102.93.192 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok type: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok size: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok type: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok size: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): priv: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): cli_pid: 14404 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_target_access_permit] (9): be_target_access_permit called, returning PAM_SUCCESS. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (0, 0, <NULL>) [Success] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [0][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [0][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler] (4): Got request with the following data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): command: PAM_AUTHENTICATE (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): domain: default (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): user: rdoubrava (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): service: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): tty: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): ruser: rdoubrava (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): rhost: 77.104.254.75 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok type: 1 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok size: 9 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok type: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok size: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): priv: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): cli_pid: 14329 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_pam_auth_handler] (4): Backend is marked offline, retry later! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler] (4): Got request with the following data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): command: PAM_AUTHENTICATE (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): domain: default (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): user: bla\1 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): service: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): tty: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): ruser: bla\1 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): rhost: 109.80.92.20 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok type: 1 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok size: 9 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok type: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok size: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): priv: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): cli_pid: 14387 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_pam_auth_handler] (4): Backend is marked offline, retry later! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler] (4): Got request with the following data (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): command: PAM_AUTHENTICATE (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): domain: default (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): user: zplanicga (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): service: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): tty: dovecot (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): ruser: zplanicga (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): rhost: 90.180.154.142 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok type: 1 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): authtok size: 9 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok type: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): newauthtok size: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): priv: 0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [pam_print_data] (4): cli_pid: 14331 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sdap_pam_auth_handler] (4): Backend is marked offline, retry later! (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Backend returned: (1, 9, <NULL>) [Provider is Offline (Autentizační služba nemůže získat informace pro autentizaci)] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sending result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_pam_handler_callback] (4): Sent result [9][default] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Got request for [3][1][name=lrandusa] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [acctinfo_callback] (4): Request processed. Returned 1,11,Offline (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D82CD0 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D81798 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Got request for [4097][1][name=ohorek] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D81798 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Got request for [4097][1][name=jkleina] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D81798 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Got request for [4097][1][name=eivica] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D81798 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Got request for [4097][1][name=rbrazdon] (Tue May 3 11:35:29 2011) [sssd[be[default]]] [be_get_account_info] (4): Request processed. Returned 1,11,Fast reply - offline (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): dbus conn: 9D81798 (Tue May 3 11:35:29 2011) [sssd[be[default]]] [sbus_dispatch] (9): Dispatching. }}} Thank in advance, Franta Hanzlik -- Ticket URL: <https://fedorahosted.org/sssd/ticket/862> SSSD <http://fedorahosted.org/sssd> System Security Services Daemon

1 0

[PATCH] Fixes #861 remove select()
by Simo Sorce 03 May '11

03 May '11

We were erroneously using select() in the client code. This code can run in arbitrary apps and using select() means we can cause memory corruption in the calling application. Use poll() instead. Simo. -- Simo Sorce * Red Hat, Inc * New York

2 1

[PATCH] Return pam data to the renewal item if renewal fails
by Sumit Bose 02 May '11

02 May '11

Hi, this patch fixes an issue which was introduced by using talloc_move() insttead of talloc_steal(). bye, Sumit

2 2

2026

2025

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

2010

2009

sssd-devel May 2011