[Samba] domain won't go online

Brian J. Murrell brian at interlinx.bc.ca
Thu May 30 14:44:47 UTC 2019


Hi.  I'm hoping for some advise/help.

I have a domain that won't seem to go online:

$ wbinfo --online-status
BUILTIN : active connection
MY-HOST : active connection
FOO : no active connection

The log for the domain repeats over and over again:

[2019/05/30 09:34:10.259173,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:34:10.259208,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:10.259358, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782a960]: subreq: 0x55c027834570
[2019/05/30 09:34:10.259398, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c027833770]: subreq: 0x55c0278353e0
[2019/05/30 09:34:10.259446, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782a960]: NT_STATUS_OK tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:34:10.259513, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c027833770]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c0278353e0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c027835590)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:10.371447,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:10.371594,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:10.371668,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:10.372071,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:10.372293, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:34:10.634865, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:34:10.635006, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:34:10.817387,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:34:11.028281,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:34:11.028329,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:34:11.028512,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:34:11.028531,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:34:11.028551, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782a960]: subreq: 0x55c027834570
[2019/05/30 09:34:11.028573, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c02780da30]: subreq: 0x55c02780df30
[2019/05/30 09:34:11.028589, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782a960]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:34:11.028611, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c02780da30]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02780df30/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02780e0e0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:11.119043,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:34:11.119131,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:11.119363,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:34:11.119404,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:34:11.119546,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:34:11.119580,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:11.119672,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:34:11.119703,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:11.119893, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782a960]: subreq: 0x55c027813140
[2019/05/30 09:34:11.119932, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c02780da30]: subreq: 0x55c02780df30
[2019/05/30 09:34:11.119976, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782a960]: NT_STATUS_OK tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:34:11.120060, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c02780da30]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02780df30/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02780e0e0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:11.222624,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:11.222843,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:11.222917,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:11.223173,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:11.223376, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:34:11.460655, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:34:11.460698, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:34:11.664428,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:34:11.877817,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:34:11.877984,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:34:11.879008,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:34:11.879068,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:34:11.879135, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0278231d0]: subreq: 0x55c027813140
[2019/05/30 09:34:11.879176, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c02782a960]: subreq: 0x55c02782a4f0
[2019/05/30 09:34:11.879226, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0278231d0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:34:11.879319, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c02782a960]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02782a4f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02782a6a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:11.959138,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:34:11.959222,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:11.959457,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:34:11.959497,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:34:11.959638,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:34:11.959672,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:11.959820,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:34:11.959855,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:11.959968, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0278231d0]: subreq: 0x55c027834570
[2019/05/30 09:34:11.960003, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c02782a960]: subreq: 0x55c02782a4f0
[2019/05/30 09:34:11.960047, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0278231d0]: NT_STATUS_OK tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:34:11.960107, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c02782a960]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02782a4f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02782a6a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:12.094968,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:12.095121,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:12.095181,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:12.095412,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:12.095591, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:406(set_domain_offline)
  set_domain_offline: called for domain FOO
