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