[Samba] Joining EMC NAS to Samba 3 Domain?

Jim Hogan jimh at u.washington.edu
Tue Mar 27 16:13:59 GMT 2007


Andrew,

Thanks....some progress below

Andrew Bartlett wrote:
> On Mon, 2007-03-26 at 12:40 -0700, Jim Hogan wrote:
>   
>> I would be interested in hearing from anybody who has discovered the 
>> "trick" to getting an EMC Celerra to join their Samba 3.x domain.
>>
>> [snip] In LDAP, the SambaNTPassword attribute (and a few others created in client records when a successful join is completed) are missing.
>>
>> EMC documentation is to the effect "Windows NT servers are automatically 
>> joined to a domain when created".  This does not square with other joins 
>> where a Samba root user/password are required.  EMC does have a "Join" 
>> option for its "server_cifs" command (that takes a password), but this 
>> is supposedly only for Win2000+ .  I tried it anyway.  It times out.
>>     
>
> The password-based join is what I would prefer to have people use, but
> 'smbpasswd -a -m' should match NT4 is this respect (setting a password
> matching the machine name).
>
> Andrew Bartlett
>
>   
Sounds like this a familiar issue to you :)

I was thinking that smbldap-useradd behavior would have been the 
equivalent of this smbpasswd -a -m but not so.  When I did it without 
the -a, it complained that "emcserver$" not found, so I reran as -a -m 
and it succeeded and it expanded the LDAP record for the EMC to now 
include the sambaLMPasswrod/NTPassword and sambaPrimaryGroupSID.

The Samba log for the EMC is now a lot more interesting, too.  Where 
before I saw little that seemed interesting with respect to 
failure/success, I am now seeing what looks like successful auth of my 
user account of of an XP VMWare workstation -- there was previously no 
instance of my ID in the EMC's log. 

I have added 2 CIFS shares on the EMC.  I also waited ~30 minutes to see 
if NETBIOS info would update, but when I try to browse the EMC, I still 
get "EM-server is not accessible. You might not have permissions...the 
user name can not be found."   I have included below a fairly lengthy 
log snippet from the attempt to browse the EMC's.  Mostly it looks like 
success.  Although EMC does not support Samba officially at this time, 
I've received an email from one of their engineers who is going to help 
me look at logging on EMC side.    I also have a few questions for him 
about EMC's user mapping which may have some bearing on this now. 

We brought in this unit on an eval basis contingent on getting it to 
work with existing LDAP and Samba (in same way as old existing Filer is 
albeit also not officially supported by NetApp), so we haven't paid for 
it yet.  I'm thinking it is real close, but might have to look harder at 
EMC side next.

Thanks!

Jim


