[Samba] Performance problem when copy from samba server to client

magnum magnum at magnum.lv
Fri Aug 24 11:11:58 GMT 2007


Hi All,

I noticed slow performance when make file copy from server to client.  
 From client to server it is OK.
Also I tried mount locally  on  localhost  -  same  results. 

Here is my smb.conf
---------------------------------------------------------------------------------------------------------------------------------------------------
[global]

# 1. Server Naming Options:
# workgroup = NT-Domain-Name or Workgroup-Name
  
  workgroup = mm

  server string = rax  

   load printers = no
  
;  printing = cups

   log file = /var/log/samba/log.%m

   max log size = 5000

 log level = 10

   security = domain

   password server = *

  encrypt passwords = yes
  smb passwd file = /etc/samba/private/smbpasswd

  winbind uid = 10000-20000
  winbind gid = 10000-20000
  template homedir = /home/wins/%D/%U
  template shell = /bin/bash

  

 interfaces = 192.168.1.203/24 127.0.0.1/24

   local master = no




#============================ Share Definitions 
==============================

[homes]
   comment = Home Directories
   browseable = no
   writable = no

[tmp]
   comment = Temporary file space
   path = /tmp
   read only = no
   public = yes


_______________________________________________________________________________________________
_______________________________________________________________________________________________

[2007/08/23 16:29:59, 3] smbd/oplock.c:init_oplocks(863)
  init_oplocks: initializing messages.
[2007/08/23 16:29:59, 3] smbd/oplock_linux.c:linux_init_kernel_oplocks(276)
  Linux kernel oplocks enabled
[2007/08/23 16:29:59, 3] smbd/process.c:process_smb(1068)
  Transaction 0 of length 82
[2007/08/23 16:29:59, 3] smbd/process.c:switch_message(926)
  switch message SMBnegprot (pid 3096) conn 0x0
