[Samba] failed to set machine spn: Operations error

rajat swarup rajats at gmail.com
Fri Sep 3 01:36:11 MDT 2010


On Wed, Sep 1, 2010 at 5:00 PM, Michael Wood <esiotrot at gmail.com> wrote:
> A quick search on google for that error turns up lots of hits, but I
> have not looked at any to see if there were solutions.
>
No luck yet!

The following is the sanitized debug dump of my net ads join command:

[2010/09/03 03:10:18,  5] lib/debug.c:407(debug_dump_status)
  INFO: Current debug levels:
    all: True/10
    tdb: False/0
    printdrivers: False/0
    lanman: False/0
    smb: False/0
    rpc_parse: False/0
    rpc_srv: False/0
    rpc_cli: False/0
    passdb: False/0
    sam: False/0
    auth: False/0
    winbind: False/0
    vfs: False/0
    idmap: False/0
    quota: False/0
    acls: False/0
    locking: False/0
    msdfs: False/0
    dmapi: False/0
    registry: False/0
[2010/09/03 03:10:18,  3] param/loadparm.c:9039(lp_load_ex)
  lp_load_ex: refreshing parameters
[2010/09/03 03:10:18,  3] param/loadparm.c:4848(init_globals)
  Initialising global parameters
[2010/09/03 03:10:18,  2] param/loadparm.c:4707(max_open_files)
  rlimit_max: rlimit_max (1024) below minimum Windows limit (16384)
[2010/09/03 03:10:18,  3] ../lib/util/params.c:550(pm_process)
  params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf"
[2010/09/03 03:10:18,  3] param/loadparm.c:7726(do_section)
  Processing section "[global]"
  doing parameter security = ads
  doing parameter workgroup = ABCDEFGH
  doing parameter password server = 192.168.5.131 192.168.5.132
  doing parameter realm = ABCDEFGH.COM
  doing parameter netbios name = 0123456789a0003
[2010/09/03 03:10:18,  4] param/loadparm.c:7088(handle_netbios_name)
  handle_netbios_name: set global_myname to: 0123456789A0003
  doing parameter idmap uid = 16777216-33554431
  doing parameter idmap gid = 16777216-33554431
  doing parameter template shell = /bin/bash
  doing parameter template homedir = /home/%D/%U
  doing parameter client ntlmv2 auth = yes
  doing parameter winbind use default domain = yes
  doing parameter winbind offline logon = false
  doing parameter winbind enum users = true
  doing parameter winbind enum groups = yes
  doing parameter client use spnego = yes
  doing parameter encrypt passwords = yes
  doing parameter restrict anonymous = 2
  doing parameter server string = %h server (Samba, Ubuntu)
  doing parameter dns proxy = no
  doing parameter log file = /var/log/samba/log.%m
  doing parameter max log size = 1000
  doing parameter syslog = 0
  doing parameter panic action = /usr/share/samba/panic-action %d
  doing parameter encrypt passwords = true
  doing parameter passdb backend = tdbsam
  doing parameter obey pam restrictions = yes
  doing parameter unix password sync = yes
  doing parameter passwd program = /usr/bin/passwd %u
  doing parameter passwd chat = *Enter\snew\s*\spassword:* %n\n
*Retype\snew\s*\spassword:* %n\n *password\supdated\ssuccessfully* .
  doing parameter pam password change = yes
  doing parameter map to guest = bad user
[2010/09/03 03:10:18,  4] param/loadparm.c:9074(lp_load_ex)
  pm_process() returned Yes
[2010/09/03 03:10:18,  7] param/loadparm.c:9279(lp_servicenumber)
  lp_servicenumber: couldn't find homes
[2010/09/03 03:10:18, 10] param/loadparm.c:8287(set_server_role)
  set_server_role: role = ROLE_DOMAIN_MEMBER
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset UCS-2LE
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset UCS-2LE
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset UTF-16LE
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset UTF-16LE
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset UCS-2BE
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset UCS-2BE
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset UTF-16BE
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset UTF-16BE
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset UTF8
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset UTF8
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset UTF-8
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset UTF-8
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset ASCII
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset ASCII
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset 646
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset 646
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset ISO-8859-1
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset ISO-8859-1
[2010/09/03 03:10:18,  5] lib/iconv.c:104(smb_register_charset)
  Attempting to register new charset UCS2-HEX