[2019/05/30 09:34:12.095637, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:450(set_domain_offline)
  set_domain_offline: added event handler for domain FOO
[2019/05/30 09:34:42.117982, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:311(check_domain_online_handler)
  check_domain_online_handler: called for domain FOO (online = False)
[2019/05/30 09:34:42.211713,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:163(msg_try_to_go_online)
  msg_try_to_go_online: received for domain FOO.
[2019/05/30 09:34:42.211925,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:2147(connection_ok)
  connection_ok: Connection to SCSFOO402.foo.corp.example.com for domain FOO is not connected
[2019/05/30 09:34:42.212008, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:34:42.485855, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:34:42.486004, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC casfoo401.foo.corp.example.com for domain FOO
[2019/05/30 09:34:42.653003,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to casfoo401.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:34:42.840364,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:34:42.840442,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:34:42.840794,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:34:42.840831,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:34:42.840871, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0278231d0]: subreq: 0x55c027834570
[2019/05/30 09:34:42.840892, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0278102c0]: subreq: 0x55c02783c080
[2019/05/30 09:34:42.840917, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0278231d0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:34:42.840966, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0278102c0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02783c080/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02783c230)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:42.923221,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:34:42.923318,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:42.923587,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:34:42.923637,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:34:42.923882,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:34:42.923931,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:42.924035,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:34:42.924070,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:42.924196, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0278231d0]: subreq: 0x55c027813140
[2019/05/30 09:34:42.924234, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0278102c0]: subreq: 0x55c02783c080
[2019/05/30 09:34:42.924282, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0278231d0]: NT_STATUS_OK tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:34:42.924349, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0278102c0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02783c080/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02783c230)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:43.012482,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to casfoo401.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:43.012609,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:43.012677,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:43.012922,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to casfoo401.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:43.013131, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'casfoo401.foo.corp.example.com' for domain FOO
[2019/05/30 09:34:43.263682, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:34:43.263881, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:34:43.423077,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:34:43.615395,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:34:43.615551,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:34:43.616167,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:34:43.616229,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:34:43.616297, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782a960]: subreq: 0x55c027813140
[2019/05/30 09:34:43.616338, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277fda10]: subreq: 0x55c02781aa50
[2019/05/30 09:34:43.616388, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782a960]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:34:43.616460, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277fda10]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02781aa50/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02781ac00)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:43.696078,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:34:43.696196,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:43.696454,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:34:43.696499,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:34:43.696659,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:34:43.696696,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:43.696892,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:34:43.696931,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:43.697059, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782a960]: subreq: 0x55c027834570
[2019/05/30 09:34:43.697097, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277fda10]: subreq: 0x55c02781aa50
[2019/05/30 09:34:43.697145, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782a960]: NT_STATUS_OK tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:34:43.697214, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277fda10]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02781aa50/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02781ac00)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:43.783315,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:43.783465,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:43.783536,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:43.783903,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:43.784131, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:34:44.028391, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:34:44.028435, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:34:44.218523,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:34:44.413946,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:34:44.414082,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:34:44.414545,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:34:44.414595,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:34:44.414652, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0278231d0]: subreq: 0x55c027834570
[2019/05/30 09:34:44.414689, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0278397c0]: subreq: 0x55c02783a8f0
[2019/05/30 09:34:44.414751, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0278231d0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:34:44.414818, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0278397c0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02783a8f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02783aaa0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:44.494087,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:34:44.494125,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:44.494213,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:34:44.494237,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:34:44.494289,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:34:44.494301,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:44.494330,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:34:44.494340,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:34:44.494377, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0278231d0]: subreq: 0x55c027813140
[2019/05/30 09:34:44.494390, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0278397c0]: subreq: 0x55c02783a8f0
[2019/05/30 09:34:44.494404, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0278231d0]: NT_STATUS_OK tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:34:44.494440, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0278397c0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02783a8f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02783aaa0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:34:44.582423,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:44.582546,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:44.582602,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:34:44.582784,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:34:44.583008, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:406(set_domain_offline)
  set_domain_offline: called for domain FOO
