[Samba] User's DPAPI/backupkey protected data lost when changing domain password

William Ross william.ross at mercedes-benzsouthwest.co.uk
Mon Nov 10 07:48:12 MST 2014 

After a user changes their password (CTRL-ALT-DEL) in our Samba 4 domain
(4.1.12) they lose access to any stored passwords on their Windows PC.

I've set the log level in smb.conf to 4 and enabled the GPO to record DPAPI
log entries in Windows to get the below log data.

My reading of the two is that the Windows PC believes it is failing to reset
the access to its DPAPI store (where the saved passwords are kept) - hence
the repitition in the samba log and the Windows event log as the client
tries over-and-over again. I don't see any specific error in the samba log
though.

Any advice on getting this backupkey/DPAPI functionality to work very much
appreciated.

In the below the domain controller is
soda.mbsw.prv.mercedes-benzsouthwest.co.uk and the client is ex-wrk-11, the
user whose password is being changed is wtr30.


Audit failure log entries in Windows Event Viewer (from Windows 7 Pro PC),
there are nine entries total but the other seven appear to be duplicates of
the two below:

Log Name:      Security
Source:        Microsoft-Windows-Security-Auditing
Date:          10/11/2014 13:56:43
Event ID:      4692
Task Category: DPAPI Activity
Level:         Information
Keywords:      Audit Failure
User:          N/A
Computer:      ex-lap-11.mbsw.prv.mercedes-benzsouthwest.co.uk
Description:
Backup of data protection master key was attempted.

Subject:
	Security ID:		MBSW\wtr30
	Account Name:		wtr30
	Account Domain:		MBSW
	Logon ID:		0x28b53

Key Information:
	Key Identifier:	1668a88c-71a7-4a52-a842-dcb709965555
	Recovery Server:	\\soda.mbsw.prv.mercedes-benzsouthwest.co.uk
	Recovery Key ID:	

Status Information:
	Status Code:	0x57
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Microsoft-Windows-Security-Auditing"
Guid="{54849625-5478-4994-A5BA-3E3B0328C30D}" />
    <EventID>4692</EventID>
    <Version>0</Version>
    <Level>0</Level>
    <Task>13314</Task>
    <Opcode>0</Opcode>
    <Keywords>0x8010000000000000</Keywords>
    <TimeCreated SystemTime="2014-11-10T13:56:43.416299900Z" />
    <EventRecordID>1607</EventRecordID>
    <Correlation />
    <Execution ProcessID="580" ThreadID="2792" />
    <Channel>Security</Channel>
    <Computer>ex-lap-11.mbsw.prv.mercedes-benzsouthwest.co.uk</Computer>
    <Security />
  </System>
  <EventData>
    <Data
Name="SubjectUserSid">S-1-5-21-447411674-2312009110-1666944656-1158</Data>
    <Data Name="SubjectUserName">wtr30</Data>
    <Data Name="SubjectDomainName">MBSW</Data>
    <Data Name="SubjectLogonId">0x28b53</Data>
    <Data Name="MasterKeyId">1668a88c-71a7-4a52-a842-dcb709965555</Data>
    <Data
Name="RecoveryServer">\\soda.mbsw.prv.mercedes-benzsouthwest.co.uk</Data>
    <Data Name="RecoveryKeyId">
    </Data>
    <Data Name="FailureReason">0x57</Data>
  </EventData>
</Event>


Log Name:      Security
Source:        Microsoft-Windows-Security-Auditing
Date:          10/11/2014 13:56:43
Event ID:      4692
Task Category: DPAPI Activity
Level:         Information
Keywords:      Audit Failure
User:          N/A
Computer:      ex-lap-11.mbsw.prv.mercedes-benzsouthwest.co.uk
Description:
Backup of data protection master key was attempted.

Subject:
	Security ID:		MBSW\wtr30
	Account Name:		wtr30
	Account Domain:		MBSW
	Logon ID:		0x3f212

Key Information:
	Key Identifier:	1668a88c-71a7-4a52-a842-dcb709965555
	Recovery Server:	
	Recovery Key ID:	