[2010/09/03 03:10:18,  5] lib/iconv.c:112(smb_register_charset)
  Registered charset UCS2-HEX
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:18,  5] lib/util.c:266(init_names)
  Netbios name list:-
  my_netbios_names[0]="0123456789A0003"
[2010/09/03 03:10:18,  2] lib/interface.c:340(add_interface)
  added interface eth0 ip=fe80::1aa9:5ff:fe76:3b64%eth0
bcast=fe80::ffff:ffff:ffff:ffff%eth0 netmask=ffff:ffff:ffff:ffff::
[2010/09/03 03:10:18,  2] lib/interface.c:340(add_interface)
  added interface eth2 ip=fe80::f6ce:46ff:febe:e0f4%eth2
bcast=fe80::ffff:ffff:ffff:ffff%eth2 netmask=ffff:ffff:ffff:ffff::
[2010/09/03 03:10:18,  2] lib/interface.c:340(add_interface)
  added interface eth2 ip=192.168.5.133 bcast=192.168.5.191
netmask=255.255.255.192
[2010/09/03 03:10:18,  2] lib/interface.c:340(add_interface)
  added interface eth0 ip=10.10.10.6 bcast=10.10.10.63 netmask=255.255.255.192
[2010/09/03 03:10:23,  1] libnet/libnet_join.c:1872(libnet_Join)
  libnet_Join:
      libnet_JoinCtx: struct libnet_JoinCtx
          in: struct libnet_JoinCtx
              dc_name                  : NULL
              machine_name             : '0123456789A0003'
              domain_name              : *
                  domain_name              : 'ABCDEFGH.COM'
              account_ou               : NULL
              admin_account            : 'dadmin'
              admin_password           : *
              machine_password         : NULL
              join_flags               : 0x00000023 (35)
                     0: WKSSVC_JOIN_FLAGS_IGNORE_UNSUPPORTED_FLAGS
                     0: WKSSVC_JOIN_FLAGS_JOIN_WITH_NEW_NAME
                     0: WKSSVC_JOIN_FLAGS_JOIN_DC_ACCOUNT
                     0: WKSSVC_JOIN_FLAGS_DEFER_SPN
                     0: WKSSVC_JOIN_FLAGS_MACHINE_PWD_PASSED
                     0: WKSSVC_JOIN_FLAGS_JOIN_UNSECURE
                     1: WKSSVC_JOIN_FLAGS_DOMAIN_JOIN_IF_JOINED
                     0: WKSSVC_JOIN_FLAGS_WIN9X_UPGRADE
                     0: WKSSVC_JOIN_FLAGS_ACCOUNT_DELETE
                     1: WKSSVC_JOIN_FLAGS_ACCOUNT_CREATE
                     1: WKSSVC_JOIN_FLAGS_JOIN_TYPE
              os_version               : NULL
              os_name                  : NULL
              create_upn               : 0x00 (0)
              upn                      : NULL
              modify_config            : 0x00 (0)
              ads                      : NULL
              debug                    : 0x01 (1)
              use_kerberos             : 0x00 (0)
              secure_channel_type      : SEC_CHAN_WKSTA (2)
[2010/09/03 03:10:23, 10] libsmb/dsgetdcname.c:1167(dsgetdcname)
  dsgetdcname: domain_name: ABCDEFGH.COM, domain_guid: (null),
site_name: (null), flags: 0x40001011
[2010/09/03 03:10:23, 10] libsmb/dsgetdcname.c:46(debug_dsdcinfo_flags)
  debug_dsdcinfo_flags: 0x40001011
  	DS_FORCE_REDISCOVERY DS_DIRECTORY_SERVICE_REQUIRED
DS_WRITABLE_REQUIRED DS_RETURN_DNS_NAME
[2010/09/03 03:10:23,  5] lib/gencache.c:61(gencache_init)
  Opening cache file at /var/run/samba/gencache.tdb
[2010/09/03 03:10:23, 10] lib/gencache.c:208(gencache_get)
  Returning valid cache entry: key = AD_SITENAME/DOMAIN/ABCDEFGH.COM,
value = Default-First-Site-Name, timeout = Mon Jan 18 22:14:07 2038
[2010/09/03 03:10:23,  5] libads/dns.c:817(sitename_fetch)
  sitename_fetch: Returning sitename for ABCDEFGH.COM: "Default-First-Site-Name"