[2007/03/27 08:31:19, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_ENUMTRUSTDOM
[2007/03/27 08:31:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 24
[2007/03/27 08:31:19, 3] smbd/process.c:process_smb(1110)
  Transaction 56 of length 51
[2007/03/27 08:31:19, 3] smbd/process.c:switch_message(914)
  switch message SMBclose (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:31:19, 3] rpc_server/srv_lsa_hnd.c:close_policy_hnd(200)
  Closed policy
[2007/03/27 08:32:19, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/03/27 08:32:19, 3] smbd/process.c:process_smb(1110)
  Transaction 57 of length 104
[2007/03/27 08:32:19, 3] smbd/process.c:switch_message(914)
  switch message SMBntcreateX (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:32:19, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:32:19, 3] smbd/nttrans.c:nt_open_pipe(346)
  nt_open_pipe: Known pipe lsarpc opening.
[2007/03/27 08:32:19, 3] smbd/process.c:process_smb(1110)
  Transaction 58 of length 160
[2007/03/27 08:32:19, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:32:19, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=72 params=0 setup=2
[2007/03/27 08:32:19, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:32:19, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727b)
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe.c:api_pipe_bind_req(1534)
  api_pipe_bind_req: \PIPE\lsarpc -> \PIPE\lsass
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe.c:check_bind_req(985)
  check_bind_req for \PIPE\lsarpc
[2007/03/27 08:32:19, 3] smbd/process.c:process_smb(1110)
  Transaction 59 of length 180
[2007/03/27 08:32:19, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:32:19, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=92 params=0 setup=2
[2007/03/27 08:32:19, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:32:19, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727b)
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 70
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_OPENPOLICY2
[2007/03/27 08:32:19, 3] rpc_parse/parse_lsa.c:lsa_io_sec_qos(224)
  lsa_io_sec_qos: length c does not match size 8
[2007/03/27 08:32:19, 3] lib/util_seaccess.c:se_access_check(250)
[2007/03/27 08:32:19, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-501
  se_access_check: also S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-513
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-32-546
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 824
[2007/03/27 08:32:19, 3] smbd/process.c:process_smb(1110)
  Transaction 60 of length 140
[2007/03/27 08:32:19, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:32:19, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=52 params=0 setup=2
[2007/03/27 08:32:19, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:32:19, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727b)
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 0
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_ENUMTRUSTDOM
[2007/03/27 08:32:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 24
[2007/03/27 08:32:19, 3] smbd/process.c:process_smb(1110)
  Transaction 61 of length 51
[2007/03/27 08:32:19, 3] smbd/process.c:switch_message(914)
  switch message SMBclose (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:32:19, 3] rpc_server/srv_lsa_hnd.c:close_policy_hnd(200)
  Closed policy
[2007/03/27 08:33:04, 3] smbd/process.c:process_smb(1110)
  Transaction 62 of length 104
[2007/03/27 08:33:04, 3] smbd/process.c:switch_message(914)
  switch message SMBntcreateX (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:04, 3] smbd/nttrans.c:nt_open_pipe(346)
  nt_open_pipe: Known pipe lsarpc opening.
[2007/03/27 08:33:04, 3] smbd/process.c:process_smb(1110)
  Transaction 63 of length 160
[2007/03/27 08:33:04, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:04, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=72 params=0 setup=2
[2007/03/27 08:33:04, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:04, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727c)
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe.c:api_pipe_bind_req(1534)
  api_pipe_bind_req: \PIPE\lsarpc -> \PIPE\lsass
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe.c:check_bind_req(985)
  check_bind_req for \PIPE\lsarpc
[2007/03/27 08:33:04, 3] smbd/process.c:process_smb(1110)
  Transaction 64 of length 180
[2007/03/27 08:33:04, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:04, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=92 params=0 setup=2
[2007/03/27 08:33:04, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:04, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727c)
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 70
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_OPENPOLICY2
[2007/03/27 08:33:04, 3] rpc_parse/parse_lsa.c:lsa_io_sec_qos(224)
  lsa_io_sec_qos: length c does not match size 8
[2007/03/27 08:33:04, 3] lib/util_seaccess.c:se_access_check(250)
[2007/03/27 08:33:04, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-XXXXXXXX-XXXXXXX1073051190-501
  se_access_check: also S-1-5-21-XXXXXXXXX-XXXXXXXXXXX-1073051190-513
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-32-546
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 824
[2007/03/27 08:33:04, 3] smbd/process.c:process_smb(1110)
  Transaction 65 of length 140
[2007/03/27 08:33:04, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:04, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=52 params=0 setup=2
[2007/03/27 08:33:04, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:04, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727c)
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 0
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_ENUMTRUSTDOM
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 24
[2007/03/27 08:33:04, 3] smbd/process.c:process_smb(1110)
  Transaction 66 of length 51
[2007/03/27 08:33:04, 3] smbd/process.c:switch_message(914)
  switch message SMBclose (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:04, 3] rpc_server/srv_lsa_hnd.c:close_policy_hnd(200)
  Closed policy
[2007/03/27 08:33:04, 3] smbd/process.c:process_smb(1110)
  Transaction 67 of length 426
[2007/03/27 08:33:04, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:04, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=338 params=0 setup=2
[2007/03/27 08:33:04, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:04, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "NETLOGON" (pnum 7271)
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 0
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: NET_SAMLOGON
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] 
passdb/secrets.c:secrets_store_schannel_session_info(995)
  secrets_store_schannel_session_info: stored schannel info with key 
SECRETS/SCHANNEL/EMCSERVER
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] 
rpc_server/srv_netlog_nt.c:_net_sam_logon_internal(847)
  SAM Logon (Network). Domain:[OURDOMAIN].  User:[jim12 at COMPUTER] 
Requested Domain:[OURDOMAIN]
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] auth/auth.c:check_ntlm_password(221)
  check_ntlm_password:  Checking password for unmapped user 
[OURDOMAIN]\[jim12]@[COMPUTER] with the new password interface
[2007/03/27 08:33:04, 3] auth/auth.c:check_ntlm_password(224)
  check_ntlm_password:  mapped user is: [OURDOMAIN]\[jim12]@[COMPUTER]
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 2] passdb/pdb_ldap.c:init_sam_from_ldap(541)
  init_sam_from_ldap: Entry found for user: jim12
[2007/03/27 08:33:04, 2] passdb/pdb_ldap.c:init_group_from_ldap(2136)
  init_group_from_ldap: Entry found for group: 2600
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 2
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2007/03/27 08:33:04, 2] passdb/pdb_ldap.c:init_group_from_ldap(2136)
  init_group_from_ldap: Entry found for group: 2600
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] passdb/lookup_sid.c:fetch_gid_from_cache(999)
  fetch gid from cache 2600 -> S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-6201
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] passdb/lookup_sid.c:fetch_sid_from_gid_cache(979)
  fetch sid from gid cache 2600 -> 
S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-6201
[2007/03/27 08:33:04, 3] passdb/lookup_sid.c:fetch_sid_from_gid_cache(979)
  fetch sid from gid cache 2512 -> 
S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-512
[2007/03/27 08:33:04, 3] passdb/lookup_sid.c:fetch_sid_from_gid_cache(979)
  fetch sid from gid cache 2607 -> 
S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-6215
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] auth/auth.c:check_ntlm_password(270)
  check_ntlm_password: sam authentication for user [jim12] succeeded
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:04, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:04, 2] auth/auth.c:check_ntlm_password(309)
  check_ntlm_password:  authentication for user [jim12] -> [jim12] -> 
[jim12] succeeded
[2007/03/27 08:33:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 908
[2007/03/27 08:33:06, 3] smbd/process.c:process_smb(1110)
  Transaction 68 of length 104
[2007/03/27 08:33:06, 3] smbd/process.c:switch_message(914)
  switch message SMBntcreateX (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:06, 3] smbd/nttrans.c:nt_open_pipe(346)
  nt_open_pipe: Known pipe lsarpc opening.
[2007/03/27 08:33:06, 3] smbd/process.c:process_smb(1110)
  Transaction 69 of length 160
[2007/03/27 08:33:06, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:06, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=72 params=0 setup=2
[2007/03/27 08:33:06, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:06, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727d)
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe.c:api_pipe_bind_req(1534)
  api_pipe_bind_req: \PIPE\lsarpc -> \PIPE\lsass
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe.c:check_bind_req(985)
  check_bind_req for \PIPE\lsarpc
[2007/03/27 08:33:06, 3] smbd/process.c:process_smb(1110)
  Transaction 70 of length 180
[2007/03/27 08:33:06, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:06, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=92 params=0 setup=2
[2007/03/27 08:33:06, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:06, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727d)
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 70
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_OPENPOLICY2
[2007/03/27 08:33:06, 3] rpc_parse/parse_lsa.c:lsa_io_sec_qos(224)
  lsa_io_sec_qos: length c does not match size 8
[2007/03/27 08:33:06, 3] lib/util_seaccess.c:se_access_check(250)
[2007/03/27 08:33:06, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-501
  se_access_check: also S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-513
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-32-546
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 824
[2007/03/27 08:33:06, 3] smbd/process.c:process_smb(1110)
  Transaction 71 of length 140
[2007/03/27 08:33:06, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:06, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=52 params=0 setup=2
[2007/03/27 08:33:06, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:06, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727d)
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 0
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_ENUMTRUSTDOM
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 24
[2007/03/27 08:33:06, 3] smbd/process.c:process_smb(1110)
  Transaction 72 of length 51
[2007/03/27 08:33:06, 3] smbd/process.c:switch_message(914)
  switch message SMBclose (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:06, 3] rpc_server/srv_lsa_hnd.c:close_policy_hnd(200)
  Closed policy
[2007/03/27 08:33:06, 3] smbd/process.c:process_smb(1110)
  Transaction 73 of length 426
[2007/03/27 08:33:06, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:06, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=338 params=0 setup=2
[2007/03/27 08:33:06, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:06, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "NETLOGON" (pnum 7271)
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 0
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: NET_SAMLOGON
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] 
passdb/secrets.c:secrets_store_schannel_session_info(995)
  secrets_store_schannel_session_info: stored schannel info with key 
SECRETS/SCHANNEL/EMCSERVER
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] 
rpc_server/srv_netlog_nt.c:_net_sam_logon_internal(847)
  SAM Logon (Network). Domain:[OURDOMAIN].  User:[jim12 at COMPUTER] 
Requested Domain:[OURDOMAIN]
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] auth/auth.c:check_ntlm_password(221)
  check_ntlm_password:  Checking password for unmapped user 
[OURDOMAIN]\[jim12]@[COMPUTER] with the new password interface
[2007/03/27 08:33:06, 3] auth/auth.c:check_ntlm_password(224)
  check_ntlm_password:  mapped user is: [OURDOMAIN]\[jim12]@[COMPUTER]
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 2] passdb/pdb_ldap.c:init_sam_from_ldap(541)
  init_sam_from_ldap: Entry found for user: jim12
[2007/03/27 08:33:06, 2] passdb/pdb_ldap.c:init_group_from_ldap(2136)
  init_group_from_ldap: Entry found for group: 2600
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 2
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2007/03/27 08:33:06, 2] passdb/pdb_ldap.c:init_group_from_ldap(2136)
  init_group_from_ldap: Entry found for group: 2600
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] passdb/lookup_sid.c:fetch_gid_from_cache(999)
  fetch gid from cache 2600 -> S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-6201
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] passdb/lookup_sid.c:fetch_sid_from_gid_cache(979)
  fetch sid from gid cache 2600 -> 
S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-6201
[2007/03/27 08:33:06, 3] passdb/lookup_sid.c:fetch_sid_from_gid_cache(979)
  fetch sid from gid cache 2512 -> 
S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-512
[2007/03/27 08:33:06, 3] passdb/lookup_sid.c:fetch_sid_from_gid_cache(979)
  fetch sid from gid cache 2607 -> 
S-1-5-21-XXXXXXXX-XXXXXXXXXXX-1073051190-6215
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] auth/auth.c:check_ntlm_password(270)
  check_ntlm_password: sam authentication for user [jim12] succeeded
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(99, 99) : sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/03/27 08:33:06, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (99, 99) - sec_ctx_stack_ndx = 0
[2007/03/27 08:33:06, 2] auth/auth.c:check_ntlm_password(309)
  check_ntlm_password:  authentication for user [jim12] -> [jim12] -> 
[jim12] succeeded
[2007/03/27 08:33:06, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 908
[2007/03/27 08:33:19, 3] smbd/process.c:process_smb(1110)
  Transaction 74 of length 104
[2007/03/27 08:33:19, 3] smbd/process.c:switch_message(914)
  switch message SMBntcreateX (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:19, 3] smbd/nttrans.c:nt_open_pipe(346)
  nt_open_pipe: Known pipe lsarpc opening.
[2007/03/27 08:33:19, 3] smbd/process.c:process_smb(1110)
  Transaction 75 of length 160
[2007/03/27 08:33:19, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:19, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=72 params=0 setup=2
[2007/03/27 08:33:19, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:19, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727e)
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe.c:api_pipe_bind_req(1534)
  api_pipe_bind_req: \PIPE\lsarpc -> \PIPE\lsass
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe.c:check_bind_req(985)
  check_bind_req for \PIPE\lsarpc
[2007/03/27 08:33:19, 3] smbd/process.c:process_smb(1110)
  Transaction 76 of length 180
[2007/03/27 08:33:19, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:19, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=92 params=0 setup=2
[2007/03/27 08:33:19, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:19, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727e)
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 70
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_OPENPOLICY2
[2007/03/27 08:33:19, 3] rpc_parse/parse_lsa.c:lsa_io_sec_qos(224)
  lsa_io_sec_qos: length c does not match size 8
[2007/03/27 08:33:19, 3] lib/util_seaccess.c:se_access_check(250)
[2007/03/27 08:33:19, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-XXXXXXX-XXXXXXXX-1073051190-501
  se_access_check: also S-1-5-21-XXXXXXX-XXXXXXXX-1073051190-513
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-32-546
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 824
[2007/03/27 08:33:19, 3] smbd/process.c:process_smb(1110)
  Transaction 77 of length 140
[2007/03/27 08:33:19, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:19, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\> data=52 params=0 setup=2
[2007/03/27 08:33:19, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <> name
[2007/03/27 08:33:19, 3] smbd/ipc.c:api_fd_reply(300)
  Got API command 0x26 on pipe "lsarpc" (pnum 727e)
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 0
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe.c:api_rpcTNP(2265)
  api_rpcTNP: rpc command: LSA_ENUMTRUSTDOM
[2007/03/27 08:33:19, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(529)
  free_pipe_context: destroying talloc pool of size 24
[2007/03/27 08:33:19, 3] smbd/process.c:process_smb(1110)
  Transaction 78 of length 51
[2007/03/27 08:33:19, 3] smbd/process.c:switch_message(914)
  switch message SMBclose (pid 1446) conn 0x9ce8cc0
[2007/03/27 08:33:19, 3] rpc_server/srv_lsa_hnd.c:close_policy_hnd(200)
  Closed policy
                                                                                                                    




More information about the samba mailing list