[2007/08/23 16:29:59, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:29:59, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [LM1.2X002]
[2007/08/23 16:29:59, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [LANMAN2.1]
[2007/08/23 16:29:59, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [NT LM 0.12]
[2007/08/23 16:29:59, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [POSIX 2]
[2007/08/23 16:29:59, 3] smbd/negprot.c:reply_nt1(351)
  not using SPNEGO
[2007/08/23 16:29:59, 3] smbd/negprot.c:reply_negprot(606)
  Selected protocol NT LM 0.12
[2007/08/23 16:29:59, 3] smbd/process.c:process_smb(1068)
  Transaction 1 of length 234
[2007/08/23 16:29:59, 3] smbd/process.c:switch_message(926)
  switch message SMBsesssetupX (pid 3096) conn 0x0
[2007/08/23 16:29:59, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:29:59, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1244)
  wct=13 flg2=0xd001
[2007/08/23 16:29:59, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1390)
  Domain=[mm]  NativeOS=[Linux version 2.6.22.5] NativeLanMan=[CIFS VFS 
Client for Linux] PrimaryDomain=[]
[2007/08/23 16:29:59, 2] smbd/sesssetup.c:setup_new_vc_session(1200)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close 
all old resources.
[2007/08/23 16:29:59, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1405)
  sesssetupX:name=[mm]\[vilnisr]@[127.0.0.1]
[2007/08/23 16:29:59, 3] libsmb/namequery.c:get_dc_list(1489)
  get_dc_list: preferred server list: "PDC1, *"
[2007/08/23 16:29:59, 3] libsmb/namequery.c:resolve_lmhosts(966)
  resolve_lmhosts: Attempting lmhosts lookup for name PDC1<0x20>
[2007/08/23 16:29:59, 3] libsmb/namequery.c:resolve_wins(863)
  resolve_wins: Attempting wins lookup for name PDC1<0x20>
[2007/08/23 16:29:59, 3] libsmb/namequery.c:resolve_wins(902)
  resolve_wins: using WINS server 192.168.1.7 and tag '*'
[2007/08/23 16:29:59, 2] libsmb/namequery.c:name_query(604)
  Got a positive name query response from 192.168.1.7 ( 192.168.1.7 )
[2007/08/23 16:29:59, 3] libsmb/namequery_dc.c:rpc_dc_name(186)
  rpc_dc_name: Returning DC PDC1 (192.168.1.7) for domain MM
[2007/08/23 16:29:59, 3] libsmb/cliconnect.c:cli_start_connection(1505)
  Connecting to host=PDC1
[2007/08/23 16:29:59, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 445
[2007/08/23 16:29:59, 2] lib/util_sock.c:open_socket_out(911)
  error connecting to 192.168.1.7:445 (Connection refused)
[2007/08/23 16:29:59, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 139
[2007/08/23 16:29:59, 3] rpc_client/cli_pipe.c:rpc_pipe_bind(2081)
  rpc_pipe_bind: Remote machine PDC1 pipe \lsarpc fnum 0x800 bind 
request returned ok.
[2007/08/23 16:29:59, 3] rpc_parse/parse_lsa.c:lsa_io_sec_qos(224)
  lsa_io_sec_qos: length c does not match size 8
[2007/08/23 16:29:59, 3] auth/auth.c:check_ntlm_password(221)
  check_ntlm_password:  Checking password for unmapped user 
[mm]\[vilnisr]@[127.0.0.1] with the new password interface
[2007/08/23 16:29:59, 3] auth/auth.c:check_ntlm_password(224)
  check_ntlm_password:  mapped user is: [MM]\[vilnisr]@[127.0.0.1]
[2007/08/23 16:29:59, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:29:59, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:29:59, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:29:59, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:29:59, 3] libsmb/namequery.c:get_dc_list(1489)
  get_dc_list: preferred server list: "PDC1, *"
[2007/08/23 16:29:59, 3] libsmb/namequery_dc.c:rpc_dc_name(186)
  rpc_dc_name: Returning DC PDC1 (192.168.1.7) for domain MM
[2007/08/23 16:29:59, 3] libsmb/cliconnect.c:cli_start_connection(1505)
  Connecting to host=PDC1
[2007/08/23 16:29:59, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 445
[2007/08/23 16:29:59, 2] lib/util_sock.c:open_socket_out(911)
  error connecting to 192.168.1.7:445 (Connection refused)
[2007/08/23 16:29:59, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 139
[2007/08/23 16:29:59, 3] rpc_client/cli_pipe.c:rpc_pipe_bind(2081)
  rpc_pipe_bind: Remote machine PDC1 pipe \NETLOGON fnum 0x804 bind 
request returned ok.
[2007/08/23 16:29:59, 3] rpc_client/cli_pipe.c:rpc_pipe_bind(2081)
  rpc_pipe_bind: Remote machine PDC1 pipe \NETLOGON fnum 0x805 bind 
request returned ok.
[2007/08/23 16:29:59, 0] auth/auth_domain.c:domain_client_validate(257)
  domain_client_validate: unable to validate password for user vilnisr 
in domain MM to Domain controller PDC1. Error was NT_STATUS_WRONG_PASSWORD.
[2007/08/23 16:29:59, 2] auth/auth.c:check_ntlm_password(319)
  check_ntlm_password:  Authentication for user [vilnisr] -> [vilnisr] 
FAILED with error NT_STATUS_WRONG_PASSWORD
[2007/08/23 16:29:59, 3] smbd/error.c:error_packet_set(106)
  error packet at smbd/sesssetup.c(1489) cmd=115 (SMBsesssetupX) 
NT_STATUS_LOGON_FAILURE
[2007/08/23 16:29:59, 3] smbd/process.c:timeout_processing(1328)
  timeout_processing: End of file from client (client has disconnected).
[2007/08/23 16:29:59, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:29:59, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to
[2007/08/23 16:29:59, 3] smbd/server.c:exit_server_common(768)
  Server exit (normal exit)
[2007/08/23 16:30:25, 3] smbd/oplock.c:init_oplocks(863)
  init_oplocks: initializing messages.
[2007/08/23 16:30:25, 3] smbd/oplock_linux.c:linux_init_kernel_oplocks(276)
  Linux kernel oplocks enabled
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 0 of length 82
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBnegprot (pid 3100) conn 0x0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [LM1.2X002]
[2007/08/23 16:30:25, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [LANMAN2.1]
[2007/08/23 16:30:25, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [NT LM 0.12]
[2007/08/23 16:30:25, 3] smbd/negprot.c:reply_negprot(505)
  Requested protocol [POSIX 2]
[2007/08/23 16:30:25, 3] smbd/negprot.c:reply_nt1(351)
  not using SPNEGO
[2007/08/23 16:30:25, 3] smbd/negprot.c:reply_negprot(606)
  Selected protocol NT LM 0.12
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 1 of length 234
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBsesssetupX (pid 3100) conn 0x0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1244)
  wct=13 flg2=0xd001
[2007/08/23 16:30:25, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1390)
  Domain=[mm]  NativeOS=[Linux version 2.6.22.5] NativeLanMan=[CIFS VFS 
Client for Linux] PrimaryDomain=[]
[2007/08/23 16:30:25, 2] smbd/sesssetup.c:setup_new_vc_session(1200)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close 
all old resources.
[2007/08/23 16:30:25, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1405)
  sesssetupX:name=[mm]\[vilnisr]@[127.0.0.1]
[2007/08/23 16:30:25, 3] libsmb/namequery.c:get_dc_list(1489)
  get_dc_list: preferred server list: "PDC1, *"
[2007/08/23 16:30:25, 3] libsmb/namequery_dc.c:rpc_dc_name(186)
  rpc_dc_name: Returning DC PDC1 (192.168.1.7) for domain MM
[2007/08/23 16:30:25, 3] libsmb/cliconnect.c:cli_start_connection(1505)
  Connecting to host=PDC1
[2007/08/23 16:30:25, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 445
[2007/08/23 16:30:25, 2] lib/util_sock.c:open_socket_out(911)
  error connecting to 192.168.1.7:445 (Connection refused)
[2007/08/23 16:30:25, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 139
[2007/08/23 16:30:25, 3] rpc_client/cli_pipe.c:rpc_pipe_bind(2081)
  rpc_pipe_bind: Remote machine PDC1 pipe \lsarpc fnum 0x3813 bind 
request returned ok.
[2007/08/23 16:30:25, 3] rpc_parse/parse_lsa.c:lsa_io_sec_qos(224)
  lsa_io_sec_qos: length c does not match size 8
[2007/08/23 16:30:25, 3] auth/auth.c:check_ntlm_password(221)
  check_ntlm_password:  Checking password for unmapped user 
[mm]\[vilnisr]@[127.0.0.1] with the new password interface
[2007/08/23 16:30:25, 3] auth/auth.c:check_ntlm_password(224)
  check_ntlm_password:  mapped user is: [MM]\[vilnisr]@[127.0.0.1]
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] libsmb/namequery.c:get_dc_list(1489)
  get_dc_list: preferred server list: "PDC1, *"
[2007/08/23 16:30:25, 3] libsmb/namequery_dc.c:rpc_dc_name(186)
  rpc_dc_name: Returning DC PDC1 (192.168.1.7) for domain MM
[2007/08/23 16:30:25, 3] libsmb/cliconnect.c:cli_start_connection(1505)
  Connecting to host=PDC1
[2007/08/23 16:30:25, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 445
[2007/08/23 16:30:25, 2] lib/util_sock.c:open_socket_out(911)
  error connecting to 192.168.1.7:445 (Connection refused)
[2007/08/23 16:30:25, 3] lib/util_sock.c:open_socket_out(874)
  Connecting to 192.168.1.7 at port 139
[2007/08/23 16:30:25, 3] rpc_client/cli_pipe.c:rpc_pipe_bind(2081)
  rpc_pipe_bind: Remote machine PDC1 pipe \NETLOGON fnum 0xa805 bind 
request returned ok.
[2007/08/23 16:30:25, 3] rpc_client/cli_pipe.c:rpc_pipe_bind(2081)
  rpc_pipe_bind: Remote machine PDC1 pipe \NETLOGON fnum 0x4823 bind 
request returned ok.
[2007/08/23 16:30:25, 3] auth/auth.c:check_ntlm_password(270)
  check_ntlm_password: winbind authentication for user [vilnisr] succeeded
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 2] auth/auth.c:check_ntlm_password(309)
  check_ntlm_password:  authentication for user [vilnisr] -> [vilnisr] 
-> [vilnisr] succeeded
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] passdb/lookup_sid.c:fetch_gid_from_cache(1089)
  fetch gid from cache 10001 -> S-1-5-32-544
[2007/08/23 16:30:25, 3] passdb/lookup_sid.c:fetch_gid_from_cache(1089)
  fetch gid from cache 10002 -> S-1-5-32-545
[2007/08/23 16:30:25, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID 
[S-1-5-21-852334022-912643877-2881777060-3266]
[2007/08/23 16:30:25, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID [S-1-22-2-100]
[2007/08/23 16:30:25, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID [S-1-5-2]
[2007/08/23 16:30:25, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID [S-1-5-11]
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/uid.c:push_conn_ctx(358)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:pop_sec_ctx(356)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/password.c:register_vuid(280)
  User name: vilnisr    Real name:
[2007/08/23 16:30:25, 3] smbd/password.c:register_vuid(301)
  UNIX uid 1133 is UNIX user vilnisr, and will be vuid 100
[2007/08/23 16:30:25, 3] smbd/password.c:register_vuid(332)
  Adding homes service for user 'vilnisr' using home directory: 
'/home/vilnisr'
[2007/08/23 16:30:25, 3] param/loadparm.c:lp_add_home(2660)
  adding home's share [vilnisr] for user 'vilnisr' at '/home/vilnisr'
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 2 of length 86
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBtconX (pid 3100) conn 0x0
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/service.c:make_connection_snum(806)
  Connect path is '/tmp' for service [tmp]
[2007/08/23 16:30:25, 3] lib/util_seaccess.c:se_access_check(250)
[2007/08/23 16:30:25, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-852334022-912643877-2881777060-3266
  se_access_check: also S-1-22-2-100
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
[2007/08/23 16:30:25, 3] smbd/vfs.c:vfs_init_default(95)
  Initialising default vfs hooks
[2007/08/23 16:30:25, 3] smbd/vfs.c:vfs_init_custom(128)
  Initialising custom vfs hooks from [/[Default VFS]/]
[2007/08/23 16:30:25, 3] lib/util_seaccess.c:se_access_check(250)
[2007/08/23 16:30:25, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-852334022-912643877-2881777060-3266
  se_access_check: also S-1-22-2-100
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
[2007/08/23 16:30:25, 3] lib/util_seaccess.c:se_access_check(250)
[2007/08/23 16:30:25, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-852334022-912643877-2881777060-3266
  se_access_check: also S-1-22-2-100
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (1133, 100) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 1] smbd/service.c:make_connection_snum(1033)
  127.0.0.1 (127.0.0.1) connect to service tmp initially as user vilnisr 
(uid=1133, gid=100) (pid 3100)
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/reply.c:reply_tcon_and_X(574)
  tconX service=tmp
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 3 of length 72
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:25, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (1133, 100) - sec_ctx_stack_ndx = 0
[2007/08/23 16:30:25, 3] smbd/trans2.c:call_trans2qfsinfo(2246)
  call_trans2qfsinfo: level = 260
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 4 of length 72
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:25, 3] smbd/trans2.c:call_trans2qfsinfo(2246)
  call_trans2qfsinfo: level = 261
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 5 of length 72
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:25, 3] smbd/trans2.c:call_trans2qfsinfo(2246)
  call_trans2qfsinfo: level = 512
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 6 of length 86
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:25, 3] smbd/process.c:process_smb(1068)
  Transaction 7 of length 78
[2007/08/23 16:30:25, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:25, 3] smbd/trans2.c:call_trans2qfilepathinfo(3252)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
[2007/08/23 16:30:25, 3] smbd/trans2.c:call_trans2qfilepathinfo(3314)
  call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0
[2007/08/23 16:30:34, 3] smbd/process.c:process_smb(1068)
  Transaction 8 of length 78
[2007/08/23 16:30:34, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:34, 3] smbd/trans2.c:call_trans2qfilepathinfo(3252)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
[2007/08/23 16:30:34, 3] smbd/trans2.c:call_trans2qfilepathinfo(3314)
  call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0
[2007/08/23 16:30:35, 3] smbd/process.c:process_smb(1068)
  Transaction 9 of length 78
[2007/08/23 16:30:35, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:35, 3] smbd/trans2.c:call_trans2qfilepathinfo(3252)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
[2007/08/23 16:30:35, 3] smbd/trans2.c:call_trans2qfilepathinfo(3314)
  call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0
[2007/08/23 16:30:35, 3] smbd/process.c:process_smb(1068)
  Transaction 10 of length 88
[2007/08/23 16:30:35, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:35, 3] smbd/trans2.c:call_trans2findfirst(1703)
  call_trans2findfirst: dirtype = 17, maxentries = 150, 
close_after_first=0, close_if_end = 2 requires_resume_key = 4 level = 
0x202, max_data_bytes = 16384
[2007/08/23 16:30:35, 3] smbd/dir.c:dptr_create(516)
  creating new dirptr 256 for path ./, expect_close = 1
[2007/08/23 16:30:42, 3] smbd/process.c:process_smb(1068)
  Transaction 11 of length 78
[2007/08/23 16:30:42, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:42, 3] smbd/trans2.c:call_trans2qfilepathinfo(3252)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
[2007/08/23 16:30:42, 3] smbd/trans2.c:call_trans2qfilepathinfo(3314)
  call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 12 of length 116
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/trans2.c:call_trans2qfilepathinfo(3252)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
[2007/08/23 16:30:45, 3] smbd/trans2.c:call_trans2qfilepathinfo(3314)
  call_trans2qfilepathinfo austrumi-1.5.1.iso (fnum = -1) level=512 
call=5 total_data=0
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 13 of length 128
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBntcreateX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(austrumi-1.5.1.iso) returning 0744
[2007/08/23 16:30:45, 2] smbd/open.c:open_file(391)
  vilnisr opened file austrumi-1.5.1.iso read=Yes write=No (numopen=1)
[2007/08/23 16:30:45, 3] smbd/oplock_linux.c:linux_set_kernel_oplock(180)
  linux_set_kernel_oplock: got kernel oplock on file austrumi-1.5.1.iso, 
dev = 901, inode = 354, file_id = 1
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 14 of length 116
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBtrans2 (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/trans2.c:call_trans2qfilepathinfo(3252)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
[2007/08/23 16:30:45, 3] smbd/trans2.c:call_trans2qfilepathinfo(3314)
  call_trans2qfilepathinfo austrumi-1.5.1.iso (fnum = -1) level=512 
call=5 total_data=0
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 15 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 16 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 17 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 18 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 19 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 20 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 21 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 22 of length 63
[2007/08/23 16:30:45, 3] smbd/process.c:switch_message(926)
  switch message SMBreadX (pid 3100) conn 0x80461658
[2007/08/23 16:30:45, 3] smbd/reply.c:send_file_readX(2640)
  send_file_readX fnum=6889 max=16384 nread=16384
[2007/08/23 16:30:45, 3] smbd/process.c:process_smb(1068)
  Transaction 23 of length 63
---------------------------------------------------------------------------------------------------------------------------------------------
Any help appreciated






More information about the samba mailing list