[2010/09/03 03:10:23, 10] libsmb/dsgetdcname.c:1080(dsgetdcname_rediscover)
  dsgetdcname_rediscover
[2010/09/03 03:10:23,  4] libads/dns.c:432(ads_dns_lookup_srv)
  ads_dns_lookup_srv: 2 records returned in the answer section.
[2010/09/03 03:10:23, 10] libads/dns.c:213(ads_dns_parse_rr_srv)
  ads_dns_parse_rr_srv: Parsed 0123456789a0001.abcdefgh.com [0, 100, 389]
[2010/09/03 03:10:23, 10] libads/dns.c:213(ads_dns_parse_rr_srv)
  ads_dns_parse_rr_srv: Parsed 0123456789a0002.abcdefgh.com [0, 100, 389]
[2010/09/03 03:10:23, 10] libsmb/dsgetdcname.c:894(process_dc_dns)
  LDAP ping to 0123456789a0001.abcdefgh.com
[2010/09/03 03:10:23, 10] lib/gencache.c:374(gencache_set_data_blob)
  Adding cache entry with key = DSGETDCNAME/DOMAIN/ABCDEFGH; blob size
= 162 and timeout = Fri Sep  3 03:25:23 2010
  (900 seconds ahead)
[2010/09/03 03:10:23, 10] libads/dns.c:778(sitename_store)
  sitename_store: realm = [ABCDEFGH], sitename =
[Default-First-Site-Name], expire = [2147483647]
[2010/09/03 03:10:23, 10] lib/gencache.c:131(gencache_set)
  Adding cache entry with key = AD_SITENAME/DOMAIN/ABCDEFGH; value =
Default-First-Site-Name and timeout = Mon Jan 18 22:14:07 2038
   (863985824 seconds ahead)
[2010/09/03 03:10:23, 10] lib/gencache.c:374(gencache_set_data_blob)
  Adding cache entry with key = DSGETDCNAME/DOMAIN/ABCDEFGH.COM; blob
size = 162 and timeout = Fri Sep  3 03:25:23 2010
  (900 seconds ahead)
[2010/09/03 03:10:23, 10] libads/dns.c:778(sitename_store)
  sitename_store: realm = [abcdefgh.com], sitename =
[Default-First-Site-Name], expire = [2147483647]
[2010/09/03 03:10:23, 10] lib/gencache.c:131(gencache_set)
  Adding cache entry with key = AD_SITENAME/DOMAIN/ABCDEFGH.COM; value
= Default-First-Site-Name and timeout = Mon Jan 18 22:14:07 2038
   (863985824 seconds ahead)
[2010/09/03 03:10:23,  3] libsmb/cliconnect.c:2032(cli_start_connection)
  Connecting to host=0123456789A0001.abcdefgh.com
[2010/09/03 03:10:23, 10] lib/gencache.c:208(gencache_get)
  Returning valid cache entry: key = AD_SITENAME/DOMAIN/ABCDEFGH.COM,
value = Default-First-Site-Name, timeout = Mon Jan 18 22:14:07 2038
[2010/09/03 03:10:23,  5] libads/dns.c:817(sitename_fetch)
  sitename_fetch: Returning sitename for ABCDEFGH.COM: "Default-First-Site-Name"
[2010/09/03 03:10:23, 10] libsmb/namequery.c:1506(internal_resolve_name)
  internal_resolve_name: looking up 0123456789A0001.abcdefgh.com#20
(sitename Default-First-Site-Name)
[2010/09/03 03:10:23, 10] lib/gencache.c:208(gencache_get)
  Returning expired cache entry: key =
NBT/0123456789A0001.ABCDEFGH.COM#20, value =
192.168.5.131:0,10.10.10.4:0, timeout = Fri Sep  3 02:28:45 2010
[2010/09/03 03:10:23,  5] libsmb/namecache.c:208(namecache_fetch)
  no entry for 0123456789A0001.abcdefgh.com#20 found.
[2010/09/03 03:10:23,  3] libsmb/namequery.c:1225(resolve_lmhosts)
  resolve_lmhosts: Attempting lmhosts lookup for name
0123456789A0001.abcdefgh.com<0x20>
[2010/09/03 03:10:23,  4] libsmb/namequery.c:839(startlmhosts)
  startlmhosts: Can't open lmhosts file /etc/samba/lmhosts. Error was
