More progress! We seem to be past the stuff that has to do with missing
files now. However, it looks like the patches didn't quite do the trick.
Something is causing the LDAP entries not to get returned. In fact, it
doesn't even seem to try and process anything past the first user found.
Here are the log entries (sssd -d 10 -f):


(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [fo_set_port_status]
(4): Marking port 389 of server 'auth.mossholder.com' as 'working'
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[set_server_common_status] (4): Marking server 'auth.mossholder.com' as
'working'
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (6): calling ldap_search_ext with
[(&(uid=*)(objectclass=posixAccount))][dc=mossho
lder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [objectClass]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [uid]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [userPassword]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [uidNumber]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [gidNumber]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [gecos]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [homeDirectory]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [loginShell]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [krbPrincipalName]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [cn]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [modifyTimestamp]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [shadowLastChange]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [shadowMin]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [shadowMax]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [shadowWarning]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [shadowInactive]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [shadowExpire]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [shadowFlag]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [krbLastPwdChange]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [krbPasswordExpiration]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (7): Requesting attrs: [pwdAttribute]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_send] (8): ldap_search_ext called, msgid = 3
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=mattcm,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=jenn,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=hayley,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=mythtv,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=darcy,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=robin,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=cadwyn,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=tim,ou=Guests,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=mattcm/admin,ou=Kerberos,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=test,ou=Guests,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_parse_entry]
(9): OriginalDN: [uid=tester,ou=People,dc=mossholder,dc=com].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[0xbeccf0], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_generic_done] (6): Search result: Success(0), (null)
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[sdap_get_users_process] (6): Search for users, returned 11 results.
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: sh[0xbe2930], connected[1], ops[(nil)], ldap[0xbe3360]
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_process_result]
(8): Trace: ldap_result found nothing!
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [ldb] (9): start ldb
transaction (nesting: 0)
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(9): Save user
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(7): Adding original DN [uid=mattcm,ou=People,dc=mossholder,dc=com] to
attributes of
 [mattcm].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(7): Original memberOf is not available for [mattcm].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(7): User principal is not available for [mattcm].
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(9): Adding [shadowLastChange]=[12905] to user attributes.
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(9): Adding [shadowMax]=[99999] to user attributes.
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(9): Adding [shadowWarning]=[7] to user attributes.
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [sdap_save_user_send]
(6): Storing info for user mattcm
(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [ldb] (9): tevent:
Added timed event "ltdb_callback": 0xc01850

(Sat Apr  9 17:27:42 2011) [sssd[be[MOSSHOLDER.COM]]] [ldb] (9): tevent:
Added timed event "ltdb_timeout": 0xc01900

(Sat Apr  9 17:27:51 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
dbus conn: BCF3A0
(Sat Apr  9 17:27:51 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
Dispatching.
(Sat Apr  9 17:27:51 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_message_handler]
(9): Received SBUS method [ping]
(Sat Apr  9 17:27:54 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
dbus conn: BDA3C0
(Sat Apr  9 17:27:54 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
Dispatching.
(Sat Apr  9 17:27:54 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_message_handler]
(9): Received SBUS method [getAccountInfo]
(Sat Apr  9 17:27:54 2011) [sssd[be[MOSSHOLDER.COM]]] [be_get_account_info]
(4): Got request for [4097][1][name=*]
(Sat Apr  9 17:27:54 2011) [sssd[be[MOSSHOLDER.COM]]] [acctinfo_callback]
(4): Request processed. Returned 0,0,Success

### These three lines repeat for a while...
(Sat Apr  9 17:28:01 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
dbus conn: BCF3A0
(Sat Apr  9 17:28:01 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
Dispatching.
(Sat Apr  9 17:28:01 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_message_handler]
(9): Received SBUS method [ping]

### ...and then...
(Sat Apr  9 17:32:20 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_message_handler]
(9): Received SBUS method [getAccountInfo]
(Sat Apr  9 17:32:20 2011) [sssd[be[MOSSHOLDER.COM]]] [be_get_account_info]
(4): Got request for [4097][1][name=*]
(Sat Apr  9 17:32:20 2011) [sssd[be[MOSSHOLDER.COM]]] [acctinfo_callback]
(4): Request processed. Returned 0,0,Success
(Sat Apr  9 17:32:21 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
dbus conn: BCF3A0
(Sat Apr  9 17:32:21 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
Dispatching.
(Sat Apr  9 17:32:21 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_message_handler]
(9): Received SBUS method [ping]
(Sat Apr  9 17:32:31 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
dbus conn: BCF3A0
(Sat Apr  9 17:32:31 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
Dispatching.
(Sat Apr  9 17:32:31 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_message_handler]
(9): Received SBUS method [ping]
(Sat Apr  9 17:32:41 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
dbus conn: BCF3A0
(Sat Apr  9 17:32:41 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_dispatch] (9):
Dispatching.
(Sat Apr  9 17:32:41 2011) [sssd[be[MOSSHOLDER.COM]]] [sbus_message_handler]
(9): Received SBUS method [ping]
(Sat Apr  9 17:32:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[ldap_id_enumerate_timeout] (1): Enumeration timed out! Timeout too small?
(300s)!
(Sat Apr  9 17:32:42 2011) [sssd[be[MOSSHOLDER.COM]]]
[ldap_id_enumerate_set_timer] (6): Scheduling next enumeration at
1302385062.842369
(Sat Apr  9 17:32:42 2011) [sssd[be[MOSSHOLDER.COM]]] [ldb] (9): cancel ldb
transaction (nesting: 0)


You can tell that the connectivity to the LDAP backend actually works,
because it is able to enumerate the users, and also because it can tell that
the memberOf and User Principal attributes are not available. It also seems
to think the LDAP enumeration times out.


     --Matt


On Sat, Apr 9, 2011 at 4:13 PM, Fabrice Coutadeur <coutade...@gmail.com>wrote:

> (uploaded in my ppa)
>
> --
> You received this bug notification because you are a direct subscriber
> of the bug.
> https://bugs.launchpad.net/bugs/746981
>
> Title:
>  sssd fails to find memberof.so
>
> To unsubscribe from this bug, go to:
> https://bugs.launchpad.net/ubuntu/+source/sssd/+bug/746981/+subscribe
>

-- 
You received this bug notification because you are a member of Ubuntu
Bugs, which is subscribed to Ubuntu.
https://bugs.launchpad.net/bugs/746981

Title:
  sssd fails to find memberof.so

-- 
ubuntu-bugs mailing list
ubuntu-bugs@lists.ubuntu.com
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs

Reply via email to