Andy Liebman
2013-Oct-25 22:36 UTC
[Samba] Mounting Linux Samba Shares on Windows when Active Directory Server is down
Hi, I am running Samba 3.6.19 and making my way through all the Active Directory documentation. I have joined various Linux boxes to a Windows Server 2008 R2 Active Directory domain. Windows 7 users who log on with their domain accounts can mount the correct shares exported by the Linux boxes without having to supply any additional credentials. All working perfectly! However, I have a question about whether there is anything I can do to allow Windows users to mount those same Linux shares if the Active Directory server is down/unreachable. I am able to log onto Windows 7 with domain accounts even when the Active Directory server is down (at least for some amount of time -- as long as the cached credentials are good). However, if I try browse the Linux box to mount shares, I get a popup dialog from Windows telling me, in essence, the Active Directory server is unreachable and there is no way to authenticate me. Is there any way for Windows and Linux to do a "caching dance" so that Windows users are able to mount the Linux shares at least for some amount of time via cached credentials if the Active Directory server is down? Setting the smb.conf option "winbind offline logon = true" doesn't seem to help here. Is this possible with Samba 3.6.x? Looking forward to some helpful replies! Thanks in advance. Andy Liebman
Jeremy Allison
2013-Oct-25 22:59 UTC
[Samba] Mounting Linux Samba Shares on Windows when Active Directory Server is down
On Fri, Oct 25, 2013 at 06:36:47PM -0400, Andy Liebman wrote:> Hi, > > I am running Samba 3.6.19 and making my way through all the Active > Directory documentation. I have joined various Linux boxes to a > Windows Server 2008 R2 Active Directory domain. Windows 7 users who > log on with their domain accounts can mount the correct shares > exported by the Linux boxes without having to supply any additional > credentials. All working perfectly! > > However, I have a question about whether there is anything I can do > to allow Windows users to mount those same Linux shares if the > Active Directory server is down/unreachable. I am able to log onto > Windows 7 with domain accounts even when the Active Directory server > is down (at least for some amount of time -- as long as the cached > credentials are good). However, if I try browse the Linux box to > mount shares, I get a popup dialog from Windows telling me, in > essence, the Active Directory server is unreachable and there is no > way to authenticate me. > > Is there any way for Windows and Linux to do a "caching dance" so > that Windows users are able to mount the Linux shares at least for > some amount of time via cached credentials if the Active Directory > server is down? Setting the smb.conf option "winbind offline logon > = true" doesn't seem to help here. > > Is this possible with Samba 3.6.x?Whilst you have a valid kerberos ticket we should still authenticate you against a member server. What do your smbd logs say when the client is trying to attach to the Samba share ? Jeremy.
Andy Liebman
2013-Oct-26 15:38 UTC
[Samba] Mounting Linux Samba Shares on Windows when Active Directory Server is down
Hi Jeremy! Long time since we last spoke. Thanks for replying to this question. Please see below.>> Is there any way for Windows and Linux to do a "caching dance" so >> that Windows users are able to mount the Linux shares at least for >> some amount of time via cached credentials if the Active Directory >> server is down? Setting the smb.conf option "winbind offline logon >> = true" doesn't seem to help here. >> > >Whilst you have a valid kerberos ticket we should still >authenticate you against a member server. >What do your smbd logs say when the client is trying to >attach to the Samba share ? > >Jeremy.I just ran another test here. With the AD server accessible, the user "andyl" logged into the Linux (Ubuntu) server at 11:08 and successfully browsed and connected to some Linux shares. Then I disconnected the AD server. At 11:12, you can see in the Linux logs that an attempt was made by andyl to connect. I think the relevant lines are: [2013/10/26 11:12:29.712417, 2] auth/auth.c:319(check_ntlm_password) check_ntlm_password: Authentication for user [andyl] -> [andyl] FAILED with error NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:29.712475, 3] smbd/error.c:81(error_packet_set) error packet at smbd/sesssetup.c(124) cmd=115 (SMBsesssetupX) NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:42.348928, 1] smbd/process.c:457(receive_smb_talloc) receive_smb_raw_talloc failed for client 172.16.3.129 read error = NT_STATUS_CONNECTION_RESET. The entire logs are below (not too long I hope) -- Andy log.win-vnekof9be96 [2013/10/26 11:08:06.030737, 3] smbd/process.c:1467(switch_message) switch message SMBtconX (pid 2305) conn 0x0 [2013/10/26 11:08:06.030836, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:06.030878, 4] smbd/reply.c:794(reply_tcon_and_X) Client requested device type [?????] for share [SMB FILE EXCHANGE] [2013/10/26 11:08:06.030918, 3] lib/access.c:338(allow_access) Allowed connection from 172.16.3.129 (172.16.3.129) [2013/10/26 11:08:06.030964, 4] smbd/sec_ctx.c:214(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/10/26 11:08:06.030990, 4] smbd/uid.c:460(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/10/26 11:08:06.031013, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/10/26 11:08:06.031065, 4] smbd/sec_ctx.c:422(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:06.031463, 3] smbd/service.c:581(find_forced_group) Forced group editors [2013/10/26 11:08:06.031496, 3] smbd/service.c:837(make_connection_snum) Connect path is '/home/editshare/FileExchange/SMB' for service [SMB File Exchange] [2013/10/26 11:08:06.031534, 3] smbd/vfs.c:102(vfs_init_default) Initialising default vfs hooks [2013/10/26 11:08:06.031557, 3] smbd/vfs.c:128(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2013/10/26 11:08:06.031623, 3] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID @editors is not in a valid format [2013/10/26 11:08:06.031735, 4] smbd/sec_ctx.c:214(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/10/26 11:08:06.031763, 4] smbd/uid.c:460(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/10/26 11:08:06.031786, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/10/26 11:08:06.031829, 4] smbd/sec_ctx.c:422(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:06.032091, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (16777227, 500) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:06.032129, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:06.032170, 1] smbd/service.c:1081(make_connection_snum) win-vnekof9be96 (172.16.3.129) connect to service SMB File Exchange initially as user MYDOMAIN\andyl (uid=16777227, gid=500) (pid 2305) [2013/10/26 11:08:06.032219, 3] smbd/reply.c:871(reply_tcon_and_X) tconX service=SMB FILE EXCHANGE [2013/10/26 11:08:08.017632, 3] smbd/process.c:1662(process_smb) Transaction 26 of length 80 (0 toread) [2013/10/26 11:08:08.017721, 3] smbd/process.c:1467(switch_message) switch message SMBtrans2 (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.017754, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (16777227, 1007) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:08.017807, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:08.017857, 3] smbd/trans2.c:5117(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004 [2013/10/26 11:08:08.017920, 3] smbd/vfs.c:905(check_reduced_name) check_reduced_name [.] [/RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content] [2013/10/26 11:08:08.017947, 3] smbd/vfs.c:1039(check_reduced_name) check_reduced_name: . reduced to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:08.017992, 3] smbd/trans2.c:5261(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=1004 call=5 total_data=0 [2013/10/26 11:08:08.047746, 3] smbd/process.c:1662(process_smb) Transaction 27 of length 80 (0 toread) [2013/10/26 11:08:08.047844, 3] smbd/process.c:1467(switch_message) switch message SMBtrans2 (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.047869, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.047895, 3] smbd/trans2.c:5117(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1005 [2013/10/26 11:08:08.047929, 3] smbd/vfs.c:905(check_reduced_name) check_reduced_name [.] [/RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content] [2013/10/26 11:08:08.047964, 3] smbd/vfs.c:1039(check_reduced_name) check_reduced_name: . reduced to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:08.048021, 3] smbd/trans2.c:5261(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=1005 call=5 total_data=0 [2013/10/26 11:08:08.197438, 3] smbd/process.c:1662(process_smb) Transaction 28 of length 90 (0 toread) [2013/10/26 11:08:08.197529, 3] smbd/process.c:1467(switch_message) switch message SMBntcreateX (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.197571, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.197610, 3] smbd/vfs.c:905(check_reduced_name) check_reduced_name [.] [/RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content] [2013/10/26 11:08:08.197638, 3] smbd/vfs.c:1039(check_reduced_name) check_reduced_name: . reduced to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:08.198014, 4] smbd/sec_ctx.c:214(push_sec_ctx) push_sec_ctx(16777227, 1007) : sec_ctx_stack_ndx = 1 [2013/10/26 11:08:08.198049, 4] smbd/uid.c:460(push_conn_ctx) push_conn_ctx(100) : conn_ctx_stack_ndx = 0 [2013/10/26 11:08:08.198073, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/10/26 11:08:08.198151, 4] smbd/sec_ctx.c:214(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/10/26 11:08:08.198176, 4] smbd/uid.c:460(push_conn_ctx) push_conn_ctx(100) : conn_ctx_stack_ndx = 1 [2013/10/26 11:08:08.198199, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/10/26 11:08:08.198233, 4] smbd/sec_ctx.c:422(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/10/26 11:08:08.198262, 4] smbd/sec_ctx.c:422(pop_sec_ctx) pop_sec_ctx (16777227, 1007) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:08.199296, 3] smbd/process.c:1662(process_smb) Transaction 29 of length 76 (0 toread) [2013/10/26 11:08:08.199344, 3] smbd/process.c:1467(switch_message) switch message SMBtrans2 (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.199365, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.199388, 3] smbd/trans2.c:5032(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1006 [2013/10/26 11:08:08.199416, 3] smbd/trans2.c:5261(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = 25559) level=1006 call=7 total_data=0 [2013/10/26 11:08:08.199876, 3] smbd/process.c:1662(process_smb) Transaction 30 of length 88 (0 toread) [2013/10/26 11:08:08.199913, 3] smbd/process.c:1467(switch_message) switch message SMBnttrans (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.199935, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.199959, 3] smbd/nttrans.c:1703(call_nt_transact_notify_change) call_nt_transact_notify_change [2013/10/26 11:08:08.199985, 3] smbd/nttrans.c:1720(call_nt_transact_notify_change) call_nt_transact_notify_change: notify change called on ., filter = FILE_NAME|DIR_NAME|ATTRIBUTES|LAST_WRITE, recursive = 0 [2013/10/26 11:08:08.200751, 3] smbd/process.c:1662(process_smb) Transaction 31 of length 114 (0 toread) [2013/10/26 11:08:08.200799, 3] smbd/process.c:1467(switch_message) switch message SMBntcreateX (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.200822, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.200884, 3] smbd/vfs.c:905(check_reduced_name) check_reduced_name [desktop.ini] [/RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content] [2013/10/26 11:08:08.200922, 3] smbd/vfs.c:1039(check_reduced_name) check_reduced_name: desktop.ini reduced to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content/desktop.ini [2013/10/26 11:08:08.200950, 3] smbd/dosmode.c:159(unix_mode) unix_mode(desktop.ini) returning 02664 [2013/10/26 11:08:08.200982, 3] smbd/error.c:81(error_packet_set) error packet at smbd/error.c(161) cmd=162 (SMBntcreateX) NT_STATUS_OBJECT_NAME_NOT_FOUND [2013/10/26 11:08:08.201449, 3] smbd/process.c:1662(process_smb) Transaction 32 of length 90 (0 toread) [2013/10/26 11:08:08.201497, 3] smbd/process.c:1467(switch_message) switch message SMBntcreateX (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.201521, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.201560, 3] smbd/vfs.c:905(check_reduced_name) check_reduced_name [.] [/RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content] [2013/10/26 11:08:08.201597, 3] smbd/vfs.c:1039(check_reduced_name) check_reduced_name: . reduced to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:08.201626, 3] smbd/dosmode.c:159(unix_mode) unix_mode(.) returning 02664 [2013/10/26 11:08:08.201669, 4] smbd/open.c:2069(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x0 mode=02664, access_mask = 0x81, open_access_mask = 0x81 [2013/10/26 11:08:08.202306, 3] smbd/process.c:1662(process_smb) Transaction 33 of length 76 (0 toread) [2013/10/26 11:08:08.202345, 3] smbd/process.c:1467(switch_message) switch message SMBtrans2 (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.202367, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.202388, 3] smbd/trans2.c:5032(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1005 [2013/10/26 11:08:08.202416, 3] smbd/trans2.c:5261(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = 25562) level=1005 call=7 total_data=0 [2013/10/26 11:08:08.203304, 3] smbd/process.c:1662(process_smb) Transaction 34 of length 90 (0 toread) [2013/10/26 11:08:08.203343, 3] smbd/process.c:1467(switch_message) switch message SMBtrans2 (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.203365, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.203388, 3] smbd/trans2.c:2292(call_trans2findfirst) call_trans2findfirst: dirtype = 16, maxentries = 1366, close_after_first=0, close_if_end = 1 requires_resume_key = 1 level = 0x104, max_data_bytes = 16384 [2013/10/26 11:08:08.203418, 3] smbd/vfs.c:905(check_reduced_name) check_reduced_name [*] [/RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content] [2013/10/26 11:08:08.203450, 3] smbd/vfs.c:1039(check_reduced_name) check_reduced_name: * reduced to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content/* [2013/10/26 11:08:08.203474, 3] smbd/vfs.c:905(check_reduced_name) check_reduced_name [.] [/RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content] [2013/10/26 11:08:08.203497, 3] smbd/vfs.c:1039(check_reduced_name) check_reduced_name: . reduced to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:08.203524, 3] smbd/dir.c:578(dptr_create) creating new dirptr 256 for path ., expect_close = 1 [2013/10/26 11:08:08.203545, 4] smbd/trans2.c:2445(call_trans2findfirst) dptr_num is 256, wcard = *, attr = 22 [2013/10/26 11:08:08.203584, 3] smbd/dir.c:1041(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./. fname=. (.) [2013/10/26 11:08:08.203623, 3] smbd/dir.c:1041(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./.. fname=.. (..) [2013/10/26 11:08:08.203676, 3] smbd/dir.c:1041(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./helloworld_renamed.rtf fname=helloworld_renamed.rtf (helloworld_renamed.rtf) [2013/10/26 11:08:08.203725, 3] smbd/dir.c:1041(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./andymade.txt fname=andymade.txt (andymade.txt) [2013/10/26 11:08:08.203755, 4] smbd/dir.c:257(dptr_close_internal) closing dptr key 256 [2013/10/26 11:08:08.203820, 4] smbd/trans2.c:2555(call_trans2findfirst) SMBtrans2 mask=* directory=. dirtype=22 numentries=4 [2013/10/26 11:08:08.205971, 3] smbd/process.c:1662(process_smb) Transaction 35 of length 45 (0 toread) [2013/10/26 11:08:08.206022, 3] smbd/process.c:1467(switch_message) switch message SMBclose (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:08.206046, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.206075, 3] smbd/reply.c:4836(reply_close) close directory fnum=25562 [2013/10/26 11:08:08.277431, 3] smbd/process.c:1662(process_smb) Transaction 36 of length 76 (0 toread) [2013/10/26 11:08:08.277526, 3] smbd/process.c:1467(switch_message) switch message SMBtrans2 (pid 2305) conn 0x7fe5b7d7d880 [2013/10/26 11:08:08.277566, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (16777227, 16777222) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:08.277615, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /tmp [2013/10/26 11:08:08.277647, 3] smbd/error.c:81(error_packet_set) error packet at smbd/trans2.c(4149) cmd=50 (SMBtrans2) NT_STATUS_INVALID_HANDLE [2013/10/26 11:08:08.278352, 3] smbd/process.c:1662(process_smb) Transaction 37 of length 76 (0 toread) [2013/10/26 11:08:08.278393, 3] smbd/process.c:1467(switch_message) switch message SMBtrans2 (pid 2305) conn 0x7fe5b7d7d880 [2013/10/26 11:08:08.278416, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.278439, 3] smbd/error.c:81(error_packet_set) error packet at smbd/trans2.c(4149) cmd=50 (SMBtrans2) NT_STATUS_INVALID_HANDLE [2013/10/26 11:08:08.279284, 3] smbd/process.c:1662(process_smb) Transaction 38 of length 104 (0 toread) [2013/10/26 11:08:08.279325, 3] smbd/process.c:1467(switch_message) switch message SMBtrans (pid 2305) conn 0x7fe5b7d7d880 [2013/10/26 11:08:08.279348, 4] smbd/uid.c:351(change_to_user) Skipping user change - already user [2013/10/26 11:08:08.279375, 3] smbd/ipc.c:560(handle_trans) trans <\PIPE\MsFteWds> data=0 params=0 setup=2 [2013/10/26 11:08:08.279399, 3] smbd/ipc.c:511(named_pipe) named pipe command on <MsFteWds> name [2013/10/26 11:08:08.279420, 3] smbd/ipc.c:546(named_pipe) unknown named pipe: setup 0x53 setup1=0 [2013/10/26 11:08:08.279440, 3] smbd/error.c:81(error_packet_set) error packet at smbd/ipc.c(548) cmd=37 (SMBtrans) NT_STATUS_NOT_SUPPORTED [2013/10/26 11:08:10.456788, 3] smbd/process.c:1662(process_smb) Transaction 39 of length 40 (0 toread) [2013/10/26 11:08:10.456898, 3] smbd/process.c:1467(switch_message) switch message SMBntcancel (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:10.456939, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:10.457022, 3] smbd/error.c:81(error_packet_set) error packet at smbd/nttrans.c(83) cmd=160 (SMBnttrans) NT_STATUS_CANCELLED [2013/10/26 11:08:10.457129, 3] smbd/nttrans.c:1336(reply_ntcancel) reply_ntcancel: cancel called on mid = 1922. [2013/10/26 11:08:10.458081, 3] smbd/process.c:1662(process_smb) Transaction 40 of length 45 (0 toread) [2013/10/26 11:08:10.458135, 3] smbd/process.c:1467(switch_message) switch message SMBclose (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:10.458184, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (16777227, 1007) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:10.458236, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:10.458292, 3] smbd/reply.c:4836(reply_close) close directory fnum=25559 [2013/10/26 11:08:18.357012, 3] smbd/process.c:1662(process_smb) Transaction 41 of length 39 (0 toread) [2013/10/26 11:08:18.357278, 3] smbd/process.c:1467(switch_message) switch message SMBtdis (pid 2305) conn 0x7fe5b7d8e630 [2013/10/26 11:08:18.357375, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.357495, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /home/andyl/Projects [2013/10/26 11:08:18.357677, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.357789, 1] smbd/service.c:1345(close_cnum) win-vnekof9be96 (172.16.3.129) closed connection to service andyl's Private Files [2013/10/26 11:08:18.357898, 3] smbd/connection.c:35(yield_connection) Yielding connection to andyl's Private Files [2013/10/26 11:08:18.358042, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to / [2013/10/26 11:08:18.358144, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.359091, 3] smbd/process.c:1662(process_smb) Transaction 42 of length 39 (0 toread) [2013/10/26 11:08:18.359249, 3] smbd/process.c:1467(switch_message) switch message SMBtdis (pid 2305) conn 0x7fe5b7d87920 [2013/10/26 11:08:18.359342, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.359443, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /RAIDS/RAID_1/AvidStyle/AvidTest_1/Content [2013/10/26 11:08:18.359547, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.359713, 1] smbd/service.c:1345(close_cnum) win-vnekof9be96 (172.16.3.129) closed connection to service AvidTest_1 [2013/10/26 11:08:18.359820, 3] smbd/connection.c:35(yield_connection) Yielding connection to AvidTest_1 [2013/10/26 11:08:18.359948, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to / [2013/10/26 11:08:18.360050, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.360908, 3] smbd/process.c:1662(process_smb) Transaction 43 of length 39 (0 toread) [2013/10/26 11:08:18.361068, 3] smbd/process.c:1467(switch_message) switch message SMBtdis (pid 2305) conn 0x7fe5b7d91d20 [2013/10/26 11:08:18.361162, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.361263, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /home/editshare/FileExchange/SMB [2013/10/26 11:08:18.361365, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.361459, 1] smbd/service.c:1345(close_cnum) win-vnekof9be96 (172.16.3.129) closed connection to service SMB File Exchange [2013/10/26 11:08:18.361560, 3] smbd/connection.c:35(yield_connection) Yielding connection to SMB File Exchange [2013/10/26 11:08:18.361755, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to / [2013/10/26 11:08:18.361860, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.362719, 3] smbd/process.c:1662(process_smb) Transaction 44 of length 39 (0 toread) [2013/10/26 11:08:18.362879, 3] smbd/process.c:1467(switch_message) switch message SMBtdis (pid 2305) conn 0x7fe5b7d7d880 [2013/10/26 11:08:18.362972, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.363074, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /tmp [2013/10/26 11:08:18.363170, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:18.363267, 3] smbd/service.c:1345(close_cnum) win-vnekof9be96 (172.16.3.129) closed connection to service IPC$ [2013/10/26 11:08:18.363367, 3] smbd/connection.c:35(yield_connection) Yielding connection to IPC$ [2013/10/26 11:08:18.363494, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to / [2013/10/26 11:08:18.363694, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:24.346740, 3] smbd/process.c:1662(process_smb) Transaction 45 of length 39 (0 toread) [2013/10/26 11:08:24.346831, 3] smbd/process.c:1467(switch_message) switch message SMBtdis (pid 2305) conn 0x7fe5b7d8f670 [2013/10/26 11:08:24.346863, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:24.346903, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content [2013/10/26 11:08:24.346937, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:24.346960, 1] smbd/service.c:1345(close_cnum) win-vnekof9be96 (172.16.3.129) closed connection to service JustinDemo_1 [2013/10/26 11:08:24.346988, 3] smbd/connection.c:35(yield_connection) Yielding connection to JustinDemo_1 [2013/10/26 11:08:24.347031, 4] smbd/vfs.c:780(vfs_ChDir) vfs_ChDir to / [2013/10/26 11:08:24.347056, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:24.347518, 3] smbd/process.c:1662(process_smb) Transaction 46 of length 43 (0 toread) [2013/10/26 11:08:24.347552, 3] smbd/process.c:1467(switch_message) switch message SMBulogoffX (pid 2305) conn 0x0 [2013/10/26 11:08:24.347617, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:24.347726, 3] smbd/reply.c:2096(reply_ulogoffX) ulogoffX vuid=100 [2013/10/26 11:08:54.342137, 1] smbd/process.c:457(receive_smb_talloc) receive_smb_raw_talloc failed for client 172.16.3.129 read error = NT_STATUS_CONNECTION_RESET. [2013/10/26 11:08:54.342418, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:54.342759, 3] smbd/server_exit.c:180(exit_server_common) Server exit (failed to receive smb request) [2013/10/26 11:12:29.677877, 3] param/loadparm.c:9572(lp_load_ex) lp_load_ex: refreshing parameters [2013/10/26 11:12:29.677942, 3] param/loadparm.c:5192(init_globals) Initialising global parameters [2013/10/26 11:12:29.678039, 3] ../lib/util/params.c:550(pm_process) params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf" [2013/10/26 11:12:29.678070, 3] param/loadparm.c:8310(do_section) Processing section "[global]" doing parameter dns proxy = No doing parameter load printers = no doing parameter log file = /var/log/samba/log.%m doing parameter map to guest = Bad User doing parameter log level = 4 doing parameter max log size = 50 doing parameter netbios name = es-master [2013/10/26 11:12:29.678583, 4] param/loadparm.c:7561(handle_netbios_name) handle_netbios_name: set global_myname to: ES-MASTER doing parameter os level = 65 doing parameter printcap name = /etc/printcap doing parameter printing = bsd doing parameter server string = es-master doing parameter unix extensions = No doing parameter use sendfile = yes doing parameter wins support = Yes doing parameter workgroup = MYDOMAIN doing parameter realm = MYDOMAIN.ES1 doing parameter security = ads doing parameter idmap uid = 16777216-33554431 [2013/10/26 11:12:29.679147, 1] param/loadparm.c:7992(lp_do_parameter) WARNING: The "idmap uid" option is deprecated doing parameter idmap gid = 16777216-33554431 [2013/10/26 11:12:29.679197, 1] param/loadparm.c:7992(lp_do_parameter) WARNING: The "idmap gid" option is deprecated doing parameter template shell = /sbin/nologin doing parameter winbind use default domain = true doing parameter winbind offline logon = true doing parameter winbind enum users = yes doing parameter winbind enum groups = yes doing parameter client ntlmv2 auth = yes doing parameter client use spnego principal = no doing parameter max open files = 32768 doing parameter include = /etc/samba/smb_era.conf [2013/10/26 11:12:29.679975, 3] ../lib/util/params.c:550(pm_process) params.c:pm_process() - Processing configuration file "/etc/samba/smb_era.conf" [2013/10/26 11:12:29.680099, 3] param/loadparm.c:8310(do_section) Processing section "[global]" doing parameter netbios name = es-vmware [2013/10/26 11:12:29.680305, 4] param/loadparm.c:7561(handle_netbios_name) handle_netbios_name: set global_myname to: ES-VMWARE doing parameter server string = es-vmware doing parameter os level = 65 doing parameter include = /etc/samba/smb_custom.conf [2013/10/26 11:12:29.680375, 2] param/loadparm.c:7690(handle_include) Can't find include file /etc/samba/smb_custom.conf doing parameter include = /etc/samba/smb.%U.conf [2013/10/26 11:12:29.680426, 3] ../lib/util/params.c:550(pm_process) params.c:pm_process() - Processing configuration file "/etc/samba/smb.andyl.conf" [2013/10/26 11:12:29.680452, 2] param/loadparm.c:8327(do_section) Processing section "[andyl's Private Files]" doing parameter comment = Private project metadata only. No media here! doing parameter create mask = 0770 doing parameter directory mask = 0770 doing parameter force create mode = 2040 doing parameter force directory mode = 2060 doing parameter force group = editors doing parameter force user = andyl doing parameter guest ok = No doing parameter path = /home/andyl/Projects doing parameter read only = No doing parameter veto files = /*OMFI MediaFiles*/*Avid MediaFiles*/*Capture Scratch*/*Audio Capture Scratch*/*.omf/*.mxf/*.wav/*.avi/*.mpg/*.mov/*.aif*/*.mp3/*Render Files*/ [2013/10/26 11:12:29.680958, 2] param/loadparm.c:8327(do_section) Processing section "[AvidTest_1]" doing parameter comment = Shared Media Files doing parameter create mask = 2664 doing parameter directory mask = 2775 doing parameter force create mode = 2040 doing parameter force directory mode = 2060 doing parameter force group = avidtest doing parameter force user = andyl doing parameter guest ok = No doing parameter nt acl support = no doing parameter path = /RAIDS/RAID_1/AvidStyle/AvidTest_1/Content doing parameter read only = No [2013/10/26 11:12:29.681168, 2] param/loadparm.c:8327(do_section) Processing section "[JustinDemo_1]" doing parameter comment = Shared Media Files doing parameter create mask = 2664 doing parameter directory mask = 2775 doing parameter force create mode = 2040 doing parameter force directory mode = 2060 doing parameter force group = justindemo doing parameter force user = andyl doing parameter guest ok = No doing parameter nt acl support = no doing parameter path = /RAIDS/RAID_1/AvidStyle/JustinDemo_1/Content doing parameter read only = No [2013/10/26 11:12:29.681342, 2] param/loadparm.c:8327(do_section) Processing section "[SMB File Exchange]" doing parameter comment = Do Not Put Media Files Here doing parameter create mask = 0775 doing parameter directory mask = 0775 doing parameter guest ok = No doing parameter path = "/home/editshare/FileExchange/SMB" doing parameter read only = No doing parameter veto files = /*OMFI MediaFiles*/*Avid MediaFiles*/*Capture Scratch*/*Render Files*/ doing parameter write list = @editors doing parameter force group = editors [2013/10/26 11:12:29.681493, 2] param/loadparm.c:8327(do_section) Processing section "[es_objects$]" doing parameter force group = editshare doing parameter force user = editshare doing parameter path = "/tmp/.editshare/objects" doing parameter read only = Yes doing parameter write ok = No [2013/10/26 11:12:29.681589, 4] param/loadparm.c:9608(lp_load_ex) pm_process() returned Yes [2013/10/26 11:12:29.681639, 3] param/loadparm.c:6630(lp_add_ipc) adding IPC service [2013/10/26 11:12:29.681829, 2] lib/interface.c:341(add_interface) added interface eth0 ip=fe80::20c:29ff:fec7:bfdd%eth0 bcast=fe80::ffff:ffff:ffff:ffff%eth0 netmask=ffff:ffff:ffff:ffff:: [2013/10/26 11:12:29.681881, 2] lib/interface.c:341(add_interface) added interface eth0 ip=172.16.3.10 bcast=172.16.3.255 netmask=255.255.255.0 [2013/10/26 11:12:29.682196, 3] auth/auth.c:219(check_ntlm_password) check_ntlm_password: Checking password for unmapped user [MYDOMAIN]\[andyl]@[WIN-VNEKOF9BE96] with the new password interface [2013/10/26 11:12:29.682229, 3] auth/auth.c:222(check_ntlm_password) check_ntlm_password: mapped user is: [MYDOMAIN]\[andyl]@[WIN-VNEKOF9BE96] [2013/10/26 11:12:29.682258, 4] smbd/sec_ctx.c:214(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/10/26 11:12:29.682285, 4] smbd/uid.c:460(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/10/26 11:12:29.682312, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/10/26 11:12:29.682468, 4] smbd/sec_ctx.c:422(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.682498, 2] auth/auth.c:319(check_ntlm_password) check_ntlm_password: Authentication for user [andyl] -> [andyl] FAILED with error NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:29.682530, 3] smbd/error.c:81(error_packet_set) error packet at smbd/sesssetup.c(124) cmd=115 (SMBsesssetupX) NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:29.698572, 3] smbd/process.c:1662(process_smb) Transaction 3 of length 142 (0 toread) [2013/10/26 11:12:29.698689, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2341) conn 0x0 [2013/10/26 11:12:29.698740, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.698822, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:12:29.698871, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:12:29.698948, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:12:29.699007, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:12:29.699070, 3] smbd/sesssetup.c:660(reply_spnego_negotiate) reply_spnego_negotiate: Got secblob of size 40 [2013/10/26 11:12:29.699138, 3] ../libcli/auth/ntlmssp.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/10/26 11:12:29.700729, 3] smbd/process.c:1662(process_smb) Transaction 4 of length 496 (0 toread) [2013/10/26 11:12:29.700792, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2341) conn 0x0 [2013/10/26 11:12:29.700843, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.700899, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:12:29.700979, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:12:29.701031, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:12:29.701079, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:12:29.701145, 3] ../libcli/auth/ntlmssp_server.c:348(ntlmssp_server_preauth) Got user=[andyl] domain=[MYDOMAIN] workstation=[WIN-VNEKOF9BE96] len1=24 len2=228 [2013/10/26 11:12:29.701344, 3] auth/auth.c:219(check_ntlm_password) check_ntlm_password: Checking password for unmapped user [MYDOMAIN]\[andyl]@[WIN-VNEKOF9BE96] with the new password interface [2013/10/26 11:12:29.701394, 3] auth/auth.c:222(check_ntlm_password) check_ntlm_password: mapped user is: [MYDOMAIN]\[andyl]@[WIN-VNEKOF9BE96] [2013/10/26 11:12:29.701444, 4] smbd/sec_ctx.c:214(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/10/26 11:12:29.701485, 4] smbd/uid.c:460(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/10/26 11:12:29.701525, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/10/26 11:12:29.701721, 4] smbd/sec_ctx.c:422(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.701767, 2] auth/auth.c:319(check_ntlm_password) check_ntlm_password: Authentication for user [andyl] -> [andyl] FAILED with error NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:29.701815, 3] smbd/error.c:81(error_packet_set) error packet at smbd/sesssetup.c(124) cmd=115 (SMBsesssetupX) NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:29.709336, 3] smbd/process.c:1662(process_smb) Transaction 5 of length 142 (0 toread) [2013/10/26 11:12:29.709445, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2341) conn 0x0 [2013/10/26 11:12:29.709498, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.709559, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:12:29.709621, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:12:29.709671, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:12:29.709722, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:12:29.709791, 3] smbd/sesssetup.c:660(reply_spnego_negotiate) reply_spnego_negotiate: Got secblob of size 40 [2013/10/26 11:12:29.709865, 3] ../libcli/auth/ntlmssp.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/10/26 11:12:29.711324, 3] smbd/process.c:1662(process_smb) Transaction 6 of length 496 (0 toread) [2013/10/26 11:12:29.711383, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2341) conn 0x0 [2013/10/26 11:12:29.711434, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.711487, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:12:29.711535, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:12:29.711583, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:12:29.711631, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:12:29.711690, 3] ../libcli/auth/ntlmssp_server.c:348(ntlmssp_server_preauth) Got user=[andyl] domain=[MYDOMAIN] workstation=[WIN-VNEKOF9BE96] len1=24 len2=228 [2013/10/26 11:12:29.711901, 3] auth/auth.c:219(check_ntlm_password) check_ntlm_password: Checking password for unmapped user [MYDOMAIN]\[andyl]@[WIN-VNEKOF9BE96] with the new password interface [2013/10/26 11:12:29.711988, 3] auth/auth.c:222(check_ntlm_password) check_ntlm_password: mapped user is: [MYDOMAIN]\[andyl]@[WIN-VNEKOF9BE96] [2013/10/26 11:12:29.712045, 4] smbd/sec_ctx.c:214(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/10/26 11:12:29.712096, 4] smbd/uid.c:460(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/10/26 11:12:29.712144, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/10/26 11:12:29.712360, 4] smbd/sec_ctx.c:422(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.712417, 2] auth/auth.c:319(check_ntlm_password) check_ntlm_password: Authentication for user [andyl] -> [andyl] FAILED with error NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:29.712475, 3] smbd/error.c:81(error_packet_set) error packet at smbd/sesssetup.c(124) cmd=115 (SMBsesssetupX) NT_STATUS_NO_LOGON_SERVERS [2013/10/26 11:12:42.348928, 1] smbd/process.c:457(receive_smb_talloc) receive_smb_raw_talloc failed for client 172.16.3.129 read error = NT_STATUS_CONNECTION_RESET. [2013/10/26 11:12:42.349289, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:42.349572, 3] smbd/server_exit.c:180(exit_server_common) Server exit (failed to receive smb request) log.172.16.3.129 [2013/10/26 11:08:05.895054, 3] lib/access.c:338(allow_access) Allowed connection from 172.16.3.129 (172.16.3.129) [2013/10/26 11:08:05.895524, 3] smbd/oplock.c:922(init_oplocks) init_oplocks: initializing messages. [2013/10/26 11:08:05.895865, 3] smbd/oplock_linux.c:226(linux_init_kernel_oplocks) Linux kernel oplocks enabled [2013/10/26 11:08:05.896130, 3] smbd/process.c:1662(process_smb) Transaction 0 of length 159 (0 toread) [2013/10/26 11:08:05.896339, 3] smbd/process.c:1467(switch_message) switch message SMBnegprot (pid 2305) conn 0x0 [2013/10/26 11:08:05.896393, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:05.896636, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [PC NETWORK PROGRAM 1.0] [2013/10/26 11:08:05.896666, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [LANMAN1.0] [2013/10/26 11:08:05.896689, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [Windows for Workgroups 3.1a] [2013/10/26 11:08:05.896713, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [LM1.2X002] [2013/10/26 11:08:05.896735, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [LANMAN2.1] [2013/10/26 11:08:05.896757, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [NT LM 0.12] [2013/10/26 11:08:05.896790, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [SMB 2.002] [2013/10/26 11:08:05.896826, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [SMB 2.???] [2013/10/26 11:08:05.896910, 3] smbd/negprot.c:419(reply_nt1) using SPNEGO [2013/10/26 11:08:05.896935, 3] smbd/negprot.c:704(reply_negprot) Selected protocol NT LM 0.12 [2013/10/26 11:08:05.897600, 3] smbd/process.c:1662(process_smb) Transaction 1 of length 142 (0 toread) [2013/10/26 11:08:05.897723, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2305) conn 0x0 [2013/10/26 11:08:05.897757, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:05.897787, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:08:05.897812, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:08:05.897835, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:08:05.897859, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:08:05.897896, 3] smbd/sesssetup.c:660(reply_spnego_negotiate) reply_spnego_negotiate: Got secblob of size 40 [2013/10/26 11:08:05.898074, 3] ../libcli/auth/ntlmssp.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/10/26 11:08:05.898598, 3] smbd/process.c:1662(process_smb) Transaction 2 of length 496 (0 toread) [2013/10/26 11:08:05.898642, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2305) conn 0x0 [2013/10/26 11:08:05.898667, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:08:05.898694, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:08:05.898718, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:08:05.898741, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:08:05.898765, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:08:05.898800, 3] ../libcli/auth/ntlmssp_server.c:348(ntlmssp_server_preauth) Got user=[andyl] domain=[MYDOMAIN] workstation=[WIN-VNEKOF9BE96] len1=24 len2=228 [2013/10/26 11:12:29.669487, 3] lib/access.c:338(allow_access) Allowed connection from 172.16.3.129 (172.16.3.129) [2013/10/26 11:12:29.670863, 3] smbd/oplock.c:922(init_oplocks) init_oplocks: initializing messages. [2013/10/26 11:12:29.671658, 3] smbd/oplock_linux.c:226(linux_init_kernel_oplocks) Linux kernel oplocks enabled [2013/10/26 11:12:29.672146, 3] smbd/process.c:1662(process_smb) Transaction 0 of length 159 (0 toread) [2013/10/26 11:12:29.672279, 3] smbd/process.c:1467(switch_message) switch message SMBnegprot (pid 2341) conn 0x0 [2013/10/26 11:12:29.672396, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.673297, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [PC NETWORK PROGRAM 1.0] [2013/10/26 11:12:29.673437, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [LANMAN1.0] [2013/10/26 11:12:29.673543, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [Windows for Workgroups 3.1a] [2013/10/26 11:12:29.673646, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [LM1.2X002] [2013/10/26 11:12:29.673746, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [LANMAN2.1] [2013/10/26 11:12:29.673847, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [NT LM 0.12] [2013/10/26 11:12:29.674029, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [SMB 2.002] [2013/10/26 11:12:29.674056, 3] smbd/negprot.c:598(reply_negprot) Requested protocol [SMB 2.???] [2013/10/26 11:12:29.674147, 3] smbd/negprot.c:419(reply_nt1) using SPNEGO [2013/10/26 11:12:29.674174, 3] smbd/negprot.c:704(reply_negprot) Selected protocol NT LM 0.12 [2013/10/26 11:12:29.675751, 3] smbd/process.c:1662(process_smb) Transaction 1 of length 142 (0 toread) [2013/10/26 11:12:29.675904, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2341) conn 0x0 [2013/10/26 11:12:29.675995, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.676030, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:12:29.676059, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:12:29.676082, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:12:29.676173, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:12:29.676230, 3] smbd/sesssetup.c:660(reply_spnego_negotiate) reply_spnego_negotiate: Got secblob of size 40 [2013/10/26 11:12:29.676585, 3] ../libcli/auth/ntlmssp.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/10/26 11:12:29.677310, 3] smbd/process.c:1662(process_smb) Transaction 2 of length 496 (0 toread) [2013/10/26 11:12:29.677352, 3] smbd/process.c:1467(switch_message) switch message SMBsesssetupX (pid 2341) conn 0x0 [2013/10/26 11:12:29.677416, 4] smbd/sec_ctx.c:314(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/10/26 11:12:29.677532, 3] smbd/sesssetup.c:1333(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/10/26 11:12:29.677632, 2] smbd/sesssetup.c:1279(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/10/26 11:12:29.677725, 3] smbd/sesssetup.c:1065(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/10/26 11:12:29.677750, 3] smbd/sesssetup.c:1107(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/10/26 11:12:29.677786, 3] ../libcli/auth/ntlmssp_server.c:348(ntlmssp_server_preauth) Got user=[andyl] domain=[MYDOMAIN] workstation=[WIN-VNEKOF9BE96] len1=24 len2=228
Apparently Analagous Threads
- NT_STATUS_ACCESS_DENIED Causes?
- unix fifo inaccessible via samba share
- with streams_xattr enabled, ads are written correctly but not retrieved
- smb mount as root, access as non-root. Changed behaviour between samba 3.0.x and 3.4.x?
- Unable to upload printer drivers