No such file or directory
[2010/09/03 03:10:23,  3] libsmb/namequery.c:1089(resolve_wins)
  resolve_wins: Attempting wins lookup for name
0123456789A0001.abcdefgh.com<0x20>
[2010/09/03 03:10:23,  3] libsmb/namequery.c:1093(resolve_wins)
  resolve_wins: WINS server resolution selected and no WINS servers listed.
[2010/09/03 03:10:23,  3] libsmb/namequery.c:1307(resolve_hosts)
  resolve_hosts: Attempting host lookup for name
0123456789A0001.abcdefgh.com<0x20>
[2010/09/03 03:10:23, 10] libsmb/namequery.c:583(remove_duplicate_addrs2)
  remove_duplicate_addrs2: looking for duplicate address/port pairs
[2010/09/03 03:10:23,  5] libsmb/namecache.c:122(namecache_store)
  namecache_store: storing 2 addresses for
0123456789A0001.abcdefgh.com#20: 192.168.5.131,10.10.10.4
[2010/09/03 03:10:23, 10] lib/gencache.c:131(gencache_set)
  Adding cache entry with key = NBT/0123456789A0001.ABCDEFGH.COM#20;
value = 192.168.5.131:0,10.10.10.4:0 and timeout = Fri Sep  3 03:21:23
2010
   (660 seconds ahead)
[2010/09/03 03:10:23, 10] libsmb/namequery.c:1653(internal_resolve_name)
  internal_resolve_name: returning 2 addresses: 192.168.5.131:0 10.10.10.4:0
[2010/09/03 03:10:23, 10] lib/events.c:287(s3_event_debug)
  s3_event: Added timed event "tevent_req_timedout": 0x7f0a3e414bf0
[2010/09/03 03:10:23, 10] lib/events.c:287(s3_event_debug)
  s3_event: Added timed event "tevent_req_timedout": 0x7f0a3e4151c0
[2010/09/03 03:10:23, 10] lib/events.c:105(run_events)
  Running timed event "tevent_req_timedout" 0x7f0a3e414bf0
[2010/09/03 03:10:23, 10] lib/events.c:287(s3_event_debug)
  s3_event: Destroying timer event 0x7f0a3e414bf0 "tevent_req_timedout"
[2010/09/03 03:10:23, 10] lib/events.c:287(s3_event_debug)
  s3_event: Added timed event "tevent_req_timedout": 0x7f0a3e414bf0
[2010/09/03 03:10:23,  3] lib/util_sock.c:1033(open_socket_out_send)
  Connecting to 192.168.5.131 at port 445
[2010/09/03 03:10:23, 10] lib/events.c:287(s3_event_debug)
  s3_event: Added timed event "tevent_req_timedout": 0x7f0a3e415c20
[2010/09/03 03:10:23, 10] lib/events.c:287(s3_event_debug)
  s3_event: Destroying timer event 0x7f0a3e415c20 "tevent_req_timedout"
[2010/09/03 03:10:23, 10] lib/events.c:287(s3_event_debug)
  s3_event: Destroying timer event 0x7f0a3e414bf0 "tevent_req_timedout"
[2010/09/03 03:10:23,  5] lib/util_sock.c:371(print_socket_options)
  Socket options:
  	SO_KEEPALIVE = 0
  	SO_REUSEADDR = 0
  	SO_BROADCAST = 0
  	TCP_NODELAY = 1
  	TCP_KEEPCNT = 9
  	TCP_KEEPIDLE = 7200
  	TCP_KEEPINTVL = 75
  	IPTOS_LOWDELAY = 0
  	IPTOS_THROUGHPUT = 0
  	SO_SNDBUF = 16384
  	SO_RCVBUF = 87380
  	SO_SNDLOWAT = 1
  	SO_RCVLOWAT = 1
  	SO_SNDTIMEO = 0
  	SO_RCVTIMEO = 0
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23,  5] lib/charcnv.c:82(charset_name)
  Substituting charset 'UTF-8' for LOCALE
[2010/09/03 03:10:23, 10] libsmb/async_smb.c:510(cli_chain_cork)
  cli_chain_cork: mid=1
[2010/09/03 03:10:23, 10] libsmb/async_smb.c:939(handle_incoming_pdu)
  handle_incoming_pdu: got mid 1
[2010/09/03 03:10:23,  3] libsmb/cliconnect.c:940(cli_session_setup_spnego)
  Doing spnego session setup (blob length=119)
