Attachment 17444 Details for Bug 15128 – associated debug from time of valgrind trace

associated debug from time of valgrind trace

log.smbd (text/plain), 34.04 KB, created by Noel Power on 2022-07-24 14:02:41 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Noel Power

Created: 2022-07-24 14:02:41 UTC

Size: 34.04 KB

patch

obsolete

>[2022/07/15 16:21:58.894502,  0, pid=10070] ../../source3/smbd/server.c:1734(main)
>  smbd version 4.15.4 started.
>  Copyright Andrew Tridgell and the Samba Team 1992-2021
>[2022/07/15 16:22:32.399271,  0, pid=10337] ../../source3/smbd/smbXsrv_client.c:824(smbXsrv_client_create)
>  smbXsrv_client_create: ### client_guid[00000000-0000-0000-0000-000000000000] created
>[2022/07/15 16:22:32.402791,  0, pid=10337] ../../source3/smbd/process.c:4025(smbd_process)
>  smbd_process: ### created new smbd_server_connection 0x1a941640
>[2022/07/15 16:22:32.508633,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:32.629906,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:32.636799,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:32.665434,  0, pid=10337] ../../source3/smbd/smb2_negprot.c:801(smbd_smb2_request_process_negprot)
>  smbd_smb2_request_process_negprot: ## calling smb2srv_client_mc_negprot_send
>[2022/07/15 16:22:32.670566,  0, pid=10337] ../../source3/smbd/smbXsrv_client.c:500(smb2srv_client_mc_negprot_next)
>  smb2srv_client_mc_negprot_next: #### first time client_guid[44249f00-043a-11ed-80d4-525400ecc94d] stored
>[2022/07/15 16:22:32.683700,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:32.685965,  0, pid=10337] ../../source3/smbd/smb2_negprot.c:825(smbd_smb2_request_process_negprot_mc_done)
>  smbd_smb2_request_process_negprot_mc_done: ### mc_negprot done with status NT_STATUS_OK
>[2022/07/15 16:22:32.688885,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>[2022/07/15 16:22:32.753956,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:32.765979,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>[2022/07/15 16:22:32.813340,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:32.881024,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_TCON]
>[2022/07/15 16:22:32.899159,  0, pid=10337] ../../source3/smbd/conn.c:69(conn_new)
>  conn_new: ### new con created!!! 0x1aa3c5d0
>[2022/07/15 16:22:32.903104,  0, pid=10337] ../../source3/smbd/conn.c:118(conn_new)
>  conn_new: ## sconn 0x1a941640 added connection 0x1aa3c5d0, num conns = 1
>[2022/07/15 16:22:32.981157,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_TCON] returning NT_STATUS_OK
>[2022/07/15 16:22:33.885821,  0, pid=10349] ../../source3/smbd/smbXsrv_client.c:824(smbXsrv_client_create)
>  smbXsrv_client_create: ### client_guid[00000000-0000-0000-0000-000000000000] created
>[2022/07/15 16:22:33.890406,  0, pid=10349] ../../source3/smbd/process.c:4025(smbd_process)
>  smbd_process: ### created new smbd_server_connection 0x1a9417a0
>[2022/07/15 16:22:34.276299,  0, pid=10349] ../../source3/smbd/conn.c:69(conn_new)
>  conn_new: ### new con created!!! 0x1a9cea60
>[2022/07/15 16:22:34.280046,  0, pid=10349] ../../source3/smbd/conn.c:118(conn_new)
>  conn_new: ## sconn 0x1a9417a0 added connection 0x1a9cea60, num conns = 1
>[2022/07/15 16:22:34.432415,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:35.928414,  0, pid=10349] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:36.434775,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:37.930059,  0, pid=10349] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:37.951560,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>[2022/07/15 16:22:38.104724,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:38.208659,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_TCON]
>[2022/07/15 16:22:38.210964,  0, pid=10337] ../../source3/smbd/conn.c:69(conn_new)
>  conn_new: ### new con created!!! 0x1aaf2580
>[2022/07/15 16:22:38.211767,  0, pid=10337] ../../source3/smbd/conn.c:118(conn_new)
>  conn_new: ## sconn 0x1a941640 added connection 0x1aaf2580, num conns = 2
>[2022/07/15 16:22:38.215636,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_TCON] returning NT_STATUS_OK
>[2022/07/15 16:22:38.216577,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_IOCTL]
>[2022/07/15 16:22:38.233210,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_IOCTL] returning NT_STATUS_OK
>[2022/07/15 16:22:38.234089,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_IOCTL]
>[2022/07/15 16:22:38.243558,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_IOCTL] returning NT_STATUS_OK
>[2022/07/15 16:22:38.244525,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_CREATE]
>[2022/07/15 16:22:38.303710,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_CREATE] returning NT_STATUS_OK
>[2022/07/15 16:22:38.305087,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_WRITE]
>[2022/07/15 16:22:38.322445,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_WRITE] returning NT_STATUS_OK
>[2022/07/15 16:22:38.362172,  0, pid=10379] ../../source3/smbd/smbXsrv_client.c:824(smbXsrv_client_create)
>  smbXsrv_client_create: ### client_guid[00000000-0000-0000-0000-000000000000] created
>[2022/07/15 16:22:38.384119,  0, pid=10380] ../../source3/smbd/smbXsrv_client.c:824(smbXsrv_client_create)
>  smbXsrv_client_create: ### client_guid[00000000-0000-0000-0000-000000000000] created
>[2022/07/15 16:22:38.386231,  0, pid=10380] ../../source3/smbd/process.c:4025(smbd_process)
>  smbd_process: ### created new smbd_server_connection 0x1a941bc0
>[2022/07/15 16:22:38.396130,  0, pid=10378] ../../source3/smbd/smbXsrv_client.c:824(smbXsrv_client_create)
>  smbXsrv_client_create: ### client_guid[00000000-0000-0000-0000-000000000000] created
>[2022/07/15 16:22:38.398285,  0, pid=10378] ../../source3/smbd/process.c:4025(smbd_process)
>  smbd_process: ### created new smbd_server_connection 0x1a941900
>[2022/07/15 16:22:38.400399,  0, pid=10379] ../../source3/smbd/process.c:4025(smbd_process)
>  smbd_process: ### created new smbd_server_connection 0x1a941a60
>[2022/07/15 16:22:38.404665,  0, pid=10382] ../../source3/smbd/smbXsrv_client.c:824(smbXsrv_client_create)
>  smbXsrv_client_create: ### client_guid[00000000-0000-0000-0000-000000000000] created
>[2022/07/15 16:22:38.412319,  0, pid=10382] ../../source3/smbd/process.c:4025(smbd_process)
>  smbd_process: ### created new smbd_server_connection 0x1a941e80
>[2022/07/15 16:22:38.415704,  0, pid=10381] ../../source3/smbd/smbXsrv_client.c:824(smbXsrv_client_create)
>  smbXsrv_client_create: ### client_guid[00000000-0000-0000-0000-000000000000] created
>[2022/07/15 16:22:38.418109,  0, pid=10381] ../../source3/smbd/process.c:4025(smbd_process)
>  smbd_process: ### created new smbd_server_connection 0x1a941d20
>[2022/07/15 16:22:38.475422,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:38.476500,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_READ]
>[2022/07/15 16:22:38.508222,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_READ] returning NT_STATUS_OK
>[2022/07/15 16:22:38.541806,  0, pid=10379] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:38.547807,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_IOCTL]
>[2022/07/15 16:22:38.550620,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_IOCTL] returning NT_STATUS_OK
>[2022/07/15 16:22:38.552690,  0, pid=10378] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:38.523496,  0, pid=10380] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:38.566196,  0, pid=10381] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:38.588034,  0, pid=10382] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:38.695846,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_CLOSE]
>[2022/07/15 16:22:38.722080,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_CLOSE] returning NT_STATUS_OK
>[2022/07/15 16:22:38.865447,  0, pid=10382] ../../source3/smbd/smb2_negprot.c:801(smbd_smb2_request_process_negprot)
>  smbd_smb2_request_process_negprot: ## calling smb2srv_client_mc_negprot_send
>[2022/07/15 16:22:38.871847,  0, pid=10381] ../../source3/smbd/smb2_negprot.c:801(smbd_smb2_request_process_negprot)
>  smbd_smb2_request_process_negprot: ## calling smb2srv_client_mc_negprot_send
>[2022/07/15 16:22:38.887711,  0, pid=10381] ../../source3/smbd/smbXsrv_client.c:542(smb2srv_client_mc_negprot_next)
>  smb2srv_client_mc_negprot_next: ### not the first time
>[2022/07/15 16:22:38.892018,  0, pid=10381] ../../source3/smbd/smbXsrv_client.c:295(smb2srv_client_connection_pass)
>  smb2srv_client_connection_pass: ### connection_pass
>[2022/07/15 16:22:38.900480,  0, pid=10379] ../../source3/smbd/smb2_negprot.c:801(smbd_smb2_request_process_negprot)
>  smbd_smb2_request_process_negprot: ## calling smb2srv_client_mc_negprot_send
>[2022/07/15 16:22:38.904723,  0, pid=10380] ../../source3/smbd/smb2_negprot.c:801(smbd_smb2_request_process_negprot)
>  smbd_smb2_request_process_negprot: ## calling smb2srv_client_mc_negprot_send
>[2022/07/15 16:22:38.910833,  0, pid=10337] ../../source3/smbd/smbXsrv_client.c:861(smb2srv_client_connection_passed)
>[2022/07/15 16:22:38.911983,  0, pid=10378] ../../source3/smbd/smb2_negprot.c:801(smbd_smb2_request_process_negprot)
>  smbd_smb2_request_process_negprot: ## calling smb2srv_client_mc_negprot_send
>[2022/07/15 16:22:38.924158,  0, pid=10381] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:38.930744,  0, pid=10382] ../../source3/smbd/smbXsrv_client.c:542(smb2srv_client_mc_negprot_next)
>  smb2srv_client_mc_negprot_next: ### not the first time
>[2022/07/15 16:22:38.935034,  0, pid=10382] ../../source3/smbd/smbXsrv_client.c:295(smb2srv_client_connection_pass)
>  smb2srv_client_connection_passed: ### connection passed
>  smb2srv_client_connection_pass: ### connection_pass
>[2022/07/15 16:22:38.952149,  0, pid=10382] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:38.953733,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:38.959792,  0, pid=10379] ../../source3/smbd/smbXsrv_client.c:542(smb2srv_client_mc_negprot_next)
>  smb2srv_client_mc_negprot_next: ### not the first time
>[2022/07/15 16:22:38.963917,  0, pid=10379] ../../source3/smbd/smbXsrv_client.c:295(smb2srv_client_connection_pass)
>  smb2srv_client_connection_pass: ### connection_pass
>[2022/07/15 16:22:38.973296,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:38.975551,  0, pid=10337] ../../source3/smbd/smbXsrv_client.c:861(smb2srv_client_connection_passed)
>  smb2srv_client_connection_passed: ### connection passed
>[2022/07/15 16:22:38.977098,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:38.988195,  0, pid=10379] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:38.992415,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>[2022/07/15 16:22:38.999071,  0, pid=10380] ../../source3/smbd/smbXsrv_client.c:542(smb2srv_client_mc_negprot_next)
>  smb2srv_client_mc_negprot_next: ### not the first time
>[2022/07/15 16:22:39.003210,  0, pid=10380] ../../source3/smbd/smbXsrv_client.c:295(smb2srv_client_connection_pass)
>  smb2srv_client_connection_pass: ### connection_pass
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:39.004410,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>[2022/07/15 16:22:39.024214,  0, pid=10380] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:39.026906,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:39.033486,  0, pid=10378] ../../source3/smbd/smbXsrv_client.c:542(smb2srv_client_mc_negprot_next)
>  smb2srv_client_mc_negprot_next: ### not the first time
>[2022/07/15 16:22:39.037424,  0, pid=10378] ../../source3/smbd/smbXsrv_client.c:295(smb2srv_client_connection_pass)
>  smb2srv_client_connection_pass: ### connection_pass
>[2022/07/15 16:22:39.047554,  0, pid=10378] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:39.049486,  0, pid=10381] ../../source3/smbd/smb2_negprot.c:825(smbd_smb2_request_process_negprot_mc_done)
>  smbd_smb2_request_process_negprot_mc_done: ### mc_negprot done with status NT_STATUS_MESSAGE_RETRIEVED
>[2022/07/15 16:22:39.052069,  0, pid=10382] ../../source3/smbd/smb2_negprot.c:825(smbd_smb2_request_process_negprot_mc_done)
>[2022/07/15 16:22:39.052595,  0, pid=10381] ../../source3/smbd/server_exit.c:257(smbd_exit_server_cleanly)
>  smbd_smb2_request_process_negprot_mc_done: ### mc_negprot done with status NT_STATUS_MESSAGE_RETRIEVED
>  smbd_exit_server_cleanly: #### exiting because passed connection
>[2022/07/15 16:22:39.055040,  0, pid=10382] ../../source3/smbd/server_exit.c:257(smbd_exit_server_cleanly)
>  smbd_exit_server_cleanly: #### exiting because passed connection
>[2022/07/15 16:22:39.074526,  0, pid=10337] ../../source3/smbd/smbXsrv_client.c:861(smb2srv_client_connection_passed)
>  smb2srv_client_connection_passed: ### connection passed
>[2022/07/15 16:22:39.084838,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:39.104104,  0, pid=10379] ../../source3/smbd/smb2_negprot.c:825(smbd_smb2_request_process_negprot_mc_done)
>  smbd_smb2_request_process_negprot_mc_done: ### mc_negprot done with status NT_STATUS_MESSAGE_RETRIEVED
>[2022/07/15 16:22:39.106816,  0, pid=10379] ../../source3/smbd/server_exit.c:257(smbd_exit_server_cleanly)
>  smbd_exit_server_cleanly: #### exiting because passed connection
>[2022/07/15 16:22:39.120022,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:39.121135,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>[2022/07/15 16:22:39.177525,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:39.226377,  0, pid=10337] ../../source3/smbd/smbXsrv_client.c:861(smb2srv_client_connection_passed)
>  smb2srv_client_connection_passed: ### connection passed
>[2022/07/15 16:22:39.227961,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:39.266521,  0, pid=10380] ../../source3/smbd/smb2_negprot.c:825(smbd_smb2_request_process_negprot_mc_done)
>  smbd_smb2_request_process_negprot_mc_done: ### mc_negprot done with status NT_STATUS_MESSAGE_RETRIEVED
>[2022/07/15 16:22:39.268195,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:39.276202,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>[2022/07/15 16:22:39.293552,  0, pid=10380] ../../source3/smbd/server_exit.c:257(smbd_exit_server_cleanly)
>  smbd_exit_server_cleanly: #### exiting because passed connection
>[2022/07/15 16:22:39.324222,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:39.358185,  0, pid=10337] ../../source3/smbd/smbXsrv_client.c:861(smb2srv_client_connection_passed)
>  smb2srv_client_connection_passed: ### connection passed
>[2022/07/15 16:22:39.360018,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_NEGPROT]
>[2022/07/15 16:22:39.393880,  0, pid=10378] ../../source3/smbd/smb2_negprot.c:825(smbd_smb2_request_process_negprot_mc_done)
>[2022/07/15 16:22:39.395206,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_NEGPROT] returning NT_STATUS_OK
>[2022/07/15 16:22:39.396538,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>  smbd_smb2_request_process_negprot_mc_done: ### mc_negprot done with status NT_STATUS_MESSAGE_RETRIEVED
>[2022/07/15 16:22:39.406837,  0, pid=10378] ../../source3/smbd/server_exit.c:257(smbd_exit_server_cleanly)
>  smbd_exit_server_cleanly: #### exiting because passed connection
>[2022/07/15 16:22:39.453225,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:39.505867,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_SESSSETUP]
>[2022/07/15 16:22:39.530848,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_SESSSETUP] returning NT_STATUS_OK
>[2022/07/15 16:22:39.932916,  0, pid=10349] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:40.476820,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:41.935584,  0, pid=10349] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:42.479758,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:43.938305,  0, pid=10349] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:44.484313,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:45.941202,  0, pid=10349] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:46.486504,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:47.476608,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_CREATE]
>[2022/07/15 16:22:47.484363,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_CREATE] returning NT_STATUS_OK
>[2022/07/15 16:22:47.485845,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_WRITE]
>[2022/07/15 16:22:47.487943,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_WRITE] returning NT_STATUS_OK
>[2022/07/15 16:22:47.494705,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_READ]
>[2022/07/15 16:22:47.497048,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_READ] returning NT_STATUS_OK
>[2022/07/15 16:22:47.501206,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_IOCTL]
>[2022/07/15 16:22:47.502895,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_IOCTL] returning NT_STATUS_OK
>[2022/07/15 16:22:47.514094,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_CLOSE]
>[2022/07/15 16:22:47.516874,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_CLOSE] returning NT_STATUS_OK
>[2022/07/15 16:22:47.944397,  0, pid=10349] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 1
>[2022/07/15 16:22:48.488201,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:49.106546,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_TDIS]
>[2022/07/15 16:22:49.115051,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_TDIS] returning NT_STATUS_OK
>[2022/07/15 16:22:49.119063,  0, pid=10349] ../../source3/smbd/smbXsrv_tcon.c:904(smbXsrv_tcon_disconnect)
>[2022/07/15 16:22:49.119927,  0, pid=10337] ../../source3/smbd/smbXsrv_tcon.c:904(smbXsrv_tcon_disconnect)
>  smbXsrv_tcon_disconnect: ### got disconnect for 0x1aa3c5d0
>  smbXsrv_tcon_disconnect: ### got disconnect for 0x1a9cea60
>[2022/07/15 16:22:49.122279,  0, pid=10349] ../../source3/smbd/smbXsrv_tcon.c:911(smbXsrv_tcon_disconnect)
>[2022/07/15 16:22:49.122473,  0, pid=10337] ../../source3/smbd/smbXsrv_tcon.c:911(smbXsrv_tcon_disconnect)
>  smbXsrv_tcon_disconnect: ## 0
>  smbXsrv_tcon_disconnect: ## 0
>[2022/07/15 16:22:49.124338,  0, pid=10337] ../../source3/smbd/smbXsrv_tcon.c:918(smbXsrv_tcon_disconnect)
>[2022/07/15 16:22:49.124338,  0, pid=10349] ../../source3/smbd/smbXsrv_tcon.c:918(smbXsrv_tcon_disconnect)
>  #### smbXsrv_tcon_disconnect(0x0f60508d, 'IPC$'): chdir_current_service() failed: NT_STATUS_INTERNAL_ERROR
>  #### smbXsrv_tcon_disconnect(0x06f91310, 'IPC$'): chdir_current_service() failed: NT_STATUS_INTERNAL_ERROR
>[2022/07/15 16:22:49.128251,  0, pid=10349] ../../source3/smbd/server_exit.c:251(smbd_exit_server)
>  smbd_exit_server: #### exiting because ../../source3/smbd/reply.c:6314: smbXsrv_tcon_disconnect failed
>[2022/07/15 16:22:49.130513,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_LOGOFF]
>[2022/07/15 16:22:49.134720,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_LOGOFF] returning NT_STATUS_OK
>[2022/07/15 16:22:49.168040,  0, pid=10349] ../../lib/util/fault.c:172(smb_panic_log)
>  ===============================================================
>[2022/07/15 16:22:49.169265,  0, pid=10349] ../../lib/util/fault.c:176(smb_panic_log)
>  INTERNAL ERROR: ../../source3/smbd/reply.c:6314: smbXsrv_tcon_disconnect failed in pid 10349 (4.15.4)
>[2022/07/15 16:22:49.170166,  0, pid=10349] ../../lib/util/fault.c:181(smb_panic_log)
>  If you are running a recent Samba version, and if you think this problem is not yet fixed in the latest versions, please consider reporting this bug, see https://wiki.samba.org/index.php/Bug_Reporting
>[2022/07/15 16:22:49.170994,  0, pid=10349] ../../lib/util/fault.c:182(smb_panic_log)
>  ===============================================================
>[2022/07/15 16:22:49.171867,  0, pid=10349] ../../lib/util/fault.c:184(smb_panic_log)
>  PANIC (pid 10349): ../../source3/smbd/reply.c:6314: smbXsrv_tcon_disconnect failed in 4.15.4
>[2022/07/15 16:22:49.206887,  0, pid=10349] ../../lib/util/fault.c:288(log_stack_trace)
>  BACKTRACE: 38 stack frames:
>   #0 /root/suse-sle15-sp3/bin/shared/libsamba-util.so.0(log_stack_trace+0x1f) [0x5876ab9]
>   #1 /root/suse-sle15-sp3/bin/shared/libsamba-util.so.0(smb_panic_log+0x1b1) [0x5876a4d]
>   #2 /root/suse-sle15-sp3/bin/shared/libsamba-util.so.0(smb_panic+0x18) [0x5876a68]
>   #3 /root/suse-sle15-sp3/bin/shared/private/libsmbd-base-samba4.so(+0x1e9301) [0x5230301]
>   #4 /root/suse-sle15-sp3/bin/shared/private/libsmbd-base-samba4.so(smbd_exit_server_cleanly+0) [0x523041e]
>   #5 /root/suse-sle15-sp3/bin/shared/private/libsmbd-shim-samba4.so(exit_server+0x28) [0x847ba8b]
>   #6 /root/suse-sle15-sp3/bin/shared/private/libsmbd-base-samba4.so(+0x125f66) [0x516cf66]
>   #7 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_req_notify_callback+0x6a) [0x634eb2b]
>   #8 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0x9c8c) [0x634ec8c]
>   #9 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_req_done+0x25) [0x634ecb9]
>   #10 /root/suse-sle15-sp3/bin/shared/private/libsmbd-base-samba4.so(+0x125ca5) [0x516cca5]
>   #11 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_req_notify_callback+0x6a) [0x634eb2b]
>   #12 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0x9c8c) [0x634ec8c]
>   #13 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_req_done+0x25) [0x634ecb9]
>   #14 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0x94df) [0x634e4df]
>   #15 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0x8f10) [0x634df10]
>   #16 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(tevent_common_invoke_immediate_handler+0x1b5) [0x634d9d8]
>   #17 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(tevent_common_loop_immediate+0x37) [0x634db27]
>   #18 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0x12f89) [0x6357f89]
>   #19 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0xf9bc) [0x63549bc]
>   #20 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_loop_once+0x10f) [0x634bfc8]
>   #21 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(tevent_common_loop_wait+0x25) [0x634c2e3]
>   #22 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0xfa5e) [0x6354a5e]
>   #23 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_loop_wait+0x2b) [0x634c386]
>   #24 /root/suse-sle15-sp3/bin/shared/private/libsmbd-base-samba4.so(smbd_process+0xd59) [0x51dabd5]
>   #25 ./bin/smbd(+0xe289) [0x116289]
>   #26 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(tevent_common_invoke_fd_handler+0x11d) [0x634d0f7]
>   #27 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0x129dc) [0x63579dc]
>   #28 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0x13023) [0x6358023]
>   #29 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0xf9bc) [0x63549bc]
>   #30 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_loop_once+0x10f) [0x634bfc8]
>   #31 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(tevent_common_loop_wait+0x25) [0x634c2e3]
>   #32 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(+0xfa5e) [0x6354a5e]
>   #33 /root/suse-sle15-sp3/bin/shared/private/libtevent.so.0(_tevent_loop_wait+0x2b) [0x634c386]
>   #34 ./bin/smbd(+0xef11) [0x116f11]
>   #35 ./bin/smbd(main+0x1a14) [0x1191e4]
>   #36 /lib64/libc.so.6(__libc_start_main+0xef) [0x8d122bd]
>   #37 ./bin/smbd(_start+0x2a) [0x10f1aa]
>[2022/07/15 16:22:49.218975,  0, pid=10349] ../../source3/lib/util.c:693(smb_panic_s3)
>  smb_panic(): calling panic action [/bin/sleep 90000]
>[2022/07/15 16:22:50.490717,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:52.493214,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:54.495579,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:56.498277,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:58.501449,  0, pid=10337] ../../source3/smbd/process.c:2924(deadtime_fn)
>  deadtime_fn: ## num open conns = 2
>[2022/07/15 16:22:59.856391,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_TDIS]
>[2022/07/15 16:22:59.857806,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_TDIS] returning NT_STATUS_OK
>[2022/07/15 16:22:59.858557,  0, pid=10337] ../../source3/smbd/smbXsrv_tcon.c:904(smbXsrv_tcon_disconnect)
>  smbXsrv_tcon_disconnect: ### got disconnect for 0x1aaf2580
>[2022/07/15 16:22:59.859252,  0, pid=10337] ../../source3/smbd/smbXsrv_tcon.c:911(smbXsrv_tcon_disconnect)
>  smbXsrv_tcon_disconnect: ## 1
>[2022/07/15 16:22:59.873148,  0, pid=10337] ../../source3/smbd/conn.c:235(conn_free)
>  conn_free: ## sconn 0x1a941640 removed connection 0x1aaf2580, num conns = 1
>[2022/07/15 16:22:59.885252,  0, pid=10337] ../../source3/smbd/smb2_server.c:3056(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: about to call opcode[SMB2_OP_LOGOFF]
>[2022/07/15 16:22:59.886083,  0, pid=10337] ../../source3/smbd/smb2_server.c:3535(smbd_smb2_request_dispatch)
>  smbd_smb2_request_dispatch: #### smbd_smb2_request_dispatch: [SMB2_OP_LOGOFF] returning NT_STATUS_OK
>[2022/07/15 16:22:59.911227,  0, pid=10337] ../../source3/smbd/server_exit.c:257(smbd_exit_server_cleanly)
>  smbd_exit_server_cleanly: #### exiting because NT_STATUS_CONNECTION_RESET

Actions: View

Attachments on bug 15128: 17440 | 17441 | 17442 | 17443 | 17444 | 17457 | 17458 | 17459 | 17478 | 17479 | 17481 | 17482 | 17483