[2011/05/16 10:24:47.755838, 6] param/loadparm.c:7133(lp_file_list_changed) lp_file_list_changed() file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Mon May 16 10:21:46 2011 [2011/05/16 10:24:47.756805, 3] smbd/oplock.c:895(init_oplocks) init_oplocks: initializing messages. [2011/05/16 10:24:47.756832, 5] lib/messages.c:329(messaging_deregister) Deregistering messaging pointer for type 1 - private_data=(nil) [2011/05/16 10:24:47.756860, 10] smbd/process.c:740(event_add_idle) event_add_idle: idle_evt(keepalive) 0xb7784ef8 [2011/05/16 10:24:47.756882, 10] smbd/process.c:740(event_add_idle) event_add_idle: idle_evt(deadtime) 0xb7825698 [2011/05/16 10:24:47.756902, 10] smbd/process.c:740(event_add_idle) event_add_idle: idle_evt(housekeeping) 0xb780c978 [2011/05/16 10:24:50.955114, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 78 [2011/05/16 10:24:50.955167, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4e [2011/05/16 10:24:50.955186, 3] smbd/process.c:1489(process_smb) Transaction 0 of length 82 (0 toread) [2011/05/16 10:24:50.955204, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.955215, 5] lib/util.c:627(show_msg) size=78 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=0 smb_pid=1064 smb_uid=0 smb_mid=436 smt_wct=0 smb_bcc=43 [2011/05/16 10:24:50.955280, 10] ../lib/util/util.c:278(_dump_data) [0000] 02 4C 4D 31 2E 32 58 30 30 32 00 02 4C 41 4E 4D .LM1.2X0 02..LANM [0010] 41 4E 32 2E 31 00 02 4E 54 20 4C 4D 20 30 2E 31 AN2.1..N T LM 0.1 [0020] 32 00 02 50 4F 53 49 58 20 32 00 2..POSIX 2. [2011/05/16 10:24:50.955370, 3] smbd/process.c:1298(switch_message) switch message SMBnegprot (pid 9822) conn 0x0 [2011/05/16 10:24:50.955392, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.955411, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.955428, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.955460, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/05/16 10:24:50.955546, 3] smbd/negprot.c:586(reply_negprot) Requested protocol [LM1.2X002] [2011/05/16 10:24:50.955565, 3] smbd/negprot.c:586(reply_negprot) Requested protocol [LANMAN2.1] [2011/05/16 10:24:50.955581, 3] smbd/negprot.c:586(reply_negprot) Requested protocol [NT LM 0.12] [2011/05/16 10:24:50.955598, 3] smbd/negprot.c:586(reply_negprot) Requested protocol [POSIX 2] [2011/05/16 10:24:50.955617, 10] lib/util.c:1969(set_remote_arch) set_remote_arch: Client arch is 'CIFSFS' [2011/05/16 10:24:50.955652, 6] param/loadparm.c:7133(lp_file_list_changed) lp_file_list_changed() file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Mon May 16 10:21:46 2011 [2011/05/16 10:24:50.955689, 5] smbd/connection.c:142(claim_connection) claiming [] [2011/05/16 10:24:50.955802, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 5E260000FFFFFFFF0000 [2011/05/16 10:24:50.955830, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb7819fd8 [2011/05/16 10:24:50.955877, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 5E260000FFFFFFFF0000 [2011/05/16 10:24:50.955976, 6] param/loadparm.c:7133(lp_file_list_changed) lp_file_list_changed() file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Mon May 16 10:21:46 2011 [2011/05/16 10:24:50.956016, 10] smbd/negprot.c:41(get_challenge) get challenge: creating negprot_global_auth_context [2011/05/16 10:24:50.956034, 5] auth/auth.c:487(make_auth_context_subsystem) Making default auth method list for standalone security=user, encrypt passwords = yes [2011/05/16 10:24:50.956059, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend sam [2011/05/16 10:24:50.956075, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'sam' [2011/05/16 10:24:50.956109, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend sam_ignoredomain [2011/05/16 10:24:50.956125, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'sam_ignoredomain' [2011/05/16 10:24:50.956142, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend unix [2011/05/16 10:24:50.956158, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'unix' [2011/05/16 10:24:50.956173, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend winbind [2011/05/16 10:24:50.956189, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'winbind' [2011/05/16 10:24:50.956204, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend wbc [2011/05/16 10:24:50.956220, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'wbc' [2011/05/16 10:24:50.956235, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend smbserver [2011/05/16 10:24:50.956250, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'smbserver' [2011/05/16 10:24:50.956267, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend trustdomain [2011/05/16 10:24:50.956282, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'trustdomain' [2011/05/16 10:24:50.956298, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend ntdomain [2011/05/16 10:24:50.956313, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'ntdomain' [2011/05/16 10:24:50.956329, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend guest [2011/05/16 10:24:50.956345, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'guest' [2011/05/16 10:24:50.956360, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend netlogond [2011/05/16 10:24:50.956378, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'netlogond' [2011/05/16 10:24:50.956393, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match guest [2011/05/16 10:24:50.956411, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method guest has a valid init [2011/05/16 10:24:50.956427, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match sam [2011/05/16 10:24:50.956443, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method sam has a valid init [2011/05/16 10:24:50.956459, 10] smbd/negprot.c:49(get_challenge) get challenge: getting challenge [2011/05/16 10:24:50.956476, 5] auth/auth.c:97(get_ntlm_challenge) auth_get_challenge: module guest did not want to specify a challenge [2011/05/16 10:24:50.956491, 5] auth/auth.c:97(get_ntlm_challenge) auth_get_challenge: module sam did not want to specify a challenge [2011/05/16 10:24:50.956520, 5] auth/auth.c:132(get_ntlm_challenge) auth_context challenge created by random [2011/05/16 10:24:50.956536, 5] auth/auth.c:133(get_ntlm_challenge) challenge is: [2011/05/16 10:24:50.956552, 5] ../lib/util/util.c:278(_dump_data) [0000] BE 23 30 57 6C EB 92 99 .#0Wl... [2011/05/16 10:24:50.956584, 3] smbd/negprot.c:385(reply_nt1) not using SPNEGO [2011/05/16 10:24:50.956599, 3] smbd/negprot.c:691(reply_negprot) Selected protocol NT LM 0.12 [2011/05/16 10:24:50.956614, 5] smbd/negprot.c:698(reply_negprot) negprot index=2 [2011/05/16 10:24:50.956630, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.956640, 5] lib/util.c:627(show_msg) size=103 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=0 smb_pid=1064 smb_uid=0 smb_mid=436 smt_wct=17 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]=12803 (0x3203) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]=24064 (0x5E00) smb_vwv[ 8]= 38 (0x26) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]= 0 (0x0) smb_vwv[12]=14389 (0x3835) smb_vwv[13]=41657 (0xA2B9) smb_vwv[14]=52243 (0xCC13) smb_vwv[15]=34817 (0x8801) smb_vwv[16]= 2303 (0x8FF) smb_bcc=8 [2011/05/16 10:24:50.956816, 10] ../lib/util/util.c:278(_dump_data) [0000] BE 23 30 57 6C EB 92 99 .#0Wl... [2011/05/16 10:24:50.957232, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 230 [2011/05/16 10:24:50.957252, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0xe6 [2011/05/16 10:24:50.957268, 3] smbd/process.c:1489(process_smb) Transaction 1 of length 234 (0 toread) [2011/05/16 10:24:50.957284, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.957294, 5] lib/util.c:627(show_msg) size=230 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=53249 smb_tid=0 smb_pid=1064 smb_uid=0 smb_mid=437 smt_wct=13 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]=16472 (0x4058) smb_vwv[ 3]= 50 (0x32) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 24 (0x18) smb_vwv[ 8]= 24 (0x18) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 0 (0x0) smb_vwv[11]=53468 (0xD0DC) smb_vwv[12]= 128 (0x80) smb_bcc=169 [2011/05/16 10:24:50.957427, 10] ../lib/util/util.c:278(_dump_data) [0000] EB 86 B6 FE 6D 5D 08 E9 AD 4D B7 2A FB 2B 6F 43 ....m].. .M.*.+oC [0010] FA 7A 8C A3 09 F8 31 37 EB 86 B6 FE 6D 5D 08 E9 .z....17 ....m].. [0020] AD 4D B7 2A FB 2B 6F 43 FA 7A 8C A3 09 F8 31 37 .M.*.+oC .z....17 [0030] 00 00 00 00 00 4C 00 69 00 6E 00 75 00 78 00 20 .....L.i .n.u.x. [0040] 00 76 00 65 00 72 00 73 00 69 00 6F 00 6E 00 20 .v.e.r.s .i.o.n. [0050] 00 32 00 2E 00 36 00 2E 00 33 00 32 00 2D 00 33 .2...6.. .3.2.-.3 [0060] 00 31 00 2D 00 67 00 65 00 6E 00 65 00 72 00 69 .1.-.g.e .n.e.r.i [0070] 00 63 00 00 00 43 00 49 00 46 00 53 00 20 00 56 .c...C.I .F.S. .V [0080] 00 46 00 53 00 20 00 43 00 6C 00 69 00 65 00 6E .F.S. .C .l.i.e.n [0090] 00 74 00 20 00 66 00 6F 00 72 00 20 00 4C 00 69 .t. .f.o .r. .L.i [00A0] 00 6E 00 75 00 78 00 00 00 .n.u.x.. . [2011/05/16 10:24:50.957678, 3] smbd/process.c:1298(switch_message) switch message SMBsesssetupX (pid 9822) conn 0x0 [2011/05/16 10:24:50.957706, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.957723, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.957739, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.957763, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/05/16 10:24:50.957782, 3] smbd/sesssetup.c:1436(reply_sesssetup_and_X) wct=13 flg2=0xd001 [2011/05/16 10:24:50.957802, 3] smbd/sesssetup.c:1639(reply_sesssetup_and_X) Domain=[] NativeOS=[Linux version 2.6.32-31-generic] NativeLanMan=[CIFS VFS Client for Linux] PrimaryDomain=[] [2011/05/16 10:24:50.957821, 2] smbd/sesssetup.c:1391(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2011/05/16 10:24:50.957839, 3] smbd/sesssetup.c:1655(reply_sesssetup_and_X) sesssetupX:name=[]\[]@[__ffff_192.168.0.15] [2011/05/16 10:24:50.957867, 6] param/loadparm.c:7133(lp_file_list_changed) lp_file_list_changed() file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Mon May 16 10:21:46 2011 [2011/05/16 10:24:50.957900, 3] smbd/sesssetup.c:140(check_guest_password) Got anonymous request [2011/05/16 10:24:50.957916, 5] auth/auth.c:487(make_auth_context_subsystem) Making default auth method list for standalone security=user, encrypt passwords = yes [2011/05/16 10:24:50.957935, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match guest [2011/05/16 10:24:50.957951, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method guest has a valid init [2011/05/16 10:24:50.957976, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match sam [2011/05/16 10:24:50.957994, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method sam has a valid init [2011/05/16 10:24:50.958011, 5] auth/auth_util.c:122(make_user_info) attempting to make a user_info for () [2011/05/16 10:24:50.958029, 5] auth/auth_util.c:132(make_user_info) making strings for 's user_info struct [2011/05/16 10:24:50.958045, 5] auth/auth_util.c:164(make_user_info) making blobs for 's user_info struct [2011/05/16 10:24:50.958060, 10] auth/auth_util.c:182(make_user_info) made an encrypted user_info for () [2011/05/16 10:24:50.958076, 3] auth/auth.c:216(check_ntlm_password) check_ntlm_password: Checking password for unmapped user []\[]@[] with the new password interface [2011/05/16 10:24:50.958093, 3] auth/auth.c:219(check_ntlm_password) check_ntlm_password: mapped user is: []\[]@[] [2011/05/16 10:24:50.958109, 10] auth/auth.c:228(check_ntlm_password) check_ntlm_password: auth_context challenge created by fixed [2011/05/16 10:24:50.958125, 10] auth/auth.c:230(check_ntlm_password) challenge is: [2011/05/16 10:24:50.958139, 5] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 ........ [2011/05/16 10:24:50.958249, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.958268, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.958284, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.958300, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.958315, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.958352, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/05/16 10:24:50.958373, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.958403, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username office, was [2011/05/16 10:24:50.958420, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain OFFICE, was [2011/05/16 10:24:50.958437, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/05/16 10:24:50.958453, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/05/16 10:24:50.958471, 4] lib/substitute.c:504(automount_server) Home server: office [2011/05/16 10:24:50.958491, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\office\office, was [2011/05/16 10:24:50.958508, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2011/05/16 10:24:50.958527, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/05/16 10:24:50.958544, 4] lib/substitute.c:504(automount_server) Home server: office [2011/05/16 10:24:50.958563, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\office\office\profile, was [2011/05/16 10:24:50.958580, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/05/16 10:24:50.958597, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.958614, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.958630, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.958646, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.958661, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.958711, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/05/16 10:24:50.958731, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.958751, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-3937548381-614798192-88495934-501 [2011/05/16 10:24:50.958772, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-3937548381-614798192-88495934-501 from rid 501 [2011/05/16 10:24:50.958818, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-3937548381-614798192-88495934-513 couldn't be found [2011/05/16 10:24:50.958888, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.958912, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.958928, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.958945, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.958961, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.958976, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.959004, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/05/16 10:24:50.959021, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/05/16 10:24:50.959038, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/05/16 10:24:50.959053, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/05/16 10:24:50.959069, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.959085, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.959121, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/05/16 10:24:50.959182, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.959201, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/05/16 10:24:50.959220, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.959237, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.959255, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.959274, 3] auth/auth.c:265(check_ntlm_password) check_ntlm_password: guest authentication for user [] succeeded [2011/05/16 10:24:50.959291, 5] auth/auth.c:304(check_ntlm_password) check_ntlm_password: guest authentication for user [] -> [] -> [office] succeeded [2011/05/16 10:24:50.959309, 5] auth/auth_util.c:2119(free_user_info) attempting to free (and zero) a user_info structure [2011/05/16 10:24:50.959325, 10] auth/auth_util.c:2123(free_user_info) structure was created for [2011/05/16 10:24:50.959341, 5] auth/auth_util.c:2119(free_user_info) attempting to free (and zero) a user_info structure [2011/05/16 10:24:50.959363, 10] smbd/password.c:184(register_initial_vuid) register_initial_vuid: allocated vuid = 100 [2011/05/16 10:24:50.959381, 10] smbd/password.c:278(register_existing_vuid) register_existing_vuid: (1019,100) office office OFFICE guest=1 [2011/05/16 10:24:50.959398, 3] smbd/password.c:282(register_existing_vuid) register_existing_vuid: User name: office Real name: [2011/05/16 10:24:50.959427, 3] smbd/password.c:292(register_existing_vuid) register_existing_vuid: UNIX uid 1019 is UNIX user office, and will be vuid 100 [2011/05/16 10:24:50.959459, 6] param/loadparm.c:7133(lp_file_list_changed) lp_file_list_changed() file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Mon May 16 10:21:46 2011 [2011/05/16 10:24:50.959692, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 98 [2011/05/16 10:24:50.959726, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x62 [2011/05/16 10:24:50.959742, 3] smbd/process.c:1489(process_smb) Transaction 2 of length 102 (0 toread) [2011/05/16 10:24:50.959758, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.959768, 5] lib/util.c:627(show_msg) size=98 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=53249 smb_tid=0 smb_pid=1064 smb_uid=100 smb_mid=438 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 8 (0x8) smb_vwv[ 3]= 1 (0x1) smb_bcc=55 [2011/05/16 10:24:50.959852, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 5C 00 5C 00 31 00 39 00 32 00 2E 00 31 00 36 .\.\.1.9 .2...1.6 [0010] 00 38 00 2E 00 30 00 2E 00 31 00 5C 00 67 00 65 .8...0.. .1.\.g.e [0020] 00 6D 00 65 00 69 00 6E 00 73 00 61 00 6D 00 00 .m.e.i.n .s.a.m.. [0030] 00 3F 3F 3F 3F 3F 00 .?????. [2011/05/16 10:24:50.959939, 3] smbd/process.c:1298(switch_message) switch message SMBtconX (pid 9822) conn 0x0 [2011/05/16 10:24:50.959957, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.959974, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.959989, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.960012, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/05/16 10:24:50.960035, 4] smbd/reply.c:786(reply_tcon_and_X) Client requested device type [?????] for share [gemeinsam] [2011/05/16 10:24:50.960061, 5] smbd/service.c:1227(make_connection) making a connection to 'normal' service gemeinsam [2011/05/16 10:24:50.960090, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960107, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.960122, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960138, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.960153, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.960182, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/05/16 10:24:50.960202, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.960222, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username office, was [2011/05/16 10:24:50.960238, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain OFFICE, was [2011/05/16 10:24:50.960254, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/05/16 10:24:50.960270, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/05/16 10:24:50.960286, 4] lib/substitute.c:504(automount_server) Home server: office [2011/05/16 10:24:50.960304, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\office\office, was [2011/05/16 10:24:50.960321, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2011/05/16 10:24:50.960337, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/05/16 10:24:50.960363, 4] lib/substitute.c:504(automount_server) Home server: office [2011/05/16 10:24:50.960382, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\office\office\profile, was [2011/05/16 10:24:50.960399, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/05/16 10:24:50.960415, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960431, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.960447, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960463, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.960478, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.960505, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/05/16 10:24:50.960526, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.960543, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-3937548381-614798192-88495934-501 [2011/05/16 10:24:50.960561, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-3937548381-614798192-88495934-501 from rid 501 [2011/05/16 10:24:50.960597, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-3937548381-614798192-88495934-513 couldn't be found [2011/05/16 10:24:50.960625, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.960644, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960661, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.960676, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960692, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.960722, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.960746, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/05/16 10:24:50.960763, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/05/16 10:24:50.960779, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960794, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/05/16 10:24:50.960810, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.960826, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.960853, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/05/16 10:24:50.960905, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.960922, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/05/16 10:24:50.960941, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.960958, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.960976, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.960996, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user office [2011/05/16 10:24:50.961021, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is office [2011/05/16 10:24:50.961038, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [office]! [2011/05/16 10:24:50.961067, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service gemeinsam, connectpath = /home/alle [2011/05/16 10:24:50.961084, 3] smbd/service.c:807(make_connection_snum) Connect path is '/home/alle' for service [gemeinsam] [2011/05/16 10:24:50.961112, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2011/05/16 10:24:50.961133, 3] smbd/vfs.c:97(vfs_init_default) Initialising default vfs hooks [2011/05/16 10:24:50.961150, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ [2011/05/16 10:24:50.961166, 5] smbd/vfs.c:87(smb_register_vfs) Successfully added vfs backend '/[Default VFS]/' [2011/05/16 10:24:50.961183, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for posixacl [2011/05/16 10:24:50.961198, 5] smbd/vfs.c:87(smb_register_vfs) Successfully added vfs backend 'posixacl' [2011/05/16 10:24:50.961213, 3] smbd/vfs.c:122(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2011/05/16 10:24:50.961229, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ Successfully loaded vfs module [/[Default VFS]/] with the new modules system [2011/05/16 10:24:50.961327, 5] smbd/connection.c:142(claim_connection) claiming [gemeinsam] [2011/05/16 10:24:50.961429, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 5E260000010000006765 [2011/05/16 10:24:50.961450, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb7808200 [2011/05/16 10:24:50.961475, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 5E260000010000006765 [2011/05/16 10:24:50.961587, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service gemeinsam, connectpath = /home/alle [2011/05/16 10:24:50.961608, 10] smbd/share_access.c:238(user_ok_token) user_ok_token: share gemeinsam is ok for unix user office [2011/05/16 10:24:50.961626, 10] smbd/share_access.c:283(is_share_read_only_for_token) is_share_read_only_for_user: share gemeinsam is read-write for unix user office [2011/05/16 10:24:50.961649, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2011/05/16 10:24:50.961671, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2011/05/16 10:24:50.961693, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.961721, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.961736, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.961752, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.961767, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.961795, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/05/16 10:24:50.961814, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.961835, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username office, was [2011/05/16 10:24:50.961851, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain OFFICE, was [2011/05/16 10:24:50.961866, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/05/16 10:24:50.961882, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/05/16 10:24:50.961898, 4] lib/substitute.c:504(automount_server) Home server: office [2011/05/16 10:24:50.961927, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\office\office, was [2011/05/16 10:24:50.961943, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2011/05/16 10:24:50.961960, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/05/16 10:24:50.961976, 4] lib/substitute.c:504(automount_server) Home server: office [2011/05/16 10:24:50.961994, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\office\office\profile, was [2011/05/16 10:24:50.962011, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/05/16 10:24:50.962028, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.962044, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.962059, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.962075, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.962090, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.962118, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/05/16 10:24:50.962137, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.962154, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-3937548381-614798192-88495934-501 [2011/05/16 10:24:50.962173, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-3937548381-614798192-88495934-501 from rid 501 [2011/05/16 10:24:50.962208, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-3937548381-614798192-88495934-513 couldn't be found [2011/05/16 10:24:50.962237, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.962256, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.962272, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/05/16 10:24:50.962288, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.962303, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.962319, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.962343, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/05/16 10:24:50.962360, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/05/16 10:24:50.962376, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/05/16 10:24:50.962391, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/05/16 10:24:50.962407, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.962422, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.962451, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/05/16 10:24:50.962503, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/05/16 10:24:50.962521, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/05/16 10:24:50.962539, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.962565, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.962584, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-3937548381-614798192-88495934-513 [2011/05/16 10:24:50.962607, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (1019, 100) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.962624, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-3937548381-614798192-88495934-501 contains 6 SIDs SID[ 0]: S-1-5-21-3937548381-614798192-88495934-501 SID[ 1]: S-1-22-2-100 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-32-546 SID[ 5]: S-1-22-1-1019 SE_PRIV 0x0 0x0 0x0 0x0 [2011/05/16 10:24:50.962693, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 1019 Primary group is 100 and contains 1 supplementary groups Group[ 0]: 100 [2011/05/16 10:24:50.962737, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,1019) gid=(0,100) [2011/05/16 10:24:50.962768, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service gemeinsam, connectpath = /home/alle [2011/05/16 10:24:50.962796, 1] smbd/service.c:1070(make_connection_snum) __ffff_192.168.0.15 (::ffff:192.168.0.15) connect to service gemeinsam initially as user office (uid=1019, gid=100) (pid 9822) [2011/05/16 10:24:50.962818, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.962834, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:24:50.962849, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:24:50.962875, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/05/16 10:24:50.962896, 3] smbd/reply.c:865(reply_tcon_and_X) tconX service=gemeinsam [2011/05/16 10:24:50.963049, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:24:50.963070, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:24:50.963086, 3] smbd/process.c:1489(process_smb) Transaction 3 of length 72 (0 toread) [2011/05/16 10:24:50.963101, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.963112, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=439 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:24:50.963248, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 ... [2011/05/16 10:24:50.963272, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:24:50.963290, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (1019, 100) - sec_ctx_stack_ndx = 0 [2011/05/16 10:24:50.963306, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-3937548381-614798192-88495934-501 contains 6 SIDs SID[ 0]: S-1-5-21-3937548381-614798192-88495934-501 SID[ 1]: S-1-22-2-100 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-32-546 SID[ 5]: S-1-22-1-1019 SE_PRIV 0x0 0x0 0x0 0x0 [2011/05/16 10:24:50.963373, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 1019 Primary group is 100 and contains 1 supplementary groups Group[ 0]: 100 [2011/05/16 10:24:50.963402, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,1019) gid=(0,100) [2011/05/16 10:24:50.963423, 4] smbd/vfs.c:751(vfs_ChDir) vfs_ChDir to /home/alle [2011/05/16 10:24:50.963470, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 512 [2011/05/16 10:24:50.963492, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 512 [2011/05/16 10:24:50.963517, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 12, useable_space = 16412 [2011/05/16 10:24:50.963535, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 12, paramsize = 0, datasize = 12 [2011/05/16 10:24:50.963551, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.963561, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=439 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 12 (0xC) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 12 (0xC) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=13 [2011/05/16 10:24:50.963680, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 00 00 00 7B 01 00 00 00 00 00 00 .....{.. ..... [2011/05/16 10:24:50.963730, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 512 [2011/05/16 10:24:50.963846, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 82 [2011/05/16 10:24:50.963866, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x52 [2011/05/16 10:24:50.963882, 3] smbd/process.c:1489(process_smb) Transaction 4 of length 86 (0 toread) [2011/05/16 10:24:50.963898, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.963908, 5] lib/util.c:627(show_msg) size=82 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=440 smt_wct=15 smb_vwv[ 0]= 4 (0x4) smb_vwv[ 1]= 12 (0xC) smb_vwv[ 2]= 4 (0x4) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 4 (0x4) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 12 (0xC) smb_vwv[12]= 70 (0x46) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 4 (0x4) smb_bcc=17 [2011/05/16 10:24:50.964054, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 02 01 00 00 00 5B 00 00 00 00 00 00 ........ .[...... [0010] 00 . [2011/05/16 10:24:50.964097, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:24:50.964113, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:24:50.964130, 10] smbd/trans2.c:3498(call_trans2setfsinfo) call_trans2setfsinfo: for service [gemeinsam] [2011/05/16 10:24:50.964147, 10] smbd/trans2.c:3563(call_trans2setfsinfo) call_trans2setfsinfo: set unix info. major = 1, minor = 0 cap_low = 0x5b, cap_high = 0x0 [2011/05/16 10:24:50.964171, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.964182, 5] lib/util.c:627(show_msg) size=55 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=440 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=0 [2011/05/16 10:24:50.964419, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:24:50.964439, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:24:50.964454, 3] smbd/process.c:1489(process_smb) Transaction 5 of length 72 (0 toread) [2011/05/16 10:24:50.964470, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.964480, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=441 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:24:50.964628, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:24:50.964652, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:24:50.964668, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:24:50.964684, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:24:50.964720, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:24:50.964928, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:24:50.964948, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:24:50.964964, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:24:50.964980, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.964990, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=441 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:24:50.965105, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F4 2E 3D 08 00 00 00 00 98 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 63 9E 97 03 00 00 00 ........ .c...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:24:50.965204, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:24:50.965337, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:24:50.965357, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:24:50.965373, 3] smbd/process.c:1489(process_smb) Transaction 6 of length 78 (0 toread) [2011/05/16 10:24:50.965389, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.965399, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=442 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:24:50.965538, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:24:50.965565, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:24:50.965581, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:24:50.965599, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:24:50.965626, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:24:50.965662, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:24:50.965679, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:24:50.965709, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:24:50.965727, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:24:50.965761, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:24:50.965779, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:24:50.965797, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:24:50.965815, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:24:50.965833, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:24:50.965852, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:24:50.965875, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:24:50.965890, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:24:50.965909, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=0, 17=38, 18=fffffff4, 19=ffffffa4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=0, 33=38, 34=fffffff4, 35=ffffffa4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:24:50.965999, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:24:50.966015, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:24:50.966031, 5] lib/util.c:617(show_msg) [2011/05/16 10:24:50.966042, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=442 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:24:50.966157, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 00 38 F4 A4 A2 13 CC 01 00 D5 A9 ......8. ........ [0020] 1A 9E 13 CC 01 00 38 F4 A4 A2 13 CC 01 FB 03 00 ......8. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:25:00.954627, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:25:00.954668, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:25:00.954687, 3] smbd/process.c:1489(process_smb) Transaction 7 of length 72 (0 toread) [2011/05/16 10:25:00.954716, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:00.954746, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=443 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:25:00.954887, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:25:00.954915, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:00.954933, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:00.954953, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:25:00.954976, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:25:00.955154, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:25:00.955175, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:25:00.955191, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:25:00.955208, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:00.955218, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=443 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:25:00.955333, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F4 2E 3D 08 00 00 00 00 98 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 63 9E 97 03 00 00 00 ........ .c...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:25:00.955435, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:25:00.955746, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:25:00.955766, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:25:00.955782, 3] smbd/process.c:1489(process_smb) Transaction 8 of length 78 (0 toread) [2011/05/16 10:25:00.955798, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:00.955809, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=444 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:25:00.955948, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:25:00.955976, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:00.955993, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:00.956009, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:25:00.956042, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:25:00.956060, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:25:00.956076, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:25:00.956095, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:25:00.956112, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:25:00.956139, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:25:00.956155, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:25:00.956172, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:25:00.956189, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:25:00.956207, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:25:00.956223, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:25:00.956243, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:00.956258, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:25:00.956274, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=0, 17=38, 18=fffffff4, 19=ffffffa4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=0, 33=38, 34=fffffff4, 35=ffffffa4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:25:00.956365, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:25:00.956381, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:25:00.956396, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:00.956407, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=444 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:25:00.956517, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 00 38 F4 A4 A2 13 CC 01 00 D5 A9 ......8. ........ [0020] 1A 9E 13 CC 01 00 38 F4 A4 A2 13 CC 01 FB 03 00 ......8. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:25:09.658275, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 106 [2011/05/16 10:25:09.658320, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x6a [2011/05/16 10:25:09.658362, 3] smbd/process.c:1489(process_smb) Transaction 9 of length 110 (0 toread) [2011/05/16 10:25:09.658380, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:09.658392, 5] lib/util.c:627(show_msg) size=106 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=2587 smb_uid=100 smb_mid=445 smt_wct=15 smb_vwv[ 0]= 20 (0x14) smb_vwv[ 1]= 18 (0x12) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 1000 (0x3E8) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 20 (0x14) smb_vwv[10]= 68 (0x44) smb_vwv[11]= 18 (0x12) smb_vwv[12]= 88 (0x58) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 6 (0x6) smb_bcc=41 [2011/05/16 10:25:09.658558, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 09 02 00 00 00 00 2F 00 74 00 65 00 73 ........ ./.t.e.s [0010] 00 74 00 37 00 00 00 00 00 00 00 12 00 00 00 A4 .t.7.... ........ [0020] 01 00 00 00 00 00 00 00 02 ........ . [2011/05/16 10:25:09.658635, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:09.658654, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:09.658683, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "test7" [2011/05/16 10:25:09.658803, 5] smbd/filename.c:328(unix_convert) unix_convert begin: name = test7, dirpath = , start = test7 [2011/05/16 10:25:09.658856, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [test7] [/home/alle] [2011/05/16 10:25:09.658892, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [test7] -> [/home/alle/test7] [2011/05/16 10:25:09.658911, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: test7 reduced to /home/alle/test7 [2011/05/16 10:25:09.658930, 3] smbd/trans2.c:7722(call_trans2setfilepathinfo) call_trans2setfilepathinfo(6) test7 (fnum -1) info_level=521 totdata=18 [2011/05/16 10:25:09.658951, 3] smbd/trans2.c:7320(smbd_do_setfilepathinfo) smbd_do_setfilepathinfo: test7 (fnum -1) info_level=521 totdata=18 [2011/05/16 10:25:09.658972, 10] smbd/trans2.c:7088(smb_posix_open) smb_posix_open: file test7, smb_posix_flags = 16, mode 0666 [2011/05/16 10:25:09.658993, 10] smbd/open.c:3381(create_file_default) create_file: access_mask = 0x2 file_attributes = 0x10001b6, share_access = 0x7, create_disposition = 0x3 create_options = 0x40 oplock_request = 0x0 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x(nil), fname = test7 [2011/05/16 10:25:09.659018, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [test7] [/home/alle] [2011/05/16 10:25:09.659044, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [test7] -> [/home/alle/test7] [2011/05/16 10:25:09.659061, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: test7 reduced to /home/alle/test7 [2011/05/16 10:25:09.659080, 10] smbd/open.c:2906(create_file_unixpath) create_file_unixpath: access_mask = 0x2 file_attributes = 0x10001b6, share_access = 0x7, create_disposition = 0x3 create_options = 0x40 oplock_request = 0x0 ea_list = 0x(nil), sd = 0x(nil), fname = test7 [2011/05/16 10:25:09.659108, 5] smbd/files.c:119(file_new) allocated file structure 14651, fnum = 18747 (1 used) [2011/05/16 10:25:09.659131, 10] smbd/open.c:1533(open_file_ntcreate) open_file_ntcreate: fname=test7, dos_attrs=0x0 access_mask=0x2 share_access=0x7 create_disposition = 0x3 create_options=0x40 unix mode=0646 oplock_request=0 [2011/05/16 10:25:09.659152, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [test7] [/home/alle] [2011/05/16 10:25:09.659178, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [test7] -> [/home/alle/test7] [2011/05/16 10:25:09.659195, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: test7 reduced to /home/alle/test7 [2011/05/16 10:25:09.659214, 10] smbd/open.c:1715(open_file_ntcreate) open_file_ntcreate: fname=test7, after mapping access_mask=0x2 [2011/05/16 10:25:09.659246, 4] smbd/open.c:1977(open_file_ntcreate) calling open_file with flags=0x1 flags2=0x40 mode=0646, access_mask = 0x2, open_access_mask = 0x2 [2011/05/16 10:25:09.659285, 10] smbd/open.c:170(fd_open) fd_open: name test7, flags = 0400101 mode = 0646, fd = 32. [2011/05/16 10:25:09.659322, 10] smbd/notify_internal.c:890(notify_trigger) notify_trigger called action=0x1, filter=0x1, path=/home/alle/test7 [2011/05/16 10:25:09.659347, 10] smbd/notify_internal.c:189(notify_load) notify_load: [2011/05/16 10:25:09.659365, 1] ../librpc/ndr/ndr.c:214(ndr_print_debug) notify->array: struct notify_array num_depths : 0x00000000 (0) depth: ARRAY(0) [2011/05/16 10:25:09.659409, 2] smbd/open.c:634(open_file) office opened file test7 read=No write=Yes (numopen=1) [2011/05/16 10:25:09.659438, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 110800000000000008C0 [2011/05/16 10:25:09.659461, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb781a748 [2011/05/16 10:25:09.659482, 10] smbd/open.c:1034(delay_for_oplocks) delay_for_oplocks: oplock type 0x10 on file test7 [2011/05/16 10:25:09.659500, 10] smbd/open.c:1034(delay_for_oplocks) delay_for_oplocks: oplock type 0x10 on file test7 [2011/05/16 10:25:09.659519, 5] smbd/oplock.c:86(set_file_oplock) set_file_oplock: granted oplock on file test7, 811:1bac008:0/1, tv_sec = 4dd0df65, tv_usec = a0ea1 [2011/05/16 10:25:09.659547, 10] locking/locking.c:726(unparse_share_modes) unparse_share_modes: del: 0, owrt: Mon May 16 10:25:09 2011 CEST cwrt: Thu Jan 1 01:00:00 1970 CET, tok: 0, num: 1 [2011/05/16 10:25:09.659589, 10] locking/locking.c:518(print_share_mode_table) print_share_mode_table: share_mode_entry[0]: pid = 9822, share_access = 0x7, private_options = 0x40, access_mask = 0x82, mid = 0x0, type= 0x10, gen_id = 1, uid = 1019, flags = 1, file_id 811:1bac008:0 [2011/05/16 10:25:09.659964, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 110800000000000008C0 [2011/05/16 10:25:09.660031, 10] smbd/open.c:3198(create_file_unixpath) create_file_unixpath: info=2 [2011/05/16 10:25:09.660079, 10] smbd/open.c:3454(create_file_default) create_file: info=2 [2011/05/16 10:25:09.660119, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:09.660158, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=100646 [2011/05/16 10:25:09.660225, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 112, useable_space = 16410 [2011/05/16 10:25:09.660267, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 112, paramsize = 2, datasize = 112 [2011/05/16 10:25:09.660308, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:09.660331, 5] lib/util.c:627(show_msg) size=172 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=2587 smb_uid=100 smb_mid=445 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 112 (0x70) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 112 (0x70) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=117 [2011/05/16 10:25:09.660950, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 3B 49 02 00 00 00 00 02 00 .......; I....... [0010] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0020] 00 80 60 8B C4 A2 13 CC 01 80 60 8B C4 A2 13 CC ..`..... ..`..... [0030] 01 80 60 8B C4 A2 13 CC 01 FB 03 00 00 00 00 00 ..`..... ........ [0040] 00 64 00 00 00 00 00 00 00 00 00 00 00 00 00 00 .d...... ........ [0050] 00 00 00 00 00 00 00 00 00 00 00 00 00 08 C0 BA ........ ........ [0060] 01 00 00 00 00 A6 01 00 00 00 00 00 00 01 00 00 ........ ........ [0070] 00 00 00 00 00 ..... [2011/05/16 10:25:09.661763, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 41 [2011/05/16 10:25:09.661809, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x29 [2011/05/16 10:25:09.661848, 3] smbd/process.c:1489(process_smb) Transaction 10 of length 45 (0 toread) [2011/05/16 10:25:09.661897, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:09.661920, 5] lib/util.c:627(show_msg) size=41 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=2587 smb_uid=100 smb_mid=446 smt_wct=3 smb_vwv[ 0]=18747 (0x493B) smb_vwv[ 1]=65535 (0xFFFF) smb_vwv[ 2]=65535 (0xFFFF) smb_bcc=0 [2011/05/16 10:25:09.662177, 3] smbd/process.c:1298(switch_message) switch message SMBclose (pid 9822) conn 0xb7818128 [2011/05/16 10:25:09.662216, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:09.662258, 3] smbd/reply.c:4653(reply_close) close fd=32 fnum=18747 (numopen=1) [2011/05/16 10:25:09.662300, 6] smbd/close.c:501(set_close_write_time) close_write_time: Thu Jan 1 00:59:59 1970 [2011/05/16 10:25:09.662365, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 110800000000000008C0 [2011/05/16 10:25:09.662407, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb78197f8 [2011/05/16 10:25:09.662446, 10] locking/locking.c:552(parse_share_modes) parse_share_modes: delete_on_close: 0, owrt: Mon May 16 10:25:09 2011 CEST, cwrt: Thu Jan 1 01:00:00 1970 CET, tok: 0, num_share_modes: 1 [2011/05/16 10:25:09.662509, 10] locking/locking.c:655(parse_share_modes) parse_share_modes: share_mode_entry[0]: pid = 9822, share_access = 0x7, private_options = 0x40, access_mask = 0x82, mid = 0x0, type= 0x10, gen_id = 1, uid = 1019, flags = 1, file_id 811:1bac008:0 [2011/05/16 10:25:09.662555, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 110800000000000008C0 [2011/05/16 10:25:09.662607, 10] locking/posix.c:512(get_windows_lock_ref_count) get_windows_lock_count for file test7 = 0 [2011/05/16 10:25:09.662650, 10] locking/posix.c:538(delete_windows_lock_ref_count) delete_windows_lock_ref_count for file test7 [2011/05/16 10:25:09.662708, 2] smbd/close.c:656(close_normal_file) office closed file test7 (numopen=0) NT_STATUS_OK [2011/05/16 10:25:09.662827, 5] smbd/files.c:497(file_free) freed files structure 18747 (0 used) [2011/05/16 10:25:09.662867, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:09.662891, 5] lib/util.c:627(show_msg) size=35 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=2587 smb_uid=100 smb_mid=446 smt_wct=0 smb_bcc=0 [2011/05/16 10:25:10.953568, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:25:10.953624, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:25:10.953645, 3] smbd/process.c:1489(process_smb) Transaction 11 of length 72 (0 toread) [2011/05/16 10:25:10.953664, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:10.953675, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=447 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:25:10.953856, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:25:10.953887, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:10.953906, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:10.953948, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:25:10.953974, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:25:10.954166, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:25:10.954189, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:25:10.954208, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:25:10.954226, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:10.954237, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=447 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:25:10.954373, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F4 2E 3D 08 00 00 00 00 98 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:25:10.954481, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:25:10.954676, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:25:10.954848, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:25:10.954888, 3] smbd/process.c:1489(process_smb) Transaction 12 of length 78 (0 toread) [2011/05/16 10:25:10.954927, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:10.954949, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=448 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:25:10.955420, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:25:10.955471, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:10.955511, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:10.955550, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:25:10.955596, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:25:10.955636, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:25:10.955675, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:25:10.955796, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:25:10.955838, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:25:10.955894, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:25:10.955933, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:25:10.955985, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:25:10.956047, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:25:10.956088, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:25:10.956128, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:25:10.956172, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:10.956210, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:25:10.956249, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:25:10.956369, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:25:10.956409, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:25:10.956449, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:10.956472, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=448 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:25:10.956926, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:25:20.952227, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:25:20.952288, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:25:20.952308, 3] smbd/process.c:1489(process_smb) Transaction 13 of length 72 (0 toread) [2011/05/16 10:25:20.952326, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:20.952338, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=449 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:25:20.952497, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:25:20.952527, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:20.952564, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:20.952585, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:25:20.952609, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:25:20.952805, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:25:20.952828, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:25:20.952846, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:25:20.952863, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:20.952874, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=449 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:25:20.953005, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F3 2E 3D 08 00 00 00 00 97 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:25:20.953114, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:25:20.953337, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:25:20.953361, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:25:20.953379, 3] smbd/process.c:1489(process_smb) Transaction 14 of length 78 (0 toread) [2011/05/16 10:25:20.953397, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:20.953408, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=450 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:25:20.953567, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:25:20.953596, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:20.953614, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:20.953632, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:25:20.953655, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:25:20.953674, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:25:20.953691, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:25:20.953930, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:25:20.953971, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:25:20.954037, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:25:20.954077, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:25:20.954138, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:25:20.954188, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:25:20.954229, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:25:20.954268, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:25:20.954311, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:20.954349, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:25:20.954388, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:25:20.954508, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:25:20.954548, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:25:20.954588, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:20.954610, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=450 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:25:20.955133, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:25:30.953637, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:25:30.953711, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:25:30.953732, 3] smbd/process.c:1489(process_smb) Transaction 15 of length 72 (0 toread) [2011/05/16 10:25:30.953751, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:30.953763, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=451 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:25:30.953955, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:25:30.953985, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:30.954005, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:30.954027, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:25:30.954051, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:25:30.954233, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:25:30.954255, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:25:30.954274, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:25:30.954292, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:30.954303, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=451 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:25:30.954441, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F3 2E 3D 08 00 00 00 00 97 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:25:30.954549, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:25:30.954881, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:25:30.954907, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:25:30.954926, 3] smbd/process.c:1489(process_smb) Transaction 16 of length 78 (0 toread) [2011/05/16 10:25:30.954943, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:30.954955, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=452 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:25:30.955131, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:25:30.955170, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:30.955197, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:30.955216, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:25:30.955240, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:25:30.955259, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:25:30.955277, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:25:30.955299, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:25:30.955317, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:25:30.955360, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:25:30.955379, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:25:30.955398, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:25:30.955417, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:25:30.955437, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:25:30.955455, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:25:30.955477, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:30.955495, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:25:30.955513, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:25:30.955605, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:25:30.955624, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:25:30.955642, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:30.955653, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=452 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:25:30.955802, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:25:40.950873, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:25:40.950932, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:25:40.950952, 3] smbd/process.c:1489(process_smb) Transaction 17 of length 72 (0 toread) [2011/05/16 10:25:40.950971, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:40.950982, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=453 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:25:40.951165, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:25:40.951195, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:40.951215, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:40.951236, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:25:40.951260, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:25:40.951444, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:25:40.951466, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:25:40.951484, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:25:40.951502, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:40.951513, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=453 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:25:40.951650, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F3 2E 3D 08 00 00 00 00 97 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:25:40.951771, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:25:40.951966, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:25:40.951991, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:25:40.952009, 3] smbd/process.c:1489(process_smb) Transaction 18 of length 78 (0 toread) [2011/05/16 10:25:40.952027, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:40.952038, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=454 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:25:40.952204, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:25:40.952233, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:40.952252, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:40.952270, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:25:40.952294, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:25:40.952313, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:25:40.952331, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:25:40.952354, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:25:40.952383, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:25:40.952414, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:25:40.952432, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:25:40.952451, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:25:40.952469, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:25:40.952489, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:25:40.952507, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:25:40.952529, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:40.952545, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:25:40.952564, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:25:40.952657, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:25:40.952675, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:25:40.952692, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:40.952926, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=454 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:25:40.953319, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:25:43.037919, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:25:43.037964, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:25:43.037984, 3] smbd/process.c:1489(process_smb) Transaction 19 of length 72 (0 toread) [2011/05/16 10:25:43.038002, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:43.038014, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1510 smb_uid=100 smb_mid=455 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:25:43.038195, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:25:43.038226, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:43.038245, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:43.038266, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:25:43.038291, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:25:43.038472, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:25:43.038495, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:25:43.038513, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:25:43.038530, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:43.038542, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1510 smb_uid=100 smb_mid=455 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:25:43.038673, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F3 2E 3D 08 00 00 00 00 97 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:25:43.038793, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:25:43.038987, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:25:43.039011, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:25:43.039029, 3] smbd/process.c:1489(process_smb) Transaction 20 of length 78 (0 toread) [2011/05/16 10:25:43.039047, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:43.039058, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1510 smb_uid=100 smb_mid=456 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:25:43.039221, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:25:43.039250, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:43.039268, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:43.039287, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:25:43.039310, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:25:43.039329, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:25:43.039358, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:25:43.039380, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:25:43.039399, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:25:43.039429, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:25:43.039447, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:25:43.039467, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:25:43.039485, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:25:43.039505, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:25:43.039523, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:25:43.039544, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:43.039561, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:25:43.039580, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:25:43.039671, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:25:43.039689, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:25:43.039951, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:43.039975, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1510 smb_uid=100 smb_mid=456 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:25:43.040347, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:25:47.761623, 10] lib/events.c:131(run_events) Running timed event "smbd_idle_event_handler" 0xb7825698 [2011/05/16 10:25:47.761658, 10] smbd/process.c:683(smbd_idle_event_handler) smbd_idle_event_handler: idle_evt(deadtime) (nil) called [2011/05/16 10:25:47.761678, 10] smbd/process.c:694(smbd_idle_event_handler) smbd_idle_event_handler: idle_evt(deadtime) (nil) rescheduled [2011/05/16 10:25:47.761716, 10] lib/events.c:131(run_events) Running timed event "smbd_idle_event_handler" 0xb780c978 [2011/05/16 10:25:47.761758, 10] smbd/process.c:683(smbd_idle_event_handler) smbd_idle_event_handler: idle_evt(housekeeping) (nil) called [2011/05/16 10:25:47.761776, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/05/16 10:25:47.761793, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/05/16 10:25:47.761810, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/05/16 10:25:47.761839, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/05/16 10:25:47.761870, 10] smbd/process.c:694(smbd_idle_event_handler) smbd_idle_event_handler: idle_evt(housekeeping) (nil) rescheduled [2011/05/16 10:25:50.949072, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:25:50.949131, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:25:50.949151, 3] smbd/process.c:1489(process_smb) Transaction 21 of length 72 (0 toread) [2011/05/16 10:25:50.949169, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:50.949180, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=457 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:25:50.949341, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:25:50.949370, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:50.949393, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (1019, 100) - sec_ctx_stack_ndx = 0 [2011/05/16 10:25:50.949411, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-3937548381-614798192-88495934-501 contains 6 SIDs SID[ 0]: S-1-5-21-3937548381-614798192-88495934-501 SID[ 1]: S-1-22-2-100 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-32-546 SID[ 5]: S-1-22-1-1019 SE_PRIV 0x0 0x0 0x0 0x0 [2011/05/16 10:25:50.949490, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 1019 Primary group is 100 and contains 1 supplementary groups Group[ 0]: 100 [2011/05/16 10:25:50.949531, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,1019) gid=(0,100) [2011/05/16 10:25:50.949555, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:25:50.949576, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:25:50.949772, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:25:50.949795, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:25:50.949814, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:25:50.949831, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:50.949842, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=457 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:25:50.949974, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F3 2E 3D 08 00 00 00 00 97 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:25:50.950102, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:25:50.950313, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:25:50.950338, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:25:50.950356, 3] smbd/process.c:1489(process_smb) Transaction 22 of length 78 (0 toread) [2011/05/16 10:25:50.950373, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:50.950384, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=458 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:25:50.950548, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:25:50.950577, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:25:50.950595, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:25:50.950614, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:25:50.950637, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:25:50.950656, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:25:50.950673, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:25:50.950711, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:25:50.950948, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:25:50.951001, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:25:50.951052, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:25:50.951094, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:25:50.951134, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:25:50.951184, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:25:50.951232, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:25:50.951277, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:25:50.951315, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:25:50.951354, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:25:50.951490, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:25:50.951531, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:25:50.951570, 5] lib/util.c:617(show_msg) [2011/05/16 10:25:50.951593, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=458 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:25:50.952112, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:26:00.949105, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:26:00.949145, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:26:00.949163, 3] smbd/process.c:1489(process_smb) Transaction 23 of length 72 (0 toread) [2011/05/16 10:26:00.949181, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:00.949192, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=459 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:26:00.949337, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:26:00.949365, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:26:00.949383, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:26:00.949403, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:26:00.949426, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:26:00.949609, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:26:00.949630, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:26:00.949647, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:26:00.949664, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:00.949674, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=459 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:26:00.949827, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F3 2E 3D 08 00 00 00 00 97 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:26:00.949931, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:26:00.950113, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:26:00.950133, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:26:00.950150, 3] smbd/process.c:1489(process_smb) Transaction 24 of length 78 (0 toread) [2011/05/16 10:26:00.950166, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:00.950177, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=460 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:26:00.950322, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:26:00.950350, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:26:00.950367, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:26:00.950384, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:26:00.950406, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:26:00.950424, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:26:00.950441, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:26:00.950461, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:26:00.950479, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:26:00.950508, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:26:00.950524, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:26:00.950542, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:26:00.950559, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:26:00.950578, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:26:00.950595, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:26:00.950615, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:26:00.950631, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:26:00.950648, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:26:00.950763, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:26:00.950782, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:26:00.950798, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:00.950809, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=460 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:26:00.950927, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ . [2011/05/16 10:26:10.947065, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 68 [2011/05/16 10:26:10.947121, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x44 [2011/05/16 10:26:10.947139, 3] smbd/process.c:1489(process_smb) Transaction 25 of length 72 (0 toread) [2011/05/16 10:26:10.947156, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:10.947168, 5] lib/util.c:627(show_msg) size=68 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=461 smt_wct=15 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 100 (0x64) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 2 (0x2) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 3 (0x3) smb_bcc=3 [2011/05/16 10:26:10.947306, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 01 02 ... [2011/05/16 10:26:10.947334, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:26:10.947352, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:26:10.947372, 3] smbd/trans2.c:3463(call_trans2qfsinfo) call_trans2qfsinfo: level = 513 [2011/05/16 10:26:10.947394, 3] smbd/trans2.c:2906(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 513 [2011/05/16 10:26:10.947578, 5] smbd/trans2.c:3286(smbd_do_qfsinfo) smbd_do_qfsinfo : SMB_QUERY_POSIX_FS_INFO succsessful [2011/05/16 10:26:10.947599, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 0, data_sent_thistime = 56, useable_space = 16412 [2011/05/16 10:26:10.947616, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 0, data_to_send = 56, paramsize = 0, datasize = 56 [2011/05/16 10:26:10.947632, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:10.947642, 5] lib/util.c:627(show_msg) size=112 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=461 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 56 (0x38) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 56 (0x38) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=57 [2011/05/16 10:26:10.947801, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 10 00 00 00 10 00 00 82 92 53 0E 00 00 00 ........ ...S.... [0010] 00 F3 2E 3D 08 00 00 00 00 97 E1 82 07 00 00 00 ...=.... ........ [0020] 00 00 A0 A3 03 00 00 00 00 62 9E 97 03 00 00 00 ........ .b...... [0030] 00 A9 39 2C 52 00 00 00 00 ..9,R... . [2011/05/16 10:26:10.947905, 4] smbd/trans2.c:3479(call_trans2qfsinfo) SMBtrans2 info_level = 513 [2011/05/16 10:26:10.948169, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 74 [2011/05/16 10:26:10.948190, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x4a [2011/05/16 10:26:10.948206, 3] smbd/process.c:1489(process_smb) Transaction 26 of length 78 (0 toread) [2011/05/16 10:26:10.948222, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:10.948232, 5] lib/util.c:627(show_msg) size=74 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=49153 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=462 smt_wct=15 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 4000 (0xFA0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 8 (0x8) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=9 [2011/05/16 10:26:10.948371, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 02 00 00 00 00 00 00 ........ . [2011/05/16 10:26:10.948398, 3] smbd/process.c:1298(switch_message) switch message SMBtrans2 (pid 9822) conn 0xb7818128 [2011/05/16 10:26:10.948415, 4] smbd/uid.c:257(change_to_user) change_to_user: Skipping user change - already user [2011/05/16 10:26:10.948431, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512 [2011/05/16 10:26:10.948453, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "" [2011/05/16 10:26:10.948471, 5] smbd/filename.c:203(unix_convert) conversion finished "" -> . [2011/05/16 10:26:10.948487, 3] smbd/vfs.c:881(check_reduced_name) check_reduced_name [.] [/home/alle] [2011/05/16 10:26:10.948508, 10] smbd/vfs.c:968(check_reduced_name) check_reduced_name realpath [.] -> [/home/alle] [2011/05/16 10:26:10.948525, 3] smbd/vfs.c:1038(check_reduced_name) check_reduced_name: . reduced to /home/alle [2011/05/16 10:26:10.948554, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2011/05/16 10:26:10.948571, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo . (fnum = -1) level=512 call=5 total_data=0 [2011/05/16 10:26:10.948588, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: . (fnum = -1) level=512 max_data=4000 [2011/05/16 10:26:10.948605, 8] smbd/dosmode.c:613(dos_mode) dos_mode: . [2011/05/16 10:26:10.948623, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning d [2011/05/16 10:26:10.948640, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning d [2011/05/16 10:26:10.948661, 10] smbd/trans2.c:3873(store_file_unix_basic) store_file_unix_basic: SMB_QUERY_FILE_UNIX_BASIC [2011/05/16 10:26:10.948676, 4] smbd/trans2.c:3874(store_file_unix_basic) store_file_unix_basic: st_mode=40777 [2011/05/16 10:26:10.948693, 4] smbd/trans2.c:4724(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_UNIX_BASIC 0=0, 1=0, 2=0, 3=0, 4=0, 5=0, 6=0, 7=0, 8=0, 9=0, 10=0, 11=0, 12=0, 13=0, 14=0, 15=0, 16=ffffff80, 17=60, 18=ffffff8b, 19=ffffffc4, 20=ffffffa2, 21=13, 22=ffffffcc, 23=1, 24=0, 25=ffffffd5, 26=ffffffa9, 27=1a, 28=ffffff9e, 29=13, 30=ffffffcc, 31=1, 32=ffffff80, 33=60, 34=ffffff8b, 35=ffffffc4, 36=ffffffa2, 37=13, 38=ffffffcc, 39=1, 40=fffffffb, 41=3, 42=0, 43=0, 44=0, 45=0, 46=0, 47=0, 48=64, 49=0, 50=0, 51=0, 52=0, 53=0, 54=0, 55=0, 56=1, 57=0, 58=0, 59=0, 60=0, 61=0, 62=0, 63=0, 64=0, 65=0, 66=0, 67=0, 68=0, 69=0, 70=0, 71=0, 72=0, 73=0, 74=0, 75=0, 76=5e, 77=ffffffa2, 78=ffffffae, 79=2, 80=0, 81=0, 82=0, 83=0, 84=ffffffff, 85=1, 86=0, 87=0, 88=0, 89=0, 90=0, 91=0, 92=f, 93=0, 94=0, 95=0, 96=0, 97=0, 98=0, 99=0, [2011/05/16 10:26:10.948807, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 100, useable_space = 16410 [2011/05/16 10:26:10.948825, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 100, paramsize = 2, datasize = 100 [2011/05/16 10:26:10.948841, 5] lib/util.c:617(show_msg) [2011/05/16 10:26:10.948851, 5] lib/util.c:627(show_msg) size=160 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=49155 smb_tid=1 smb_pid=1064 smb_uid=100 smb_mid=462 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 100 (0x64) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 100 (0x64) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=105 [2011/05/16 10:26:10.948968, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0010] 00 00 00 00 00 80 60 8B C4 A2 13 CC 01 00 D5 A9 ......`. ........ [0020] 1A 9E 13 CC 01 80 60 8B C4 A2 13 CC 01 FB 03 00 ......`. ........ [0030] 00 00 00 00 00 64 00 00 00 00 00 00 00 01 00 00 .....d.. ........ [0040] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0050] 00 5E A2 AE 02 00 00 00 00 FF 01 00 00 00 00 00 .^...... ........ [0060] 00 0F 00 00 00 00 00 00 00 ........ .