[2010/09/03 03:10:23,  3] libsmb/cliconnect.c:967(cli_session_setup_spnego)
  got OID=1.2.840.48018.1.2.2
[2010/09/03 03:10:23,  3] libsmb/cliconnect.c:967(cli_session_setup_spnego)
  got OID=1.2.840.113554.1.2.2
[2010/09/03 03:10:23,  3] libsmb/cliconnect.c:967(cli_session_setup_spnego)
  got OID=1.2.840.113554.1.2.2.3
[2010/09/03 03:10:23,  3] libsmb/cliconnect.c:967(cli_session_setup_spnego)
  got OID=1.3.6.1.4.1.311.2.2.10
[2010/09/03 03:10:23,  3] libsmb/cliconnect.c:975(cli_session_setup_spnego)
  got principal=0123456789a0001$@ABCDEFGH.COM
[2010/09/03 03:10:23,  6] libsmb/clientgen.c:245(write_socket)
  write_socket(6,176)
[2010/09/03 03:10:23,  6] libsmb/clientgen.c:248(write_socket)
  write_socket(6,176) wrote 176
[2010/09/03 03:10:23, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
  got smb length of 484
[2010/09/03 03:10:23,  5] lib/util.c:632(show_msg)
[2010/09/03 03:10:23,  5] lib/util.c:642(show_msg)
  size=484
  smb_com=0x73
  smb_rcls=22
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51205
  smb_tid=0
  smb_pid=22299
  smb_uid=43010
  smb_mid=2
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=  484 (0x1E4)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  301 (0x12D)
  smb_bcc=441
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] A1 82 01 29 30 82 01 25   A0 03 0A 01 01 A1 0C 06   ...)0..% ........
  [0010] 0A 2B 06 01 04 01 82 37   02 02 0A A2 82 01 0E 04   .+.....7 ........
  [0020] 82 01 0A 4E 54 4C 4D 53   53 50 00 02 00 00 00 14   ...NTLMS SP......
  [0030] 00 14 00 38 00 00 00 15   82 89 62 C8 B8 B0 07 A3   ...8.... ..b.....
  [0040] 06 68 2C 00 00 00 00 00   00 00 00 BE 00 BE 00 4C   .h,..... .......L
[SCRUBBED]
  [01B0] 00 35 00 2E 00 32 00 00   00                       .5...2.. .
[2010/09/03 03:10:23,  5] lib/util.c:632(show_msg)
[2010/09/03 03:10:23,  5] lib/util.c:642(show_msg)
  size=484
  smb_com=0x73
  smb_rcls=22
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51205
  smb_tid=0
  smb_pid=22299
  smb_uid=43010
  smb_mid=2
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=  484 (0x1E4)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  301 (0x12D)
  smb_bcc=441
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] A1 82 01 29 30 82 01 25   A0 03 0A 01 01 A1 0C 06   ...)0..% ........
  [0010] 0A 2B 06 01 04 01 82 37   02 02 0A A2 82 01 0E 04   .+.....7 ........
  [0020] 82 01 0A 4E 54 4C 4D 53   53 50 00 02 00 00 00 14   ...NTLMS SP......
[SCRUBBED]
  [0030] 00 14 00 38 00 00 00 15   82 89 62 C8 B8 B0 07 A3   ...8.... ..b.....
  [01A0] 00 32 00 30 00 30 00 33   00 20 00 52 00 32 00 20   .2.0.0.3 . .R.2.
  [01B0] 00 35 00 2E 00 32 00 00   00                       .5...2.. .
[2010/09/03 03:10:23,  3] libsmb/ntlmssp.c:1023(ntlmssp_client_challenge)
  Got challenge flags:
[2010/09/03 03:10:23,  3] libsmb/ntlmssp.c:62(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_NEGOTIATE_NTLM2
    NTLMSSP_CHAL_TARGET_INFO
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2010/09/03 03:10:23,  3] libsmb/ntlmssp.c:1045(ntlmssp_client_challenge)
  NTLMSSP: Set final flags:
[2010/09/03 03:10:23,  3] libsmb/ntlmssp.c:62(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x60088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_NTLM2
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2010/09/03 03:10:23,  3] libsmb/ntlmssp_sign.c:342(ntlmssp_sign_init)
  NTLMSSP Sign/Seal - Initialising with flags:
[2010/09/03 03:10:23,  3] libsmb/ntlmssp.c:62(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x60088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_NTLM2
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2010/09/03 03:10:23,  6] libsmb/clientgen.c:245(write_socket)
  write_socket(6,482)
[2010/09/03 03:10:23,  6] libsmb/clientgen.c:248(write_socket)
  write_socket(6,482) wrote 482
[2010/09/03 03:10:23, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
  got smb length of 192
[2010/09/03 03:10:23,  5] lib/util.c:632(show_msg)
[2010/09/03 03:10:23,  5] lib/util.c:642(show_msg)
  size=192
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51205
  smb_tid=0
  smb_pid=22299
  smb_uid=43010
  smb_mid=3
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=  192 (0xC0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    9 (0x9)
  smb_bcc=149
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] A1 07 30 05 A0 03 0A 01   00 57 00 69 00 6E 00 64   ..0..... .W.i.n.d
  [0010] 00 6F 00 77 00 73 00 20   00 53 00 65 00 72 00 76   .o.w.s.  .S.e.r.v
[SCRUBBED]
  [0090] 00 32 00 00 00                                    .2...
[2010/09/03 03:10:23,  5] lib/util.c:632(show_msg)
[2010/09/03 03:10:23,  5] lib/util.c:642(show_msg)
  size=192
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51205
  smb_tid=0
  smb_pid=22299
  smb_uid=43010
  smb_mid=3
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=  192 (0xC0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    9 (0x9)
  smb_bcc=149
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] A1 07 30 05 A0 03 0A 01   00 57 00 69 00 6E 00 64   ..0..... .W.i.n.d
  [0010] 00 6F 00 77 00 73 00 20   00 53 00 65 00 72 00 76   .o.w.s.  .S.e.r.v
[SRUBBED]
  [0090] 00 32 00 00 00                                    .2...
[2010/09/03 03:10:23,  5] libsmb/smb_signing.c:140(set_smb_signing_real_common)
  Mandatory SMB signing enabled!
[2010/09/03 03:10:23,  5] libsmb/smb_signing.c:144(set_smb_signing_real_common)
  SMB signing enabled!
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:494(cli_simple_set_signing)
  cli_simple_set_signing: user_session_key
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] B4 39 EC 32 61 6E 5C 5E   1A 3A F9 64 4A 80 48 37   .9.2an\^ .:.dJ.H7
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:502(cli_simple_set_signing)
  cli_simple_set_signing: NULL response_data
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:285(simple_packet_signature)
  simple_packet_signature: sequence number 0
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:351(client_sign_outgoing_message)
  client_sign_outgoing_message: sent SMB signature of
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] CF 87 80 74 1A DB 9D 64                            ...t...d
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:67(store_sequence_for_reply)
  store_sequence_for_reply: stored seq = 1 mid = 3
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:80(get_sequence_for_reply)
  get_sequence_for_reply: found seq = 1 mid = 3
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:285(simple_packet_signature)
  simple_packet_signature: sequence number 1
[2010/09/03 03:10:23, 10]
libsmb/smb_signing.c:434(client_check_incoming_message)
  client_check_incoming_message: seq 1: got good SMB signature of
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 3F AA A7 43 52 CA B0 3B                            ?..CR..;
[2010/09/03 03:10:23, 10] libsmb/async_smb.c:510(cli_chain_cork)
  cli_chain_cork: mid=4
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:285(simple_packet_signature)
  simple_packet_signature: sequence number 2
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:351(client_sign_outgoing_message)
  client_sign_outgoing_message: sent SMB signature of
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] A2 61 FD 07 11 3C D5 A8                            .a...<..
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:67(store_sequence_for_reply)
  store_sequence_for_reply: stored seq = 3 mid = 4
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:80(get_sequence_for_reply)
  get_sequence_for_reply: found seq = 3 mid = 4
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:285(simple_packet_signature)
  simple_packet_signature: sequence number 3
[2010/09/03 03:10:23, 10]
libsmb/smb_signing.c:434(client_check_incoming_message)
  client_check_incoming_message: seq 3: got good SMB signature of
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 77 DA EC CB 0A 6F 06 37                            w....o.7
[2010/09/03 03:10:23, 10] libsmb/async_smb.c:939(handle_incoming_pdu)
  handle_incoming_pdu: got mid 4
