<div class="gmail_quote">On Thu, Jul 22, 2010 at 5:24 PM, Sumit Bose <span dir="ltr"><<a href="mailto:sbose@redhat.com">sbose@redhat.com</a>></span> wrote:<br><blockquote class="gmail_quote" style="margin: 0pt 0pt 0pt 0.8ex; border-left: 1px solid rgb(204, 204, 204); padding-left: 1ex;">
<div><div></div><div class="h5">On Thu, Jul 22, 2010 at 04:19:53PM -0400, Scott Duckworth wrote:<br>
> On Thu, Jul 22, 2010 at 12:38 PM, Stephen Gallagher <<a href="mailto:sgallagh@redhat.com">sgallagh@redhat.com</a>>wrote:<br>
><br>
> > -----BEGIN PGP SIGNED MESSAGE-----<br>
> > Hash: SHA1<br>
> ><br>
> > On 07/22/2010 11:47 AM, Scott Duckworth wrote:<br>
> > ><br>
> > > "yum localinstall libcollection-0.5.0-21.fc14.*<br>
> > > libini_config-0.6.0-21.fc14.* sssd-1.2.91-21.fc14.*<br>
> > > sssd-client-1.2.91-21.fc14.*" requires python 2.7.  Adding<br>
> > > python-2.7-3.fc14.* and python-libs-2.7-3.fc14.* results in a slew of<br>
> > > dependency resolution errors.<br>
> > ><br>
> > > If I get the chance in the few days, I'll try it under rawhide.<br>
> > ><br>
> ><br>
> > Sorry, that was the wrong package. Please try:<br>
> > <a href="http://koji.fedoraproject.org/koji/buildinfo?buildID=182852" target="_blank">http://koji.fedoraproject.org/koji/buildinfo?buildID=182852</a><br>
> ><br>
> > The one Sumit sent you mistakenly was from an in-progress rebuild of<br>
> > python for Fedora 14. This one uses Python 2.6 and should install<br>
> > cleanly on Fedora 13.<br>
> ><br>
><br>
> Updated:<br>
><br>
> [root@duck2 ~]# rpm -qa | grep fc14 | sort<br>
> libcollection-0.5.0-20.fc14.i686<br>
> libcollection-0.5.0-20.fc14.x86_64<br>
> libdhash-0.4.0-20.fc14.i686<br>
> libdhash-0.4.0-20.fc14.x86_64<br>
> libini_config-0.6.0-20.fc14.i686<br>
> libini_config-0.6.0-20.fc14.x86_64<br>
> libpath_utils-0.2.0-20.fc14.i686<br>
> libpath_utils-0.2.0-20.fc14.x86_64<br>
> libref_array-0.1.0-20.fc14.i686<br>
> libref_array-0.1.0-20.fc14.x86_64<br>
> sssd-1.2.91-20.fc14.x86_64<br>
> sssd-client-1.2.91-20.fc14.i686<br>
> sssd-client-1.2.91-20.fc14.x86_64<br>
><br>
> But I'm still having the same issue.<br>
><br>
> (Thu Jul 22 16:12:49 2010) [sssd[be[CLEMSONU]]] [simple_bind_send] (4):<br>
> Executing simple bind as: cn=SDUCKWO,ou=s,ou=EMPLOYEE,o=CLEMSONU<br>
> (Thu Jul 22 16:12:49 2010) [sssd[be[CLEMSONU]]] [simple_bind_send] (8): ldap<br>
> simple bind sent, msgid = 2<br>
<br>
</div></div>So the next line in the log still looks like:<br>
<div class="im"><br>
(Wed Jul 21 12:32:24 2010) [sssd[be[CLEMSONU]]] [sdap_process_result] (4):<br>
ldap_result gave -1, something bad happend!<br>
<br>
</div><div class="im">?<br>
<br></div></blockquote><div><br>sssd_CLEMSONU.log:<br>(Fri Jul 23 17:43:06 2010) [sssd[be[CLEMSONU]]] [sbus_dispatch] (9): dbus conn: 6A5130<br>(Fri Jul 23 17:43:06 2010) [sssd[be[CLEMSONU]]] [sbus_dispatch] (9): Dispatching.<br>
(Fri Jul 23 17:43:06 2010) [sssd[be[CLEMSONU]]] [sbus_message_handler] (9): Received SBUS method [ping]<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sbus_dispatch] (9): dbus conn: 6ABE30<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sbus_dispatch] (9): Dispatching.<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sbus_message_handler] (9): Received SBUS method [pamHandler]<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [be_pam_handler] (4): Got request with the following data<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): command: PAM_AUTHENTICATE<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): domain: CLEMSONU<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): user: sduckwo<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): service: login<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): tty: tty2<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): ruser:<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): rhost:<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): authtok type: 1<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): authtok size: 8<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): newauthtok type: 0<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): newauthtok size: 0<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): priv: 0<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [pam_print_data] (4): cli_pid: 17646<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [fo_resolve_service_send] (4): Trying to resolve service 'LDAP'<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [get_server_status] (7): Status of server '<a href="http://clemsonuldap.clemson.edu">clemsonuldap.clemson.edu</a>' is 'working'<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [get_port_status] (7): Port status of port 636 for server '<a href="http://clemsonuldap.clemson.edu">clemsonuldap.clemson.edu</a>' is 'working'<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [get_server_status] (7): Status of server '<a href="http://clemsonuldap.clemson.edu">clemsonuldap.clemson.edu</a>' is 'working'<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [be_resolve_server_done] (4): Found address for server <a href="http://clemsonuldap.clemson.edu">clemsonuldap.clemson.edu</a>: [130.127.255.249]<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_connect_send] (4): Executing START TLS<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_ldap_connect_callback_add] (9): New LDAP connection to [ldaps://<a href="http://clemsonuldap.clemson.edu:636">clemsonuldap.clemson.edu:636</a>] with fd [26].<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_process_result] (8): Trace: sh[0x7c9780], connected[1], ops[0x7c1a40], ldap[0x7bb840]<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_connect_done] (3): START TLS result: Success(0), (null)<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_connect_done] (9): SSL/TLS handler already in place.<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [fo_set_port_status] (4): Marking port 636 of server '<a href="http://clemsonuldap.clemson.edu">clemsonuldap.clemson.edu</a>' as 'working'<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [set_server_common_status] (4): Marking server '<a href="http://clemsonuldap.clemson.edu">clemsonuldap.clemson.edu</a>' as 'working'<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [ldb] (9): tevent: Added timed event "ltdb_callback": 0x7b0830<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [ldb] (9): tevent: Added timed event "ltdb_timeout": 0x7adcd0<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [ldb] (9): tevent: Destroying timer event 0x7adcd0 "ltdb_timeout"<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [ldb] (9): tevent: Ending timer event 0x7b0830 "ltdb_callback"<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [find_password_expiration_attributes] (9): No password policy requested.<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [simple_bind_send] (4): Executing simple bind as: cn=SDUCKWO,ou=s,ou=EMPLOYEE,o=CLEMSONU<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [simple_bind_send] (8): ldap simple bind sent, msgid = 2<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_process_result] (8): Trace: sh[0x7c9780], connected[1], ops[0x7be100], ldap[0x7bb840]<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_process_result] (8): Trace: ldap_result found nothing!<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_process_result] (8): Trace: sh[0x7c9780], connected[1], ops[0x7be100], ldap[0x7bb840]<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_process_result] (4): ldap_result gave -1, something bad happend!<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [sdap_handle_release] (8): Trace: sh[0x7c9780], connected[1], ops[0x7be100], ldap[0x7bb840], destructor_lock[0], release_memory[0]<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [remove_connection_callback] (9): Successfully removed connection callback.<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [auth_bind_user_done] (9): Found ppolicy data, assuming LDAP password policies are active.<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [be_pam_handler_callback] (4): Backend returned: (3, 4, <NULL>) [Internal Error (Interrupted system call)]<br>(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [be_pam_handler_callback] (4): Sending result [4][CLEMSONU]<br>
(Fri Jul 23 17:43:08 2010) [sssd[be[CLEMSONU]]] [be_pam_handler_callback] (4): Sent result [4][CLEMSONU]<br><br><br></div><blockquote class="gmail_quote" style="margin: 0pt 0pt 0pt 0.8ex; border-left: 1px solid rgb(204, 204, 204); padding-left: 1ex;">
<div class="im">
><br>
> I have a feeling that a real LDAP error message would provide more insight<br>
> into the situation.<br>
<br>
</div>Can you find anything in the server logs?<br></blockquote><div><br>I don't have access to the server.<br> <br></div><blockquote class="gmail_quote" style="margin: 0pt 0pt 0pt 0.8ex; border-left: 1px solid rgb(204, 204, 204); padding-left: 1ex;">

I can prepare a special build for you which prints the<br>
LDAP_OPT_DIAGNOSTIC_MESSAGE LDAP option and let you use wireshark. But<br>
I'm afraid this has to wait until tomorrow, it's nearly half to<br>
midnight, here.<br></blockquote><div><br>That may be useful to others, too.  Why not put it in the production build?<br><br>There's no sense of urgency on my end.  I'm just testing this stuff out before it does become urgent.<br>
 <br></div><blockquote class="gmail_quote" style="margin: 0pt 0pt 0pt 0.8ex; border-left: 1px solid rgb(204, 204, 204); padding-left: 1ex;">
<br>
bye,<br>
<font color="#888888">Sumit<br>
</font><div><div></div><div class="h5"><br>
<br>
><br>
> - --<br>
> > Stephen Gallagher<br>
> > RHCE 804006346421761<br>
> ><br>
> > Delivering value year after year.<br>
> > Red Hat ranks #1 in value among software vendors.<br>
> > <a href="http://www.redhat.com/promo/vendor/" target="_blank">http://www.redhat.com/promo/vendor/</a><br>
> > -----BEGIN PGP SIGNATURE-----<br>
> > Version: GnuPG v2.0.14 (GNU/Linux)<br>
> > Comment: Using GnuPG with Fedora - <a href="http://enigmail.mozdev.org/" target="_blank">http://enigmail.mozdev.org/</a><br>
> ><br>
> > iEYEARECAAYFAkxIdB8ACgkQeiVVYja6o6MpMQCfch5jTZlOHvuWaBNePVFVLK7s<br>
> > Fg4AoItYQ6rNj8lwxwLb0pSgZfYdzhtL<br>
> > =jdnq<br>
> > -----END PGP SIGNATURE-----<br>
> ><br>
> > _______________________________________________<br>
> > Freeipa-users mailing list<br>
> > <a href="mailto:Freeipa-users@redhat.com">Freeipa-users@redhat.com</a><br>
> > <a href="https://www.redhat.com/mailman/listinfo/freeipa-users" target="_blank">https://www.redhat.com/mailman/listinfo/freeipa-users</a><br>
> ><br>
</div></div></blockquote></div><br>