May 2011 - sssd-devel - Fedora mailing-lists

[PATCH] IPA Provider: don't fail if user is not a member of any groups
by Stephen Gallagher 20 May '11

20 May '11

We were erroneously returning ENOENT, but the associated _done() function treats all error codes other than EOK as fatal. This patch modifies sdap_initgr_nested_send() to return EOK instead. Fixes https://fedorahosted.org/sssd/ticket/872

2 2

[PATCH] Fixed copying of pam_data structure
by Jan Zelený 20 May '11

20 May '11

This is what caused the wrong error message described in related ticket. The code for the right error message was already there, but it didn't execute because of this bug. Related ticket: https://fedorahosted.org/sssd/ticket/855 Jan

3 2

[PATCH] AD group nesting
by Jan Zelený 19 May '11

19 May '11

Hi, I'm sending the first version of the patch solving issues with nested groups without GID. The patch is definitely not final, let's say it's the first draft of final patch. It depends on Jakub's recent series of rfc2307bis patches and it won't be final until they are pushed. At this moment I'd like to hear your opinion on the concept of the patch. Thanks in advance Jan

3 6

[PATCH] Fixed uninitialized value in sss_cache
by Jan Zelený 16 May '11

16 May '11

https://fedorahosted.org/sssd/ticket/865 Thanks Jan

3 2

[PATCH] More simple fixes
by Jan Zelený 16 May '11

16 May '11

jzeleny-022-possible-memory-leak-fixed.patch - this could cause leak in case filter was NULL jzeleny-023-fixed-uninitialized-return-value.patch - https://fedorahosted.org/sssd/ticket/858 jzeleny-024-fixed-unitialized-pointer.patch - https://fedorahosted.org/sssd/ticket/857 Jan

3 2

[PATCH] Couple bugfixing patches
by Jan Zelený 16 May '11

16 May '11

Hi, I'm sending couple patches fixing bugs I found in the code today: jzeleny-020-fixed-debug-to-files.patch This error caused that monitor didn't pass --debug-to-files option to nss and pam services when creating them. jzeleny-021-fixed-wrong-variable.patch Current solution doesn't make any sense to me, I believe the original intention was as my patch suggests even though the line can be dropped entirely. Jan

3 2

[PATCH] Use a temporary memory context in expand_ccname_template
by Jakub Hrozek 13 May '11

13 May '11

We were leaking "dummy" and "copy" in expand_ccname_template. The attached patch switches to using a temporary memory context and only talloc_move the result on success.

3 4

[PATCH] Set c-ares to retry nameservers
by Jakub Hrozek 12 May '11

12 May '11

https://fedorahosted.org/sssd/ticket/867 channel->tries is only used when a query fails. We were forcibly setting it to 0, which meant we never retried another server.

2 4

SSSD - Configuration w/ 2008 R2
by Ben Kevan 11 May '11

11 May '11

I'm wondering what the heck I'm doing wrong. I'm working on getting SSSD + KRB5 working against 2008 R2 AD. It's working fine in RHEL5 w/ the standard LDAP.conf configuration. I'm working on sssd, but am not getting a binddn connection to AD. Here's my config: grep -vE '^#|^$' /etc/sssd/sssd.conf [sssd] config_file_version = 2 reconnection_retries = 3 sbus_timeout = 30 services = nss, pam domains = default [nss] filter_groups = root filter_users = root reconnection_retries = 3 [pam] reconnection_retries = 3 [domain/default] description = LDAP domain with AD server enumerate = false id_provider = ldap chpass_provider = krb5 ldap_uri = ldap://usherdc103.domain.com ldap://usherdc104.domain.com ldap_search_base = DC=Domain,DC=com ldap_tls_cacertdir = /etc/openldap/cacerts ldap_default_bind_dn = ldapbinddn(a)DOMAIN.COM ldap_default_authtok_type = password ldap_default_authtok = YAYYOUGOTME ldap_pwd_policy = none ldap_user_object_class = user ldap_group_object_class = group cache_credentials = True krb5_realm = DOMAIN.COM krb5_kdcip = usherdc103.domain.com,usherdc104.domain.com krb5_chanegpw_principle = kadmin/changepw wtf am I doing wrong, and is ldap for authentication better then krb5? or should I stick with ldap for authorization and krb5 for authentication? Thank you.

3 13

[PATCH] Do not leak netgroups hash table
by Jakub Hrozek 06 May '11

06 May '11

Nothing dangerous but still a leak

2 2

[PATCH] Remove unused constants from data_provider.h
by Jakub Hrozek 06 May '11

06 May '11

These constants were harmless, but unused

2 2

[PATCH] Add support for openldap24 package on RHEL 5.7
by Sumit Bose 06 May '11

06 May '11

Hi, this is a revised version of Stephen patch to support the openldap24 package on RHEL 5.7. I have moved the code to find the right include and library path into ldap.m4 and added a check in the spec file if the platform is RHEL 5.7 to allow the spec file to be used on older RHEL5 versions, too. This test is quite simple, but I think we can take care of RHEL 5.10 and later version if they are available. bye, Sumit

2 2

[PATCHES] Allow changing log-level without restarting SSSD
by Stephen Gallagher 06 May '11

06 May '11

These patches are dependent on the patch provided in my earlier email "Override config file debug_level with command-line" Patch 0002: Create common sss_monitor_init() This was implemented almost identically for both the responders and the providers. It is easier to maintain as a single routine. This patch also adds the ability to provide a private context to attach to the sbus_connection for later use. Patch 0003: Allow changing the log level without restart We will now re-read the confdb debug_level value when processing the monitor_common_logrotate() function, which occurs when the monitor receives a SIGHUP. For now, this can be tested by using ldbedit on /var/lib/sss/db/confdb.ldb to change the debug_level values and then send 'kill -HUP $(pidof sssd)'. In the future, I will write a command-line tool to effect this change more easily.

2 4

Call graph of sdap_async_accounts
by Jan Zelený 06 May '11

06 May '11

Since sdap_async_accounts.c is becoming a great monstrosity, I've created a call graph of functions defined in there. The graph shows where in the file is each function defined there called and it already takes Jakub's last big set of patches into account. I'm also sending the source .dot file in case anyone wants to extend it in the future. I hope it will be useful to more people than just me. Thanks Jan

4 7

[PATCH] Add support for building against openldap24-libs on RHEL 5.7
by Stephen Gallagher 05 May '11

05 May '11

We want to support building against RHEL 5.7 with openldap24-libs This will fix the nightly RHEL5 builds.

2 1

[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