[2010/09/03 03:10:23, 10] libsmb/clientgen.c:467(cli_init_creds)
  cli_init_creds: user dadmin domain
[2010/09/03 03:10:23, 10] libsmb/async_smb.c:510(cli_chain_cork)
  cli_chain_cork: mid=5
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:285(simple_packet_signature)
  simple_packet_signature: sequence number 4
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:351(client_sign_outgoing_message)
  client_sign_outgoing_message: sent SMB signature of
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 23 47 2C 85 2D 4B BA E2                            #G,.-K..
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:67(store_sequence_for_reply)
  store_sequence_for_reply: stored seq = 5 mid = 5
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:80(get_sequence_for_reply)
  get_sequence_for_reply: found seq = 5 mid = 5
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:285(simple_packet_signature)
  simple_packet_signature: sequence number 5
[2010/09/03 03:10:23, 10]
libsmb/smb_signing.c:434(client_check_incoming_message)
  client_check_incoming_message: seq 5: got good SMB signature of
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 7C 17 28 CC 9D D1 CB D5                            |.(.....
[2010/09/03 03:10:23, 10] libsmb/async_smb.c:939(handle_incoming_pdu)
  handle_incoming_pdu: got mid 5
[2010/09/03 03:10:23,  5] rpc_client/cli_pipe.c:2555(rpc_pipe_bind_send)
  Bind RPC Pipe: host 0123456789A0001.abcdefgh.com auth_type 0, auth_level 0
[2010/09/03 03:10:23,  5] rpc_parse/parse_prs.c:88(prs_debug)
  000000 smb_io_rpc_hdr hdr
      0000 major     : 05
      0001 minor     : 00
      0002 pkt_type  : 0b
      0003 flags     : 03
      0004 pack_type0: 10
      0005 pack_type1: 00
      0006 pack_type2: 00
      0007 pack_type3: 00
      0008 frag_len  : 0048
      000a auth_len  : 0000
      000c call_id   : 00000001
[2010/09/03 03:10:23,  5] rpc_parse/parse_prs.c:88(prs_debug)
  000010 smb_io_rpc_hdr_rb
[2010/09/03 03:10:23,  6] rpc_parse/parse_prs.c:88(prs_debug)
      000010 smb_io_rpc_hdr_bba
          0010 max_tsize: 10b8
          0012 max_rsize: 10b8
          0014 assoc_gid: 00000000
      0018 num_contexts: 01
      001c context_id  : 0000
      001e num_transfer_syntaxes: 01
[2010/09/03 03:10:23,  6] rpc_parse/parse_prs.c:88(prs_debug)
      00001f smb_io_rpc_iface
[2010/09/03 03:10:23,  7] rpc_parse/parse_prs.c:88(prs_debug)
          000020 smb_io_uuid uuid
              0020 data   : 12345778
              0024 data   : 1234
              0026 data   : abcd
              0028 data   : ef 00
              002a data   : 01 23 45 67 89 ab
          0030 version: 00000000
[2010/09/03 03:10:23,  6] rpc_parse/parse_prs.c:88(prs_debug)
      000034 smb_io_rpc_iface
[2010/09/03 03:10:23,  7] rpc_parse/parse_prs.c:88(prs_debug)
          000034 smb_io_uuid uuid
              0034 data   : 8a885d04
              0038 data   : 1ceb
              003a data   : 11c9
              003c data   : 9f e8
              003e data   : 08 00 2b 10 48 60
          0044 version: 00000002
[2010/09/03 03:10:23,  5] rpc_client/cli_pipe.c:1280(rpc_api_pipe_send)
  rpc_api_pipe: host 0123456789A0001.abcdefgh.com
[2010/09/03 03:10:23, 10] libsmb/clitrans.c:825(cli_ship_trans)
  num_setup=2, max_setup=0, param_total=0, this_param=0, max_param=0,
data_total=72, this_data=72, max_data=4280, param_offset=82,
param_disp=0, data_disp=0
[2010/09/03 03:10:23, 10] libsmb/async_smb.c:510(cli_chain_cork)
  cli_chain_cork: mid=6
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:285(simple_packet_signature)
  simple_packet_signature: sequence number 6
[2010/09/03 03:10:23, 10] libsmb/smb_signing.c:351(client_sign_outgoing_message)
  client_sign_outgoing_message: sent SMB signature of
[2010/09/03 03:10:23, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 47 63 F6 12 7D 87 D5 40