Attachment 78 Details for Bug 282 – "winbind -d10" : "groups SNB.CA:xbking" returns 1 of 6 groups (see comment 8)

"winbind -d10" : "groups SNB.CA:xbking" returns 1 of 6 groups (see comment 8)

log.winbindd (text/plain), 26.92 KB, created by Brian King on 2003-08-14 05:24:52 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Brian King

Created: 2003-08-14 05:24:52 UTC

Size: 26.92 KB

patch

obsolete

>  ads_find_dc: looking for realm 'SNB.CA'
>[2003/08/14 09:18:53, 8] libsmb/namequery.c:get_sorted_dc_list(1215)
>  get_sorted_dc_list: attempting lookup using [hosts]
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad1.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD1.SNB.CA#20, value = 142.139.93.41:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad1.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad3.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD3.SNB.CA#20, value = 142.139.171.205:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad3.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:remove_duplicate_addrs2(312)
>  remove_duplicate_addrs2: looking for duplicate address/port pairs
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1350)
>  get_dc_list: returning 2 ip addresses in an ordered list
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1351)
>  get_dc_list: 142.139.93.41:389 142.139.171.205:389 
>[2003/08/14 09:18:53, 5] libads/ldap.c:ads_try_connect(56)
>  ads_try_connect: trying ldap server '142.139.93.41' port 389
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_connect(205)
>  Connected to LDAP server 142.139.93.41
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_server_info(1864)
>  got ldap server name snb-fton-ad1@SNB.CA, using bind path: dc=SNB,dc=CA
>[2003/08/14 09:18:53, 4] libads/ldap.c:ads_server_info(1870)
>  time offset is 0 seconds
>[2003/08/14 09:18:53, 4] libads/sasl.c:ads_sasl_bind(415)
>  Found SASL mechanism GSS-SPNEGO
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 48018 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2 3
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 3 6 1 4 1 311 2 2 10
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(190)
>  got principal=snb-fton-ad1$@SNB.CA
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_do_paged_search(438)
>  ldap_search_ext_s((distinguishedName=CN=Myers\,Travis (SNB/xwave),OU=xwave,OU=IT Admin,OU=SNB UsersG,DC=snb,DC=ca)) -> Bad search filter
>[2003/08/14 09:18:53, 3] libads/ldap_utils.c:ads_do_search_retry(60)
>  Reopening ads connection to realm 'SNB.CA' after error Bad search filter
>[2003/08/14 09:18:53, 6] libads/ldap.c:ads_find_dc(134)
>  ads_find_dc: looking for realm 'SNB.CA'
>[2003/08/14 09:18:53, 8] libsmb/namequery.c:get_sorted_dc_list(1215)
>  get_sorted_dc_list: attempting lookup using [hosts]
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad1.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD1.SNB.CA#20, value = 142.139.93.41:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad1.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad3.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD3.SNB.CA#20, value = 142.139.171.205:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad3.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:remove_duplicate_addrs2(312)
>  remove_duplicate_addrs2: looking for duplicate address/port pairs
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1350)
>  get_dc_list: returning 2 ip addresses in an ordered list
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1351)
>  get_dc_list: 142.139.93.41:389 142.139.171.205:389 
>[2003/08/14 09:18:53, 5] libads/ldap.c:ads_try_connect(56)
>  ads_try_connect: trying ldap server '142.139.93.41' port 389
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_connect(205)
>  Connected to LDAP server 142.139.93.41
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_server_info(1864)
>  got ldap server name snb-fton-ad1@SNB.CA, using bind path: dc=SNB,dc=CA
>[2003/08/14 09:18:53, 4] libads/ldap.c:ads_server_info(1870)
>  time offset is 0 seconds
>[2003/08/14 09:18:53, 4] libads/sasl.c:ads_sasl_bind(415)
>  Found SASL mechanism GSS-SPNEGO
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 48018 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2 3
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 3 6 1 4 1 311 2 2 10
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(190)
>  got principal=snb-fton-ad1$@SNB.CA
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_do_paged_search(438)
>  ldap_search_ext_s((distinguishedName=CN=Myers\,Travis (SNB/xwave),OU=xwave,OU=IT Admin,OU=SNB UsersG,DC=snb,DC=ca)) -> Bad search filter
>[2003/08/14 09:18:53, 3] libads/ldap_utils.c:ads_do_search_retry(60)
>  Reopening ads connection to realm 'SNB.CA' after error Bad search filter
>[2003/08/14 09:18:53, 6] libads/ldap.c:ads_find_dc(134)
>  ads_find_dc: looking for realm 'SNB.CA'
>[2003/08/14 09:18:53, 8] libsmb/namequery.c:get_sorted_dc_list(1215)
>  get_sorted_dc_list: attempting lookup using [hosts]
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad1.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD1.SNB.CA#20, value = 142.139.93.41:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad1.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad3.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD3.SNB.CA#20, value = 142.139.171.205:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad3.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:remove_duplicate_addrs2(312)
>  remove_duplicate_addrs2: looking for duplicate address/port pairs
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1350)
>  get_dc_list: returning 2 ip addresses in an ordered list
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1351)
>  get_dc_list: 142.139.93.41:389 142.139.171.205:389 
>[2003/08/14 09:18:53, 5] libads/ldap.c:ads_try_connect(56)
>  ads_try_connect: trying ldap server '142.139.93.41' port 389
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_connect(205)
>  Connected to LDAP server 142.139.93.41
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_server_info(1864)
>  got ldap server name snb-fton-ad1@SNB.CA, using bind path: dc=SNB,dc=CA
>[2003/08/14 09:18:53, 4] libads/ldap.c:ads_server_info(1870)
>  time offset is 0 seconds
>[2003/08/14 09:18:53, 4] libads/sasl.c:ads_sasl_bind(415)
>  Found SASL mechanism GSS-SPNEGO
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 48018 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2 3
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 3 6 1 4 1 311 2 2 10
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(190)
>  got principal=snb-fton-ad1$@SNB.CA
>[2003/08/14 09:18:53, 1] libads/ldap_utils.c:ads_do_search_retry(76)
>  ads reopen failed after error Success
>[2003/08/14 09:18:53, 3] nsswitch/winbindd_ads.c:dn_lookup(370)
>  ads: dn_lookup
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_do_paged_search(438)
>  ldap_search_ext_s((distinguishedName=CN=Fortune\, Jim (SNB/xwave),OU=xwave,OU=IT Admin,OU=SNB UsersG,DC=snb,DC=ca)) -> Bad search filter
>[2003/08/14 09:18:53, 3] libads/ldap_utils.c:ads_do_search_retry(60)
>  Reopening ads connection to realm 'SNB.CA' after error Bad search filter
>[2003/08/14 09:18:53, 6] libads/ldap.c:ads_find_dc(134)
>  ads_find_dc: looking for realm 'SNB.CA'
>[2003/08/14 09:18:53, 8] libsmb/namequery.c:get_sorted_dc_list(1215)
>  get_sorted_dc_list: attempting lookup using [hosts]
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad1.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD1.SNB.CA#20, value = 142.139.93.41:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad1.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad3.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD3.SNB.CA#20, value = 142.139.171.205:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad3.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:remove_duplicate_addrs2(312)
>  remove_duplicate_addrs2: looking for duplicate address/port pairs
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1350)
>  get_dc_list: returning 2 ip addresses in an ordered list
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1351)
>  get_dc_list: 142.139.93.41:389 142.139.171.205:389 
>[2003/08/14 09:18:53, 5] libads/ldap.c:ads_try_connect(56)
>  ads_try_connect: trying ldap server '142.139.93.41' port 389
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_connect(205)
>  Connected to LDAP server 142.139.93.41
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_server_info(1864)
>  got ldap server name snb-fton-ad1@SNB.CA, using bind path: dc=SNB,dc=CA
>[2003/08/14 09:18:53, 4] libads/ldap.c:ads_server_info(1870)
>  time offset is 0 seconds
>[2003/08/14 09:18:53, 4] libads/sasl.c:ads_sasl_bind(415)
>  Found SASL mechanism GSS-SPNEGO
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 48018 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2 3
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 3 6 1 4 1 311 2 2 10
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(190)
>  got principal=snb-fton-ad1$@SNB.CA
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_do_paged_search(438)
>  ldap_search_ext_s((distinguishedName=CN=Fortune\, Jim (SNB/xwave),OU=xwave,OU=IT Admin,OU=SNB UsersG,DC=snb,DC=ca)) -> Bad search filter
>[2003/08/14 09:18:53, 3] libads/ldap_utils.c:ads_do_search_retry(60)
>  Reopening ads connection to realm 'SNB.CA' after error Bad search filter
>[2003/08/14 09:18:53, 6] libads/ldap.c:ads_find_dc(134)
>  ads_find_dc: looking for realm 'SNB.CA'
>[2003/08/14 09:18:53, 8] libsmb/namequery.c:get_sorted_dc_list(1215)
>  get_sorted_dc_list: attempting lookup using [hosts]
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad1.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD1.SNB.CA#20, value = 142.139.93.41:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad1.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad3.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD3.SNB.CA#20, value = 142.139.171.205:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad3.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:remove_duplicate_addrs2(312)
>  remove_duplicate_addrs2: looking for duplicate address/port pairs
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1350)
>  get_dc_list: returning 2 ip addresses in an ordered list
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1351)
>  get_dc_list: 142.139.93.41:389 142.139.171.205:389 
>[2003/08/14 09:18:53, 5] libads/ldap.c:ads_try_connect(56)
>  ads_try_connect: trying ldap server '142.139.93.41' port 389
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_connect(205)
>  Connected to LDAP server 142.139.93.41
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_server_info(1864)
>  got ldap server name snb-fton-ad1@SNB.CA, using bind path: dc=SNB,dc=CA
>[2003/08/14 09:18:53, 4] libads/ldap.c:ads_server_info(1870)
>  time offset is 0 seconds
>[2003/08/14 09:18:53, 4] libads/sasl.c:ads_sasl_bind(415)
>  Found SASL mechanism GSS-SPNEGO
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 48018 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2 3
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 3 6 1 4 1 311 2 2 10
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(190)
>  got principal=snb-fton-ad1$@SNB.CA
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_do_paged_search(438)
>  ldap_search_ext_s((distinguishedName=CN=Fortune\, Jim (SNB/xwave),OU=xwave,OU=IT Admin,OU=SNB UsersG,DC=snb,DC=ca)) -> Bad search filter
>[2003/08/14 09:18:53, 3] libads/ldap_utils.c:ads_do_search_retry(60)
>  Reopening ads connection to realm 'SNB.CA' after error Bad search filter
>[2003/08/14 09:18:53, 6] libads/ldap.c:ads_find_dc(134)
>  ads_find_dc: looking for realm 'SNB.CA'
>[2003/08/14 09:18:53, 8] libsmb/namequery.c:get_sorted_dc_list(1215)
>  get_sorted_dc_list: attempting lookup using [hosts]
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad1.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD1.SNB.CA#20, value = 142.139.93.41:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad1.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:internal_resolve_name(989)
>  internal_resolve_name: looking up snb-fton-ad3.snb.ca#20
>[2003/08/14 09:18:53, 10] lib/gencache.c:gencache_get(263)
>  Returning valid cache entry: key = NBT/SNB-FTON-AD3.SNB.CA#20, value = 142.139.171.205:0, timeout = Thu Aug 14 09:22:50 2003
>  
>[2003/08/14 09:18:53, 5] libsmb/namecache.c:namecache_fetch(201)
>  name snb-fton-ad3.snb.ca#20 found.
>[2003/08/14 09:18:53, 10] libsmb/namequery.c:remove_duplicate_addrs2(312)
>  remove_duplicate_addrs2: looking for duplicate address/port pairs
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1350)
>  get_dc_list: returning 2 ip addresses in an ordered list
>[2003/08/14 09:18:53, 4] libsmb/namequery.c:get_dc_list(1351)
>  get_dc_list: 142.139.93.41:389 142.139.171.205:389 
>[2003/08/14 09:18:53, 5] libads/ldap.c:ads_try_connect(56)
>  ads_try_connect: trying ldap server '142.139.93.41' port 389
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_connect(205)
>  Connected to LDAP server 142.139.93.41
>[2003/08/14 09:18:53, 3] libads/ldap.c:ads_server_info(1864)
>  got ldap server name snb-fton-ad1@SNB.CA, using bind path: dc=SNB,dc=CA
>[2003/08/14 09:18:53, 4] libads/ldap.c:ads_server_info(1870)
>  time offset is 0 seconds
>[2003/08/14 09:18:53, 4] libads/sasl.c:ads_sasl_bind(415)
>  Found SASL mechanism GSS-SPNEGO
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 48018 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 2 840 113554 1 2 2 3
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(183)
>  got OID=1 3 6 1 4 1 311 2 2 10
>[2003/08/14 09:18:53, 3] libads/sasl.c:ads_sasl_spnego_bind(190)
>  got principal=snb-fton-ad1$@SNB.CA
>[2003/08/14 09:18:53, 1] libads/ldap_utils.c:ads_do_search_retry(76)
>  ads reopen failed after error Success
>[2003/08/14 09:18:53, 3] nsswitch/winbindd_ads.c:lookup_groupmem(762)
>  ads lookup_groupmem for sid=S-1-5-21-1416833156-1238969774-10498456-513
>[2003/08/14 09:18:53, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(340)
>  refresh_sequence_number: SNB time ok
>[2003/08/14 09:18:53, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(365)
>  refresh_sequence_number: SNB seq number is now 16902572
>[2003/08/14 09:18:53, 10] nsswitch/winbindd_group.c:fill_grent_mem(126)
>  looked up 0 names
>[2003/08/14 09:18:53, 10] nsswitch/winbindd_group.c:fill_grent_mem(207)
>  num_mem = 0, len = 0, mem = NULL
>[2003/08/14 09:18:53, 10] nsswitch/winbindd_group.c:fill_grent_mem(214)
>  fill_grent_mem returning 1
>[2003/08/14 09:18:53, 10] nsswitch/winbindd.c:client_write(516)
>  client_write: wrote 1300 bytes.
>[2003/08/14 09:18:53, 10] nsswitch/winbindd.c:winbind_client_read(469)
>  client_read: read 0 bytes. Need 1312 more for a full request.
>[2003/08/14 09:18:53, 5] nsswitch/winbindd.c:winbind_client_read(476)
>  read failed on sock 17, pid 27004: EOF
>[2003/08/14 09:18:55, 6] nsswitch/winbindd.c:new_connection(354)
>  accepted socket 17
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:winbind_client_read(469)
>  client_read: read 1312 bytes. Need 0 more for a full request.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:process_request(319)
>  process_request: request fn INTERFACE_VERSION
>[2003/08/14 09:18:55, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(207)
>  [27044]: request interface version
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:client_write(516)
>  client_write: wrote 1300 bytes.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:winbind_client_read(469)
>  client_read: read 1312 bytes. Need 0 more for a full request.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:process_request(319)
>  process_request: request fn WINBINDD_PRIV_PIPE_DIR
>[2003/08/14 09:18:55, 3] nsswitch/winbindd_misc.c:winbindd_priv_pipe_dir(243)
>  [27044]: request location of privileged pipe
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:client_write(516)
>  client_write: wrote 1300 bytes.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:client_write(561)
>  client_write: need to write 47 extra data bytes.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:client_write(516)
>  client_write: wrote 47 bytes.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:client_write(550)
>  client_write: client_write: complete response written.
>[2003/08/14 09:18:55, 6] nsswitch/winbindd.c:new_connection(354)
>  accepted socket 20
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:winbind_client_read(469)
>  client_read: read 1312 bytes. Need 0 more for a full request.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:process_request(319)
>  process_request: request fn GETPWNAM
>[2003/08/14 09:18:55, 3] nsswitch/winbindd_user.c:winbindd_getpwnam(112)
>  [27044]: getpwnam SNB.CA:xbking
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(340)
>  refresh_sequence_number: SNB time ok
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(365)
>  refresh_sequence_number: SNB seq number is now 16902572
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:name_to_sid(956)
>  name_to_sid: [Cached] - doing backend query for name for domain SNB
>[2003/08/14 09:18:55, 3] nsswitch/winbindd_ads.c:name_to_sid(321)
>  ads: name_to_sid
>[2003/08/14 09:18:55, 5] libads/ldap_utils.c:ads_do_search_retry(52)
>  Search for (|(sAMAccountName=xbking)(userPrincipalName=xbking@SNB.CA)) gave 1 replies
>[2003/08/14 09:18:55, 3] libads/ads_ldap.c:ads_name_to_sid(82)
>  ads name_to_sid mapped xbking
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:wcache_save_name_to_sid(600)
>  wcache_save_name_to_sid: XBKING -> S-1-5-21-1416833156-1238969774-10498456-5909
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(340)
>  refresh_sequence_number: SNB time ok
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(365)
>  refresh_sequence_number: SNB seq number is now 16902572
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:centry_expired(389)
>  centry_expired: Key U/S-1-5-21-1416833156-1238969774-10498456-5909 for domain SNB is good.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:wcache_fetch(468)
>  wcache_fetch: returning entry U/S-1-5-21-1416833156-1238969774-10498456-5909 for domain SNB
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:query_user(1065)
>  query_user: [Cached] - cached info for domain SNB status Success
>[2003/08/14 09:18:55, 10] sam/idmap_util.c:idmap_sid_to_uid(191)
>  idmap_sid_to_uid: sid = [S-1-5-21-1416833156-1238969774-10498456-5909]
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:db_get_id_from_sid(325)
>  db_get_id_from_sid
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(231)
>  internal_get_id_from_sid: fetching record S-1-5-21-1416833156-1238969774-10498456-5909 of type 0x1
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(238)
>  internal_get_id_from_sid: record S-1-5-21-1416833156-1238969774-10498456-5909 -> UID 10010
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(253)
>  internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-1416833156-1238969774-10498456-5909 -> UID 10010 
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(200)
>  internal_get_sid_from_id: fetching record UID 10010
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(206)
>  internal_get_sid_from_id: fetching record UID 10010 -> S-1-5-21-1416833156-1238969774-10498456-5909
>[2003/08/14 09:18:55, 10] sam/idmap_util.c:idmap_sid_to_uid(198)
>  idmap_sid_to_uid: uid = [10010]
>[2003/08/14 09:18:55, 10] sam/idmap_util.c:idmap_sid_to_gid(220)
>  sid_to_gid: sid = [S-1-5-21-1416833156-1238969774-10498456-513]
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:db_get_id_from_sid(325)
>  db_get_id_from_sid
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(231)
>  internal_get_id_from_sid: fetching record S-1-5-21-1416833156-1238969774-10498456-513 of type 0x2
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(238)
>  internal_get_id_from_sid: record S-1-5-21-1416833156-1238969774-10498456-513 -> GID 10013
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(272)
>  internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-1416833156-1238969774-10498456-513 -> GID 10013 
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(200)
>  internal_get_sid_from_id: fetching record GID 10013
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(206)
>  internal_get_sid_from_id: fetching record GID 10013 -> S-1-5-21-1416833156-1238969774-10498456-513
>[2003/08/14 09:18:55, 10] sam/idmap_util.c:idmap_sid_to_gid(228)
>  idmap_sid_to_gid: gid = [10013]
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:winbind_client_read(469)
>  client_read: read 0 bytes. Need 1312 more for a full request.
>[2003/08/14 09:18:55, 5] nsswitch/winbindd.c:winbind_client_read(476)
>  read failed on sock 17, pid 27044: EOF
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:client_write(516)
>  client_write: wrote 1300 bytes.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:winbind_client_read(469)
>  client_read: read 1312 bytes. Need 0 more for a full request.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:process_request(319)
>  process_request: request fn GETGRGID
>[2003/08/14 09:18:55, 3] nsswitch/winbindd_group.c:winbindd_getgrgid(338)
>  [27044]: getgrgid 10013
>[2003/08/14 09:18:55, 4] nsswitch/winbindd_acct.c:wb_getgrgid(547)
>  wb_getgrgid: failed to locate gid == 10013
>[2003/08/14 09:18:55, 10] sam/idmap_util.c:idmap_gid_to_sid(167)
>  idmap_gid_to_sid: gid = [10013]
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:db_get_sid_from_id(293)
>  db_get_sid_from_id: id_type_in = 0x2
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(200)
>  internal_get_sid_from_id: fetching record GID 10013
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(206)
>  internal_get_sid_from_id: fetching record GID 10013 -> S-1-5-21-1416833156-1238969774-10498456-513
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(231)
>  internal_get_id_from_sid: fetching record S-1-5-21-1416833156-1238969774-10498456-513 of type 0x2
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(238)
>  internal_get_id_from_sid: record S-1-5-21-1416833156-1238969774-10498456-513 -> GID 10013
>[2003/08/14 09:18:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(272)
>  internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-1416833156-1238969774-10498456-513 -> GID 10013 
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(340)
>  refresh_sequence_number: SNB time ok
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(365)
>  refresh_sequence_number: SNB seq number is now 16902572
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:centry_expired(389)
>  centry_expired: Key SN/S-1-5-21-1416833156-1238969774-10498456-513 for domain SNB is good.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:wcache_fetch(468)
>  wcache_fetch: returning entry SN/S-1-5-21-1416833156-1238969774-10498456-513 for domain SNB
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:sid_to_name(995)
>  sid_to_name: [Cached] - cached name for domain SNB status Success
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_group.c:fill_grent_mem(103)
>  group SID S-1-5-21-1416833156-1238969774-10498456-513
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(340)
>  refresh_sequence_number: SNB time ok
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(365)
>  refresh_sequence_number: SNB seq number is now 16902572
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:centry_expired(389)
>  centry_expired: Key GM/S-1-5-21-1416833156-1238969774-10498456-513 for domain SNB is good.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:wcache_fetch(468)
>  wcache_fetch: returning entry GM/S-1-5-21-1416833156-1238969774-10498456-513 for domain SNB
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_cache.c:lookup_groupmem(1217)
>  lookup_groupmem: [Cached] - cached info for domain SNB status Success
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_group.c:fill_grent_mem(126)
>  looked up 0 names
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_group.c:fill_grent_mem(207)
>  num_mem = 0, len = 0, mem = NULL
>[2003/08/14 09:18:55, 10] nsswitch/winbindd_group.c:fill_grent_mem(214)
>  fill_grent_mem returning 1
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:client_write(516)
>  client_write: wrote 1300 bytes.
>[2003/08/14 09:18:55, 10] nsswitch/winbindd.c:winbind_client_read(469)
>  client_read: read 0 bytes. Need 1312 more for a full request.
>[2003/08/14 09:18:55, 5] nsswitch/winbindd.c:winbind_client_read(476)
>  read failed on sock 20, pid 27044: EOF

Actions: View

Attachments on bug 282: 65 | 67 | 69 | 70 | 77 | 78 | 80 | 81 | 82