[2019/05/30 09:34:44.583051, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:450(set_domain_offline)
  set_domain_offline: added event handler for domain FOO
[2019/05/30 09:35:14.612626, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:311(check_domain_online_handler)
  check_domain_online_handler: called for domain FOO (online = False)
[2019/05/30 09:35:14.699335,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:163(msg_try_to_go_online)
  msg_try_to_go_online: received for domain FOO.
[2019/05/30 09:35:14.699460,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:2147(connection_ok)
  connection_ok: Connection to SCSFOO402.foo.corp.example.com for domain FOO is not connected
[2019/05/30 09:35:14.699516, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:35:14.947543, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:35:14.947684, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:35:15.216807,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:35:15.411616,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:35:15.411864,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:35:15.412445,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:35:15.412507,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:35:15.412582, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782a960]: subreq: 0x55c027813140
[2019/05/30 09:35:15.412626, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277e2730]: subreq: 0x55c027834120
[2019/05/30 09:35:15.412679, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782a960]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:35:15.412770, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277e2730]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834120/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c0278342d0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:15.495106,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:35:15.495206,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:15.495509,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:35:15.495557,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:35:15.495719,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:35:15.495829,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:15.495936,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:35:15.495970,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:15.496096, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782a960]: subreq: 0x55c027834570
[2019/05/30 09:35:15.496134, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277e2730]: subreq: 0x55c027834120
[2019/05/30 09:35:15.496182, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782a960]: NT_STATUS_OK tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:35:15.496248, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277e2730]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834120/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c0278342d0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:15.728662,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:15.728863,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:15.728922,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:15.729134,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:15.729331, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:35:15.975268, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:35:15.975390, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:35:16.152811,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:35:16.331675,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:35:16.331902,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:35:16.332412,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:35:16.332466,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:35:16.332527, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c027833770]: subreq: 0x55c027834570
[2019/05/30 09:35:16.332564, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c02782a960]: subreq: 0x55c02780d770
[2019/05/30 09:35:16.332608, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c027833770]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:35:16.332673, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c02782a960]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02780d770/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02780d920)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:16.422549,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:35:16.422629,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:16.422900,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:35:16.422942,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:35:16.423061,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:35:16.423110,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:16.423189,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:35:16.423215,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:16.423309, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c027833770]: subreq: 0x55c027813140
[2019/05/30 09:35:16.423338, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c02782a960]: subreq: 0x55c02780d770
[2019/05/30 09:35:16.423375, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c027833770]: NT_STATUS_OK tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:35:16.423426, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c02782a960]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02780d770/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02780d920)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:16.518450,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:16.518510,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:16.518533,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:16.518636,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:16.518711, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:35:16.778605, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:35:16.778724, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:35:16.978455,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:35:17.176811,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:35:17.176994,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:35:17.177763,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:35:17.177830,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:35:17.177897, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782abd0]: subreq: 0x55c027813140
[2019/05/30 09:35:17.177939, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c027833770]: subreq: 0x55c0278221f0
[2019/05/30 09:35:17.177989, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782abd0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:35:17.178062, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c027833770]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c0278221f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c0278223a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:17.262861,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:35:17.262935,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:17.263114,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:35:17.263145,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:35:17.263253,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:35:17.263279,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:17.263349,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:35:17.263373,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:17.263479, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782abd0]: subreq: 0x55c027834570
[2019/05/30 09:35:17.263507, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c027833770]: subreq: 0x55c0278221f0
[2019/05/30 09:35:17.263541, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782abd0]: NT_STATUS_OK tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:35:17.263587, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c027833770]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c0278221f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c0278223a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:17.358485,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:17.358613,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:17.358670,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:17.359001,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:17.359220, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:406(set_domain_offline)
  set_domain_offline: called for domain FOO
