Stephen Borrill
2004-Oct-20 15:37 UTC
[Samba] Home drives not being mounted. Samba 3.0.7 vs W2k TS
At a number of sites we are using Windows 2000 Server SP4 (APPSERVER) as a Terminal Server and a PDC. All user areas are stored on a NetBSD 1.6.2 server with Samba 3.0.7 using security = domain and a named password server. We've joined the domain from the Samba box (domain DOMAINNAME). In general everything works fine, but when a number of clients log on at around the same time (say 25 users at once), a fair proportion do not map their home drive. Doing a "net use U: /home" at a later time generally, but not always, maps it. It happens occasionally with 2.2.8, but we are getting feedback that 3.0.7 is much worse. An extract of a log at the time of failure: [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:make_auth_context_subsystem(467) Making default auth method list for security=domain [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match guest [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(409) load_auth_module: auth method guest has a valid init [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match sam [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(409) load_auth_module: auth method sam has a valid init [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match winbind:ntdomain [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match ntdomain [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(409) load_auth_module: auth method ntdomain has a valid init [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:load_auth_module(409) load_auth_module: auth method winbind has a valid init [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:get_ntlm_challenge(95) auth_get_challenge: module guest did not want to specify a challenge [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:get_ntlm_challenge(95) auth_get_challenge: module sam did not want to specify a challenge [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:get_ntlm_challenge(95) auth_get_challenge: module winbind did not want to specify a challenge [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:get_ntlm_challenge(135) auth_context challenge created by random [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:get_ntlm_challenge(136) challenge is: [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util.c:dump_data(1835) [000] 69 C6 F2 30 FD DD 53 29 i..0..S) [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:make_user_info_for_reply(403) make_user_info_for_reply: User passwords not in encrypted format. [2004/10/14 09:28:21, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/username.c:map_username(132) Scanning username map /usr/pkg/etc/samba/smbusers [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/username.c:user_in_list(529) user_in_list: checking user 00bblues in list [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/username.c:user_in_list(533) user_in_list: checking user |00bblues| against |administrator| [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:make_user_info_map(225) make_user_info_map: Mapping user []\[00bblues] from workstation [nc91] [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_get(264) Returning valid cache entry: key = TDOMCACHE/TIMESTAMP, value = 0, timeout = Thu Oct 14 09:37:47 2004 [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_set(127) Adding cache entry with key = TDOMCACHE/TIMESTAMP; value = 0 and timeout = Thu Oct 14 09:38:21 2004 (600 seconds ahead) [2004/10/14 09:28:21, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/passdb/secrets.c:secrets_fetch_trust_account_password(290) Using cleartext machine password [2004/10/14 09:28:21, 8] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:get_sorted_dc_list(1416) get_sorted_dc_list: attempting lookup using [lmhosts wins host bcast] [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:internal_resolve_name(1010) internal_resolve_name: looking up APPSERVER#20 [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_get(264) Returning valid cache entry: key = NBT/APPSERVER#20, value = 192.168.2.253:0, timeout = Thu Oct 14 09:36:18 2004 [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namecache.c:namecache_fetch(201) name APPSERVER#20 found. [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:remove_duplicate_addrs2(320) remove_duplicate_addrs2: looking for duplicate address/port pairs [2004/10/14 09:28:21, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:get_dc_list(1389) get_dc_list: returning 1 ip addresses in an ordered list [2004/10/14 09:28:21, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:get_dc_list(1390) get_dc_list: 192.168.2.253:0 [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:name_status_find(188) name_status_find: looking up DOMAINNAME#1c at 192.168.2.253 [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_get(286) Cache entry with key = NBT/DOMAINNAME#1C.20.192.168.2.253 couldn't be found [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namecache.c:namecache_status_fetch(308) namecache_status_fetch: no entry for NBT/DOMAINNAME#1C.20.192.168.2.253 found. [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_del(214) Deleting cache entry (key = NBT/DOMAINNAME#1C.20.192.168.2.253) [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util_sock.c:open_socket_in(717) bind succeeded on port 0 [2004/10/14 09:28:21, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:send_udp(779) Sending a packet of len 50 to (192.168.2.253) on port 137 [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util_sock.c:read_udp_socket(230) read_udp_socket: lastip 192.168.2.253 lastport 137 read: 576 [2004/10/14 09:28:21, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:parse_nmb(503) parse_nmb: packet id = 21496 [2004/10/14 09:28:23, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:send_udp(779) Sending a packet of len 50 to (192.168.2.253) on port 137 [2004/10/14 09:28:23, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util_sock.c:read_udp_socket(230) read_udp_socket: lastip 192.168.2.253 lastport 137 read: 576 [2004/10/14 09:28:23, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:parse_nmb(503) parse_nmb: packet id = 21496 [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:name_status_find(227) name_status_find: name not found [2004/10/14 09:28:25, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/trusts_util.c:enumerate_domain_trusts(149) enumerate_domain_trusts: can't locate a DC for domain DOMAINNAME [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_get(286) Cache entry with key = TDOM/DOMAINNAME couldn't be found [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/trustdom_cache.c:trustdom_cache_fetch(184) no entry for trusted domain DOMAINNAME found. [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:make_user_info(133) attempting to make a user_info for 00bblues (00bblues) [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:make_user_info(143) making strings for 00bblues's user_info struct [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:make_user_info(185) making blobs for 00bblues's user_info struct [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:make_user_info(201) made an unencrypted user_info for 00bblues (00bblues) [2004/10/14 09:28:25, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(219) check_ntlm_password: Checking password for unmapped user []\[00bblues]@[nc91] with the new password interface [2004/10/14 09:28:25, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(222) check_ntlm_password: mapped user is: [DOMAINNAME]\[00bblues]@[nc91] [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(231) check_ntlm_password: auth_context challenge created by random [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(233) challenge is: [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util.c:dump_data(1835) [000] 69 C6 F2 30 FD DD 53 29 i..0..S) [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(259) check_ntlm_password: guest had nothing to say [2004/10/14 09:28:25, 8] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util.c:is_myname(1698) is_myname("DOMAINNAME") returns 0 [2004/10/14 09:28:25, 6] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_sam.c:check_samstrict_security(358) check_samstrict_security: DOMAINNAME is not one of my local names (ROLE_DOMAIN_MEMBER) [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(259) check_ntlm_password: sam had nothing to say [2004/10/14 09:28:25, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2004/10/14 09:28:25, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/smbd/uid.c:push_conn_ctx(365) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2004/10/14 09:28:25, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2004/10/14 09:28:25, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2004/10/14 09:28:25, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/passdb/secrets.c:secrets_fetch_trust_account_password(290) Using cleartext machine password [2004/10/14 09:28:25, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/passdb/secrets.c:secrets_fetch_trust_account_password(290) Using cleartext machine password [2004/10/14 09:28:25, 8] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:get_sorted_dc_list(1416) get_sorted_dc_list: attempting lookup using [lmhosts wins host bcast] [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:internal_resolve_name(1010) internal_resolve_name: looking up APPSERVER#20 [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_get(264) Returning valid cache entry: key = NBT/APPSERVER#20, value = 192.168.2.253:0, timeout = Thu Oct 14 09:36:18 2004 [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namecache.c:namecache_fetch(201) name APPSERVER#20 found. [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:remove_duplicate_addrs2(320) remove_duplicate_addrs2: looking for duplicate address/port pairs [2004/10/14 09:28:25, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:get_dc_list(1389) get_dc_list: returning 1 ip addresses in an ordered list [2004/10/14 09:28:25, 4] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:get_dc_list(1390) get_dc_list: 192.168.2.253:0 [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:name_status_find(188) name_status_find: looking up DOMAINNAME#1c at 192.168.2.253 [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_get(286) Cache entry with key = NBT/DOMAINNAME#1C.20.192.168.2.253 couldn't be found [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namecache.c:namecache_status_fetch(308) namecache_status_fetch: no entry for NBT/DOMAINNAME#1C.20.192.168.2.253 found. [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/gencache.c:gencache_del(214) Deleting cache entry (key = NBT/DOMAINNAME#1C.20.192.168.2.253) [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util_sock.c:open_socket_in(717) bind succeeded on port 0 [2004/10/14 09:28:25, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:send_udp(779) Sending a packet of len 50 to (192.168.2.253) on port 137 [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util_sock.c:read_udp_socket(230) read_udp_socket: lastip 192.168.2.253 lastport 137 read: 576 [2004/10/14 09:28:25, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:parse_nmb(503) parse_nmb: packet id = 21146 [2004/10/14 09:28:27, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:send_udp(779) Sending a packet of len 50 to (192.168.2.253) on port 137 [2004/10/14 09:28:27, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/lib/util_sock.c:read_udp_socket(230) read_udp_socket: lastip 192.168.2.253 lastport 137 read: 576 [2004/10/14 09:28:27, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/nmblib.c:parse_nmb(503) parse_nmb: packet id = 21146 [2004/10/14 09:28:29, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/libsmb/namequery.c:name_status_find(227) name_status_find: name not found [2004/10/14 09:28:29, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_domain.c:check_ntdomain_security(301) check_ntdomain_security: unable to locate a DC for domain DOMAINNAME [2004/10/14 09:28:29, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(271) check_ntlm_password: winbind authentication for user [00bblues] FAILED with error NT_STATUS_NO_LOGON_SERVERS [2004/10/14 09:28:29, 2] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth.c:check_ntlm_password(312) check_ntlm_password: Authentication for user [00bblues] -> [00bblues] FAILED with error NT_STATUS_NO_LOGON_SERVERS [2004/10/14 09:28:29, 5] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:free_user_info(1306) attempting to free (and zero) a user_info structure [2004/10/14 09:28:29, 10] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/auth/auth_util.c:free_user_info(1309) structure was created for 00bblues [2004/10/14 09:28:29, 3] /usr/pkgsrc/net/samba/work/samba-3.0.7/source/smbd/error.c:error_packet(145) error packet at /usr/pkgsrc/net/samba/work/samba-3.0.7/source/smbd/sesssetup.c(887) cmd=115 (SMBsesssetupX) eclass=1 ecode=2215 -- Stephen