Attachment 17993 Details for Bug 15428 – Successful mount.smb3 prior to windows update

Successful mount.smb3 prior to windows update

file_15428.txt (text/plain), 15.16 KB, created by Scott Harvey on 2023-07-22 00:00:11 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Scott Harvey

Created: 2023-07-22 00:00:11 UTC

Size: 15.16 KB

patch

obsolete

>[2023/07/21 15:25:57.552236,  3] ../../source3/smbd/server_exit.c:229(exit_server_common)
>  Server exit (NT_STATUS_CONNECTION_RESET)
>[2023/07/21 15:26:11.576843,  3] ../../source3/param/loadparm.c:3995(lp_load_ex)
>  lp_load_ex: refreshing parameters
>[2023/07/21 15:26:11.576895,  3] ../../source3/param/loadparm.c:559(init_globals)
>  Initialising global parameters
>[2023/07/21 15:26:11.576932,  3] ../../source3/param/loadparm.c:2897(lp_do_section)
>  Processing section "[global]"
>[2023/07/21 15:26:11.577011,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[sysvol]"
>[2023/07/21 15:26:11.577030,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[netlogon]"
>[2023/07/21 15:26:11.577046,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[home]"
>[2023/07/21 15:26:11.577058,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[fin_data]"
>[2023/07/21 15:26:11.577070,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[common_docs]"
>[2023/07/21 15:26:11.577081,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[Office97]"
>[2023/07/21 15:26:11.577097,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[windows-apps-install]"
>[2023/07/21 15:26:11.577108,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[media]"
>[2023/07/21 15:26:11.577135,  3] ../../source3/param/loadparm.c:1681(lp_add_ipc)
>  adding IPC service
>  added interface lo ip=::1 bcast= netmask=ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff
>  added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0
>  added interface enp5s0 ip=192.168.1.1 bcast=192.168.1.63 netmask=255.255.255.192
>  added interface enp6s0 ip=192.168.1.65 bcast=192.168.1.127 netmask=255.255.255.192
>[2023/07/21 15:26:11.581204,  3] ../../source3/param/loadparm.c:3995(lp_load_ex)
>  lp_load_ex: refreshing parameters
>[2023/07/21 15:26:11.581236,  3] ../../source3/param/loadparm.c:559(init_globals)
>  Initialising global parameters
>[2023/07/21 15:26:11.581270,  3] ../../source3/param/loadparm.c:2897(lp_do_section)
>  Processing section "[global]"
>[2023/07/21 15:26:11.581340,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[sysvol]"
>[2023/07/21 15:26:11.581357,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[netlogon]"
>[2023/07/21 15:26:11.581373,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[home]"
>[2023/07/21 15:26:11.581384,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[fin_data]"
>[2023/07/21 15:26:11.581396,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[common_docs]"
>[2023/07/21 15:26:11.581407,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[Office97]"
>[2023/07/21 15:26:11.581423,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[windows-apps-install]"
>[2023/07/21 15:26:11.581434,  2] ../../source3/param/loadparm.c:2914(lp_do_section)
>  Processing section "[media]"
>[2023/07/21 15:26:11.581459,  3] ../../source3/param/loadparm.c:1681(lp_add_ipc)
>  adding IPC service
>  added interface lo ip=::1 bcast= netmask=ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff
>  added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0
>  added interface enp5s0 ip=192.168.1.1 bcast=192.168.1.63 netmask=255.255.255.192
>  added interface enp6s0 ip=192.168.1.65 bcast=192.168.1.127 netmask=255.255.255.192
>[2023/07/21 15:33:46.203072, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 5 vectors
>[2023/07/21 15:33:46.203131, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_CANCEL] mid = 0
>[2023/07/21 15:33:46.203204, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2446(smbd_smb2_request_process_cancel)
>  smbd_smb2_request_process_cancel: attempting to cancel opcode[SMB2_OP_NOTIFY] mid 109
>[2023/07/21 15:33:46.203234,  3, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3962(smbd_smb2_request_error_ex)
>  smbd_smb2_request_error_ex: smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_CANCELLED] || at ../../source3/smbd/smb2_notify.c:126
>[2023/07/21 15:33:46.203243, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3847(smbd_smb2_request_done_ex)
>  smbd_smb2_request_done_ex: mid [109] idx[1] status[NT_STATUS_CANCELLED] body[8] dyn[yes:1] at ../../source3/smbd/smb2_server.c:4013
>[2023/07/21 15:33:46.203743, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 5 vectors
>[2023/07/21 15:33:46.203760, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_CLOSE] mid = 153
>[2023/07/21 15:33:46.203813, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_close.c:283(smbd_smb2_close_send)
>  smbd_smb2_close_send: sbharvey - fnum 1009143032
>[2023/07/21 15:33:46.203822, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_close.c:211(smbd_smb2_close)
>  smbd_smb2_close: sbharvey - fnum 1009143032
>[2023/07/21 15:33:46.203991, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:3847(smbd_smb2_request_done_ex)
>  smbd_smb2_request_done_ex: mid [153] idx[1] status[NT_STATUS_OK] body[60] dyn[no:0] at ../../source3/smbd/smb2_close.c:146
>[2023/07/21 15:33:46.204417, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 5 vectors
>[2023/07/21 15:33:46.204428, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_CANCEL] mid = 0
>[2023/07/21 15:33:46.204440, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2446(smbd_smb2_request_process_cancel)
>  smbd_smb2_request_process_cancel: attempting to cancel opcode[SMB2_OP_NOTIFY] mid 111
>[2023/07/21 15:33:46.204449,  3, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3962(smbd_smb2_request_error_ex)
>  smbd_smb2_request_error_ex: smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_CANCELLED] || at ../../source3/smbd/smb2_notify.c:126
>[2023/07/21 15:33:46.204454, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3847(smbd_smb2_request_done_ex)
>  smbd_smb2_request_done_ex: mid [111] idx[1] status[NT_STATUS_CANCELLED] body[8] dyn[yes:1] at ../../source3/smbd/smb2_server.c:4013
>[2023/07/21 15:33:46.204898, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 5 vectors
>[2023/07/21 15:33:46.204910, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_CLOSE] mid = 154
>[2023/07/21 15:33:46.204932, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_close.c:283(smbd_smb2_close_send)
>  smbd_smb2_close_send: sbharvey - fnum 888947291
>[2023/07/21 15:33:46.204957, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_close.c:211(smbd_smb2_close)
>  smbd_smb2_close: sbharvey - fnum 888947291
>[2023/07/21 15:33:46.204981, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:3847(smbd_smb2_request_done_ex)
>  smbd_smb2_request_done_ex: mid [154] idx[1] status[NT_STATUS_OK] body[60] dyn[no:0] at ../../source3/smbd/smb2_close.c:146
>[2023/07/21 15:33:46.242218, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 5 vectors
>[2023/07/21 15:33:46.242266, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_CREATE] mid = 155
>[2023/07/21 15:33:46.242300, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:748(smbd_smb2_create_send)
>  smbd_smb2_create_send: name [sbharvey]
>[2023/07/21 15:33:46.242319, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:864(smbd_smb2_create_send)
>  smbd_smb2_create_send: open execution phase
>[2023/07/21 15:33:46.242580, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:1411(smbd_smb2_create_after_exec)
>  smbd_smb2_create_send: response construction phase
>[2023/07/21 15:33:46.242629, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:1473(smbd_smb2_create_after_exec)
>  smb2_create_send: smbXsrv_open_update returned NT_STATUS_OK
>[2023/07/21 15:33:46.242638, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:1682(smbd_smb2_create_finish)
>  smbd_smb2_create_finish: sbharvey - fnum 770076667
>[2023/07/21 15:33:46.242649, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:3847(smbd_smb2_request_done_ex)
>  smbd_smb2_request_done_ex: mid [155] idx[1] status[NT_STATUS_OK] body[88] dyn[yes:88] at ../../source3/smbd/smb2_create.c:411
>[2023/07/21 15:33:46.243323, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 5 vectors
>[2023/07/21 15:33:46.243343, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_NOTIFY] mid = 156
>[2023/07/21 15:33:46.243369, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_notify.c:232(smbd_smb2_notify_send)
>  smbd_smb2_notify_send: sbharvey - fnum 770076667
>[2023/07/21 15:33:46.243380,  3, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_notify.c:251(smbd_smb2_notify_send)
>  smbd_smb2_notify_send: notify change called on sbharvey, filter = DIR_NAME, recursive = 0
>[2023/07/21 15:33:46.243704, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 9 vectors
>[2023/07/21 15:33:46.243722, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_CREATE] mid = 157
>[2023/07/21 15:33:46.243738, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:748(smbd_smb2_create_send)
>  smbd_smb2_create_send: name [sbharvey]
>[2023/07/21 15:33:46.243744, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:864(smbd_smb2_create_send)
>  smbd_smb2_create_send: open execution phase
>[2023/07/21 15:33:46.243839, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:1411(smbd_smb2_create_after_exec)
>  smbd_smb2_create_send: response construction phase
>[2023/07/21 15:33:46.243876, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_create.c:1682(smbd_smb2_create_finish)
>  smbd_smb2_create_finish: sbharvey - fnum 194169262
>[2023/07/21 15:33:46.243884, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:3847(smbd_smb2_request_done_ex)
>  smbd_smb2_request_done_ex: mid [157] idx[1] status[NT_STATUS_OK] body[88] dyn[yes:32] at ../../source3/smbd/smb2_create.c:411
>[2023/07/21 15:33:46.243891, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_NOTIFY] mid = 158
>[2023/07/21 15:33:46.243901, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_notify.c:232(smbd_smb2_notify_send)
>  smbd_smb2_notify_send: sbharvey - fnum 194169262
>[2023/07/21 15:33:46.243905,  3, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_notify.c:251(smbd_smb2_notify_send)
>  smbd_smb2_notify_send: notify change called on sbharvey, filter = FILE_NAME|ATTRIBUTES|LAST_WRITE, recursive = 0
>[2023/07/21 15:33:46.243933, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2232(smbd_smb2_request_pending_timer)
>  smbd_smb2_request_pending_queue: opcode[SMB2_OP_NOTIFY] mid 156 going async
>[2023/07/21 15:33:46.243940, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2346(smbd_smb2_request_pending_timer)
>  	state->vector[0/5].iov_len = 4
>  	state->vector[1/5].iov_len = 0
>  	state->vector[2/5].iov_len = 64
>  	state->vector[3/5].iov_len = 8
>  	state->vector[4/5].iov_len = 1
>[2023/07/21 15:33:46.245089, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2232(smbd_smb2_request_pending_timer)
>  smbd_smb2_request_pending_queue: opcode[SMB2_OP_NOTIFY] mid 158 going async
>[2023/07/21 15:33:46.245137, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2346(smbd_smb2_request_pending_timer)
>  	state->vector[0/5].iov_len = 4
>  	state->vector[1/5].iov_len = 0
>  	state->vector[2/5].iov_len = 64
>  	state->vector[3/5].iov_len = 8
>  	state->vector[4/5].iov_len = 1
>[2023/07/21 15:34:15.549825, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:5003(smbd_smb2_io_handler)
>  smbd_smb2_request idx[1] of 5 vectors
>[2023/07/21 15:34:15.549881, 10, pid=66487, effective(10003, 100), real(10003, 0), class=smb2] ../../source3/smbd/smb2_server.c:2986(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: opcode[SMB2_OP_IOCTL] mid = 159
>[2023/07/21 15:34:15.549923, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_ioctl.c:443(smbd_smb2_ioctl_send)
>  smbd_smb2_ioctl: ctl_code[0x001401fc] <no handle>, fnum [fsp is NULL]
>[2023/07/21 15:34:15.549961, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_ioctl.c:314(smbd_smb2_request_ioctl_done)
>  smbd_smb2_request_ioctl_done: smbd_smb2_ioctl_recv returned 608 status NT_STATUS_OK
>[2023/07/21 15:34:15.549968, 10, pid=66487, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3847(smbd_smb2_request_done_ex)
>  smbd_smb2_request_done_ex: mid [159] idx[1] status[NT_STATUS_OK] body[48] dyn[yes:608] at ../../source3/smbd/smb2_ioctl.c:410

Actions: View

Attachments on bug 15428: 17993 | 17994 | 18009 | 18010 | 18011 | 18012