root@cipdc01:~# tail -f /var/log/samba/log.smbd [2013/12/10 17:18:55.382002, 0, pid=1537] ../source3/printing/print_cups.c:528(cups_async_callback) failed to retrieve printer list: NT_STATUS_UNSUCCESSFUL [2013/12/10 17:19:53.395199, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2090 -- ignoring [2013/12/10 17:20:53.460388, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2186 -- ignoring [2013/12/10 17:21:53.485373, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2201 -- ignoring [2013/12/10 17:22:53.490495, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2276 -- ignoring [2013/12/10 17:23:53.501543, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2285 -- ignoring [2013/12/10 17:24:39.187214, 3, pid=2309] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:24:39.201072, 3, pid=2309] ../source3/smbd/oplock.c:868(init_oplocks) init_oplocks: initializing messages. [2013/12/10 17:24:39.201957, 3, pid=2309] ../source3/smbd/process.c:1796(process_smb) Transaction 0 of length 108 (0 toread) [2013/12/10 17:24:39.202533, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:39.203251, 3, pid=2309] ../source3/smbd/smb2_negprot.c:243(smbd_smb2_request_process_negprot) Selected protocol SMB2_10 [2013/12/10 17:24:39.260572, 2, pid=2309] ../lib/util/modules.c:191(do_smb_load_module) Module 'samba4' loaded [2013/12/10 17:24:39.265545, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_spnego' registered [2013/12/10 17:24:39.265825, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_krb5' registered [2013/12/10 17:24:39.266044, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_krb5_sasl' registered [2013/12/10 17:24:39.266288, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'schannel' registered [2013/12/10 17:24:39.266549, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'spnego' registered [2013/12/10 17:24:39.266788, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'ntlmssp' registered [2013/12/10 17:24:39.267086, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'krb5' registered [2013/12/10 17:24:39.267320, 3, pid=2309] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'fake_gssapi_krb5' registered [2013/12/10 17:24:39.270771, 3, pid=2309] ../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect) ldb_wrap open of secrets.ldb [2013/12/10 17:24:39.275116, 3, pid=2309] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'sam' registered [2013/12/10 17:24:39.275344, 3, pid=2309] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'sam_ignoredomain' registered [2013/12/10 17:24:39.275546, 3, pid=2309] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'anonymous' registered [2013/12/10 17:24:39.275801, 3, pid=2309] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'winbind' registered [2013/12/10 17:24:39.276084, 3, pid=2309] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'winbind_wbclient' registered [2013/12/10 17:24:39.276364, 3, pid=2309] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'name_to_ntstatus' registered [2013/12/10 17:24:39.276625, 3, pid=2309] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'unix' registered [2013/12/10 17:24:44.376318, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:44.378765, 3, pid=2309] ../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect) ldb_wrap open of secrets.ldb [2013/12/10 17:24:44.387933, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.388193, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:44.388458, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.388911, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:44.389914, 3, pid=2309] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/12/10 17:24:44.391589, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.391810, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:44.392030, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.392395, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:44.401799, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:44.402066, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.402287, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:44.402498, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.402817, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:44.403233, 3, pid=2309] ../auth/ntlmssp/ntlmssp_server.c:358(ntlmssp_server_preauth) Got user=[Administrator] domain=[CARE-IT] workstation=[CIHP7800-W7P] len1=24 len2=256 [2013/12/10 17:24:44.403529, 3, pid=2309] ../source4/auth/ntlm/auth.c:270(auth_check_password_send) auth_check_password_send: Checking password for unmapped user [CARE-IT]\[Administrator]@[CIHP7800-W7P] auth_check_password_send: mapped user is: [CARE-IT]\[Administrator]@[CIHP7800-W7P] [2013/12/10 17:24:44.411685, 4, pid=2309] ../libcli/auth/ntlm_check.c:359(ntlm_password_check) ntlm_password_check: Checking NTLMv2 password with domain [CARE-IT] [2013/12/10 17:24:44.412149, 4, pid=2309] ../source4/auth/sam.c:170(authsam_account_ok) authsam_account_ok: Checking SMB password for user Administrator [2013/12/10 17:24:44.431087, 3, pid=2309] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init) NTLMSSP Sign/Seal - Initialising with flags: [2013/12/10 17:24:44.431318, 3, pid=2309] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/12/10 17:24:44.432054, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.432214, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:44.432369, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:44.432560, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:44.456960, 3, pid=2309] ../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect) ldb_wrap open of privilege.ldb [2013/12/10 17:24:44.539492, 3, pid=2309] ../source3/smbd/password.c:138(register_homes_share) No home directory defined for user 'CARE-IT+Administrator' [2013/12/10 17:24:44.540106, 4, pid=2309] ../source3/auth/pampass.c:483(smb_pam_start) smb_pam_start: PAM: Init user: CARE-IT+Administrator [2013/12/10 17:24:44.593977, 4, pid=2309] ../source3/auth/pampass.c:492(smb_pam_start) smb_pam_start: PAM: setting rhost to: 192.168.1.62 [2013/12/10 17:24:44.594263, 4, pid=2309] ../source3/auth/pampass.c:501(smb_pam_start) smb_pam_start: PAM: setting tty [2013/12/10 17:24:44.594493, 4, pid=2309] ../source3/auth/pampass.c:509(smb_pam_start) smb_pam_start: PAM: Init passed for user: CARE-IT+Administrator [2013/12/10 17:24:44.594872, 4, pid=2309] ../source3/auth/pampass.c:646(smb_internal_pam_session) smb_internal_pam_session: PAM: tty set to: smb/3990493017 [2013/12/10 17:24:48.173901, 4, pid=2309] ../source3/auth/pampass.c:465(smb_pam_end) smb_pam_end: PAM: PAM_END OK. [2013/12/10 17:24:48.186143, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.186993, 3, pid=2309] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:24:48.187498, 3, pid=2309] ../source3/smbd/service.c:612(make_connection_snum) Connect path is '/tmp' for service [IPC$] [2013/12/10 17:24:48.187909, 3, pid=2309] ../source3/smbd/vfs.c:113(vfs_init_default) Initialising default vfs hooks [2013/12/10 17:24:48.188110, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2013/12/10 17:24:48.188316, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [dfs_samba4] [2013/12/10 17:24:48.238971, 2, pid=2309] ../lib/util/modules.c:191(do_smb_load_module) Module 'dfs_samba4' loaded [2013/12/10 17:24:48.247930, 3, pid=2309] ../source3/smbd/oplock_linux.c:251(linux_init_kernel_oplocks) Linux kernel oplocks enabled [2013/12/10 17:24:48.248422, 3, pid=2309] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID administrator is not in a valid format [2013/12/10 17:24:48.248745, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.248909, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:48.249044, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.252967, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.253437, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:48.253824, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.254325, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.254783, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.255155, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:48.255374, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.256040, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.256861, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.257097, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:48.257680, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.258220, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.259272, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.260008, 2, pid=2309] ../source3/smbd/uid.c:270(check_user_ok) check_user_ok: user CARE-IT+Administrator is an admin user. Setting uid as 0 [2013/12/10 17:24:48.260294, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.261104, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.261676, 3, pid=2309] ../source3/smbd/service.c:848(make_connection_snum) 192.168.1.62 (ipv4:192.168.1.62:58384) connect to service IPC$ initially as user CARE-IT+Administrator (uid=0, gid=5000) (pid 2309) [2013/12/10 17:24:48.263703, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.264042, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:24:48.264362, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:24:48.287664, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.288105, 3, pid=2309] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:24:48.288580, 3, pid=2309] ../source3/smbd/service.c:612(make_connection_snum) Connect path is '/CIT-DATA/CI-C' for service [CI-C] [2013/12/10 17:24:48.288850, 3, pid=2309] ../source3/smbd/vfs.c:113(vfs_init_default) Initialising default vfs hooks [2013/12/10 17:24:48.289061, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2013/12/10 17:24:48.289210, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [acl_xattr] [2013/12/10 17:24:48.303278, 2, pid=2309] ../lib/util/modules.c:191(do_smb_load_module) Module 'acl_xattr' loaded [2013/12/10 17:24:48.303535, 2, pid=2309] ../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 CI-C [2013/12/10 17:24:48.304401, 3, pid=2309] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID administrator is not in a valid format [2013/12/10 17:24:48.304626, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.304756, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:48.304883, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.306509, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.306781, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:48.306951, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.307184, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.307370, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.307551, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:48.307708, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.307926, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.308196, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.308458, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:48.308635, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:48.308856, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:48.309684, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.310114, 2, pid=2309] ../source3/smbd/uid.c:270(check_user_ok) check_user_ok: user CARE-IT+Administrator is an admin user. Setting uid as 0 [2013/12/10 17:24:48.310401, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.310641, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.311376, 2, pid=2309] ../source3/smbd/service.c:848(make_connection_snum) 192.168.1.62 (ipv4:192.168.1.62:58384) connect to service CI-C initially as user CARE-IT+Administrator (uid=0, gid=5000) (pid 2309) [2013/12/10 17:24:48.653267, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.653546, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-C [2013/12/10 17:24:48.654074, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-C [2013/12/10 17:24:48.686148, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:24:48.686406, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:24:48.687545, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(.) returning 0777 [2013/12/10 17:24:48.688120, 4, pid=2309] ../source3/smbd/open.c:2297(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0777, access_mask = 0x80, open_access_mask = 0x80 [2013/12/10 17:24:48.707798, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.708104, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:24:48.708451, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:24:48.709681, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:48.709961, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-C [2013/12/10 17:24:48.710429, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-C [2013/12/10 17:24:48.710747, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:24:48.711063, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:24:48.712697, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.193478, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.193945, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:24:49.194192, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:24:49.195218, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.195566, 3, pid=2309] ../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/12/10 17:24:49.219802, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.220973, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [desktop.ini] [/CIT-DATA/CI-C] [2013/12/10 17:24:49.221392, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: desktop.ini reduced to /CIT-DATA/CI-C/desktop.ini [2013/12/10 17:24:49.221861, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(desktop.ini) returning 0777 [2013/12/10 17:24:49.223195, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.223665, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:24:49.223939, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:24:49.224386, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(.) returning 0777 [2013/12/10 17:24:49.224850, 4, pid=2309] ../source3/smbd/open.c:2297(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0777, access_mask = 0x100081, open_access_mask = 0x100081 [2013/12/10 17:24:49.226825, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.227292, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:24:49.227560, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:24:49.229188, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.256223, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.256713, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:24:49.256953, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:24:49.258527, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.259914, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.260526, 3, pid=2309] ../source3/smbd/dir.c:665(dptr_create) creating new dirptr 0 for path ., expect_close = 0 [2013/12/10 17:24:49.261254, 3, pid=2309] ../source3/smbd/dir.c:1134(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./. fname=. (.) [2013/12/10 17:24:49.261921, 3, pid=2309] ../source3/smbd/dir.c:1134(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./.. fname=.. (..) [2013/12/10 17:24:49.262762, 3, pid=2309] ../source3/smbd/dir.c:1134(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./CI-TEMPLATE fname=CI-TEMPLATE (CI-TEMPLATE) [2013/12/10 17:24:49.263379, 3, pid=2309] ../source3/smbd/dir.c:1134(smbd_dirptr_get_entry) smbd_dirptr_get_entry mask=[*] found ./CI-USERS fname=CI-USERS (CI-USERS) [2013/12/10 17:24:49.263858, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.265131, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.265623, 4, pid=2309] ../source3/smbd/dir.c:263(dptr_close_internal) closing dptr key 0 [2013/12/10 17:24:49.284093, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.284589, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:24:49.284788, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:24:49.285591, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.285930, 3, pid=2309] ../source3/smbd/trans2.c:3092(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 1001 [2013/12/10 17:24:49.286395, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:49.286652, 3, pid=2309] ../source3/smbd/trans2.c:3092(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 1005 [2013/12/10 17:24:49.287725, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.178774, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.179376, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:24:50.179922, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:24:50.181126, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.181940, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.466830, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.467844, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.468315, 3, pid=2309] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:24:50.468716, 3, pid=2309] ../source3/smbd/service.c:612(make_connection_snum) Connect path is '/CIT-DATA/CI-VOGTS' for service [CI-VOGTS] [2013/12/10 17:24:50.468934, 3, pid=2309] ../source3/smbd/vfs.c:113(vfs_init_default) Initialising default vfs hooks [2013/12/10 17:24:50.469075, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2013/12/10 17:24:50.469195, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [acl_xattr] [2013/12/10 17:24:50.469334, 2, pid=2309] ../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 CI-VOGTS [2013/12/10 17:24:50.470040, 3, pid=2309] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID administrator is not in a valid format [2013/12/10 17:24:50.470251, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.470389, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:50.470519, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.471923, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.472140, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:50.472285, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.472482, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.472679, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.472799, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:50.472917, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.473086, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.473317, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.473460, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:50.473571, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.473771, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.474564, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.474952, 2, pid=2309] ../source3/smbd/uid.c:270(check_user_ok) check_user_ok: user CARE-IT+Administrator is an admin user. Setting uid as 0 [2013/12/10 17:24:50.475267, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.475471, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.476150, 2, pid=2309] ../source3/smbd/service.c:848(make_connection_snum) 192.168.1.62 (ipv4:192.168.1.62:58384) connect to service CI-VOGTS initially as user CARE-IT+Administrator (uid=0, gid=5000) (pid 2309) [2013/12/10 17:24:50.497292, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.501940, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.502352, 3, pid=2309] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:24:50.502705, 3, pid=2309] ../source3/smbd/service.c:612(make_connection_snum) Connect path is '/CIT-DATA/CI-D' for service [CI-D] [2013/12/10 17:24:50.502919, 3, pid=2309] ../source3/smbd/vfs.c:113(vfs_init_default) Initialising default vfs hooks [2013/12/10 17:24:50.503042, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2013/12/10 17:24:50.503182, 3, pid=2309] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [acl_xattr] [2013/12/10 17:24:50.503343, 2, pid=2309] ../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 CI-D [2013/12/10 17:24:50.504068, 3, pid=2309] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID administrator is not in a valid format [2013/12/10 17:24:50.504342, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.504514, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:24:50.504768, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.506211, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.506430, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:50.506543, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.506724, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.506874, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.507023, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:50.507216, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.507449, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.507676, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.507815, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:24:50.508008, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:24:50.508194, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:24:50.508998, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.509407, 2, pid=2309] ../source3/smbd/uid.c:270(check_user_ok) check_user_ok: user CARE-IT+Administrator is an admin user. Setting uid as 0 [2013/12/10 17:24:50.509666, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.509850, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.510590, 2, pid=2309] ../source3/smbd/service.c:848(make_connection_snum) 192.168.1.62 (ipv4:192.168.1.62:58384) connect to service CI-D initially as user CARE-IT+Administrator (uid=0, gid=5000) (pid 2309) [2013/12/10 17:24:50.933844, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.934157, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-D [2013/12/10 17:24:50.934574, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-D [2013/12/10 17:24:50.934944, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-D] [2013/12/10 17:24:50.935227, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-D [2013/12/10 17:24:50.935629, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(.) returning 0777 [2013/12/10 17:24:50.935988, 4, pid=2309] ../source3/smbd/open.c:2297(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0777, access_mask = 0x80, open_access_mask = 0x80 [2013/12/10 17:24:50.937221, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.937521, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:50.937904, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-VOGTS [2013/12/10 17:24:50.938265, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-VOGTS] [2013/12/10 17:24:50.938633, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:50.939025, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(.) returning 0777 [2013/12/10 17:24:50.939422, 4, pid=2309] ../source3/smbd/open.c:2297(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0777, access_mask = 0x80, open_access_mask = 0x80 [2013/12/10 17:24:50.940607, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.940905, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-D [2013/12/10 17:24:50.941374, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-D [2013/12/10 17:24:50.941726, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-D] [2013/12/10 17:24:50.941986, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-D [2013/12/10 17:24:50.943100, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.943495, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:50.943939, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-VOGTS [2013/12/10 17:24:50.944278, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-VOGTS] [2013/12/10 17:24:50.944552, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:50.945624, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.945920, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-D [2013/12/10 17:24:50.946313, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-D [2013/12/10 17:24:50.947217, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:50.947513, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:50.947939, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-VOGTS [2013/12/10 17:24:51.465750, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:51.466020, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-D [2013/12/10 17:24:51.466450, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-D [2013/12/10 17:24:51.466770, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-D] [2013/12/10 17:24:51.466963, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-D [2013/12/10 17:24:51.468002, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:51.468312, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:51.468732, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-VOGTS [2013/12/10 17:24:51.469031, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-VOGTS] [2013/12/10 17:24:51.469244, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:51.470294, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:51.470548, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-D [2013/12/10 17:24:51.470948, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-D [2013/12/10 17:24:51.471717, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:24:51.471970, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-VOGTS [2013/12/10 17:24:51.472509, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-VOGTS [2013/12/10 17:24:53.520719, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2348 -- ignoring [2013/12/10 17:25:03.816804, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:03.817130, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-C [2013/12/10 17:25:03.817613, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-C [2013/12/10 17:25:03.817950, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:25:03.818178, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:25:03.818510, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(.) returning 0777 [2013/12/10 17:25:03.818840, 4, pid=2309] ../source3/smbd/open.c:2297(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0777, access_mask = 0x80, open_access_mask = 0x80 [2013/12/10 17:25:03.820859, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:03.961221, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:03.961808, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:25:03.962484, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:25:03.963678, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:03.965030, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.632770, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.633379, 4, pid=2309] ../source3/rpc_server/rpc_ncacn_np.c:60(make_internal_rpc_pipe_p) Create pipe requested \srvsvc [2013/12/10 17:25:06.633805, 4, pid=2309] ../source3/rpc_server/rpc_ncacn_np.c:100(make_internal_rpc_pipe_p) Created internal pipe \srvsvc [2013/12/10 17:25:06.634838, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.635890, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.636651, 3, pid=2309] ../source3/rpc_server/srv_pipe.c:693(api_pipe_bind_req) api_pipe_bind_req: srvsvc -> srvsvc rpc service [2013/12/10 17:25:06.636867, 3, pid=2309] ../source3/rpc_server/srv_pipe.c:342(check_bind_req) check_bind_req for \srvsvc [2013/12/10 17:25:06.636998, 3, pid=2309] ../source3/rpc_server/srv_pipe.c:349(check_bind_req) check_bind_req: srvsvc -> srvsvc rpc service [2013/12/10 17:25:06.638069, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.638369, 3, pid=2309] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context) free_pipe_context: destroying talloc pool of size 28 [2013/12/10 17:25:06.639313, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.639989, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 5000) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:06.640374, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:06.640697, 4, pid=2309] ../source3/rpc_server/srv_pipe.c:1356(api_rpcTNP) api_rpcTNP: \srvsvc op 0x10 - api_rpcTNP: rpc command: SRVSVC_NETSHAREGETINFO [2013/12/10 17:25:06.699740, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 5000) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:06.700008, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(3990493017) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:06.700204, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:06.700946, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 5000) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:06.722356, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.722821, 3, pid=2309] ../source3/rpc_server/srv_pipe_hnd.c:122(free_pipe_context) free_pipe_context: destroying talloc pool of size 103 [2013/12/10 17:25:06.726409, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.728136, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.728499, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-C [2013/12/10 17:25:06.729029, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-C [2013/12/10 17:25:06.729281, 3, pid=2309] ../source3/smbd/trans2.c:3092(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 1001 [2013/12/10 17:25:06.729820, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.730182, 3, pid=2309] ../source3/smbd/trans2.c:3092(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 1005 [2013/12/10 17:25:06.741882, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.742506, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:25:06.742993, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:25:06.743806, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(.) returning 0777 [2013/12/10 17:25:06.744332, 4, pid=2309] ../source3/smbd/open.c:2297(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0777, access_mask = 0x10e0080, open_access_mask = 0x10e0080 [2013/12/10 17:25:06.746108, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.758813, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.759137, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:25:06.759407, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:25:06.760001, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 5000) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:06.760295, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(3990493017) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:06.760508, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:06.836482, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.837949, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.839021, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.840318, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.841821, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:06.869758, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:07.124527, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:07.125017, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-C [2013/12/10 17:25:07.125601, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-C [2013/12/10 17:25:07.127133, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:07.128504, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:07.129344, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [$Extend] [/CIT-DATA/CI-C] [2013/12/10 17:25:07.129692, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: $Extend reduced to /CIT-DATA/CI-C/$Extend [2013/12/10 17:25:07.130867, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:07.347143, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:07.347444, 3, pid=2309] ../source3/smbd/trans2.c:3092(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 1007 [2013/12/10 17:25:07.348464, 3, pid=2309] ../source3/lib/sysquotas.c:433(sys_get_quota) sys_get_vfs_quota() failed for mntpath[/CIT-DATA] bdev[/dev/sda1] qtype[2] id[0]: Function not implemented [2013/12/10 17:25:07.349061, 3, pid=2309] ../source3/lib/sysquotas.c:433(sys_get_quota) sys_get_vfs_quota() failed for mntpath[/CIT-DATA] bdev[/dev/sda1] qtype[4] id[5000]: Function not implemented [2013/12/10 17:25:07.364546, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:07.365056, 3, pid=2309] ../source3/smbd/trans2.c:3092(smbd_do_qfsinfo) smbd_do_qfsinfo: level = 1007 [2013/12/10 17:25:07.365989, 3, pid=2309] ../source3/lib/sysquotas.c:433(sys_get_quota) sys_get_vfs_quota() failed for mntpath[/CIT-DATA] bdev[/dev/sda1] qtype[2] id[0]: Function not implemented [2013/12/10 17:25:07.366564, 3, pid=2309] ../source3/lib/sysquotas.c:433(sys_get_quota) sys_get_vfs_quota() failed for mntpath[/CIT-DATA] bdev[/dev/sda1] qtype[4] id[5000]: Function not implemented [2013/12/10 17:25:08.582854, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.583163, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:25:08.583431, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:25:08.584019, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 5000) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:08.584589, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(3990493017) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:08.584975, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:08.586865, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.587871, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.588837, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.589765, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.590726, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.608426, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.618005, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.618326, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /CIT-DATA/CI-C [2013/12/10 17:25:08.618874, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /CIT-DATA/CI-C [2013/12/10 17:25:08.619212, 3, pid=2309] ../source3/smbd/vfs.c:1137(check_reduced_name) check_reduced_name [.] [/CIT-DATA/CI-C] [2013/12/10 17:25:08.619526, 3, pid=2309] ../source3/smbd/vfs.c:1267(check_reduced_name) check_reduced_name: . reduced to /CIT-DATA/CI-C [2013/12/10 17:25:08.620135, 3, pid=2309] ../source3/smbd/dosmode.c:158(unix_mode) unix_mode(.) returning 0777 [2013/12/10 17:25:08.620560, 4, pid=2309] ../source3/smbd/open.c:2297(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0777, access_mask = 0x20080, open_access_mask = 0x20080 [2013/12/10 17:25:08.622424, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.622756, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 5000) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:08.622944, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(3990493017) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:08.623067, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:08.623459, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.624349, 3, pid=2309] ../source3/smbd/nttrans.c:1974(smbd_do_query_security_desc) smbd_do_query_security_desc: sd_size = 28. [2013/12/10 17:25:08.625208, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.625518, 4, pid=2309] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 5000) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:08.625686, 4, pid=2309] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(3990493017) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:08.625909, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:08.626207, 4, pid=2309] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:08.626697, 3, pid=2309] ../source3/smbd/nttrans.c:1974(smbd_do_query_security_desc) smbd_do_query_security_desc: sd_size = 28. [2013/12/10 17:25:08.627817, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:13.601877, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:13.603370, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:22.295489, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 5000) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:22.487029, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:25:22.487360, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:25:22.487645, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:22.488124, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:22.488478, 3, pid=2309] ../source3/smbd/service.c:1122(close_cnum) 192.168.1.62 (ipv4:192.168.1.62:58384) closed connection to service IPC$ [2013/12/10 17:25:22.488798, 4, pid=2309] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to / [2013/12/10 17:25:22.489115, 4, pid=2309] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got / [2013/12/10 17:25:22.489349, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.679215, 3, pid=2395] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:25:33.679754, 3, pid=2395] ../source3/smbd/oplock.c:868(init_oplocks) init_oplocks: initializing messages. [2013/12/10 17:25:33.680547, 3, pid=2395] ../source3/smbd/process.c:1796(process_smb) Transaction 0 of length 108 (0 toread) [2013/12/10 17:25:33.681048, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.681560, 3, pid=2395] ../source3/smbd/smb2_negprot.c:243(smbd_smb2_request_process_negprot) Selected protocol SMB2_10 [2013/12/10 17:25:33.694781, 2, pid=2395] ../lib/util/modules.c:191(do_smb_load_module) Module 'samba4' loaded [2013/12/10 17:25:33.699734, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_spnego' registered [2013/12/10 17:25:33.699995, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_krb5' registered [2013/12/10 17:25:33.700158, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_krb5_sasl' registered [2013/12/10 17:25:33.700339, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'schannel' registered [2013/12/10 17:25:33.700470, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'spnego' registered [2013/12/10 17:25:33.700606, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'ntlmssp' registered [2013/12/10 17:25:33.700749, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'krb5' registered [2013/12/10 17:25:33.700877, 3, pid=2395] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'fake_gssapi_krb5' registered [2013/12/10 17:25:33.704168, 3, pid=2395] ../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect) ldb_wrap open of secrets.ldb [2013/12/10 17:25:33.708425, 3, pid=2395] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'sam' registered [2013/12/10 17:25:33.708682, 3, pid=2395] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'sam_ignoredomain' registered [2013/12/10 17:25:33.708808, 3, pid=2395] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'anonymous' registered [2013/12/10 17:25:33.708966, 3, pid=2395] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'winbind' registered [2013/12/10 17:25:33.709085, 3, pid=2395] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'winbind_wbclient' registered [2013/12/10 17:25:33.709203, 3, pid=2395] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'name_to_ntstatus' registered [2013/12/10 17:25:33.709322, 3, pid=2395] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'unix' registered [2013/12/10 17:25:33.733746, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.735978, 3, pid=2395] ../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect) ldb_wrap open of secrets.ldb [2013/12/10 17:25:33.745248, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.745514, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.746090, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.746623, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.747769, 3, pid=2395] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/12/10 17:25:33.750247, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.750479, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.750665, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.750992, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.762648, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.762925, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.763077, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.763198, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.763339, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.763569, 3, pid=2395] ../auth/ntlmssp/ntlmssp_server.c:358(ntlmssp_server_preauth) Got user=[] domain=[] workstation=[CIHP7800-W7P] len1=1 len2=0 [2013/12/10 17:25:33.763780, 3, pid=2395] ../source4/auth/ntlm/auth.c:270(auth_check_password_send) auth_check_password_send: Checking password for unmapped user []\[]@[CIHP7800-W7P] auth_check_password_send: mapped user is: [CARE-IT]\[]@[CIHP7800-W7P] [2013/12/10 17:25:33.764219, 3, pid=2395] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init) NTLMSSP Sign/Seal - Initialising with flags: [2013/12/10 17:25:33.764495, 3, pid=2395] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/12/10 17:25:33.765414, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.765596, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.765714, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.765867, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.780853, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.781520, 3, pid=2395] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:25:33.781997, 3, pid=2395] ../source3/smbd/service.c:612(make_connection_snum) Connect path is '/tmp' for service [IPC$] [2013/12/10 17:25:33.782472, 3, pid=2395] ../source3/smbd/vfs.c:113(vfs_init_default) Initialising default vfs hooks [2013/12/10 17:25:33.782682, 3, pid=2395] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2013/12/10 17:25:33.782839, 3, pid=2395] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [dfs_samba4] [2013/12/10 17:25:33.790325, 2, pid=2395] ../lib/util/modules.c:191(do_smb_load_module) Module 'dfs_samba4' loaded [2013/12/10 17:25:33.799752, 3, pid=2395] ../source3/smbd/oplock_linux.c:251(linux_init_kernel_oplocks) Linux kernel oplocks enabled [2013/12/10 17:25:33.800163, 3, pid=2395] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID administrator is not in a valid format [2013/12/10 17:25:33.800583, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.800760, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.800872, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.804977, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.805188, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.805320, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.805530, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.805715, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.805850, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.805968, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.806114, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.806443, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.806586, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.806691, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.806946, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.807841, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.808182, 3, pid=2395] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID join-backup is not in a valid format [2013/12/10 17:25:33.808505, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.808646, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.808843, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.810316, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.810525, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.810638, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.810851, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.811054, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.811187, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.811294, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.811453, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.811666, 4, pid=2395] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.811807, 4, pid=2395] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.811951, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.812107, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.812962, 4, pid=2395] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.813383, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (5025, 5013) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.813657, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.814046, 3, pid=2395] ../source3/smbd/service.c:848(make_connection_snum) 192.168.1.62 (ipv4:192.168.1.62:58395) connect to service IPC$ initially as user NT AUTHORITY+ANONYMOUS LOGON (uid=5025, gid=5013) (pid 2395) [2013/12/10 17:25:33.823018, 3, pid=2396] ../source3/lib/access.c:338(allow_access) Allowed connection from 192.168.1.62 (192.168.1.62) [2013/12/10 17:25:33.823536, 3, pid=2396] ../source3/smbd/oplock.c:868(init_oplocks) init_oplocks: initializing messages. [2013/12/10 17:25:33.824273, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 0 of length 72 (0 toread) [2013/12/10 17:25:33.824680, 2, pid=2396] ../source3/smbd/reply.c:592(reply_special) netbios connect: name1=CIPDC01 0x20 name2=CIHP7800-W7P 0x0 [2013/12/10 17:25:33.824950, 2, pid=2396] ../source3/smbd/reply.c:633(reply_special) netbios connect: local=cipdc01 remote=cihp7800-w7p, name type = 0 [2013/12/10 17:25:33.830643, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 0 of length 137 (0 toread) [2013/12/10 17:25:33.830956, 3, pid=2396] ../source3/smbd/process.c:1399(switch_message) switch message SMBnegprot (pid 2396) conn 0x0 [2013/12/10 17:25:33.831224, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.833264, 3, pid=2396] ../source3/smbd/negprot.c:563(reply_negprot) Requested protocol [PC NETWORK PROGRAM 1.0] [2013/12/10 17:25:33.833514, 3, pid=2396] ../source3/smbd/negprot.c:563(reply_negprot) Requested protocol [LANMAN1.0] [2013/12/10 17:25:33.833653, 3, pid=2396] ../source3/smbd/negprot.c:563(reply_negprot) Requested protocol [Windows for Workgroups 3.1a] [2013/12/10 17:25:33.833939, 3, pid=2396] ../source3/smbd/negprot.c:563(reply_negprot) Requested protocol [LM1.2X002] [2013/12/10 17:25:33.834077, 3, pid=2396] ../source3/smbd/negprot.c:563(reply_negprot) Requested protocol [LANMAN2.1] [2013/12/10 17:25:33.834204, 3, pid=2396] ../source3/smbd/negprot.c:563(reply_negprot) Requested protocol [NT LM 0.12] [2013/12/10 17:25:33.847358, 2, pid=2396] ../lib/util/modules.c:191(do_smb_load_module) Module 'samba4' loaded [2013/12/10 17:25:33.852223, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_spnego' registered [2013/12/10 17:25:33.852539, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_krb5' registered [2013/12/10 17:25:33.852670, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'gssapi_krb5_sasl' registered [2013/12/10 17:25:33.852811, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'schannel' registered [2013/12/10 17:25:33.852929, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'spnego' registered [2013/12/10 17:25:33.853056, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'ntlmssp' registered [2013/12/10 17:25:33.853210, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'krb5' registered [2013/12/10 17:25:33.853365, 3, pid=2396] ../auth/gensec/gensec_start.c:870(gensec_register) GENSEC backend 'fake_gssapi_krb5' registered [2013/12/10 17:25:33.856813, 3, pid=2396] ../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect) ldb_wrap open of secrets.ldb [2013/12/10 17:25:33.860983, 3, pid=2396] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'sam' registered [2013/12/10 17:25:33.861190, 3, pid=2396] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'sam_ignoredomain' registered [2013/12/10 17:25:33.861309, 3, pid=2396] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'anonymous' registered [2013/12/10 17:25:33.861435, 3, pid=2396] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'winbind' registered [2013/12/10 17:25:33.861547, 3, pid=2396] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'winbind_wbclient' registered [2013/12/10 17:25:33.861664, 3, pid=2396] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'name_to_ntstatus' registered [2013/12/10 17:25:33.861783, 3, pid=2396] ../source4/auth/ntlm/auth.c:673(auth_register) AUTH backend 'unix' registered [2013/12/10 17:25:33.881559, 3, pid=2396] ../source3/smbd/negprot.c:384(reply_nt1) using SPNEGO [2013/12/10 17:25:33.881781, 3, pid=2396] ../source3/smbd/negprot.c:671(reply_negprot) Selected protocol NT LM 0.12 [2013/12/10 17:25:33.883712, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 1 of length 142 (0 toread) [2013/12/10 17:25:33.884107, 3, pid=2396] ../source3/smbd/process.c:1399(switch_message) switch message SMBsesssetupX (pid 2396) conn 0x0 [2013/12/10 17:25:33.884415, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.884650, 3, pid=2396] ../source3/smbd/sesssetup.c:601(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/12/10 17:25:33.884904, 2, pid=2396] ../source3/smbd/sesssetup.c:542(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/12/10 17:25:33.885218, 3, pid=2396] ../source3/smbd/sesssetup.c:138(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/12/10 17:25:33.885513, 3, pid=2396] ../source3/smbd/sesssetup.c:179(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/12/10 17:25:33.887595, 3, pid=2396] ../lib/ldb-samba/ldb_wrap.c:320(ldb_wrap_connect) ldb_wrap open of secrets.ldb [2013/12/10 17:25:33.896636, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.896952, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.897156, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.898076, 3, pid=2396] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/12/10 17:25:33.899483, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.900978, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 2 of length 208 (0 toread) [2013/12/10 17:25:33.901233, 3, pid=2396] ../source3/smbd/process.c:1399(switch_message) switch message SMBsesssetupX (pid 2396) conn 0x0 [2013/12/10 17:25:33.901456, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.901678, 3, pid=2396] ../source3/smbd/sesssetup.c:601(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2013/12/10 17:25:33.901866, 2, pid=2396] ../source3/smbd/sesssetup.c:542(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2013/12/10 17:25:33.902039, 3, pid=2396] ../source3/smbd/sesssetup.c:138(reply_sesssetup_and_X_spnego) Doing spnego session setup [2013/12/10 17:25:33.902233, 3, pid=2396] ../source3/smbd/sesssetup.c:179(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2013/12/10 17:25:33.902427, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.902609, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.902779, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.903119, 3, pid=2396] ../auth/ntlmssp/ntlmssp_server.c:358(ntlmssp_server_preauth) Got user=[] domain=[] workstation=[CIHP7800-W7P] len1=1 len2=0 [2013/12/10 17:25:33.903436, 3, pid=2396] ../source4/auth/ntlm/auth.c:270(auth_check_password_send) auth_check_password_send: Checking password for unmapped user []\[]@[CIHP7800-W7P] auth_check_password_send: mapped user is: [CARE-IT]\[]@[CIHP7800-W7P] [2013/12/10 17:25:33.904046, 3, pid=2396] ../auth/ntlmssp/ntlmssp_sign.c:547(ntlmssp_sign_init) NTLMSSP Sign/Seal - Initialising with flags: [2013/12/10 17:25:33.904340, 3, pid=2396] ../auth/ntlmssp/ntlmssp_util.c:34(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2013/12/10 17:25:33.905391, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.919116, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 3 of length 84 (0 toread) [2013/12/10 17:25:33.919363, 3, pid=2396] ../source3/smbd/process.c:1399(switch_message) switch message SMBtconX (pid 2396) conn 0x0 [2013/12/10 17:25:33.919490, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.919659, 4, pid=2396] ../source3/smbd/reply.c:857(reply_tcon_and_X) Client requested device type [?????] for share [IPC$] [2013/12/10 17:25:33.920289, 3, pid=2396] ../source3/lib/access.c:338(allow_access) Allowed connection from cihp7800-w7p (192.168.1.62) [2013/12/10 17:25:33.920808, 3, pid=2396] ../source3/smbd/service.c:612(make_connection_snum) Connect path is '/tmp' for service [IPC$] [2013/12/10 17:25:33.921277, 3, pid=2396] ../source3/smbd/vfs.c:113(vfs_init_default) Initialising default vfs hooks [2013/12/10 17:25:33.921483, 3, pid=2396] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2013/12/10 17:25:33.921620, 3, pid=2396] ../source3/smbd/vfs.c:139(vfs_init_custom) Initialising custom vfs hooks from [dfs_samba4] [2013/12/10 17:25:33.929191, 2, pid=2396] ../lib/util/modules.c:191(do_smb_load_module) Module 'dfs_samba4' loaded [2013/12/10 17:25:33.938290, 3, pid=2396] ../source3/smbd/oplock_linux.c:251(linux_init_kernel_oplocks) Linux kernel oplocks enabled [2013/12/10 17:25:33.938700, 3, pid=2396] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID administrator is not in a valid format [2013/12/10 17:25:33.939109, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.939280, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.939438, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.943456, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.943665, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.943778, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.943977, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.944185, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.944355, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.944489, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.944687, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.945059, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.945256, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.945390, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.945562, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.946491, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.946824, 3, pid=2396] ../libcli/security/dom_sid.c:208(dom_sid_parse_endp) string_to_sid: SID join-backup is not in a valid format [2013/12/10 17:25:33.947017, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.947184, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2013/12/10 17:25:33.947295, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.948882, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.949098, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.949212, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.949369, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.949645, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.949781, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.949888, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.950065, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.950278, 4, pid=2396] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.950495, 4, pid=2396] ../source3/smbd/uid.c:485(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2013/12/10 17:25:33.950607, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2013/12/10 17:25:33.950778, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2013/12/10 17:25:33.951616, 4, pid=2396] ../source3/smbd/sec_ctx.c:424(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.952097, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (5025, 5013) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.952424, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.952762, 3, pid=2396] ../source3/smbd/service.c:848(make_connection_snum) cihp7800-w7p (ipv4:192.168.1.62:58396) connect to service IPC$ initially as user NT AUTHORITY+ANONYMOUS LOGON (uid=5025, gid=5013) (pid 2396) [2013/12/10 17:25:33.953147, 3, pid=2396] ../source3/smbd/reply.c:1024(reply_tcon_and_X) tconX service=IPC$ [2013/12/10 17:25:33.954239, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 4 of length 130 (0 toread) [2013/12/10 17:25:33.954425, 3, pid=2396] ../source3/smbd/process.c:1399(switch_message) switch message SMBtrans (pid 2396) conn 0x7f05c865cf00 [2013/12/10 17:25:33.954558, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (5025, 5013) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:33.954742, 4, pid=2396] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:25:33.955062, 4, pid=2396] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:25:33.955293, 3, pid=2396] ../source3/smbd/ipc.c:589(handle_trans) trans <\PIPE\LANMAN> data=0 params=34 setup=0 [2013/12/10 17:25:33.955485, 3, pid=2396] ../source3/smbd/ipc.c:540(named_pipe) named pipe command on name [2013/12/10 17:25:33.955613, 3, pid=2396] ../source3/smbd/lanman.c:5853(api_reply) Got API command 104 of form (tdscnt=0,tpscnt=34,mdrcnt=4374,mprcnt=8) [2013/12/10 17:25:33.955775, 3, pid=2396] ../source3/smbd/lanman.c:5857(api_reply) Doing NetServerEnum2 [2013/12/10 17:25:33.955957, 4, pid=2396] ../source3/smbd/lanman.c:1495(api_RNetServerEnum2) server request level: B16BBDz 3fffffff domains_req:No local_only:No [2013/12/10 17:25:33.956136, 4, pid=2396] ../source3/smbd/lanman.c:1508(api_RNetServerEnum2) domain [CARE-IT] [2013/12/10 17:25:33.956517, 4, pid=2396] ../source3/smbd/lanman.c:1243(get_session_info) Servertype search: 3fffffff [2013/12/10 17:25:33.956819, 4, pid=2396] ../source3/smbd/lanman.c:1322(get_session_info) s: dom mismatch CARE-IT 80001000 CIPDC01 CARE-IT [2013/12/10 17:25:33.956996, 4, pid=2396] ../source3/smbd/lanman.c:1335(get_session_info) **SV** CIPDC01 d9b0b Univention Corporate Server CARE-IT [2013/12/10 17:25:33.957136, 4, pid=2396] ../source3/smbd/lanman.c:1335(get_session_info) **SV** CIVOGTWWIN7 11003 CARE-IT [2013/12/10 17:25:33.957284, 4, pid=2396] ../source3/smbd/lanman.c:1531(api_RNetServerEnum2) fill_srv_info[0] CIPDC01 d9b0b Univention Corporate Server CARE-IT [2013/12/10 17:25:33.957464, 4, pid=2396] ../source3/smbd/lanman.c:1531(api_RNetServerEnum2) fill_srv_info[1] CIVOGTWWIN7 11003 CARE-IT [2013/12/10 17:25:33.957665, 4, pid=2396] ../source3/smbd/lanman.c:1567(api_RNetServerEnum2) fill_srv_info[0] CIPDC01 d9b0b Univention Corporate Server CARE-IT [2013/12/10 17:25:33.957848, 4, pid=2396] ../source3/smbd/lanman.c:1567(api_RNetServerEnum2) fill_srv_info[1] CIVOGTWWIN7 11003 CARE-IT [2013/12/10 17:25:33.957995, 3, pid=2396] ../source3/smbd/lanman.c:1585(api_RNetServerEnum2) NetServerEnum2 domain = CARE-IT uLevel=1 counted=2 total=2 [2013/12/10 17:25:39.218384, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.309823, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (5025, 5013) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.310180, 4, pid=2395] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to /tmp [2013/12/10 17:25:46.310573, 4, pid=2395] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got /tmp [2013/12/10 17:25:46.310853, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.311330, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.311560, 3, pid=2395] ../source3/smbd/service.c:1122(close_cnum) 192.168.1.62 (ipv4:192.168.1.62:58395) closed connection to service IPC$ [2013/12/10 17:25:46.311848, 4, pid=2395] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to / [2013/12/10 17:25:46.312122, 4, pid=2395] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got / [2013/12/10 17:25:46.312535, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.335240, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.335701, 4, pid=2395] ../source3/auth/pampass.c:483(smb_pam_start) smb_pam_start: PAM: Init user: NT AUTHORITY+ANONYMOUS LOGON [2013/12/10 17:25:46.351533, 4, pid=2395] ../source3/auth/pampass.c:492(smb_pam_start) smb_pam_start: PAM: setting rhost to: 192.168.1.62 [2013/12/10 17:25:46.351772, 4, pid=2395] ../source3/auth/pampass.c:501(smb_pam_start) smb_pam_start: PAM: setting tty [2013/12/10 17:25:46.351916, 4, pid=2395] ../source3/auth/pampass.c:509(smb_pam_start) smb_pam_start: PAM: Init passed for user: NT AUTHORITY+ANONYMOUS LOGON [2013/12/10 17:25:46.352031, 4, pid=2395] ../source3/auth/pampass.c:646(smb_internal_pam_session) smb_internal_pam_session: PAM: tty set to: smb/879440106 [2013/12/10 17:25:46.354828, 4, pid=2395] ../source3/auth/pampass.c:465(smb_pam_end) smb_pam_end: PAM: PAM_END OK. [2013/12/10 17:25:46.358826, 2, pid=2395] ../source3/smbd/smb2_server.c:3250(smbd_smb2_request_incoming) smbd_smb2_request_incoming: client read error NT_STATUS_CONNECTION_RESET [2013/12/10 17:25:46.359087, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 5 of length 39 (0 toread) [2013/12/10 17:25:46.359193, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.359289, 3, pid=2396] ../source3/smbd/process.c:1399(switch_message) switch message SMBtdis (pid 2396) conn 0x7f05c865cf00 [2013/12/10 17:25:46.359392, 4, pid=2395] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.359452, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.359858, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.359972, 3, pid=2395] ../source3/smbd/server_exit.c:212(exit_server_common) Server exit (NT_STATUS_CONNECTION_RESET) [2013/12/10 17:25:46.360103, 3, pid=2396] ../source3/smbd/service.c:1122(close_cnum) cihp7800-w7p (ipv4:192.168.1.62:58396) closed connection to service IPC$ [2013/12/10 17:25:46.360401, 4, pid=2396] ../source3/smbd/vfs.c:838(vfs_ChDir) vfs_ChDir to / [2013/12/10 17:25:46.360681, 4, pid=2396] ../source3/smbd/vfs.c:849(vfs_ChDir) vfs_ChDir got / [2013/12/10 17:25:46.360921, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.362324, 3, pid=2396] ../source3/smbd/process.c:1796(process_smb) Transaction 6 of length 43 (0 toread) [2013/12/10 17:25:46.362660, 3, pid=2396] ../source3/smbd/process.c:1399(switch_message) switch message SMBulogoffX (pid 2396) conn 0x0 [2013/12/10 17:25:46.362901, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.363476, 4, pid=2396] ../source3/auth/pampass.c:483(smb_pam_start) smb_pam_start: PAM: Init user: NT AUTHORITY+ANONYMOUS LOGON [2013/12/10 17:25:46.384136, 4, pid=2396] ../source3/auth/pampass.c:492(smb_pam_start) smb_pam_start: PAM: setting rhost to: cihp7800-w7p [2013/12/10 17:25:46.384585, 4, pid=2396] ../source3/auth/pampass.c:501(smb_pam_start) smb_pam_start: PAM: setting tty [2013/12/10 17:25:46.384859, 4, pid=2396] ../source3/auth/pampass.c:509(smb_pam_start) smb_pam_start: PAM: Init passed for user: NT AUTHORITY+ANONYMOUS LOGON [2013/12/10 17:25:46.385128, 4, pid=2396] ../source3/auth/pampass.c:646(smb_internal_pam_session) smb_internal_pam_session: PAM: tty set to: smb/3656595360 [2013/12/10 17:25:46.388960, 4, pid=2396] ../source3/auth/pampass.c:465(smb_pam_end) smb_pam_end: PAM: PAM_END OK. [2013/12/10 17:25:46.390117, 3, pid=2396] ../source3/smbd/reply.c:2282(reply_ulogoffX) ulogoffX vuid=34851 [2013/12/10 17:25:46.391538, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.391891, 4, pid=2396] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:25:46.392415, 3, pid=2396] ../source3/smbd/server_exit.c:212(exit_server_common) Server exit (failed to receive smb request) [2013/12/10 17:25:53.532685, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2407 -- ignoring [2013/12/10 17:26:39.277274, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:26:53.597526, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2852 -- ignoring [2013/12/10 17:27:39.337685, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2013/12/10 17:27:53.640630, 2, pid=1520] ../source3/smbd/server.c:437(remove_child_pid) Could not find child 2858 -- ignoring [2013/12/10 17:28:39.341214, 4, pid=2309] ../source3/smbd/sec_ctx.c:316(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0