[Samba] Sluggish server response

Chris Garrigues cwg-dated-1085327217.54fd3b at deepeddy.com
Tue May 18 15:46:55 GMT 2004


A user who had not been using the server for about half an hour 
had to wait for over a minute before the samba server would respond.

This is using samba3-server-3.0.2a-2mdk.  I hope to upgrade to 3.0.4 as soon 
as Buchan has the RPM ready.

In the below log, the user tried to log in at about 10:27 or so.  I think 
I'm not learning anything from this log, so I've also attached part of 
log.nmbd below.

[2004/05/18 09:52:12, 3] smbd/error.c:error_packet(94)                          
  error string = No such file or directory                                      
[2004/05/18 09:52:12, 3] smbd/error.c:error_packet(118)                         
  error packet at smbd/trans2.c(1808) cmd=50 (SMBtrans2) NT_STATUS_OBJECT_NAME_\
NOT_FOUND                                                                       
[2004/05/18 09:52:12, 3] smbd/process.c:process_smb(890)                        
  Transaction 10 of length 102                                                  
[2004/05/18 09:52:12, 3] smbd/process.c:switch_message(685)                     
  switch message SMBtrans2 (pid 7783)                                           
[2004/05/18 09:52:12, 3] smbd/trans2.c:call_trans2qfilepathinfo(1915)           
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004                   
[2004/05/18 09:52:12, 3] lib/util.c:unix_clean_name(580)                        
  unix_clean_name [/wshENU.DLL]                                                 
[2004/05/18 09:52:12, 3] lib/util.c:unix_clean_name(580)                        
  unix_clean_name [wshENU.DLL]                                                  
[2004/05/18 09:52:12, 3] smbd/trans2.c:call_trans2qfilepathinfo(1934)           
  call_trans2qfilepathinfo: SMB_VFS_STAT of wshENU.DLL failed (No such file or directory)                                                                      
[2004/05/18 09:52:12, 3] smbd/error.c:error_packet(94)                          
  error string = No such file or directory                                      
[2004/05/18 09:52:12, 3] smbd/error.c:error_packet(118)                         
  error packet at smbd/trans2.c(1808) cmd=50 (SMBtrans2) NT_STATUS_OBJECT_NAME_NOT_FOUND                                                                       
[2004/05/18 09:53:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 09:54:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 09:55:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 09:56:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 09:56:59, 3] smbd/process.c:process_smb(890)                        
  Transaction 11 of length 4                                                    
[2004/05/18 09:57:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 09:58:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 09:59:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:00:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:01:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:02:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:03:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:04:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:05:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:06:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:07:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:08:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:09:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:10:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:11:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:12:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:13:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:14:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:15:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:16:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:17:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:18:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:19:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:20:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:21:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:22:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:23:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:24:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:25:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:26:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:27:59, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0                                
[2004/05/18 10:28:52, 3] smbd/process.c:process_smb(890)                        
  Transaction 11 of length 80                                                   
[2004/05/18 10:28:52, 3] smbd/process.c:switch_message(685)                     
  switch message SMBtrans2 (pid 7783)                                           
[2004/05/18 10:28:52, 3] smbd/sec_ctx.c:set_sec_ctx(288)                        
  setting sec ctx (208, 203) - sec_ctx_stack_ndx = 0                            
[2004/05/18 10:28:52, 3] smbd/trans2.c:call_trans2qfilepathinfo(1915)           
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004                   
[2004/05/18 10:28:52, 3] lib/util.c:unix_clean_name(580)                        
  unix_clean_name []                                                            
[2004/05/18 10:28:52, 3] lib/util.c:unix_clean_name(580)                        
  unix_clean_name [.]                                                           
[2004/05/18 10:28:52, 3] smbd/trans2.c:call_trans2qfilepathinfo(1943)           
  call_trans2qfilepathinfo . (fnum = -1) level=1004 call=5 total_data=0         
[2004/05/18 10:28:52, 3] smbd/process.c:process_smb(890)                        
  Transaction 12 of length 88                                                   
[2004/05/18 10:28:52, 3] smbd/process.c:switch_message(685)                     
  switch message SMBtrans2 (pid 7783)                                           
[2004/05/18 10:28:52, 3] smbd/trans2.c:call_trans2qfilepathinfo(1915)           
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004                   
[2004/05/18 10:28:52, 3] lib/util.c:unix_clean_name(580)                        
  unix_clean_name [/È°Tê\200\205]                                               
[2004/05/18 10:28:52, 3] lib/util.c:unix_clean_name(580)                        
  unix_clean_name [È°Tê\200\205]                                                
[2004/05/18 10:28:52, 3] smbd/trans2.c:call_trans2qfilepathinfo(1934)           
  call_trans2qfilepathinfo: SMB_VFS_STAT of È°Tê\200\205 failed (No such file or directory)                                                                    
       
Here's part of log.nmbd.  The client machine at issue here is at 10.1.1.30:

[2004/05/18 10:26:21, 3] nmbd/nmbd_serverlistdb.c:write_browse_list(421)
  write_browse_list: Wrote browse list into file /var/cache/samba3/browse.dat
[2004/05/18 10:26:48, 3] nmbd/nmbd_processlogon.c:process_logon_packet(278)
  process_logon_packet: SAMLOGON sidsize 0 ntv 11
[2004/05/18 10:26:48, 3] nmbd/nmbd_processlogon.c:process_logon_packet(278)
  process_logon_packet: SAMLOGON sidsize 0 ntv 11
[2004/05/18 10:27:01, 3] nmbd/nmbd_incomingdgrams.c:process_host_announce(118)
  process_host_announce: from GANYMEDE<00> IP 10.1.1.30 to TRINSICS<1d> for server GANYMEDE.
[2004/05/18 10:27:01, 3] nmbd/nmbd_serverlistdb.c:write_browse_list(421)
  write_browse_list: Wrote browse list into file /var/cache/samba3/browse.dat
[2004/05/18 10:28:08, 3] nmbd/nmbd_incomingrequests.c:process_name_query_request(451)
  process_name_query_request: Name query from 10.1.1.187 on subnet 10.1.1.1 for name SHREDDER<00>
                                  
-- 
Chris Garrigues                 http://www.DeepEddy.Com/~cwg/
Trinsic Solutions		http://www.trinsics.com
1611-B West 6th Street
Austin, TX  78703-5074		512-322-0180

	    If you don't apply what you've learned, you haven't 
	       learned anything.


-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-signature
Size: 235 bytes
Desc: not available
Url : http://lists.samba.org/archive/samba/attachments/20040518/a802ae86/attachment.bin


More information about the samba mailing list