<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.01 Transitional//EN">
<html>
<head>
<meta content="text/html; charset=UTF-8" http-equiv="Content-Type">
</head>
<body bgcolor="#ffffff" text="#000066">
On 09/27/2011 04:13 PM, Jakub Hrozek wrote:
<blockquote
cite="mid:20110927141339.GB29400@zeppelin.brq.redhat.com"
type="cite">
<pre wrap="">What debug_level do you run with? Cau you raise it to 9 so that we see
more info?
</pre>
</blockquote>
I am here again with debug log 7:<br>
Note that the errors begin 15 minutes after successfully connecting
to the LDAP server for the first time. Just a matter of interest,
how long are we keeping the ldap connection to the server? Is it
possible to limit it somehow?<br>
<br>
(Thu Oct 6 17:10:01 2011) [sssd[be[default]]]
[sdap_get_generic_done] (6): Search result: Success(0), (null)<br>
(Thu Oct 6 17:10:01 2011) [sssd[be[default]]]
[save_rfc2307bis_user_memberships] (7): Save parent groups to sysdb<br>
(Thu Oct 6 17:10:01 2011) [sssd[be[default]]] [sysdb_search_groups]
(6): Search groups with filter:
(&(objectclass=group)(member=name=kiranr,cn=users,cn=default,cn=sysdb))<br>
(Thu Oct 6 17:10:01 2011) [sssd[be[default]]] [sysdb_search_groups]
(6): Error: 2 (No such file or directory)<br>
(Thu Oct 6 17:10:01 2011) [sssd[be[default]]]
[save_rfc2307bis_user_memberships] (6): User [kiranr] is not a
direct member of any groups<br>
(Thu Oct 6 <b>17:10:01</b> 2011) [sssd[be[default]]]
[acctinfo_callback] (4): Request processed. Returned 0,0,Success<br>
(Thu Oct 6 <b>17:25:30</b> 2011) [sssd[be[default]]]
[sdap_process_result] (4): ldap_result gave -1, something bad
happend!<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [be_get_account_info]
(4): Got request for [4099][1][name=webserv]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[fo_resolve_service_send] (4): Trying to resolve service 'LDAP'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_server_status]
(7): Status of server 'dcpra1.dublin.ad.s3group.com' is 'working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_port_status]
(7): Port status of port 389 for server
'dcpra1.dublin.ad.s3group.com' is 'working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [resolve_srv_send]
(6): The status of SRV lookup is resolved<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_server_status]
(7): Status of server 'dcpra1.dublin.ad.s3group.com' is 'working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[be_resolve_server_done] (4): Found address for server
dcpra1.dublin.ad.s3group.com: [192.168.60.203]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [sdap_uri_callback]
(6): Constructed uri '<a class="moz-txt-link-freetext" href="ldap://dcpra1.dublin.ad.s3group.com:389">ldap://dcpra1.dublin.ad.s3group.com:389</a>'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (6): calling ldap_search_ext with
[(objectclass=*)][].<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [*]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [altServer]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [namingContexts]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [supportedControl]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [supportedExtension]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [supportedFeatures]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs:
[supportedLDAPVersion]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs:
[supportedSASLMechanisms]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs:
[defaultNamingContext]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [lastUSN]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_send] (7): Requesting attrs: [highestCommittedUSN]<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_get_generic_done] (6): Search result: Success(0), (null)<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [sdap_kinit_send]
(6): Attempting kinit ((null), <a class="moz-txt-link-abbreviated" href="mailto:draco$@DUBLIN.AD.S3GROUP.COM">draco$@DUBLIN.AD.S3GROUP.COM</a>,
DUBLIN.AD.S3GROUP.COM, 86400)<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [sdap_kinit_next_kdc]
(7): Resolving next KDC for service KERBEROS<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[fo_resolve_service_send] (4): Trying to resolve service 'KERBEROS'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_port_status]
(7): Port status of port 0 for server '(no name)' is 'not working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_port_status]
(4): Reseting the status of port 0 for server '(no name)'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [resolve_srv_send]
(6): The status of SRV lookup is not resolved<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [fo_set_port_status]
(4): Marking port 389 of server 'dcpra1.dublin.ad.s3group.com' as
'not working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[fo_resolve_service_send] (4): Trying to resolve service 'LDAP'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_server_status]
(7): Status of server 'dcpra1.dublin.ad.s3group.com' is 'working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_port_status]
(7): Port status of port 389 for server
'dcpra1.dublin.ad.s3group.com' is 'not working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_server_status]
(7): Status of server 'dcpra1.dublin.ad.s3group.com' is 'working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [get_port_status]
(7): Port status of port 389 for server
'dcpra1.dublin.ad.s3group.com' is 'not working'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[fo_resolve_service_send] (1): No available servers for service
'LDAP'<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]]
[sdap_id_op_connect_done] (1): Failed to connect, going offline (5
[Input/output error])<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [be_run_offline_cb]
(3): Going offline. Running callbacks.<br>
(Thu Oct 6 17:26:40 2011) [sssd[be[default]]] [acctinfo_callback]
(4): Request processed. Returned 1,11,Offline<br>
<br>
</body>
</html>