Status Information:
	Status Code:	0x7a
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Microsoft-Windows-Security-Auditing"
Guid="{54849625-5478-4994-A5BA-3E3B0328C30D}" />
    <EventID>4692</EventID>
    <Version>0</Version>
    <Level>0</Level>
    <Task>13314</Task>
    <Opcode>0</Opcode>
    <Keywords>0x8010000000000000</Keywords>
    <TimeCreated SystemTime="2014-11-10T13:56:43.494300000Z" />
    <EventRecordID>1608</EventRecordID>
    <Correlation />
    <Execution ProcessID="580" ThreadID="632" />
    <Channel>Security</Channel>
    <Computer>ex-lap-11.mbsw.prv.mercedes-benzsouthwest.co.uk</Computer>
    <Security />
  </System>
  <EventData>
    <Data
Name="SubjectUserSid">S-1-5-21-447411674-2312009110-1666944656-1158</Data>
    <Data Name="SubjectUserName">wtr30</Data>
    <Data Name="SubjectDomainName">MBSW</Data>
    <Data Name="SubjectLogonId">0x3f212</Data>
    <Data Name="MasterKeyId">1668a88c-71a7-4a52-a842-dcb709965555</Data>
    <Data Name="RecoveryServer">
    </Data>
    <Data Name="RecoveryKeyId">
    </Data>
    <Data Name="FailureReason">0x7a</Data>
  </EventData>
</Event>


Corresponding entries in /usr/local/samba/var/log.samba:

[2014/11/10 13:56:43.735766,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ wtr30 at MBSW from ipv4:53.253.137.105:62425 for
kadmin/changepw at MBSW
[2014/11/10 13:56:43.739991,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client sent patypes: 128
[2014/11/10 13:56:43.740055,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for PKINIT pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.740103,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for ENC-TS pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.740166,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: No preauth found, returning PREAUTH-REQUIRED -- wtr30 at MBSW
[2014/11/10 13:56:43.740736,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.740838,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:43.741188,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ wtr30 at MBSW from ipv4:53.253.137.105:62426 for
kadmin/changepw at MBSW
[2014/11/10 13:56:43.744834,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client sent patypes: encrypted-timestamp, 128
[2014/11/10 13:56:43.744899,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for PKINIT pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.744947,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for ENC-TS pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.745043,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: ENC-TS Pre-authentication succeeded -- wtr30 at MBSW using
arcfour-hmac-md5
[2014/11/10 13:56:43.745114,  4]
../source4/auth/sam.c:170(authsam_account_ok)
  authsam_account_ok: Checking SMB password for user wtr30 at MBSW
[2014/11/10 13:56:43.747137,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ authtime: 2014-11-10T13:56:43 starttime: unset endtime:
2014-11-10T23:56:43 renew till: 2014-11-17T13:56:43
[2014/11/10 13:56:43.747249,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client supported enctypes: aes256-cts-hmac-sha1-96,
aes128-cts-hmac-sha1-96, arcfour-hmac-md5, 24, -135, des-cbc-md5, using
arcfour-hmac-md5/arcfour-hmac-md5
[2014/11/10 13:56:43.747308,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Requested flags: renewable-ok, renewable, forwardable
[2014/11/10 13:56:43.748107,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.748178,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:43.751877,  3]
../auth/kerberos/kerberos_pac.c:386(kerberos_decode_pac)
  Found account name from PAC: wtr30 [William Ross]
[2014/11/10 13:56:43.758686,  3]
../source4/kdc/kpasswdd.c:206(kpasswdd_change_password)
  Changing password of MBSW\wtr30
(S-1-5-21-447411674-2312009110-1666944656-1158)
[2014/11/10 13:56:43.858238,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.858337,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:43.869756,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK from
ipv4:53.253.137.105:62428 for
krbtgt/MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK at MBSW.PRV.MERCEDES-BENZSOUTHWEST
.CO.UK
[2014/11/10 13:56:43.871740,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client sent patypes: encrypted-timestamp, 128
[2014/11/10 13:56:43.871804,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for PKINIT pa-data --
wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK
[2014/11/10 13:56:43.871853,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for ENC-TS pa-data --
wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK
[2014/11/10 13:56:43.871931,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: ENC-TS Pre-authentication succeeded --
wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK using arcfour-hmac-md5
[2014/11/10 13:56:43.871982,  4]
../source4/auth/sam.c:170(authsam_account_ok)
  authsam_account_ok: Checking SMB password for user
wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK
[2014/11/10 13:56:43.874114,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ authtime: 2014-11-10T13:56:43 starttime: unset endtime:
2014-11-10T23:56:43 renew till: 2014-11-17T13:56:43
[2014/11/10 13:56:43.874218,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client supported enctypes: aes256-cts-hmac-sha1-96,
aes128-cts-hmac-sha1-96, arcfour-hmac-md5, 24, -135, des-cbc-md5, using
arcfour-hmac-md5/arcfour-hmac-md5
[2014/11/10 13:56:43.874277,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Requested flags: renewable-ok, canonicalize, renewable,
forwardable
[2014/11/10 13:56:43.874957,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.875040,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:43.881593,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK from
ipv4:53.253.137.105:62429 for wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK
[enc-tkt-in-skey, canonicalize, renewable, forwardable]
[2014/11/10 13:56:43.883859,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Principal may not act as server --
wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK
[2014/11/10 13:56:43.883954,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Failed building TGS-REP to ipv4:53.253.137.105:62429
[2014/11/10 13:56:43.884544,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.884611,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:43.898985,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ wtr30 at MBSW from ipv4:53.253.137.105:62430 for
krbtgt/MBSW at MBSW
[2014/11/10 13:56:43.901569,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client sent patypes: 128
[2014/11/10 13:56:43.901634,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for PKINIT pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.901683,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for ENC-TS pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.901740,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: No preauth found, returning PREAUTH-REQUIRED -- wtr30 at MBSW
[2014/11/10 13:56:43.902084,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.902178,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:43.902682,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ wtr30 at MBSW from ipv4:53.253.137.105:62431 for
krbtgt/MBSW at MBSW
[2014/11/10 13:56:43.905275,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client sent patypes: encrypted-timestamp, 128
[2014/11/10 13:56:43.905340,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for PKINIT pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.905388,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Looking for ENC-TS pa-data -- wtr30 at MBSW
[2014/11/10 13:56:43.905606,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: ENC-TS Pre-authentication succeeded -- wtr30 at MBSW using
arcfour-hmac-md5
[2014/11/10 13:56:43.905663,  4]
../source4/auth/sam.c:170(authsam_account_ok)
  authsam_account_ok: Checking SMB password for user wtr30 at MBSW
[2014/11/10 13:56:43.907687,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: AS-REQ authtime: 2014-11-10T13:56:43 starttime: unset endtime:
2014-11-10T23:56:43 renew till: 2014-11-17T13:56:43
[2014/11/10 13:56:43.907790,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Client supported enctypes: aes256-cts-hmac-sha1-96,
aes128-cts-hmac-sha1-96, arcfour-hmac-md5, 24, -135, des-cbc-md5, using
arcfour-hmac-md5/arcfour-hmac-md5
[2014/11/10 13:56:43.907847,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: Requested flags: renewable-ok, canonicalize, renewable,
forwardable
[2014/11/10 13:56:43.908370,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.908434,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:43.909184,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK from
ipv4:53.253.137.105:62432 for
host/ex-lap-11.mbsw.prv.mercedes-benzsouthwest.co.uk at MBSW.PRV.MERCEDES-BENZS
OUTHWEST.CO.UK [canonicalize, renewable, forwardable]
[2014/11/10 13:56:43.912187,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ authtime: 2014-11-10T13:56:43 starttime:
2014-11-10T13:56:43 endtime: 2014-11-10T23:56:43 renew till:
2014-11-17T13:56:43
[2014/11/10 13:56:43.912745,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:43.912812,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.028220,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.034589,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.034653,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.034690,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1299(dcesrv_bkrp_BackupKe
y)
  Client unknown requested certificate for client wrapped secret
[2014/11/10 13:56:44.036202,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.036309,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.068981,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK from
ipv4:53.253.137.105:62434 for
cifs/soda.mbsw.prv.mercedes-benzsouthwest.co.uk at MBSW.PRV.MERCEDES-BENZSOUTHW
EST.CO.UK [canonicalize, renewable, forwardable]
[2014/11/10 13:56:44.072197,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ authtime: 2014-11-10T13:56:43 starttime:
2014-11-10T13:56:44 endtime: 2014-11-10T23:56:43 renew till:
2014-11-17T13:56:43
[2014/11/10 13:56:44.072883,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.072980,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.073786,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK from
ipv4:53.253.137.105:62435 for
krbtgt/MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK at MBSW.PRV.MERCEDES-BENZSOUTHWEST
.CO.UK [renewable-ok, canonicalize, renewable, forwarded, forwardable]
[2014/11/10 13:56:44.075901,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ authtime: 2014-11-10T13:56:43 starttime:
2014-11-10T13:56:44 endtime: 2014-11-10T23:56:43 renew till:
2014-11-17T13:56:43
[2014/11/10 13:56:44.076429,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.076665,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.081808,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.092557,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.092625,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.097480,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'wbsrv: wbsrv_call_loop:
tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.097559,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[wbsrv: wbsrv_call_loop:
tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.102593,  4]
../source4/lib/socket/interface.c:121(add_interface)
  added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0
[2014/11/10 13:56:44.103742,  4]
../source4/lib/socket/interface.c:121(add_interface)
  added interface eth0 ip=53.253.137.16 bcast=53.253.137.255
netmask=255.255.255.0
[2014/11/10 13:56:44.113156,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ wtr30 at MBSW.PRV.MERCEDES-BENZSOUTHWEST.CO.UK from
ipv4:53.253.137.105:62436 for
ProtectedStorage/soda.mbsw.prv.mercedes-benzsouthwest.co.uk at MBSW.PRV.MERCEDE
S-BENZSOUTHWEST.CO.UK [canonicalize, renewable, forwardable]
[2014/11/10 13:56:44.116345,  3]
../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
  Kerberos: TGS-REQ authtime: 2014-11-10T13:56:43 starttime:
2014-11-10T13:56:44 endtime: 2014-11-10T23:56:43 renew till:
2014-11-17T13:56:43
[2014/11/10 13:56:44.117107,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv()
- NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.117176,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() -
NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.117750,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.124196,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 16 extra bytes in incoming RPC request
[2014/11/10 13:56:44.124260,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.124296,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1299(dcesrv_bkrp_BackupKe
y)
  Client unknown requested certificate for client wrapped secret
[2014/11/10 13:56:44.125894,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.126015,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.126328,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.126424,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.171604,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.177638,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.177700,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.178375,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.178601,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.183743,  4]
../source4/lib/socket/interface.c:121(add_interface)
  added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0
[2014/11/10 13:56:44.183817,  4]
../source4/lib/socket/interface.c:121(add_interface)
  added interface eth0 ip=53.253.137.16 bcast=53.253.137.255
netmask=255.255.255.0
[2014/11/10 13:56:44.206407,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.212393,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.212519,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.213259,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.213365,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.284671,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.290683,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.290744,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.291554,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.291658,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.399861,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.405971,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.406033,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.406068,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1299(dcesrv_bkrp_BackupKe
y)
  Client unknown requested certificate for client wrapped secret
[2014/11/10 13:56:44.407646,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.407750,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.449983,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.456089,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.456151,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.456814,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.456919,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:44.462414,  4]
../source4/lib/socket/interface.c:121(add_interface)
  added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0
[2014/11/10 13:56:44.462505,  4]
../source4/lib/socket/interface.c:121(add_interface)
  added interface eth0 ip=53.253.137.16 bcast=53.253.137.255
netmask=255.255.255.0
[2014/11/10 13:56:44.565691,  3]
../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect)
  ldb_wrap open of secrets.ldb
[2014/11/10 13:56:44.572159,  3]
../source4/rpc_server/dcerpc_server.c:963(dcesrv_request)
  Warning: 60 extra bytes in incoming RPC request
[2014/11/10 13:56:44.572221,  4]
../source4/rpc_server/backupkey/dcesrv_backupkey.c:1263(dcesrv_bkrp_BackupKe
y)
[2014/11/10 13:56:44.573195,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'dcesrv: NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:44.573300,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[dcesrv: NT_STATUS_CONNECTION_DISCONNECTED]
[2014/11/10 13:56:45.333280,  3]
../source4/smbd/service_stream.c:66(stream_terminate_connection)
  Terminating connection - 'wbsrv: wbsrv_call_loop:
tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
[2014/11/10 13:56:45.333339,  3]
../source4/smbd/process_single.c:114(single_terminate)
  single_terminate: reason[wbsrv: wbsrv_call_loop:
tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]

More information about the samba mailing list