[Samba] Home drives not being mounted. Samba 3.0.7 vs W2k TS

Stephen Borrill samba at precedence.co.uk
Wed Oct 20 15:36:25 GMT 2004


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




More information about the samba mailing list