[2019/05/30 09:35:17.359282, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:450(set_domain_offline)
  set_domain_offline: added event handler for domain FOO
[2019/05/30 09:35:47.388644, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:311(check_domain_online_handler)
  check_domain_online_handler: called for domain FOO (online = False)
[2019/05/30 09:35:47.487430,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:163(msg_try_to_go_online)
  msg_try_to_go_online: received for domain FOO.
[2019/05/30 09:35:47.487587,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:2147(connection_ok)
  connection_ok: Connection to SCSFOO402.foo.corp.example.com for domain FOO is not connected
[2019/05/30 09:35:47.487685, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:35:47.744713, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:35:47.744939, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:35:47.910615,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:35:48.095939,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:35:48.096068,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:35:48.096601,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:35:48.096654,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:35:48.096719, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0277fa980]: subreq: 0x55c027834570
[2019/05/30 09:35:48.096778, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277ec3b0]: subreq: 0x55c02782a4f0
[2019/05/30 09:35:48.096825, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0277fa980]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:35:48.096887, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277ec3b0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02782a4f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02782a6a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:48.180525,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:35:48.180611,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:48.180959,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:35:48.181025,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:35:48.181207,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:35:48.181247,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:48.181373,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:35:48.181409,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:48.181536, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c0277fa980]: subreq: 0x55c027813140
[2019/05/30 09:35:48.181575, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277ec3b0]: subreq: 0x55c02782a4f0
[2019/05/30 09:35:48.181623, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c0277fa980]: NT_STATUS_OK tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:35:48.181693, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277ec3b0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02782a4f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02782a6a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:48.286500,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:48.286572,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:48.286601,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:48.286722,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:48.286866, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:35:48.548883, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:35:48.549001, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:35:48.727974,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:35:48.925848,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:35:48.925967,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:35:48.926355,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:35:48.926398,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:35:48.926449, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782abd0]: subreq: 0x55c027813140
[2019/05/30 09:35:48.926479, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277fa980]: subreq: 0x55c02783d440
[2019/05/30 09:35:48.926517, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782abd0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:35:48.926571, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277fa980]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02783d440/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02783d5f0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:49.028129,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:35:49.028212,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:49.028471,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:35:49.028522,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:35:49.028658,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:35:49.028688,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:49.028855,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:35:49.028913,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:49.029014, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782abd0]: subreq: 0x55c027834570
[2019/05/30 09:35:49.029060, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c0277fa980]: subreq: 0x55c02783d440
[2019/05/30 09:35:49.029099, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782abd0]: NT_STATUS_OK tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:35:49.029152, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c0277fa980]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02783d440/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02783d5f0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:49.134489,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:49.134611,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:49.134665,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:49.134958,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:49.135124, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1945(cm_open_connection)
  cm_open_connection: dcname is 'SCSFOO402.foo.corp.example.com' for domain FOO
