Attachment 8492 Details for Bug 9605 – samba.log

samba.log

samba.log.txt (text/plain), 65.77 KB, created by Sergey Sidlyarenko on 2013-01-26 11:07:13 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Sergey Sidlyarenko

Created: 2013-01-26 11:07:13 UTC

Size: 65.77 KB

patch

obsolete

>[2013/01/26 14:56:59,  0] ../source4/smbd/server.c:369(binary_smbd_main)
>  samba version 4.0.1 started.
>  Copyright Andrew Tridgell and the Samba Team 1992-2012
>[2013/01/26 14:56:59,  3] ../source4/smbd/server.c:380(binary_smbd_main)
>  Becoming a daemon.
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_spnego' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5_sasl' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'sasl-DIGEST-MD5' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'schannel' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'spnego' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'ntlmssp' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'krb5' registered
>[2013/01/26 14:56:59,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'fake_gssapi_krb5' registered
>[2013/01/26 14:56:59,  3] ../source4/ntptr/ntptr_base.c:67(ntptr_register)
>  NTPTR backend 'simple_ldb'
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'default' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'posix' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'unixuid' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'unixuid' for type 3 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'unixuid' for type 2 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'cifs' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'smb2' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'simple' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'cifsposix' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'default' for type 3 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'default' for type 2 registered
>[2013/01/26 14:56:59,  3] ../source4/ntvfs/ntvfs_base.c:79(ntvfs_register)
>  NTVFS backend 'nbench' for type 1 registered
>[2013/01/26 14:56:59,  3] ../source4/smbd/process_model.c:97(register_process_model)
>  PROCESS_MODEL 'single' registered
>[2013/01/26 14:56:59,  3] ../source4/smbd/process_model.c:97(register_process_model)
>  PROCESS_MODEL 'prefork' registered
>[2013/01/26 14:56:59,  3] ../source4/smbd/process_model.c:97(register_process_model)
>  PROCESS_MODEL 'onefork' registered
>[2013/01/26 14:56:59,  3] ../source4/smbd/process_model.c:97(register_process_model)
>  PROCESS_MODEL 'standard' registered
>[2013/01/26 14:56:59,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam' registered
>[2013/01/26 14:56:59,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam_ignoredomain' registered
>[2013/01/26 14:56:59,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'anonymous' registered
>[2013/01/26 14:56:59,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind' registered
>[2013/01/26 14:56:59,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind_wbclient' registered
>[2013/01/26 14:56:59,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'name_to_ntstatus' registered
>[2013/01/26 14:56:59,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'unix' registered
>[2013/01/26 14:56:59,  3] ../source4/param/share.c:124(share_register)
>  SHARE backend [classic] registered.
>[2013/01/26 14:56:59,  3] ../source4/param/share.c:124(share_register)
>  SHARE backend [ldb] registered.
>[2013/01/26 14:56:59,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of privilege.ldb
>[2013/01/26 14:56:59,  0] ../source4/smbd/server.c:475(binary_smbd_main)
>  samba: using 'standard' process model
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'rpcecho' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'epmapper' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'remote' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'srvsvc' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'wkssvc' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'unixinfo' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'samr' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'winreg' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'netlogon' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'dssetup' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'lsarpc' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'backupkey' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'spoolss' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'drsuapi' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'browser' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'eventlog6' registered
>[2013/01/26 14:56:59,  3] ../source4/rpc_server/dcerpc_server.c:1205(dcerpc_register_ep_server)
>  DCERPC endpoint server 'dnsserver' registered
>[2013/01/26 14:56:59,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:56:59,  2] ../source4/dsdb/repl/drepl_partitions.c:116(dreplsrv_load_partitions)
>  dreplsrv_partition[CN=Configuration,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/repl/drepl_partitions.c:116(dreplsrv_load_partitions)
>  dreplsrv_partition[CN=Schema,CN=Configuration,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/repl/drepl_partitions.c:116(dreplsrv_load_partitions)
>  dreplsrv_partition[DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/repl/drepl_partitions.c:116(dreplsrv_load_partitions)
>  dreplsrv_partition[DC=DomainDnsZones,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/repl/drepl_partitions.c:116(dreplsrv_load_partitions)
>  dreplsrv_partition[DC=ForestDnsZones,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of idmap.ldb
>[2013/01/26 14:56:59.964143,  3] ../source3/param/loadparm.c:4805(lp_load_ex)
>  lp_load_ex: refreshing parameters
>[2013/01/26 14:56:59.964291,  3] ../source3/param/loadparm.c:749(init_globals)
>  Initialising global parameters
>[2013/01/26 14:56:59.964398,  2] ../source3/param/loadparm.c:542(max_open_files)
>  rlimit_max: increasing rlimit_max (1024) to minimum Windows limit (16384)
>[2013/01/26 14:56:59.964551,  3] ../lib/util/params.c:550(pm_process)
>  params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf"
>[2013/01/26 14:56:59.964648,  3] ../source3/param/loadparm.c:3532(do_section)
>  Processing section "[global]"
>[2013/01/26 14:56:59.965002,  2] ../source3/param/loadparm.c:3549(do_section)
>  Processing section "[netlogon]"
>[2013/01/26 14:56:59.965230,  2] ../source3/param/loadparm.c:3549(do_section)
>  Processing section "[sysvol]"
>[2013/01/26 14:56:59.965393,  2] ../source3/param/loadparm.c:3549(do_section)
>  Processing section "[profiles]"
>[2013/01/26 14:56:59.965537,  2] ../source3/param/loadparm.c:3549(do_section)
>  Processing section "[homes]"
>[2013/01/26 14:56:59,  2] ../source4/dsdb/kcc/kcc_service.c:127(kccsrv_load_partitions)
>  kccsrv_partition[DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/kcc/kcc_service.c:127(kccsrv_load_partitions)
>  kccsrv_partition[CN=Configuration,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/kcc/kcc_service.c:127(kccsrv_load_partitions)
>  kccsrv_partition[CN=Schema,CN=Configuration,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/kcc/kcc_service.c:127(kccsrv_load_partitions)
>  kccsrv_partition[DC=DomainDnsZones,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59,  2] ../source4/dsdb/kcc/kcc_service.c:127(kccsrv_load_partitions)
>  kccsrv_partition[DC=ForestDnsZones,DC=dc1,DC=lefoyer,DC=ru] loaded
>[2013/01/26 14:56:59.985932,  3] ../source3/param/loadparm.c:1771(lp_add_ipc)
>  adding IPC service
>[2013/01/26 14:56:59.986563,  2] ../source3/lib/interface.c:341(add_interface)
>  added interface lo ip=::1 bcast=::1 netmask=ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff
>[2013/01/26 14:56:59.986760,  2] ../source3/lib/interface.c:341(add_interface)
>  added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0
>[2013/01/26 14:56:59.986855,  2] ../source3/lib/interface.c:341(add_interface)
>  added interface br0 ip=fe80::20c:29ff:fe0b:939e%br0 bcast=fe80::ffff:ffff:ffff:ffff%br0 netmask=ffff:ffff:ffff:ffff::
>[2013/01/26 14:56:59.987003,  2] ../source3/lib/interface.c:341(add_interface)
>  added interface br0 ip=192.168.100.200 bcast=192.168.100.255 netmask=255.255.255.0
>[2013/01/26 14:56:59.987260,  3] ../source3/smbd/server.c:1259(main)
>  loaded services
>[2013/01/26 14:56:59.987723,  3] ../source3/profile/profile.c:189(profile_setup)
>  Initialised profile area
>[2013/01/26 14:56:59,  3] ../source4/dsdb/dns/dns_update.c:340(dnsupdate_check_names)
>  Calling DNS name update script
>[2013/01/26 14:56:59.987891,  0] ../source3/smbd/server.c:1280(main)
>  standard input is not a socket, assuming -D option
>[2013/01/26 14:56:59.994399,  3] ../source3/smbd/server.c:1291(main)
>  Becoming a daemon.
>[2013/01/26 14:57:00,  3] ../source4/dsdb/dns/dns_update.c:355(dnsupdate_check_names)
>  Calling SPN name update script
>[2013/01/26 14:57:00,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:01.207145,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of idmap.ldb
>[2013/01/26 14:57:01,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:01,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:01,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:01,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:01,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:01,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:01,  3] ../libcli/auth/schannel_state_tdb.c:110(schannel_store_session_key_tdb)
>  schannel_store_session_key_tdb: stored schannel info with key SECRETS/SCHANNEL/NS1
>[2013/01/26 14:57:01,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:01,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:01,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:01,  3] ../libcli/auth/schannel_state_tdb.c:180(schannel_fetch_session_key_tdb)
>  schannel_fetch_session_key_tdb: restored schannel info key SECRETS/SCHANNEL/NS1
>[2013/01/26 14:57:01,  3] ../libcli/auth/schannel_state_tdb.c:180(schannel_fetch_session_key_tdb)
>  schannel_fetch_session_key_tdb: restored schannel info key SECRETS/SCHANNEL/NS1
>[2013/01/26 14:57:01,  3] ../libcli/auth/schannel_state_tdb.c:110(schannel_store_session_key_tdb)
>  schannel_store_session_key_tdb: stored schannel info with key SECRETS/SCHANNEL/NS1
>[2013/01/26 14:57:01,  1] ../source4/auth/gensec/gensec_gssapi.c:339(gensec_gssapi_client_start)
>  Could not determine hostname for target computer, cannot use kerberos
>[2013/01/26 14:57:01,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:01,  3] ../source4/dsdb/dns/dns_update.c:325(dnsupdate_spnupdate_done)
>  Completed SPN update check OK
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_client.c:170(ntlmssp_client_challenge)
>  Got challenge flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60898235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_client.c:295(ntlmssp_client_challenge)
>  NTLMSSP: Set final flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_server.c:358(ntlmssp_server_preauth)
>  Got user=[NS1$] domain=[DC1] workstation=[NS1] len1=24 len2=140
>[2013/01/26 14:57:01,  3] ../source4/auth/ntlm/auth.c:270(auth_check_password_send)
>  auth_check_password_send: Checking password for unmapped user [DC1]\[NS1$]@[NS1]
>  auth_check_password_send: mapped user is: [DC1]\[NS1$]@[NS1]
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  1] ../source4/auth/gensec/gensec_gssapi.c:339(gensec_gssapi_client_start)
>  Could not determine hostname for target computer, cannot use kerberos
>[2013/01/26 14:57:01,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_client.c:170(ntlmssp_client_challenge)
>  Got challenge flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60898235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_client.c:295(ntlmssp_client_challenge)
>  NTLMSSP: Set final flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_server.c:358(ntlmssp_server_preauth)
>  Got user=[NS1$] domain=[DC1] workstation=[NS1] len1=24 len2=140
>[2013/01/26 14:57:01,  3] ../source4/auth/ntlm/auth.c:270(auth_check_password_send)
>  auth_check_password_send: Checking password for unmapped user [DC1]\[NS1$]@[NS1]
>  auth_check_password_send: mapped user is: [DC1]\[NS1$]@[NS1]
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2013/01/26 14:57:01,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088235
>[2013/01/26 14:57:01,  0] ../lib/util/util_runcmd.c:334(samba_runcmd_io_handler)
>  /usr/sbin/samba_dnsupdate: ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:01.765878,  3] ../source3/rpc_server/svcctl/srv_svcctl_reg.c:565(svcctl_init_winreg)
>  Initialise the svcctl registry keys if needed.
>[2013/01/26 14:57:01,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: AS-REQ NS1$@DC1.LEFOYER.RU from ipv4:192.168.100.200:44267 for krbtgt/DC1.LEFOYER.RU@DC1.LEFOYER.RU
>[2013/01/26 14:57:01.777841,  3] ../source3/rpc_server/eventlog/srv_eventlog_reg.c:59(eventlog_init_winreg)
>  Initialise the eventlog registry keys if needed.
>[2013/01/26 14:57:01.778748,  3] ../source3/printing/queue_process.c:241(start_background_queue)
>  start_background_queue: Starting background LPQ thread
>[2013/01/26 14:57:01,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: No preauth found, returning PREAUTH-REQUIRED -- NS1$@DC1.LEFOYER.RU
>[2013/01/26 14:57:01.801054,  3] ../source3/printing/pcap.c:138(pcap_cache_reload)
>  reloading printcap cache
>[2013/01/26 14:57:01.820606,  2] ../source3/smbd/server.c:940(smbd_parent_loop)
>  waiting for connections
>[2013/01/26 14:57:01.825927,  3] ../source3/printing/pcap.c:189(pcap_cache_reload)
>  reload status: ok
>[2013/01/26 14:57:01.855969,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:01.857041,  3] ../source3/smbd/oplock.c:985(init_oplocks)
>  init_oplocks: initializing messages.
>[2013/01/26 14:57:01.865877,  3] ../source3/smbd/process.c:1789(process_smb)
>  Transaction 0 of length 108 (0 toread)
>[2013/01/26 14:57:01.881457,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_spnego' registered
>[2013/01/26 14:57:01.881641,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5' registered
>[2013/01/26 14:57:01.881739,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5_sasl' registered
>[2013/01/26 14:57:01.925218,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'sasl-DIGEST-MD5' registered
>[2013/01/26 14:57:01.925361,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'schannel' registered
>[2013/01/26 14:57:01.925462,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'spnego' registered
>[2013/01/26 14:57:01.925576,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'ntlmssp' registered
>[2013/01/26 14:57:01.925695,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'krb5' registered
>[2013/01/26 14:57:01.929816,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'fake_gssapi_krb5' registered
>[2013/01/26 14:57:01.938436,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:01.945969,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam' registered
>[2013/01/26 14:57:01.946097,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam_ignoredomain' registered
>[2013/01/26 14:57:01.946205,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'anonymous' registered
>[2013/01/26 14:57:01.946311,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind' registered
>[2013/01/26 14:57:01.946398,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind_wbclient' registered
>[2013/01/26 14:57:01.946492,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'name_to_ntstatus' registered
>[2013/01/26 14:57:01.946578,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'unix' registered
>[2013/01/26 14:57:01.990634,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:02.024936,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of privilege.ldb
>[2013/01/26 14:57:02,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:02,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:02.046860,  3] ../source3/smbd/password.c:144(register_homes_share)
>  Adding homes service for user 'DC1\Administrator' using home directory: '/home/DC1/Administrator'
>[2013/01/26 14:57:02.047139,  3] ../source3/param/loadparm.c:1723(lp_add_home)
>  adding home's share [Administrator] for user 'DC1\Administrator' at '/home/DC1/%U'
>[2013/01/26 14:57:02.054074,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:02.054327,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/tmp' for service [IPC$]
>[2013/01/26 14:57:02.054559,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:02.054776,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:02.054897,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:02.057402,  2] ../lib/util/modules.c:199(do_smb_load_module)
>  Module 'acl_xattr' loaded
>[2013/01/26 14:57:02.057523,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:02.057661,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service IPC$
>[2013/01/26 14:57:02.071850,  3] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58955) connect to service IPC$ initially as user DC1\Administrator (uid=0, gid=100) (pid 7144)
>[2013/01/26 14:57:02.097509,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \ns1.dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:02.097844,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \ns1.dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:02.099195,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:02.099371,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/home/DC1/administrator' for service [Administrator]
>[2013/01/26 14:57:02.099500,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:02.099591,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:02.099685,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [full_audit]
>[2013/01/26 14:57:02.101971,  2] ../lib/util/modules.c:199(do_smb_load_module)
>  Module 'full_audit' loaded
>[2013/01/26 14:57:02.102085,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: AS-REQ NS1$@DC1.LEFOYER.RU from ipv4:192.168.100.200:59014 for krbtgt/DC1.LEFOYER.RU@DC1.LEFOYER.RU
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Client sent patypes: encrypted-timestamp
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Looking for PKINIT pa-data -- NS1$@DC1.LEFOYER.RU
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Looking for ENC-TS pa-data -- NS1$@DC1.LEFOYER.RU
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: ENC-TS Pre-authentication succeeded -- NS1$@DC1.LEFOYER.RU using aes256-cts-hmac-sha1-96
>[2013/01/26 14:57:02.109829,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service Administrator
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: AS-REQ authtime: 2013-01-26T14:57:02 starttime: unset endtime: 2013-01-27T00:57:01 renew till: unset
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Client supported enctypes: aes256-cts-hmac-sha1-96, aes128-cts-hmac-sha1-96, des3-cbc-sha1, des3-cbc-md5, arcfour-hmac-md5, using aes256-cts-hmac-sha1-96/aes256-cts-hmac-sha1-96
>[2013/01/26 14:57:02,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:02,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:02,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:02,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:02.150865,  1] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58955) connect to service Administrator initially as user DC1\Administrator (uid=0, gid=100) (pid 7144)
>[2013/01/26 14:57:02.155034,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:02.155293,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:02.157350,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [desktop.ini] [/home/DC1/administrator]
>[2013/01/26 14:57:02.157471,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: desktop.ini reduced to /home/DC1/administrator/desktop.ini
>[2013/01/26 14:57:02.157632,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(desktop.ini) returning 0600
>[2013/01/26 14:57:02.162657,  3] ../source3/smbd/smb2_notify.c:208(smbd_smb2_notify_send)
>  smbd_smb2_notify_send: notify change called on ., filter = FILE_NAME|DIR_NAME|ATTRIBUTES|LAST_WRITE, recursive = 0
>[2013/01/26 14:57:02.178318,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:02.178420,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:02.178546,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:02.181349,  3] ../source3/smbd/dir.c:663(dptr_create)
>  creating new dirptr 0 for path ., expect_close = 0
>[2013/01/26 14:57:02.181690,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./. fname=. (.)
>[2013/01/26 14:57:02.182042,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:02.182284,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./.. fname=.. (..)
>[2013/01/26 14:57:02.183983,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:02.184145,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./Thumbs.db fname=Thumbs.db (Thumbs.db)
>[2013/01/26 14:57:02.184314,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:02.184454,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./1.txt fname=1.txt (1.txt)
>[2013/01/26 14:57:02.236847,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:02.236964,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:02.237092,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: TGS-REQ NS1$@DC1.LEFOYER.RU from ipv4:192.168.100.200:47042 for DNS/ns1.dc1.lefoyer.ru@DC1.LEFOYER.RU [canonicalize]
>[2013/01/26 14:57:02,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: TGS-REQ authtime: 2013-01-26T14:57:02 starttime: 2013-01-26T14:57:02 endtime: 2013-01-27T00:57:01 renew till: unset
>[2013/01/26 14:57:02,  0] ../lib/util/util_runcmd.c:334(samba_runcmd_io_handler)
>  /usr/sbin/samba_dnsupdate: ; Communication with 127.0.1.1#53 failed: operation canceled
>[2013/01/26 14:57:02,  0] ../lib/util/util_runcmd.c:334(samba_runcmd_io_handler)
>  /usr/sbin/samba_dnsupdate: could not talk to any default name server
>[2013/01/26 14:57:02,  0] ../lib/util/util_runcmd.c:334(samba_runcmd_io_handler)
>  /usr/sbin/samba_dnsupdate: ; Communication with 127.0.1.1#53 failed: operation canceled
>[2013/01/26 14:57:02,  0] ../lib/util/util_runcmd.c:334(samba_runcmd_io_handler)
>  /usr/sbin/samba_dnsupdate: could not talk to any default name server
>[2013/01/26 14:57:02,  0] ../lib/util/util_runcmd.c:334(samba_runcmd_io_handler)
>  /usr/sbin/samba_dnsupdate: ; Communication with 127.0.1.1#53 failed: operation canceled
>[2013/01/26 14:57:02,  0] ../lib/util/util_runcmd.c:334(samba_runcmd_io_handler)
>  /usr/sbin/samba_dnsupdate: could not talk to any default name server
>[2013/01/26 14:57:02,  3] ../source4/dsdb/dns/dns_update.c:296(dnsupdate_nameupdate_done)
>  Completed DNS update check OK
>[2013/01/26 14:57:04.563104,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:04.563266,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:04.563417,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:04,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:04,  3] ../source4/rpc_server/dcerpc_server.c:961(dcesrv_request)
>  Warning: 60 extra bytes in incoming RPC request
>[2013/01/26 14:57:04,  3] ../source4/rpc_server/drsuapi/dcesrv_drsuapi.c:74(dcesrv_drsuapi_DsBind)
>  ../source4/rpc_server/drsuapi/dcesrv_drsuapi.c:74: doing DsBind with system_session
>[2013/01/26 14:57:06.517128,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:06.518368,  3] ../source3/smbd/oplock.c:985(init_oplocks)
>  init_oplocks: initializing messages.
>[2013/01/26 14:57:06.589291,  3] ../source3/smbd/process.c:1789(process_smb)
>  Transaction 0 of length 159 (0 toread)
>[2013/01/26 14:57:06.589638,  3] ../source3/smbd/process.c:1392(switch_message)
>  switch message SMBnegprot (pid 7160) conn 0x0
>[2013/01/26 14:57:06.594117,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [PC NETWORK PROGRAM 1.0]
>[2013/01/26 14:57:06.594357,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [LANMAN1.0]
>[2013/01/26 14:57:06.594491,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [Windows for Workgroups 3.1a]
>[2013/01/26 14:57:06.594593,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [LM1.2X002]
>[2013/01/26 14:57:06.594713,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [LANMAN2.1]
>[2013/01/26 14:57:06.594798,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [NT LM 0.12]
>[2013/01/26 14:57:06.594907,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [SMB 2.002]
>[2013/01/26 14:57:06.594991,  3] ../source3/smbd/negprot.c:563(reply_negprot)
>  Requested protocol [SMB 2.???]
>[2013/01/26 14:57:06.598485,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_spnego' registered
>[2013/01/26 14:57:06.598663,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5' registered
>[2013/01/26 14:57:06.598762,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5_sasl' registered
>[2013/01/26 14:57:06.617244,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'sasl-DIGEST-MD5' registered
>[2013/01/26 14:57:06.617396,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'schannel' registered
>[2013/01/26 14:57:06.617497,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'spnego' registered
>[2013/01/26 14:57:06.617616,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'ntlmssp' registered
>[2013/01/26 14:57:06.617728,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'krb5' registered
>[2013/01/26 14:57:06.617834,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'fake_gssapi_krb5' registered
>[2013/01/26 14:57:06.622504,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:06.626260,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam' registered
>[2013/01/26 14:57:06.626373,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam_ignoredomain' registered
>[2013/01/26 14:57:06.626468,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'anonymous' registered
>[2013/01/26 14:57:06.626566,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind' registered
>[2013/01/26 14:57:06.626677,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind_wbclient' registered
>[2013/01/26 14:57:06.626779,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'name_to_ntstatus' registered
>[2013/01/26 14:57:06.626873,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'unix' registered
>[2013/01/26 14:57:06.643238,  3] ../source3/smbd/negprot.c:669(reply_negprot)
>  Selected protocol SMB 2.???
>[2013/01/26 14:57:06.645220,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:06.656388,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:06.673116,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of privilege.ldb
>[2013/01/26 14:57:06,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:06,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:06.684759,  3] ../source3/smbd/password.c:144(register_homes_share)
>  Adding homes service for user 'DC1\Administrator' using home directory: '/home/DC1/Administrator'
>[2013/01/26 14:57:06.685047,  3] ../source3/param/loadparm.c:1723(lp_add_home)
>  adding home's share [Administrator] for user 'DC1\Administrator' at '/home/DC1/%U'
>[2013/01/26 14:57:06.688318,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:06.688586,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/tmp' for service [IPC$]
>[2013/01/26 14:57:06.688860,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:06.689078,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:06.689199,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:06.691694,  2] ../lib/util/modules.c:199(do_smb_load_module)
>  Module 'acl_xattr' loaded
>[2013/01/26 14:57:06.691801,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:06.691937,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service IPC$
>[2013/01/26 14:57:06.696771,  3] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) connect to service IPC$ initially as user DC1\Administrator (uid=0, gid=100) (pid 7160)
>[2013/01/26 14:57:06.699527,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:06.703280,  3] ../source3/rpc_server/srv_pipe.c:691(api_pipe_bind_req)
>  api_pipe_bind_req: srvsvc -> srvsvc rpc service
>[2013/01/26 14:57:06.703425,  3] ../source3/rpc_server/srv_pipe.c:340(check_bind_req)
>  check_bind_req for \srvsvc
>[2013/01/26 14:57:06.703512,  3] ../source3/rpc_server/srv_pipe.c:347(check_bind_req)
>  check_bind_req: srvsvc -> srvsvc rpc service
>[2013/01/26 14:57:06.705316,  3] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 23
>[2013/01/26 14:57:06.707046,  3] ../source3/rpc_server/srv_pipe.c:1369(api_rpcTNP)
>  api_rpcTNP: rpc command: SRVSVC_NETSHAREENUMALL
>[2013/01/26 14:57:06.709050,  3] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 277
>[2013/01/26 14:57:06.987719,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \ns1\Administrator is not a dfs root.
>[2013/01/26 14:57:06.989913,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |profiles| in dfs path \ns1\profiles is not a dfs root.
>[2013/01/26 14:57:07.005474,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |sysvol| in dfs path \ns1\sysvol is not a dfs root.
>[2013/01/26 14:57:07.005883,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:07.006045,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/home/DC1/administrator' for service [Administrator]
>[2013/01/26 14:57:07.006149,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:07.006234,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:07.006320,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [full_audit]
>[2013/01/26 14:57:07.008773,  2] ../lib/util/modules.c:199(do_smb_load_module)
>  Module 'full_audit' loaded
>[2013/01/26 14:57:07.008889,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:07.009338,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service Administrator
>[2013/01/26 14:57:07,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:07,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:07,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:07,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:07.030775,  1] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) connect to service Administrator initially as user DC1\Administrator (uid=0, gid=100) (pid 7160)
>[2013/01/26 14:57:07.031914,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:07.032301,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/var/lib/samba/profiles' for service [profiles]
>[2013/01/26 14:57:07.032422,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:07.032535,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:07.032657,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:07.032771,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:07.032874,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service profiles
>[2013/01/26 14:57:07.039453,  1] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) connect to service profiles initially as user DC1\Administrator (uid=0, gid=100) (pid 7160)
>[2013/01/26 14:57:07.040128,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:07.040323,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/var/lib/samba/sysvol' for service [sysvol]
>[2013/01/26 14:57:07.040438,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:07.040561,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:07.040674,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:07.040899,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:07.040986,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service sysvol
>[2013/01/26 14:57:07.045999,  1] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) connect to service sysvol initially as user DC1\Administrator (uid=0, gid=100) (pid 7160)
>[2013/01/26 14:57:07.979410,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:07.979710,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:07.979999,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:08.189326,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:08.189493,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:08.189903,  3] ../source3/smbd/smb2_notify.c:208(smbd_smb2_notify_send)
>  smbd_smb2_notify_send: notify change called on ., filter = FILE_NAME|DIR_NAME|ATTRIBUTES|LAST_WRITE, recursive = 0
>[2013/01/26 14:57:08.199674,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [desktop.ini] [/home/DC1/administrator]
>[2013/01/26 14:57:08.199820,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: desktop.ini reduced to /home/DC1/administrator/desktop.ini
>[2013/01/26 14:57:08.199964,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(desktop.ini) returning 0600
>[2013/01/26 14:57:08.201626,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:08.201739,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:08.201890,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:08.203932,  3] ../source3/smbd/dir.c:663(dptr_create)
>  creating new dirptr 0 for path ., expect_close = 0
>[2013/01/26 14:57:08.204190,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./. fname=. (.)
>[2013/01/26 14:57:08.204434,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:08.204582,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./.. fname=.. (..)
>[2013/01/26 14:57:08.204839,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:08.205029,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./Thumbs.db fname=Thumbs.db (Thumbs.db)
>[2013/01/26 14:57:08.205176,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:08.205312,  3] ../source3/smbd/dir.c:1136(smbd_dirptr_get_entry)
>  smbd_dirptr_get_entry mask=[*] found ./1.txt fname=1.txt (1.txt)
>[2013/01/26 14:57:11.075928,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:11.076078,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:11.076243,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:11.384162,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:11.384285,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:11.384420,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:16.106321,  3] ../source3/smbd/service.c:1165(close_cnum)
>  192.168.100.51 (ipv4:192.168.100.51:58955) closed connection to service IPC$
>[2013/01/26 14:57:16.402388,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:16.402794,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/tmp' for service [IPC$]
>[2013/01/26 14:57:16.402903,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:16.403005,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:16.403101,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:16.403193,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:16.403282,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service IPC$
>[2013/01/26 14:57:16.407766,  3] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58955) connect to service IPC$ initially as user DC1\Administrator (uid=0, gid=100) (pid 7144)
>[2013/01/26 14:57:16.409655,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:16.412768,  3] ../source3/rpc_server/srv_pipe.c:691(api_pipe_bind_req)
>  api_pipe_bind_req: srvsvc -> srvsvc rpc service
>[2013/01/26 14:57:16.412969,  3] ../source3/rpc_server/srv_pipe.c:340(check_bind_req)
>  check_bind_req for \srvsvc
>[2013/01/26 14:57:16.413066,  3] ../source3/rpc_server/srv_pipe.c:347(check_bind_req)
>  check_bind_req: srvsvc -> srvsvc rpc service
>[2013/01/26 14:57:16.414601,  3] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 23
>[2013/01/26 14:57:16.416331,  3] ../source3/rpc_server/srv_pipe.c:1369(api_rpcTNP)
>  api_rpcTNP: rpc command: SRVSVC_NETSHAREENUMALL
>[2013/01/26 14:57:16.416777,  3] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 277
>[2013/01/26 14:57:16.664677,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |profiles| in dfs path \ns1.dc1.lefoyer.ru\profiles is not a dfs root.
>[2013/01/26 14:57:16.667879,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |sysvol| in dfs path \ns1.dc1.lefoyer.ru\sysvol is not a dfs root.
>[2013/01/26 14:57:16.689636,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:16.689796,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/var/lib/samba/sysvol' for service [sysvol]
>[2013/01/26 14:57:16.689900,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:16.689985,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:16.690072,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:16.690158,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:16.690245,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service sysvol
>[2013/01/26 14:57:16.695097,  1] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58955) connect to service sysvol initially as user DC1\Administrator (uid=0, gid=100) (pid 7144)
>[2013/01/26 14:57:16.695652,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:16.695791,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/var/lib/samba/profiles' for service [profiles]
>[2013/01/26 14:57:16.695906,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:16.695998,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:16.696090,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:16.696175,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:16.696262,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service profiles
>[2013/01/26 14:57:16.701104,  1] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58955) connect to service profiles initially as user DC1\Administrator (uid=0, gid=100) (pid 7144)
>[2013/01/26 14:57:17.798898,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:17.799064,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:17.799219,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:18.003840,  3] ../source3/smbd/smb2_notify.c:208(smbd_smb2_notify_send)
>  smbd_smb2_notify_send: notify change called on ., filter = FILE_NAME|DIR_NAME|ATTRIBUTES|LAST_WRITE, recursive = 0
>[2013/01/26 14:57:18.013431,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:18.013530,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:18.013660,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:19,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:19,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:20.351446,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:20.351660,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:20.351833,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:20.680519,  3] ../source3/smbd/vfs.c:1118(check_reduced_name)
>  check_reduced_name [.] [/home/DC1/administrator]
>[2013/01/26 14:57:20.680707,  3] ../source3/smbd/vfs.c:1248(check_reduced_name)
>  check_reduced_name: . reduced to /home/DC1/administrator
>[2013/01/26 14:57:20.680874,  3] ../source3/smbd/dosmode.c:160(unix_mode)
>  unix_mode(.) returning 0600
>[2013/01/26 14:57:22.143085,  1] ../source3/smbd/service.c:1165(close_cnum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) closed connection to service sysvol
>[2013/01/26 14:57:22.159949,  1] ../source3/smbd/service.c:1165(close_cnum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) closed connection to service profiles
>[2013/01/26 14:57:22.162887,  3] ../source3/smbd/service.c:1165(close_cnum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) closed connection to service IPC$
>[2013/01/26 14:57:24.587777,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:24.588917,  3] ../source3/smbd/oplock.c:985(init_oplocks)
>  init_oplocks: initializing messages.
>[2013/01/26 14:57:24.589682,  3] ../source3/smbd/process.c:1789(process_smb)
>  Transaction 0 of length 108 (0 toread)
>[2013/01/26 14:57:24.596708,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_spnego' registered
>[2013/01/26 14:57:24.596865,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5' registered
>[2013/01/26 14:57:24.596962,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'gssapi_krb5_sasl' registered
>[2013/01/26 14:57:24.616396,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'sasl-DIGEST-MD5' registered
>[2013/01/26 14:57:24.616535,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'schannel' registered
>[2013/01/26 14:57:24.616634,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'spnego' registered
>[2013/01/26 14:57:24.616733,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'ntlmssp' registered
>[2013/01/26 14:57:24.616838,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'krb5' registered
>[2013/01/26 14:57:24.616955,  3] ../auth/gensec/gensec_start.c:868(gensec_register)
>  GENSEC backend 'fake_gssapi_krb5' registered
>[2013/01/26 14:57:24.621573,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:24.625254,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam' registered
>[2013/01/26 14:57:24.625372,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'sam_ignoredomain' registered
>[2013/01/26 14:57:24.625466,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'anonymous' registered
>[2013/01/26 14:57:24.625574,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind' registered
>[2013/01/26 14:57:24.625667,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'winbind_wbclient' registered
>[2013/01/26 14:57:24.625801,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'name_to_ntstatus' registered
>[2013/01/26 14:57:24.625888,  3] ../source4/auth/ntlm/auth.c:673(auth_register)
>  AUTH backend 'unix' registered
>[2013/01/26 14:57:24,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: TGS-REQ Administrator@DC1.LEFOYER.RU from ipv4:192.168.100.51:58965 for cifs/dc1.lefoyer.ru@DC1.LEFOYER.RU [canonicalize, renewable, forwardable]
>[2013/01/26 14:57:24,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Searching referral for dc1.lefoyer.ru
>[2013/01/26 14:57:24,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Returning a referral to realm LEFOYER.RU for server cifs/dc1.lefoyer.ru@DC1.LEFOYER.RU that was not found
>[2013/01/26 14:57:24,  3] ../source4/kdc/db-glue.c:1095(samba_kdc_lookup_trust)
>  Failed find a single entry for (&(objectClass=trustedDomain)(|(flatname=LEFOYER.RU)(trustPartner=LEFOYER.RU))): got 0
>[2013/01/26 14:57:24,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: samba_kdc_fetch: could not find principal in DB
>[2013/01/26 14:57:24,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Server not found in database: krbtgt/LEFOYER.RU@DC1.LEFOYER.RU: no such entry found in hdb
>[2013/01/26 14:57:24,  3] ../source4/auth/kerberos/krb5_init_context.c:80(smb_krb5_debug_wrapper)
>  Kerberos: Failed building TGS-REP to ipv4:192.168.100.51:58965
>[2013/01/26 14:57:24,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'kdc_tcp_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:24,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[kdc_tcp_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:24.656111,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of secrets.ldb
>[2013/01/26 14:57:24.661422,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0xe2088297
>[2013/01/26 14:57:24.663955,  3] ../auth/ntlmssp/ntlmssp_server.c:358(ntlmssp_server_preauth)
>  Got user=[Administrator] domain=[DC1] workstation=[LEFOYER] len1=24 len2=258
>[2013/01/26 14:57:24.664105,  3] ../source4/auth/ntlm/auth.c:270(auth_check_password_send)
>  auth_check_password_send: Checking password for unmapped user [DC1]\[Administrator]@[LEFOYER]
>  auth_check_password_send: mapped user is: [DC1]\[Administrator]@[LEFOYER]
>[2013/01/26 14:57:24.675358,  3] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2013/01/26 14:57:24.675742,  3] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0xe2088215
>[2013/01/26 14:57:24.681279,  3] ../lib/ldb-samba/ldb_wrap.c:318(ldb_wrap_connect)
>  ldb_wrap open of privilege.ldb
>[2013/01/26 14:57:24,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:24,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]
>[2013/01/26 14:57:24.692244,  3] ../source3/smbd/password.c:144(register_homes_share)
>  Adding homes service for user 'DC1\Administrator' using home directory: '/home/DC1/Administrator'
>[2013/01/26 14:57:24.692544,  3] ../source3/param/loadparm.c:1723(lp_add_home)
>  adding home's share [Administrator] for user 'DC1\Administrator' at '/home/DC1/%U'
>[2013/01/26 14:57:24.695382,  3] ../source3/lib/access.c:338(allow_access)
>  Allowed connection from 192.168.100.51 (192.168.100.51)
>[2013/01/26 14:57:24.695655,  3] ../source3/smbd/service.c:646(make_connection_snum)
>  Connect path is '/tmp' for service [IPC$]
>[2013/01/26 14:57:24.695914,  3] ../source3/smbd/vfs.c:113(vfs_init_default)
>  Initialising default vfs hooks
>[2013/01/26 14:57:24.696136,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2013/01/26 14:57:24.696264,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [acl_xattr]
>[2013/01/26 14:57:24.698775,  2] ../lib/util/modules.c:199(do_smb_load_module)
>  Module 'acl_xattr' loaded
>[2013/01/26 14:57:24.698880,  3] ../source3/smbd/vfs.c:139(vfs_init_custom)
>  Initialising custom vfs hooks from [dfs_samba4]
>[2013/01/26 14:57:24.699015,  2] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr)
>  connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service IPC$
>[2013/01/26 14:57:24.704161,  3] ../source3/smbd/service.c:891(make_connection_snum)
>  192.168.100.51 (ipv4:192.168.100.51:58964) connect to service IPC$ initially as user DC1\Administrator (uid=0, gid=100) (pid 7164)
>[2013/01/26 14:57:24.707088,  3] ../source3/locking/share_mode_lock.c:408(fetch_share_mode_unlocked)
>  Could not fetch share entry
>[2013/01/26 14:57:24.710738,  3] ../source3/rpc_server/srv_pipe.c:691(api_pipe_bind_req)
>  api_pipe_bind_req: srvsvc -> srvsvc rpc service
>[2013/01/26 14:57:24.710897,  3] ../source3/rpc_server/srv_pipe.c:340(check_bind_req)
>  check_bind_req for \srvsvc
>[2013/01/26 14:57:24.710983,  3] ../source3/rpc_server/srv_pipe.c:347(check_bind_req)
>  check_bind_req: srvsvc -> srvsvc rpc service
>[2013/01/26 14:57:24.712563,  3] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 23
>[2013/01/26 14:57:24.714537,  3] ../source3/rpc_server/srv_pipe.c:1369(api_rpcTNP)
>  api_rpcTNP: rpc command: SRVSVC_NETSHAREENUMALL
>[2013/01/26 14:57:24.715118,  3] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 277
>[2013/01/26 14:57:24.978501,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:24.979107,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |profiles| in dfs path \dc1.lefoyer.ru\profiles is not a dfs root.
>[2013/01/26 14:57:26.111575,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.115995,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.312745,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.322047,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.323387,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.324931,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.327073,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.329628,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:26.331128,  3] ../source3/smbd/msdfs.c:914(get_referred_path)
>  get_referred_path: |Administrator| in dfs path \dc1.lefoyer.ru\Administrator is not a dfs root.
>[2013/01/26 14:57:28.164560,  1] ../source3/smbd/service.c:1165(close_cnum)
>  192.168.100.51 (ipv4:192.168.100.51:58962) closed connection to service Administrator
>[2013/01/26 14:57:28.171120,  2] ../source3/smbd/smb2_server.c:3123(smbd_smb2_request_incoming)
>  smbd_smb2_request_incoming: client read error NT_STATUS_CONNECTION_RESET
>[2013/01/26 14:57:28.172397,  3] ../source3/smbd/server_exit.c:218(exit_server_common)
>  Server exit (NT_STATUS_CONNECTION_RESET)
>[2013/01/26 14:57:28.173891,  1] ../source3/smbd/service.c:1165(close_cnum)
>  192.168.100.51 (ipv4:192.168.100.51:58955) closed connection to service profiles
>[2013/01/26 14:57:28,  3] ../source4/smbd/service_stream.c:63(stream_terminate_connection)
>  Terminating connection - 'wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED'
>[2013/01/26 14:57:28,  3] ../source4/smbd/process_single.c:104(single_terminate)
>  single_terminate: reason[wbsrv_call_loop: tstream_read_pdu_blob_recv() - NT_STATUS_CONNECTION_DISCONNECTED]

Actions: View

Attachments on bug 9605: 8492