cifsd-team / ksmbd

ksmbd kernel server(SMB/CIFS server)
152 stars 23 forks source link

move files from capture one to cifsd NAS failed #434

Open senmao2020 opened 4 years ago

senmao2020 commented 4 years ago

Capture One is a photograph software similar to Lightroom,I use cifsd NAS as a external directory。I failed to move photos in Capture One internal directory (filed stored in local disk) to cifsd NAS external directory。While the same operation with samba NAS is ok。 However,copy/move/paste file to cifsd NAS using macOS Finder works very well。

cifsd version : 3.2.4 ksmbd-tools version : 3.2.6 Linux ubuntu 5.4.0-42-generic #46-Ubuntu SMP Fri Jul 10 00:24:02 UTC 2020 x86_64 x86_64 x86_64 GNU/Linux

debug message: [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 128 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 152 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:55 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 152 rsp off = 184 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 0 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 105 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_query_info:4832: GOT query info request [Mon Aug 10 22:16:55 2020] ksmbd: smb2_query_info:4836: GOT SMB2_O_INFO_FILE [Mon Aug 10 22:16:55 2020] ksmbd: smb2_get_info_file:4436: Compound request set FID = 13 [Mon Aug 10 22:16:55 2020] ksmbd: get_file_all_info:4103: filename = [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:55 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 176 rcv off = 256 rsp off = 360 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 120 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 121 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:55 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:251: SMB2 data length 6 offset 96 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 102 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_query_dir:3583: Search pattern is RAW [Mon Aug 10 22:16:55 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography [Mon Aug 10 22:16:55 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:55 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :65459, next_offset : 112, data_count : 112 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:55 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 232 rsp off = 336 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 128 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 152 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:55 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:55 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 152 rsp off = 184 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 0 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 105 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_query_info:4832: GOT query info request [Mon Aug 10 22:16:55 2020] ksmbd: smb2_query_info:4840: GOT SMB2_O_INFO_FILESYSTEM [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:55 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 96 rcv off = 256 rsp off = 280 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:55 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:55 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 120 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_calc_size:269: SMB2 len 121 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:58 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:58 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 96 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_calc_size:269: SMB2 len 104 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_query_dir:3583: Search pattern is JPEG [Mon Aug 10 22:16:58 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography [Mon Aug 10 22:16:58 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:58 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :65459, next_offset : 112, data_count : 112 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:58 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:58 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 232 rsp off = 336 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:58 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:58 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.xmp [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 121 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 104 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :65459, next_offset : 112, data_count : 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 232 rsp off = 336 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 160 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG/DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG/DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2610: can not get linux path for /media/disk2/photography/JPEG/DSC_4614.JPG, rc = -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_creat:2269: file does not exist, so creating [Mon Aug 10 22:16:59 2020] ksmbd: smb2_creat:2278: creating regular file [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 184 rsp off = 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 105 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_info:4832: GOT query info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_info:4836: GOT SMB2_O_INFO_FILE [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_info_file:4436: Compound request set FID = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 28 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 124 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is ._DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 256 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 14:14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 121 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 104 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :65459, next_offset : 112, data_count : 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 232 rsp off = 336 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 14:14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 28 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 124 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is ._DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 256 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 14:14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 152 rsp off = 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 14:14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 152 rsp off = 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 105 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_info:4832: GOT query info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_info:4840: GOT SMB2_O_INFO_FILESYSTEM [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 96 rcv off = 256 rsp off = 280 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 14:14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 104 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5638: Received set info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5669: GOT SMB2_O_INFO_FILE [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5712: error while processing smb2 query rc = -13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 524288 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 524400 not 113 for cmd:9 mid:49898 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 0, len 524288 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[8] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 524288 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 524400 not 113 for cmd:9 mid:49906 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 524288, len 524288 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[8] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 2 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 98 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :1048399, next_offset : 112, data_count : 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :1048399, next_offset : 112, data_count : 224 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :1048399, next_offset : 128, data_count : 352 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 786432 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 786544 not 113 for cmd:9 mid:49932 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 1048576, len 786432 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[12] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 262144 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 262256 not 113 for cmd:9 mid:49944 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 1835008, len 262144 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[4] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 2 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 98 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 1048688 not 113 for cmd:9 mid:49964 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 2097152, len 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 1048688 not 113 for cmd:9 mid:49980 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 3145728, len 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 1048688 not 113 for cmd:9 mid:49996 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 4194304, len 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 1048688 not 113 for cmd:9 mid:50012 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 5242880, len 1048576 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_data_area_len:217: data area larger than 128K: 784472 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 113 [Mon Aug 10 22:16:59 2020] ksmbd: ksmbd_smb2_check_message:433: cli req padded more than expected. Length 784584 not 113 for cmd:9 mid:50028 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6152: flags 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_write:6156: filename DSC_4614.JPG, offset 6291456, len 784472 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[12] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 104 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5638: Received set info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5669: GOT SMB2_O_INFO_FILE [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5712: error while processing smb2 query rc = -13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 160 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG/DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG/DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 184 rsp off = 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 74 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 170 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5638: Received set info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5645: Compound request set FID = 14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5669: GOT SMB2_O_INFO_FILE [Mon Aug 10 22:16:59 2020] ksmbd: smb2_rename:5028: setting FILE_RENAME_INFO [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG/.smbdeleteAAA6e6039b [Mon Aug 10 22:16:59 2020] ksmbd: smb2_rename:5093: new name /media/disk2/photography/JPEG/.smbdeleteAAA6e6039b [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 72 rcv off = 360 rsp off = 256 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 14:14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 14 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 104 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5638: Received set info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5669: GOT SMB2_O_INFO_FILE [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5712: error while processing smb2 query rc = -13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 176 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 200 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG/.smbdeleteAAA6e6039b [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG/.smbdeleteAAA6e6039b [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 200 rsp off = 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 1 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 97 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5638: Received set info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5645: Compound request set FID = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_info:5669: GOT SMB2_O_INFO_FILE [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 72 rcv off = 304 rsp off = 256 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context ExtA err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2517: get query maximal access context (timestamp : 281750966981630) [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context TWrp err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context AlSi err -2 [Mon Aug 10 22:16:59 2020] ksmbd: check_context_err:2089: find context QFid err -2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 152 rsp off = 184 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 0 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 105 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_info:4832: GOT query info request [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_info:4840: GOT SMB2_O_INFO_FILESYSTEM [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 96 rcv off = 256 rsp off = 280 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 24 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is DSC_4614.JPG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 80 rcv off = 248 rsp off = 232 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 0 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 121 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2392: share path len 24 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 104 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :65459, next_offset : 112, data_count : 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 184 rcv off = 232 rsp off = 336 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4952: Compound request set FID = 13:13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 13 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:479: padding len 4 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 88 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_close:4964: volatile_id = 2 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 8 offset 120 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 128 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_get_name:663: absolute name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_open:2368: converted name = /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[1] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: is_chained_smb2_message:468: got SMB2 chained command [Mon Aug 10 22:16:59 2020] ksmbd: init_chained_smb2_rsp:421: Compound req new_len = 152 rcv off = 128 rsp off = 152 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 2 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 98 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3588: Restart directory scan [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :1048399, next_offset : 112, data_count : 112 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_populate_readdir_entry:3279: info_level : 37, buf_len :1048399, next_offset : 112, data_count : 224 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512] [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:251: SMB2 data length 2 offset 96 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_calc_size:269: SMB2 len 98 [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3583: Search pattern is [Mon Aug 10 22:16:59 2020] ksmbd: smb2_query_dir:3585: Directory name is /media/disk2/photography/JPEG [Mon Aug 10 22:16:59 2020] ksmbd: smb2_set_rsp_credits:374: credits: requested[256] granted[16] total_granted[512]

namjaejeon commented 4 years ago

Can you give me a tcpdump(or wireshark) that captured packets on problem ?

namjaejeon commented 4 years ago

And want to know which local filesystem is used ? exfat ?

senmao2020 commented 4 years ago

local filesystem is macOS APFS and exfat。tcpdump will be uploaded later。

namjaejeon commented 4 years ago

Okay, If so, problem happen with exfat. right ? It work fine with MacOS. I guess it work well if you change current local filesystem with ext4 or others. can you confirm this ?

senmao2020 commented 4 years ago
OS software smb server local filesystem operation result
macOS Caputure One cifsd exFat import photo from sd card(exFAT) to smb failed
macOS Caputure One cifsd APFS move file from c1 internel directory(APFS) to smb failed
macOS Caputure One samba exFAT import photo from sd card(exFAT) to smb success
macOS Caputure One samba APFS move file from c1 internel directory(APFS) to smb success
macOS Finder cifsd exFAT drag file copy to smb success
macOS Finder cifsd APFS drag file copy to smb success

I will try to test local filesystem with ext4 on macOS。

namjaejeon commented 4 years ago

Oh, got it, I suspect file lookup issue from local filesystem, but It is not related when I check your table. You do not need to check ext4, you can send tcpdump file on CaptureOn & cifsd connection to me..

senmao2020 commented 4 years ago

tcpdump pcap file captured on server side: https://drive.google.com/file/d/17x7qLtgeaybTxfC2-5FbgbqrlSiO_OkY/view?usp=sharing

namjaejeon commented 4 years ago

Thanks! Let me take a look:)

namjaejeon commented 4 years ago

@senmao2020 Can you explain more symptom ? e.g. Did you copy the files that contain (dot) at the beginning of the file name? After copying files to cifsd share, you can not see all file list through MacOS Caputure ?

senmao2020 commented 4 years ago

no dot at the beginning of the file, just regular file name,like DSC_4618.NEF

and I run a command to monitor files in cifsd share directory, Capture One actually write data to cifsd share,but,I don't know what happened,the file finally is deleted。

while true;do ls -la ;sleep 0.1;done

the output: drwxrwxrwx 2 mao mao 16384 Aug 13 19:47 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. total 1916 drwxrwxrwx 2 mao mao 16384 Aug 13 19:48 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. -rwxrwxrwx 1 mao mao 1937408 Aug 13 19:48 DSC_4618.NEF total 9240 drwxrwxrwx 2 mao mao 16384 Aug 13 19:48 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. -rwxrwxrwx 1 mao mao 9437184 Aug 13 19:48 DSC_4618.NEF total 16408 drwxrwxrwx 2 mao mao 16384 Aug 13 19:48 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. -rwxrwxrwx 1 mao mao 16777216 Aug 13 19:48 DSC_4618.NEF total 23576 drwxrwxrwx 2 mao mao 16384 Aug 13 19:48 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. -rwxrwxrwx 1 mao mao 24117248 Aug 13 19:48 DSC_4618.NEF total 30744 drwxrwxrwx 2 mao mao 16384 Aug 13 19:48 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. -rwxrwxrwx 1 mao mao 31457280 Aug 13 19:48 DSC_4618.NEF total 24 drwxrwxrwx 2 mao mao 16384 Aug 13 19:48 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. total 24 drwxrwxrwx 2 mao mao 16384 Aug 13 19:48 . drwxrwxrwx 11 mao mao 4096 Aug 13 19:44 .. total 24

namjaejeon commented 4 years ago

@senmao2020 hm... you copied only one file(DSC_4618.NEF0 to cifsd share while ls -al loop in your local share directory. right ? some smb client(Capture One) might request to remove file if it get wrong response from smb server(cifsd). but I can't reproduce it using Capture One in my Macbook. and can't find any clue from tcpdump you sent because of too many filenames and packets in tcpdump. Can you provide one more tcpdump on current reproduction(copied one file(DSC_4618.NEF)) ?

Neustradamus commented 3 years ago

@senmao2020: @namjaejeon needs an answer to this comment...

Neustradamus commented 3 years ago

@senmao2020: @namjaejeon needs an answer to this comment...

Neustradamus commented 3 years ago

@senmao2020: @namjaejeon needs an answer to this comment...

Note: There are changes in latest code, it has been solved, no?