[2019/05/30 09:35:49.387231, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1432(dcip_check_name)
  dcip_check_name: flags = 0xf1fc
[2019/05/30 09:35:49.387345, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1050(cm_prepare_connection)
  cm_prepare_connection: connecting to DC SCSFOO402.foo.corp.example.com for domain FOO
[2019/05/30 09:35:49.557578,  5, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1146(cm_prepare_connection)
  connecting to SCSFOO402.foo.corp.example.com (FOO, FOO.CORP.EXAMPLE.COM) with account [FOO\MY-HOST$] principal [MY-HOST$@FOO.CORP.EXAMPLE.COM] and realm [FOO.CORP.EXAMPLE.COM]
[2019/05/30 09:35:49.757468,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2019/05/30 09:35:49.757599,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism gse_krb5
[2019/05/30 09:35:49.758078,  4, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:745(gensec_start_mech)
  Failed to start GENSEC client mech gse_krb5: NT_STATUS_INTERNAL_ERROR
[2019/05/30 09:35:49.758129,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2019/05/30 09:35:49.758184, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782abd0]: subreq: 0x55c027834570
[2019/05/30 09:35:49.758218, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c027833eb0]: subreq: 0x55c02782a4f0
[2019/05/30 09:35:49.758280, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782abd0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c027834570/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c027834720)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215]
[2019/05/30 09:35:49.758341, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c027833eb0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02782a4f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02782a6a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:49.841141,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:273(ntlmssp_client_challenge)
  Got challenge flags:
[2019/05/30 09:35:49.841228,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62898215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_TARGET_TYPE_DOMAIN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:49.841456,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:175(cli_credentials_get_ntlm_response)
  NTLMSSP challenge set by NTLM2
[2019/05/30 09:35:49.841499,  5, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/credentials/credentials_ntlm.c:176(cli_credentials_get_ntlm_response)
  challenge is: 
[2019/05/30 09:35:49.841654,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_client.c:761(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2019/05/30 09:35:49.841689,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:49.841845,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:514(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2019/05/30 09:35:49.841880,  3, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2019/05/30 09:35:49.841992, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: ntlmssp[0x55c02782abd0]: subreq: 0x55c027813140
[2019/05/30 09:35:49.842027, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send)
  gensec_update_send: spnego[0x55c027833eb0]: subreq: 0x55c02782a4f0
[2019/05/30 09:35:49.842071, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: ntlmssp[0x55c02782abd0]: NT_STATUS_OK tevent_req[0x55c027813140/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)]  state[struct gensec_ntlmssp_update_state (0x55c0278132f0)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:222]
[2019/05/30 09:35:49.842132, 10, pid=1606, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:512(gensec_update_done)
  gensec_update_done: spnego[0x55c027833eb0]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x55c02782a4f0/../../auth/gensec/spnego.c:1600]: state[2] error[0 (0x0)]  state[struct gensec_spnego_update_state (0x55c02782a6a0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2070]
[2019/05/30 09:35:49.985205,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1163(cm_prepare_connection)
  authenticated session setup to SCSFOO402.foo.corp.example.com using FOO\MY-HOST$ failed with NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:49.985353,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:49.985423,  3, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:673(cm_get_ipc_userpass)
  cm_get_ipc_userpass: No auth-user defined
[2019/05/30 09:35:49.985683,  1, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:1305(cm_prepare_connection)
  Failed to prepare SMB connection to SCSFOO402.foo.corp.example.com: NT_STATUS_LOGON_FAILURE
[2019/05/30 09:35:49.985967, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:406(set_domain_offline)
  set_domain_offline: called for domain FOO
[2019/05/30 09:35:49.986043, 10, pid=1606, effective(0, 0), real(0, 0), class=winbind] ../../source3/winbindd/winbindd_cm.c:450(set_domain_offline)
  set_domain_offline: added event handler for domain FOO

Not sure if it's relevant but the krb5 keytab on this host:

# klist -k /etc/krb5.keytab
Keytab name: FILE:/etc/krb5.keytab
KVNO Principal
---- --------------------------------------------------------------------------
  13 ssh/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 ssh/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 ssh/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 ssh/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 ssh/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
   3 MY-HOST$@FOO.CORP.EXAMPLE.COM
   3 MY-HOST$@FOO.CORP.EXAMPLE.COM
   3 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   3 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   3 host/my-HOST at FOO.CORP.EXAMPLE.COM
  13 host/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 host/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 host/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 host/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
  13 host/my-host.foo.corp.intel.com at FOO.CORP.EXAMPLE.COM
   4 MY-HOST$@FOO.CORP.EXAMPLE.COM
   4 MY-HOST$@FOO.CORP.EXAMPLE.COM
   3 host/my-HOST at FOO.CORP.EXAMPLE.COM
   3 host/my-HOST at FOO.CORP.EXAMPLE.COM
   3 MY-HOST$@FOO.CORP.EXAMPLE.COM
   4 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   3 MY-HOST$@FOO.CORP.EXAMPLE.COM
   4 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   3 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 host/my-HOST at FOO.CORP.EXAMPLE.COM
   3 host/my-HOST at FOO.CORP.EXAMPLE.COM
   3 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 MY-HOST$@FOO.CORP.EXAMPLE.COM
   3 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   3 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   3 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   3 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   4 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 ssh/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   4 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   4 ssh/my-HOST at FOO.CORP.EXAMPLE.COM
   4 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 host/my-host.ilinx at FOO.CORP.EXAMPLE.COM
   4 host/my-HOST at FOO.CORP.EXAMPLE.COM
   4 host/my-HOST at FOO.CORP.EXAMPLE.COM
   4 host/my-HOST at FOO.CORP.EXAMPLE.COM
   4 host/my-HOST at FOO.CORP.EXAMPLE.COM
   4 host/my-HOST at FOO.CORP.EXAMPLE.COM
   4 MY-HOST$@FOO.CORP.EXAMPLE.COM
   4 MY-HOST$@FOO.CORP.EXAMPLE.COM
   4 MY-HOST$@FOO.CORP.EXAMPLE.COM

I'm really not sure how to go about debugging why this is happening.  I
don't have any admin access to the domain so my ability to debug is
client side only.  But this was working before.

Any advise?

Cheers,
b.
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 488 bytes
Desc: This is a digitally signed message part
URL: <http://lists.samba.org/pipermail/samba/attachments/20190530/e2f2182a/signature.sig>


More information about the samba mailing list