[Samba] change_to_user: Invalid vuid - sporadically access denied
Hillig Matthias
matthias.hillig at siemens.com
Thu Jan 29 13:23:25 GMT 2004
> Hi there,
>
> we're running into sporadic (!) problems when users access files read/write using rational clearcase.
> The production is running on unix and automatically starts several telnet sessions from unix to win2k
> (but only one at a time) that copy directory trees onto the samba share (sunos 5.8/samba 2.2.8a).
> After a while in various parts of the production we ran sporadically into the following problems > ...>
The error seems to be that a change_to_user operation does not work:
> smbd/uid.c:change_to_user(138)
> change_to_user: Invalid vuid used 100
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/error.c:error_packet(113)
> error packet at smbd/process.c(742) cmd=50 (SMBtrans2)
> NT_STATUS_NETWORK_ACCESS_DENIED
>
Also the following messages seem to deal with that problem:
> ulogoff, vuser id 101 does not map to user.
>
> This message is displayed sometimes with vuid 100 or 101
>
> Sometimes the production does not get any errors...
>
> We where running up to debug level 9 to track the problem....
> Any ideas? Any help would be greatly appreciated....Thanks!
>
>
> That is the error the user gets :
>
> Opening Telnet Connection to 139.21.158.110...
> Starting view, mounting vob, determining drive
> Using drive G:
> set OFFICIAL_PROD=Y
> Not checking whether other as VOBs are mounted
> Creating 1st NFS safeguard file ... dir /OD /B . | %SystemRoot%\system32\find.exe /v ".cmake.state" >.\.tcm_remNT_nfs1_6881
> Access Denied
> omake -f Makefile.nt -v AS_PLATFORM_ID=uw7 RepGenAPI.jar JCLEAN=Y -kW
> omake: Error: Error opening CR cache file .cmake.state - File exists
> No candidate in current view for "DummyStubClass"
> ======== Rebuilding "DummyStubClass" ========
> IF NOT EXIST classes\ReportService mkdir classes\ReportService
> copy Makefile.rm classes\ReportService\_ReportTemplateManagerStub.class
> Access Denied
> 0 Files copied.
>
>
> Samba Logfile:(loglevel 9)
>
>
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)]
> smbd/files.c:file_free(346)
> freed files structure 12268 (3 used)
> [2004/01/28 09:03:24, 2, effective(0, 0), real(0, 0)]
> smbd/close.c:close_normal_file(229)
> wa38039 closed file
> vobs/as/src_as2.vbs/c/cdft/22/c/6800c6dfe44811d79bbd00105af6d150 (numopen=2)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)]
> smbd/files.c:file_free(346)
> freed files structure 12171 (2 used)
> [2004/01/28 09:03:24, 2, effective(0, 0), real(0, 0)]
> smbd/close.c:close_normal_file(229)
> wa38039 closed file
> vobs/as/src_as_comp1.vbs/c/cdft/11/d/6fc1c01f53b211d7a891001083cf964f
> (numopen=1)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)]
> smbd/files.c:file_free(346)
> freed files structure 12170 (1 used)
> [2004/01/28 09:03:24, 2, effective(0, 0), real(0, 0)]
> smbd/close.c:close_normal_file(229)
> wa38039 closed file view_area/prod06_uw7.vws/.s/00042/80000e2040167345tmp07916
> (numopen=0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)]
> smbd/files.c:file_free(346)
> freed files structure 12169 (0 used)
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/reply.c:reply_ulogoffX(1812)
> ulogoffX vuid=100
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(275)
> size=39
> smb_com=0x74
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=136
> smb_flg2=1
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(281)
> smb_tid=0
> smb_pid=65279
> smb_uid=100
> smb_mid=13312
> smt_wct=2
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[0]=255 (0xFF)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[1]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(291)
> smb_bcc=0
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> lib/util_sock.c:write_socket(518)>
> write_socket(12,43)
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> lib/util_sock.c:write_socket(521)
> write_socket(12,43) wrote 43
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> smbd/process.c:process_smb(845)
> got message type 0x0 of len 0x48
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/process.c:process_smb(846)
> Transaction 2479 of length 76
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(275)
> size=72
> smb_com=0x32
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=24
> smb_flg2=18439
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(281)
> smb_tid=1
> smb_pid=1920
> smb_uid=100
> smb_mid=13377
> smt_wct=15
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[0]=4 (0x4)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[1]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[2]=2 (0x2)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[3]=64 (0x40)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[4]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[5]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[6]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[7]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[8]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[9]=4 (0x4)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[10]=68 (0x44)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[11]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[12]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[13]=1 (0x1)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[14]=7 (0x7)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(291)
> smb_bcc=7
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/process.c:switch_message(685)
> switch message SMBtrans2 (pid 7243)
> [2004/01/28 09:03:24, 2, effective(0, 0), real(0, 0)]
> smbd/uid.c:change_to_user(138)
> change_to_user: Invalid vuid used 100
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/error.c:error_packet(113)
> error packet at smbd/process.c(742) cmd=50 (SMBtrans2)
> NT_STATUS_NETWORK_ACCESS_DENIED
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(275)
> size=35
> smb_com=0x32
> smb_rcls=202
> smb_reh=0
> smb_err=49152
> smb_flg=136
> smb_flg2=16385
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(281)
> smb_tid=1
> smb_pid=1920
> smb_uid=100
> smb_mid=13377
> smt_wct=0
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(291)
> smb_bcc=0
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> lib/util_sock.c:write_socket(518)
> write_socket(12,39)
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> lib/util_sock.c:write_socket(521)
> write_socket(12,39) wrote 39
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> smbd/process.c:process_smb(845)
> got message type 0x0 of len 0x27
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/process.c:process_smb(846)
> Transaction 2480 of length 43
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(275)
> size=39
> smb_com=0x74
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=24
> smb_flg2=18439
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(281)
> smb_tid=0
> smb_pid=65279
> smb_uid=101
>
> smb_mid=13441
> smt_wct=2
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[0]=255 (0xFF)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[1]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(291)
> smb_bcc=0
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/process.c:switch_message(685)
> switch message SMBulogoffX (pid 7243)
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/sec_ctx.c:set_sec_ctx(329)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)]
> smbd/uid.c:change_to_root_user(217)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/reply.c:reply_ulogoffX(1799)
> ulogoff, vuser id 101 does not map to user.
> [2004/01/28 09:03:24, 3, effective(0, 0), real(0, 0)]
> smbd/reply.c:reply_ulogoffX(1812)
> ulogoffX vuid=101
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(275)
> size=39
> smb_com=0x74
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=136
> smb_flg2=1
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(281)
> smb_tid=0
> smb_pid=65279
> smb_uid=101
> smb_mid=13441
> smt_wct=2
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[0]=255 (0xFF)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(286)
> smb_vwv[1]=0 (0x0)
> [2004/01/28 09:03:24, 5, effective(0, 0), real(0, 0)] lib/util.c:show_msg(291)
> smb_bcc=0
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> lib/util_sock.c:write_socket(518)
> write_socket(12,43)
> [2004/01/28 09:03:24, 6, effective(0, 0), real(0, 0)]
> lib/util_sock.c:write_socket(521)
>
>
> Matthias Hillig
> SBS ORS GD AHS OS 62
> Computer & Network Services (CNS)
> *: <mailto:Matthias.Hillig at siemens.com>
> *: +49 89 722 31614
> 6: +49 89 722 47847
>
>
More information about the samba
mailing list