[2021/03/02 17:46:51.487237, 6, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2368(lp_file_list_changed) lp_file_list_changed() file /usr/local/samba/etc/smb.conf -> /usr/local/samba/etc/smb.conf last mod_time: Tue Mar 2 16:23:56 2021 [2021/03/02 17:46:51.487298, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.487313, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_session_global.tdb 2: 3: 4: [2021/03/02 17:46:51.487332, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 28E211F9 [2021/03/02 17:46:51.487349, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f53a930 [2021/03/02 17:46:51.487399, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:452(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: No watchers [2021/03/02 17:46:51.487436, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:949(smbXsrv_session_global_store) [2021/03/02 17:46:51.487447, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:950(smbXsrv_session_global_store) smbXsrv_session_global_store: key '28E211F9' stored [2021/03/02 17:46:51.487462, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_session_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000005 (5) info : union smbXsrv_session_globalU(case 0) info0 : * info0: struct smbXsrv_session_global0 db_rec : * session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : Tue Mar 2 05:46:51 PM 2021 PST auth_session_info_seqnum : 0x00000001 (1) auth_session_info : * auth_session_info: struct auth_session_info security_token : * security_token: struct security_token num_sids : 0x0000000f (15) sids: ARRAY(15) sids : S-1-5-21-1914782597-1700840410-671320589-1000 sids : S-1-5-21-1914782597-1700840410-671320589-513 sids : S-1-22-2-1000 sids : S-1-22-2-4 sids : S-1-22-2-24 sids : S-1-22-2-27 sids : S-1-22-2-30 sids : S-1-22-2-46 sids : S-1-22-2-118 sids : S-1-22-2-129 sids : S-1-22-2-134 sids : S-1-1-0 sids : S-1-5-2 sids : S-1-5-11 sids : S-1-22-1-1000 privilege_mask : 0x0000000000000000 (0) 0: SEC_PRIV_MACHINE_ACCOUNT_BIT 0: SEC_PRIV_PRINT_OPERATOR_BIT 0: SEC_PRIV_ADD_USERS_BIT 0: SEC_PRIV_DISK_OPERATOR_BIT 0: SEC_PRIV_REMOTE_SHUTDOWN_BIT 0: SEC_PRIV_BACKUP_BIT 0: SEC_PRIV_RESTORE_BIT 0: SEC_PRIV_TAKE_OWNERSHIP_BIT 0: SEC_PRIV_INCREASE_QUOTA_BIT 0: SEC_PRIV_SECURITY_BIT 0: SEC_PRIV_LOAD_DRIVER_BIT 0: SEC_PRIV_SYSTEM_PROFILE_BIT 0: SEC_PRIV_SYSTEMTIME_BIT 0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT 0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT 0: SEC_PRIV_CREATE_PAGEFILE_BIT 0: SEC_PRIV_SHUTDOWN_BIT 0: SEC_PRIV_DEBUG_BIT 0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT 0: SEC_PRIV_CHANGE_NOTIFY_BIT 0: SEC_PRIV_UNDOCK_BIT 0: SEC_PRIV_ENABLE_DELEGATION_BIT 0: SEC_PRIV_MANAGE_VOLUME_BIT 0: SEC_PRIV_IMPERSONATE_BIT 0: SEC_PRIV_CREATE_GLOBAL_BIT rights_mask : 0x00000000 (0) 0: LSA_POLICY_MODE_INTERACTIVE 0: LSA_POLICY_MODE_NETWORK 0: LSA_POLICY_MODE_BATCH 0: LSA_POLICY_MODE_SERVICE 0: LSA_POLICY_MODE_PROXY 0: LSA_POLICY_MODE_DENY_INTERACTIVE 0: LSA_POLICY_MODE_DENY_NETWORK 0: LSA_POLICY_MODE_DENY_BATCH 0: LSA_POLICY_MODE_DENY_SERVICE 0: LSA_POLICY_MODE_REMOTE_INTERACTIVE 0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE 0x00: LSA_POLICY_MODE_ALL (0) 0x00: LSA_POLICY_MODE_ALL_NT4 (0) unix_token : * unix_token: struct security_unix_token uid : 0x00000000000003e8 (1000) gid : 0x00000000000003e8 (1000) ngroups : 0x00000009 (9) groups: ARRAY(9) groups : 0x00000000000003e8 (1000) groups : 0x0000000000000004 (4) groups : 0x0000000000000018 (24) groups : 0x000000000000001b (27) groups : 0x000000000000001e (30) groups : 0x000000000000002e (46) groups : 0x0000000000000076 (118) groups : 0x0000000000000081 (129) groups : 0x0000000000000086 (134) info : * info: struct auth_user_info account_name : * account_name : 'jeremy' user_principal_name : NULL user_principal_constructed: 0x00 (0) domain_name : * domain_name : 'JEREMY-ACERB' dns_domain_name : NULL full_name : * full_name : 'Jeremy' logon_script : * logon_script : '' profile_path : * profile_path : '\\JEREMY-ACERB\jeremy\profile' home_directory : * home_directory : '\\JEREMY-ACERB\jeremy' home_drive : * home_drive : '' logon_server : * logon_server : 'JEREMY-ACERB' last_logon : NTTIME(0) last_logoff : Wed Sep 13 07:48:05 PM 30828 PDT acct_expiry : Wed Sep 13 07:48:05 PM 30828 PDT last_password_change : Wed Sep 30 10:15:50 AM 2020 PDT allow_password_change : Wed Sep 30 10:15:50 AM 2020 PDT force_password_change : Wed Sep 13 07:48:05 PM 30828 PDT logon_count : 0x0000 (0) bad_password_count : 0x0000 (0) acct_flags : 0x00000010 (16) authenticated : 0x01 (1) unix_info : * unix_info: struct auth_user_info_unix unix_name : * unix_name : 'jeremy' sanitized_username : * sanitized_username : 'jeremy' torture : NULL credentials : NULL unique_session_token : eb3a4ee7-6d63-4013-9af5-3d0b16cff1b3 connection_dialect : 0x0311 (785) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : * encryption_key : * decryption_key : * num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : * auth_session_info_seqnum : 0x00000001 (1) connection : * encryption_cipher : 0x0002 (2) [2021/03/02 17:46:51.488431, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.488447, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 28E211F9 [2021/03/02 17:46:51.488463, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1422(smbXsrv_session_update) [2021/03/02 17:46:51.488472, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1428(smbXsrv_session_update) smbXsrv_session_update: global_id (0x28e211f9) stored [2021/03/02 17:46:51.488486, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &session_blob: struct smbXsrv_sessionB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_sessionU(case 0) info0 : * info0: struct smbXsrv_session table : * db_rec : NULL client : * local_id : 0x28e211f9 (685904377) global : * global: struct smbXsrv_session_global0 db_rec : NULL session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : Tue Mar 2 05:46:51 PM 2021 PST auth_session_info_seqnum : 0x00000001 (1) auth_session_info : * auth_session_info: struct auth_session_info security_token : * security_token: struct security_token num_sids : 0x0000000f (15) sids: ARRAY(15) sids : S-1-5-21-1914782597-1700840410-671320589-1000 sids : S-1-5-21-1914782597-1700840410-671320589-513 sids : S-1-22-2-1000 sids : S-1-22-2-4 sids : S-1-22-2-24 sids : S-1-22-2-27 sids : S-1-22-2-30 sids : S-1-22-2-46 sids : S-1-22-2-118 sids : S-1-22-2-129 sids : S-1-22-2-134 sids : S-1-1-0 sids : S-1-5-2 sids : S-1-5-11 sids : S-1-22-1-1000 privilege_mask : 0x0000000000000000 (0) 0: SEC_PRIV_MACHINE_ACCOUNT_BIT 0: SEC_PRIV_PRINT_OPERATOR_BIT 0: SEC_PRIV_ADD_USERS_BIT 0: SEC_PRIV_DISK_OPERATOR_BIT 0: SEC_PRIV_REMOTE_SHUTDOWN_BIT 0: SEC_PRIV_BACKUP_BIT 0: SEC_PRIV_RESTORE_BIT 0: SEC_PRIV_TAKE_OWNERSHIP_BIT 0: SEC_PRIV_INCREASE_QUOTA_BIT 0: SEC_PRIV_SECURITY_BIT 0: SEC_PRIV_LOAD_DRIVER_BIT 0: SEC_PRIV_SYSTEM_PROFILE_BIT 0: SEC_PRIV_SYSTEMTIME_BIT 0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT 0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT 0: SEC_PRIV_CREATE_PAGEFILE_BIT 0: SEC_PRIV_SHUTDOWN_BIT 0: SEC_PRIV_DEBUG_BIT 0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT 0: SEC_PRIV_CHANGE_NOTIFY_BIT 0: SEC_PRIV_UNDOCK_BIT 0: SEC_PRIV_ENABLE_DELEGATION_BIT 0: SEC_PRIV_MANAGE_VOLUME_BIT 0: SEC_PRIV_IMPERSONATE_BIT 0: SEC_PRIV_CREATE_GLOBAL_BIT rights_mask : 0x00000000 (0) 0: LSA_POLICY_MODE_INTERACTIVE 0: LSA_POLICY_MODE_NETWORK 0: LSA_POLICY_MODE_BATCH 0: LSA_POLICY_MODE_SERVICE 0: LSA_POLICY_MODE_PROXY 0: LSA_POLICY_MODE_DENY_INTERACTIVE 0: LSA_POLICY_MODE_DENY_NETWORK 0: LSA_POLICY_MODE_DENY_BATCH 0: LSA_POLICY_MODE_DENY_SERVICE 0: LSA_POLICY_MODE_REMOTE_INTERACTIVE 0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE 0x00: LSA_POLICY_MODE_ALL (0) 0x00: LSA_POLICY_MODE_ALL_NT4 (0) unix_token : * unix_token: struct security_unix_token uid : 0x00000000000003e8 (1000) gid : 0x00000000000003e8 (1000) ngroups : 0x00000009 (9) groups: ARRAY(9) groups : 0x00000000000003e8 (1000) groups : 0x0000000000000004 (4) groups : 0x0000000000000018 (24) groups : 0x000000000000001b (27) groups : 0x000000000000001e (30) groups : 0x000000000000002e (46) groups : 0x0000000000000076 (118) groups : 0x0000000000000081 (129) groups : 0x0000000000000086 (134) info : * info: struct auth_user_info account_name : * account_name : 'jeremy' user_principal_name : NULL user_principal_constructed: 0x00 (0) domain_name : * domain_name : 'JEREMY-ACERB' dns_domain_name : NULL full_name : * full_name : 'Jeremy' logon_script : * logon_script : '' profile_path : * profile_path : '\\JEREMY-ACERB\jeremy\profile' home_directory : * home_directory : '\\JEREMY-ACERB\jeremy' home_drive : * home_drive : '' logon_server : * logon_server : 'JEREMY-ACERB' last_logon : NTTIME(0) last_logoff : Wed Sep 13 07:48:05 PM 30828 PDT acct_expiry : Wed Sep 13 07:48:05 PM 30828 PDT last_password_change : Wed Sep 30 10:15:50 AM 2020 PDT allow_password_change : Wed Sep 30 10:15:50 AM 2020 PDT force_password_change : Wed Sep 13 07:48:05 PM 30828 PDT logon_count : 0x0000 (0) bad_password_count : 0x0000 (0) acct_flags : 0x00000010 (16) authenticated : 0x01 (1) unix_info : * unix_info: struct auth_user_info_unix unix_name : * unix_name : 'jeremy' sanitized_username : * sanitized_username : 'jeremy' torture : NULL credentials : NULL unique_session_token : eb3a4ee7-6d63-4013-9af5-3d0b16cff1b3 connection_dialect : 0x0311 (785) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : * encryption_key : * decryption_key : * num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : * auth_session_info_seqnum : 0x00000001 (1) connection : * encryption_cipher : 0x0002 (2) status : NT_STATUS_OK idle_time : Tue Mar 2 05:46:51 PM 2021 PST nonce_high_random : 0x6941c34707dfa6a9 (7584557957310817961) nonce_high_max : 0x00000000ffffffff (4294967295) nonce_high : 0x0000000000000000 (0) nonce_low : 0x0000000000000000 (0) tcon_table : * homes_snum : 0xffffffff (4294967295) pending_auth : NULL [2021/03/02 17:46:51.489555, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [2] idx[1] status[NT_STATUS_OK] body[8] dyn[yes:29] at ../../source3/smbd/smb2_sesssetup.c:183 [2021/03/02 17:46:51.489572, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 8192, charge 1, granted 8192, current possible/max 8192/8192, total granted/max/low/range 8192/8192/3/8192 [2021/03/02 17:46:51.489593, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/smb/smb2_signing.c:173(smb2_signing_sign_pdu) signed SMB2 message [2021/03/02 17:46:51.506401, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.506423, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 3 (position 3) from bitmap [2021/03/02 17:46:51.506438, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_TCON] mid = 3 [2021/03/02 17:46:51.506463, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.506478, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_session_global.tdb 2: 3: 4: [2021/03/02 17:46:51.506495, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 28E211F9 [2021/03/02 17:46:51.506511, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f5522b0 [2021/03/02 17:46:51.506551, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:452(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: No watchers [2021/03/02 17:46:51.506568, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:949(smbXsrv_session_global_store) [2021/03/02 17:46:51.506577, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:950(smbXsrv_session_global_store) smbXsrv_session_global_store: key '28E211F9' stored [2021/03/02 17:46:51.506590, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_session_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000006 (6) info : union smbXsrv_session_globalU(case 0) info0 : * info0: struct smbXsrv_session_global0 db_rec : * session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : Tue Mar 2 05:46:51 PM 2021 PST auth_session_info_seqnum : 0x00000001 (1) auth_session_info : * auth_session_info: struct auth_session_info security_token : * security_token: struct security_token num_sids : 0x0000000f (15) sids: ARRAY(15) sids : S-1-5-21-1914782597-1700840410-671320589-1000 sids : S-1-5-21-1914782597-1700840410-671320589-513 sids : S-1-22-2-1000 sids : S-1-22-2-4 sids : S-1-22-2-24 sids : S-1-22-2-27 sids : S-1-22-2-30 sids : S-1-22-2-46 sids : S-1-22-2-118 sids : S-1-22-2-129 sids : S-1-22-2-134 sids : S-1-1-0 sids : S-1-5-2 sids : S-1-5-11 sids : S-1-22-1-1000 privilege_mask : 0x0000000000000000 (0) 0: SEC_PRIV_MACHINE_ACCOUNT_BIT 0: SEC_PRIV_PRINT_OPERATOR_BIT 0: SEC_PRIV_ADD_USERS_BIT 0: SEC_PRIV_DISK_OPERATOR_BIT 0: SEC_PRIV_REMOTE_SHUTDOWN_BIT 0: SEC_PRIV_BACKUP_BIT 0: SEC_PRIV_RESTORE_BIT 0: SEC_PRIV_TAKE_OWNERSHIP_BIT 0: SEC_PRIV_INCREASE_QUOTA_BIT 0: SEC_PRIV_SECURITY_BIT 0: SEC_PRIV_LOAD_DRIVER_BIT 0: SEC_PRIV_SYSTEM_PROFILE_BIT 0: SEC_PRIV_SYSTEMTIME_BIT 0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT 0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT 0: SEC_PRIV_CREATE_PAGEFILE_BIT 0: SEC_PRIV_SHUTDOWN_BIT 0: SEC_PRIV_DEBUG_BIT 0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT 0: SEC_PRIV_CHANGE_NOTIFY_BIT 0: SEC_PRIV_UNDOCK_BIT 0: SEC_PRIV_ENABLE_DELEGATION_BIT 0: SEC_PRIV_MANAGE_VOLUME_BIT 0: SEC_PRIV_IMPERSONATE_BIT 0: SEC_PRIV_CREATE_GLOBAL_BIT rights_mask : 0x00000000 (0) 0: LSA_POLICY_MODE_INTERACTIVE 0: LSA_POLICY_MODE_NETWORK 0: LSA_POLICY_MODE_BATCH 0: LSA_POLICY_MODE_SERVICE 0: LSA_POLICY_MODE_PROXY 0: LSA_POLICY_MODE_DENY_INTERACTIVE 0: LSA_POLICY_MODE_DENY_NETWORK 0: LSA_POLICY_MODE_DENY_BATCH 0: LSA_POLICY_MODE_DENY_SERVICE 0: LSA_POLICY_MODE_REMOTE_INTERACTIVE 0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE 0x00: LSA_POLICY_MODE_ALL (0) 0x00: LSA_POLICY_MODE_ALL_NT4 (0) unix_token : * unix_token: struct security_unix_token uid : 0x00000000000003e8 (1000) gid : 0x00000000000003e8 (1000) ngroups : 0x00000009 (9) groups: ARRAY(9) groups : 0x00000000000003e8 (1000) groups : 0x0000000000000004 (4) groups : 0x0000000000000018 (24) groups : 0x000000000000001b (27) groups : 0x000000000000001e (30) groups : 0x000000000000002e (46) groups : 0x0000000000000076 (118) groups : 0x0000000000000081 (129) groups : 0x0000000000000086 (134) info : * info: struct auth_user_info account_name : * account_name : 'jeremy' user_principal_name : NULL user_principal_constructed: 0x00 (0) domain_name : * domain_name : 'JEREMY-ACERB' dns_domain_name : NULL full_name : * full_name : 'Jeremy' logon_script : * logon_script : '' profile_path : * profile_path : '\\JEREMY-ACERB\jeremy\profile' home_directory : * home_directory : '\\JEREMY-ACERB\jeremy' home_drive : * home_drive : '' logon_server : * logon_server : 'JEREMY-ACERB' last_logon : NTTIME(0) last_logoff : Wed Sep 13 07:48:05 PM 30828 PDT acct_expiry : Wed Sep 13 07:48:05 PM 30828 PDT last_password_change : Wed Sep 30 10:15:50 AM 2020 PDT allow_password_change : Wed Sep 30 10:15:50 AM 2020 PDT force_password_change : Wed Sep 13 07:48:05 PM 30828 PDT logon_count : 0x0000 (0) bad_password_count : 0x0000 (0) acct_flags : 0x00000010 (16) authenticated : 0x01 (1) unix_info : * unix_info: struct auth_user_info_unix unix_name : * unix_name : 'jeremy' sanitized_username : * sanitized_username : 'jeremy' torture : NULL credentials : NULL unique_session_token : eb3a4ee7-6d63-4013-9af5-3d0b16cff1b3 connection_dialect : 0x0311 (785) signing_flags : 0x06 (6) 0: SMBXSRV_SIGNING_REQUIRED 1: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : * encryption_key : * decryption_key : * num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : * auth_session_info_seqnum : 0x00000001 (1) connection : * encryption_cipher : 0x0002 (2) [2021/03/02 17:46:51.507531, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.507548, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 28E211F9 [2021/03/02 17:46:51.507563, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1422(smbXsrv_session_update) [2021/03/02 17:46:51.507574, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1428(smbXsrv_session_update) smbXsrv_session_update: global_id (0x28e211f9) stored [2021/03/02 17:46:51.507588, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &session_blob: struct smbXsrv_sessionB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_sessionU(case 0) info0 : * info0: struct smbXsrv_session table : * db_rec : NULL client : * local_id : 0x28e211f9 (685904377) global : * global: struct smbXsrv_session_global0 db_rec : NULL session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : Tue Mar 2 05:46:51 PM 2021 PST auth_session_info_seqnum : 0x00000001 (1) auth_session_info : * auth_session_info: struct auth_session_info security_token : * security_token: struct security_token num_sids : 0x0000000f (15) sids: ARRAY(15) sids : S-1-5-21-1914782597-1700840410-671320589-1000 sids : S-1-5-21-1914782597-1700840410-671320589-513 sids : S-1-22-2-1000 sids : S-1-22-2-4 sids : S-1-22-2-24 sids : S-1-22-2-27 sids : S-1-22-2-30 sids : S-1-22-2-46 sids : S-1-22-2-118 sids : S-1-22-2-129 sids : S-1-22-2-134 sids : S-1-1-0 sids : S-1-5-2 sids : S-1-5-11 sids : S-1-22-1-1000 privilege_mask : 0x0000000000000000 (0) 0: SEC_PRIV_MACHINE_ACCOUNT_BIT 0: SEC_PRIV_PRINT_OPERATOR_BIT 0: SEC_PRIV_ADD_USERS_BIT 0: SEC_PRIV_DISK_OPERATOR_BIT 0: SEC_PRIV_REMOTE_SHUTDOWN_BIT 0: SEC_PRIV_BACKUP_BIT 0: SEC_PRIV_RESTORE_BIT 0: SEC_PRIV_TAKE_OWNERSHIP_BIT 0: SEC_PRIV_INCREASE_QUOTA_BIT 0: SEC_PRIV_SECURITY_BIT 0: SEC_PRIV_LOAD_DRIVER_BIT 0: SEC_PRIV_SYSTEM_PROFILE_BIT 0: SEC_PRIV_SYSTEMTIME_BIT 0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT 0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT 0: SEC_PRIV_CREATE_PAGEFILE_BIT 0: SEC_PRIV_SHUTDOWN_BIT 0: SEC_PRIV_DEBUG_BIT 0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT 0: SEC_PRIV_CHANGE_NOTIFY_BIT 0: SEC_PRIV_UNDOCK_BIT 0: SEC_PRIV_ENABLE_DELEGATION_BIT 0: SEC_PRIV_MANAGE_VOLUME_BIT 0: SEC_PRIV_IMPERSONATE_BIT 0: SEC_PRIV_CREATE_GLOBAL_BIT rights_mask : 0x00000000 (0) 0: LSA_POLICY_MODE_INTERACTIVE 0: LSA_POLICY_MODE_NETWORK 0: LSA_POLICY_MODE_BATCH 0: LSA_POLICY_MODE_SERVICE 0: LSA_POLICY_MODE_PROXY 0: LSA_POLICY_MODE_DENY_INTERACTIVE 0: LSA_POLICY_MODE_DENY_NETWORK 0: LSA_POLICY_MODE_DENY_BATCH 0: LSA_POLICY_MODE_DENY_SERVICE 0: LSA_POLICY_MODE_REMOTE_INTERACTIVE 0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE 0x00: LSA_POLICY_MODE_ALL (0) 0x00: LSA_POLICY_MODE_ALL_NT4 (0) unix_token : * unix_token: struct security_unix_token uid : 0x00000000000003e8 (1000) gid : 0x00000000000003e8 (1000) ngroups : 0x00000009 (9) groups: ARRAY(9) groups : 0x00000000000003e8 (1000) groups : 0x0000000000000004 (4) groups : 0x0000000000000018 (24) groups : 0x000000000000001b (27) groups : 0x000000000000001e (30) groups : 0x000000000000002e (46) groups : 0x0000000000000076 (118) groups : 0x0000000000000081 (129) groups : 0x0000000000000086 (134) info : * info: struct auth_user_info account_name : * account_name : 'jeremy' user_principal_name : NULL user_principal_constructed: 0x00 (0) domain_name : * domain_name : 'JEREMY-ACERB' dns_domain_name : NULL full_name : * full_name : 'Jeremy' logon_script : * logon_script : '' profile_path : * profile_path : '\\JEREMY-ACERB\jeremy\profile' home_directory : * home_directory : '\\JEREMY-ACERB\jeremy' home_drive : * home_drive : '' logon_server : * logon_server : 'JEREMY-ACERB' last_logon : NTTIME(0) last_logoff : Wed Sep 13 07:48:05 PM 30828 PDT acct_expiry : Wed Sep 13 07:48:05 PM 30828 PDT last_password_change : Wed Sep 30 10:15:50 AM 2020 PDT allow_password_change : Wed Sep 30 10:15:50 AM 2020 PDT force_password_change : Wed Sep 13 07:48:05 PM 30828 PDT logon_count : 0x0000 (0) bad_password_count : 0x0000 (0) acct_flags : 0x00000010 (16) authenticated : 0x01 (1) unix_info : * unix_info: struct auth_user_info_unix unix_name : * unix_name : 'jeremy' sanitized_username : * sanitized_username : 'jeremy' torture : NULL credentials : NULL unique_session_token : eb3a4ee7-6d63-4013-9af5-3d0b16cff1b3 connection_dialect : 0x0311 (785) signing_flags : 0x06 (6) 0: SMBXSRV_SIGNING_REQUIRED 1: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : * encryption_key : * decryption_key : * num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : * auth_session_info_seqnum : 0x00000001 (1) connection : * encryption_cipher : 0x0002 (2) status : NT_STATUS_OK idle_time : Tue Mar 2 05:46:52 PM 2021 PST nonce_high_random : 0x6941c34707dfa6a9 (7584557957310817961) nonce_high_max : 0x00000000ffffffff (4294967295) nonce_high : 0x0000000000000000 (0) nonce_low : 0x0000000000000000 (0) tcon_table : * homes_snum : 0xffffffff (4294967295) pending_auth : NULL [2021/03/02 17:46:51.508620, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.508634, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.508647, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.508669, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.508691, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_tcon.c:230(smbd_smb2_tree_connect) smbd_smb2_tree_connect: path[\\127.0.0.1\IPC$] share[IPC$] [2021/03/02 17:46:51.508718, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.508734, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_tcon_global.tdb 2: 3: 4: [2021/03/02 17:46:51.508750, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key DF4BD59B [2021/03/02 17:46:51.508781, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f551fd0 [2021/03/02 17:46:51.508840, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:710(smbXsrv_tcon_global_store) [2021/03/02 17:46:51.508852, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store) smbXsrv_tcon_global_store: key 'DF4BD59B' stored [2021/03/02 17:46:51.508866, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_tcon_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000001 (1) info : union smbXsrv_tcon_globalU(case 0) info0 : * info0: struct smbXsrv_tcon_global0 db_rec : * tcon_global_id : 0xdf4bd59b (3746289051) tcon_wire_id : 0xdf4bd59b (3746289051) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : NULL encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x00000000 (0) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET [2021/03/02 17:46:51.509005, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key DF4BD59B [2021/03/02 17:46:51.509020, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.509035, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:832(smbXsrv_tcon_create) [2021/03/02 17:46:51.509044, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:838(smbXsrv_tcon_create) smbXsrv_tcon_create: global_id (0xdf4bd59b) stored [2021/03/02 17:46:51.509057, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &tcon_blob: struct smbXsrv_tconB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_tconU(case 0) info0 : * info0: struct smbXsrv_tcon table : * db_rec : NULL local_id : 0xdf4bd59b (3746289051) global : * global: struct smbXsrv_tcon_global0 db_rec : NULL tcon_global_id : 0xdf4bd59b (3746289051) tcon_wire_id : 0xdf4bd59b (3746289051) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : NULL encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x00000000 (0) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET status : NT_STATUS_INTERNAL_ERROR idle_time : Tue Mar 2 05:46:52 PM 2021 PST compat : NULL [2021/03/02 17:46:51.509265, 3, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/access.c:370(allow_access) Allowed connection from 127.0.0.1 (127.0.0.1) [2021/03/02 17:46:51.509285, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:237(user_ok_token) user_ok_token: share IPC$ is ok for unix user jeremy [2021/03/02 17:46:51.509347, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:70(set_conn_connectpath) set_conn_connectpath: service IPC$, connectpath = /tmp [2021/03/02 17:46:51.509365, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:609(make_connection_snum) make_connection_snum: Connect path is '/tmp' for service [IPC$] [2021/03/02 17:46:51.509380, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:237(user_ok_token) user_ok_token: share IPC$ is ok for unix user jeremy [2021/03/02 17:46:51.509397, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:285(is_share_read_only_for_token) is_share_read_only_for_user: share IPC$ is read-only for unix user jeremy [2021/03/02 17:46:51.509429, 10, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/access_check.c:363(se_file_access_check) se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff [2021/03/02 17:46:51.509445, 3, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:115(vfs_init_default) Initialising default vfs hooks [2021/03/02 17:46:51.509469, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ [2021/03/02 17:46:51.509483, 5, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:105(smb_register_vfs) Successfully added vfs backend '/[Default VFS]/' [2021/03/02 17:46:51.509496, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry) vfs_find_backend_entry called for vfs_not_implemented [2021/03/02 17:46:51.509509, 5, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:105(smb_register_vfs) Successfully added vfs backend 'vfs_not_implemented' [2021/03/02 17:46:51.509522, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry) vfs_find_backend_entry called for posixacl [2021/03/02 17:46:51.509536, 5, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:105(smb_register_vfs) Successfully added vfs backend 'posixacl' [2021/03/02 17:46:51.509549, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry) vfs_find_backend_entry called for dfs_samba4 [2021/03/02 17:46:51.509561, 5, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:105(smb_register_vfs) Successfully added vfs backend 'dfs_samba4' [2021/03/02 17:46:51.509587, 10, pid=592878, effective(0, 0), real(0, 0), class=dfs_samba4] ../../source3/modules/vfs_dfs_samba4.c:159(vfs_dfs_samba4_init) vfs_dfs_samba4: Debug class number of 'fileid': 38 [2021/03/02 17:46:51.509601, 3, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:141(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2021/03/02 17:46:51.509615, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ Successfully loaded vfs module [/[Default VFS]/] with the new modules system [2021/03/02 17:46:51.509656, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:70(set_conn_connectpath) set_conn_connectpath: service IPC$, connectpath = /tmp [2021/03/02 17:46:51.509676, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:237(user_ok_token) user_ok_token: share IPC$ is ok for unix user jeremy [2021/03/02 17:46:51.509691, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:285(is_share_read_only_for_token) is_share_read_only_for_user: share IPC$ is read-only for unix user jeremy [2021/03/02 17:46:51.509713, 10, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/access_check.c:363(se_file_access_check) se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff [2021/03/02 17:46:51.509770, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.509786, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:51(security_token_debug) Security token SIDs (15): SID[ 0]: S-1-5-21-1914782597-1700840410-671320589-1000 SID[ 1]: S-1-5-21-1914782597-1700840410-671320589-513 SID[ 2]: S-1-22-2-1000 SID[ 3]: S-1-22-2-4 SID[ 4]: S-1-22-2-24 SID[ 5]: S-1-22-2-27 SID[ 6]: S-1-22-2-30 SID[ 7]: S-1-22-2-46 SID[ 8]: S-1-22-2-118 SID[ 9]: S-1-22-2-129 SID[ 10]: S-1-22-2-134 SID[ 11]: S-1-1-0 SID[ 12]: S-1-5-2 SID[ 13]: S-1-5-11 SID[ 14]: S-1-22-1-1000 Privileges (0x 0): Rights (0x 0): [2021/03/02 17:46:51.509868, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 1000 Primary group is 1000 and contains 9 supplementary groups Group[ 0]: 1000 Group[ 1]: 4 Group[ 2]: 24 Group[ 3]: 27 Group[ 4]: 30 Group[ 5]: 46 Group[ 6]: 118 Group[ 7]: 129 Group[ 8]: 134 [2021/03/02 17:46:51.509930, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:293(print_impersonation_info) print_impersonation_info: Impersonated user: uid=(1000,1000), gid=(0,1000), cwd=[/usr/local/samba/var] [2021/03/02 17:46:51.509951, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.509964, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.509977, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.510005, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.510023, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:70(set_conn_connectpath) set_conn_connectpath: service IPC$, connectpath = /tmp [2021/03/02 17:46:51.510045, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/modules/vfs_default.c:182(vfswrap_fs_capabilities) vfswrap_fs_capabilities: timestamp resolution of sec available on share IPC$, directory /tmp [2021/03/02 17:46:51.510069, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:853(make_connection_snum) jeremy-acerb (ipv4:127.0.0.1:46096) connect to service IPC$ initially as user jeremy (uid=1000, gid=1000) (pid 592878) [2021/03/02 17:46:51.510089, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.510104, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_tcon_global.tdb 2: 3: 4: [2021/03/02 17:46:51.510120, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key DF4BD59B [2021/03/02 17:46:51.510134, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f521ce0 [2021/03/02 17:46:51.510154, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:710(smbXsrv_tcon_global_store) [2021/03/02 17:46:51.510165, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store) smbXsrv_tcon_global_store: key 'DF4BD59B' stored [2021/03/02 17:46:51.510179, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_tcon_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000002 (2) info : union smbXsrv_tcon_globalU(case 0) info0 : * info0: struct smbXsrv_tcon_global0 db_rec : * tcon_global_id : 0xdf4bd59b (3746289051) tcon_wire_id : 0xdf4bd59b (3746289051) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'IPC$' encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET [2021/03/02 17:46:51.510315, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key DF4BD59B [2021/03/02 17:46:51.510330, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.510345, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:876(smbXsrv_tcon_update) [2021/03/02 17:46:51.510354, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:882(smbXsrv_tcon_update) smbXsrv_tcon_update: global_id (0xdf4bd59b) stored [2021/03/02 17:46:51.510367, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &tcon_blob: struct smbXsrv_tconB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_tconU(case 0) info0 : * info0: struct smbXsrv_tcon table : * db_rec : NULL local_id : 0xdf4bd59b (3746289051) global : * global: struct smbXsrv_tcon_global0 db_rec : NULL tcon_global_id : 0xdf4bd59b (3746289051) tcon_wire_id : 0xdf4bd59b (3746289051) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'IPC$' encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET status : NT_STATUS_OK idle_time : Tue Mar 2 05:46:52 PM 2021 PST compat : * [2021/03/02 17:46:51.510559, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [3] idx[1] status[NT_STATUS_OK] body[16] dyn[no:0] at ../../source3/smbd/smb2_tcon.c:186 [2021/03/02 17:46:51.510576, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 1/8192, total granted/max/low/range 8192/8192/4/8192 [2021/03/02 17:46:51.510595, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/smb/smb2_signing.c:173(smb2_signing_sign_pdu) signed SMB2 message [2021/03/02 17:46:51.516266, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.516288, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 4 (position 4) from bitmap [2021/03/02 17:46:51.516304, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_IOCTL] mid = 4 [2021/03/02 17:46:51.516324, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.516339, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:51(security_token_debug) Security token SIDs (15): SID[ 0]: S-1-5-21-1914782597-1700840410-671320589-1000 SID[ 1]: S-1-5-21-1914782597-1700840410-671320589-513 SID[ 2]: S-1-22-2-1000 SID[ 3]: S-1-22-2-4 SID[ 4]: S-1-22-2-24 SID[ 5]: S-1-22-2-27 SID[ 6]: S-1-22-2-30 SID[ 7]: S-1-22-2-46 SID[ 8]: S-1-22-2-118 SID[ 9]: S-1-22-2-129 SID[ 10]: S-1-22-2-134 SID[ 11]: S-1-1-0 SID[ 12]: S-1-5-2 SID[ 13]: S-1-5-11 SID[ 14]: S-1-22-1-1000 Privileges (0x 0): Rights (0x 0): [2021/03/02 17:46:51.516428, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 1000 Primary group is 1000 and contains 9 supplementary groups Group[ 0]: 1000 Group[ 1]: 4 Group[ 2]: 24 Group[ 3]: 27 Group[ 4]: 30 Group[ 5]: 46 Group[ 6]: 118 Group[ 7]: 129 Group[ 8]: 134 [2021/03/02 17:46:51.516490, 4, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir) vfs_ChDir to /tmp [2021/03/02 17:46:51.516518, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir) vfs_ChDir: vfs_ChDir got /tmp [2021/03/02 17:46:51.516538, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:293(print_impersonation_info) print_impersonation_info: Impersonated user: uid=(1000,1000), gid=(0,1000), cwd=[/tmp] [2021/03/02 17:46:51.516557, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.516571, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_tcon_global.tdb 2: 3: 4: [2021/03/02 17:46:51.516588, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key DF4BD59B [2021/03/02 17:46:51.516604, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f521ce0 [2021/03/02 17:46:51.516626, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:710(smbXsrv_tcon_global_store) [2021/03/02 17:46:51.516637, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store) smbXsrv_tcon_global_store: key 'DF4BD59B' stored [2021/03/02 17:46:51.516651, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_tcon_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000003 (3) info : union smbXsrv_tcon_globalU(case 0) info0 : * info0: struct smbXsrv_tcon_global0 db_rec : * tcon_global_id : 0xdf4bd59b (3746289051) tcon_wire_id : 0xdf4bd59b (3746289051) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'IPC$' encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET [2021/03/02 17:46:51.516794, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key DF4BD59B [2021/03/02 17:46:51.516809, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.516823, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:876(smbXsrv_tcon_update) [2021/03/02 17:46:51.516833, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:882(smbXsrv_tcon_update) smbXsrv_tcon_update: global_id (0xdf4bd59b) stored [2021/03/02 17:46:51.516845, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &tcon_blob: struct smbXsrv_tconB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_tconU(case 0) info0 : * info0: struct smbXsrv_tcon table : * db_rec : NULL local_id : 0xdf4bd59b (3746289051) global : * global: struct smbXsrv_tcon_global0 db_rec : NULL tcon_global_id : 0xdf4bd59b (3746289051) tcon_wire_id : 0xdf4bd59b (3746289051) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'IPC$' encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET status : NT_STATUS_OK idle_time : Tue Mar 2 05:46:52 PM 2021 PST compat : * [2021/03/02 17:46:51.517035, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:2593(smbd_smb2_request_verify_creditcharge) smbd_smb2_request_verify_creditcharge: mid 4, CreditCharge: 1, NeededCharge: 1 [2021/03/02 17:46:51.517052, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_ioctl.c:467(smbd_smb2_ioctl_send) smbd_smb2_ioctl: ctl_code[0x00060194] , fnum [fsp is NULL] [2021/03/02 17:46:51.517074, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/modules/vfs_default.c:205(vfswrap_get_dfs_referrals) [2021/03/02 17:46:51.517085, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:478(ndr_print_function_debug) dfs_GetDFSReferral: struct dfs_GetDFSReferral in: struct dfs_GetDFSReferral req: struct dfs_GetDFSReferral_in max_referral_level : 0x0003 (3) servername : '\127.0.0.1\tmp' [2021/03/02 17:46:51.517139, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=msdfs] ../../source3/smbd/msdfs.c:131(parse_dfs_path) parse_dfs_path: temp = |127.0.0.1\tmp| after trimming \'s [2021/03/02 17:46:51.517154, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=msdfs] ../../source3/smbd/msdfs.c:157(parse_dfs_path) parse_dfs_path: hostname: 127.0.0.1 [2021/03/02 17:46:51.517167, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=msdfs] ../../source3/smbd/msdfs.c:199(parse_dfs_path) parse_dfs_path: servicename: tmp [2021/03/02 17:46:51.517189, 3, pid=592878, effective(1000, 1000), real(1000, 0), class=msdfs] ../../source3/smbd/msdfs.c:1020(get_referred_path) get_referred_path: |tmp| in dfs path \127.0.0.1\tmp is not a dfs root. [2021/03/02 17:46:51.517207, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_ioctl.c:297(smbd_smb2_request_ioctl_done) smbd_smb2_request_ioctl_done: smbd_smb2_ioctl_recv returned 0 status NT_STATUS_NOT_FOUND [2021/03/02 17:46:51.517226, 3, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:3872(smbd_smb2_request_error_ex) smbd_smb2_request_error_ex: smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_NOT_FOUND] || at ../../source3/smbd/smb2_ioctl.c:318 [2021/03/02 17:46:51.517244, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [4] idx[1] status[NT_STATUS_NOT_FOUND] body[8] dyn[yes:1] at ../../source3/smbd/smb2_server.c:3922 [2021/03/02 17:46:51.517261, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 1/8192, total granted/max/low/range 8192/8192/5/8192 [2021/03/02 17:46:51.531142, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.531166, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 5 (position 5) from bitmap [2021/03/02 17:46:51.531182, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_TDIS] mid = 5 [2021/03/02 17:46:51.531200, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:326(change_to_user_impersonate) change_to_user_impersonate: Skipping user change - already user [2021/03/02 17:46:51.531223, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:293(print_impersonation_info) print_impersonation_info: Impersonated user: uid=(1000,1000), gid=(0,1000), cwd=[/tmp] [2021/03/02 17:46:51.531239, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.531252, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.531265, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.531292, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.531325, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.531344, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.531356, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.531376, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.531392, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.531404, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.531417, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.531437, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.531450, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:1124(close_cnum) jeremy-acerb (ipv4:127.0.0.1:46096) closed connection to service IPC$ [2021/03/02 17:46:51.531465, 4, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir) vfs_ChDir to / [2021/03/02 17:46:51.531492, 5, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir) vfs_ChDir: vfs_ChDir got / [2021/03/02 17:46:51.531509, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.531521, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.531533, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.531553, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.531575, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.531589, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_tcon_global.tdb 2: 3: 4: [2021/03/02 17:46:51.531605, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key DF4BD59B [2021/03/02 17:46:51.531619, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f521ce0 [2021/03/02 17:46:51.531639, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key DF4BD59B [2021/03/02 17:46:51.531652, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.531669, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [5] idx[1] status[NT_STATUS_OK] body[4] dyn[no:0] at ../../source3/smbd/smb2_tcon.c:560 [2021/03/02 17:46:51.531684, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 1/8192, total granted/max/low/range 8192/8192/6/8192 [2021/03/02 17:46:51.534849, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.534868, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 6 (position 6) from bitmap [2021/03/02 17:46:51.534885, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_TCON] mid = 6 [2021/03/02 17:46:51.534905, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.534920, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.534933, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.534957, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.534977, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_tcon.c:230(smbd_smb2_tree_connect) smbd_smb2_tree_connect: path[\\127.0.0.1\tmp] share[tmp] [2021/03/02 17:46:51.535009, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.535025, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_tcon_global.tdb 2: 3: 4: [2021/03/02 17:46:51.535043, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 74A48162 [2021/03/02 17:46:51.535059, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f564980 [2021/03/02 17:46:51.535088, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:710(smbXsrv_tcon_global_store) [2021/03/02 17:46:51.535100, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store) smbXsrv_tcon_global_store: key '74A48162' stored [2021/03/02 17:46:51.535115, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_tcon_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000001 (1) info : union smbXsrv_tcon_globalU(case 0) info0 : * info0: struct smbXsrv_tcon_global0 db_rec : * tcon_global_id : 0x74a48162 (1956938082) tcon_wire_id : 0x74a48162 (1956938082) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : NULL encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x00000000 (0) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET [2021/03/02 17:46:51.535272, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 74A48162 [2021/03/02 17:46:51.535288, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.535304, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:832(smbXsrv_tcon_create) [2021/03/02 17:46:51.535314, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:838(smbXsrv_tcon_create) smbXsrv_tcon_create: global_id (0x74a48162) stored [2021/03/02 17:46:51.535328, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &tcon_blob: struct smbXsrv_tconB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_tconU(case 0) info0 : * info0: struct smbXsrv_tcon table : * db_rec : NULL local_id : 0x74a48162 (1956938082) global : * global: struct smbXsrv_tcon_global0 db_rec : NULL tcon_global_id : 0x74a48162 (1956938082) tcon_wire_id : 0x74a48162 (1956938082) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : NULL encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x00000000 (0) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET status : NT_STATUS_INTERNAL_ERROR idle_time : Tue Mar 2 05:46:52 PM 2021 PST compat : NULL [2021/03/02 17:46:51.535535, 3, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/access.c:370(allow_access) Allowed connection from 127.0.0.1 (127.0.0.1) [2021/03/02 17:46:51.535555, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:237(user_ok_token) user_ok_token: share tmp is ok for unix user jeremy [2021/03/02 17:46:51.535623, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:70(set_conn_connectpath) set_conn_connectpath: service tmp, connectpath = /tmp [2021/03/02 17:46:51.535647, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:609(make_connection_snum) make_connection_snum: Connect path is '/tmp' for service [tmp] [2021/03/02 17:46:51.535663, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:237(user_ok_token) user_ok_token: share tmp is ok for unix user jeremy [2021/03/02 17:46:51.535678, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:285(is_share_read_only_for_token) is_share_read_only_for_user: share tmp is read-write for unix user jeremy [2021/03/02 17:46:51.535703, 10, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/access_check.c:363(se_file_access_check) se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff [2021/03/02 17:46:51.535719, 3, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:115(vfs_init_default) Initialising default vfs hooks [2021/03/02 17:46:51.535733, 3, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:141(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2021/03/02 17:46:51.535747, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ Successfully loaded vfs module [/[Default VFS]/] with the new modules system [2021/03/02 17:46:51.535802, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/notify_msg.c:79(notify_init) notify_init: notifyd=592731 [2021/03/02 17:46:51.535818, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 784 - private_data=0x564b5f5799c0 [2021/03/02 17:46:51.535834, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 793 - private_data=0x564b5f542110 [2021/03/02 17:46:51.535846, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 799 - private_data=0x564b5f542110 [2021/03/02 17:46:51.535866, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:70(set_conn_connectpath) set_conn_connectpath: service tmp, connectpath = /tmp [2021/03/02 17:46:51.535885, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:237(user_ok_token) user_ok_token: share tmp is ok for unix user jeremy [2021/03/02 17:46:51.535900, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:285(is_share_read_only_for_token) is_share_read_only_for_user: share tmp is read-write for unix user jeremy [2021/03/02 17:46:51.535923, 10, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/access_check.c:363(se_file_access_check) se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff [2021/03/02 17:46:51.535980, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.535996, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:51(security_token_debug) Security token SIDs (15): SID[ 0]: S-1-5-21-1914782597-1700840410-671320589-1000 SID[ 1]: S-1-5-21-1914782597-1700840410-671320589-513 SID[ 2]: S-1-22-2-1000 SID[ 3]: S-1-22-2-4 SID[ 4]: S-1-22-2-24 SID[ 5]: S-1-22-2-27 SID[ 6]: S-1-22-2-30 SID[ 7]: S-1-22-2-46 SID[ 8]: S-1-22-2-118 SID[ 9]: S-1-22-2-129 SID[ 10]: S-1-22-2-134 SID[ 11]: S-1-1-0 SID[ 12]: S-1-5-2 SID[ 13]: S-1-5-11 SID[ 14]: S-1-22-1-1000 Privileges (0x 0): Rights (0x 0): [2021/03/02 17:46:51.536078, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 1000 Primary group is 1000 and contains 9 supplementary groups Group[ 0]: 1000 Group[ 1]: 4 Group[ 2]: 24 Group[ 3]: 27 Group[ 4]: 30 Group[ 5]: 46 Group[ 6]: 118 Group[ 7]: 129 Group[ 8]: 134 [2021/03/02 17:46:51.536149, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:293(print_impersonation_info) print_impersonation_info: Impersonated user: uid=(1000,1000), gid=(0,1000), cwd=[/] [2021/03/02 17:46:51.536170, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.536183, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.536197, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.536223, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.536244, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:70(set_conn_connectpath) set_conn_connectpath: service tmp, connectpath = /tmp [2021/03/02 17:46:51.536269, 10, pid=592878, effective(0, 0), real(0, 0), class=vfs] ../../source3/modules/vfs_default.c:182(vfswrap_fs_capabilities) vfswrap_fs_capabilities: timestamp resolution of sec available on share tmp, directory /tmp [2021/03/02 17:46:51.536286, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:853(make_connection_snum) jeremy-acerb (ipv4:127.0.0.1:46096) connect to service tmp initially as user jeremy (uid=1000, gid=1000) (pid 592878) [2021/03/02 17:46:51.536308, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.536322, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_tcon_global.tdb 2: 3: 4: [2021/03/02 17:46:51.536336, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 74A48162 [2021/03/02 17:46:51.536353, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f521ce0 [2021/03/02 17:46:51.536374, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:710(smbXsrv_tcon_global_store) [2021/03/02 17:46:51.536385, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store) smbXsrv_tcon_global_store: key '74A48162' stored [2021/03/02 17:46:51.536398, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_tcon_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000002 (2) info : union smbXsrv_tcon_globalU(case 0) info0 : * info0: struct smbXsrv_tcon_global0 db_rec : * tcon_global_id : 0x74a48162 (1956938082) tcon_wire_id : 0x74a48162 (1956938082) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'tmp' encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET [2021/03/02 17:46:51.536533, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 74A48162 [2021/03/02 17:46:51.536549, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.536564, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:876(smbXsrv_tcon_update) [2021/03/02 17:46:51.536574, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:882(smbXsrv_tcon_update) smbXsrv_tcon_update: global_id (0x74a48162) stored [2021/03/02 17:46:51.536587, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &tcon_blob: struct smbXsrv_tconB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_tconU(case 0) info0 : * info0: struct smbXsrv_tcon table : * db_rec : NULL local_id : 0x74a48162 (1956938082) global : * global: struct smbXsrv_tcon_global0 db_rec : NULL tcon_global_id : 0x74a48162 (1956938082) tcon_wire_id : 0x74a48162 (1956938082) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'tmp' encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET status : NT_STATUS_OK idle_time : Tue Mar 2 05:46:52 PM 2021 PST compat : * [2021/03/02 17:46:51.536777, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [6] idx[1] status[NT_STATUS_OK] body[16] dyn[no:0] at ../../source3/smbd/smb2_tcon.c:186 [2021/03/02 17:46:51.536794, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 1/8192, total granted/max/low/range 8192/8192/7/8192 [2021/03/02 17:46:51.536817, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/smb/smb2_signing.c:173(smb2_signing_sign_pdu) signed SMB2 message [2021/03/02 17:46:51.537226, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.537245, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 7 (position 7) from bitmap [2021/03/02 17:46:51.537259, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_CREATE] mid = 7 [2021/03/02 17:46:51.537277, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.537291, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:51(security_token_debug) Security token SIDs (15): SID[ 0]: S-1-5-21-1914782597-1700840410-671320589-1000 SID[ 1]: S-1-5-21-1914782597-1700840410-671320589-513 SID[ 2]: S-1-22-2-1000 SID[ 3]: S-1-22-2-4 SID[ 4]: S-1-22-2-24 SID[ 5]: S-1-22-2-27 SID[ 6]: S-1-22-2-30 SID[ 7]: S-1-22-2-46 SID[ 8]: S-1-22-2-118 SID[ 9]: S-1-22-2-129 SID[ 10]: S-1-22-2-134 SID[ 11]: S-1-1-0 SID[ 12]: S-1-5-2 SID[ 13]: S-1-5-11 SID[ 14]: S-1-22-1-1000 Privileges (0x 0): Rights (0x 0): [2021/03/02 17:46:51.537365, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 1000 Primary group is 1000 and contains 9 supplementary groups Group[ 0]: 1000 Group[ 1]: 4 Group[ 2]: 24 Group[ 3]: 27 Group[ 4]: 30 Group[ 5]: 46 Group[ 6]: 118 Group[ 7]: 129 Group[ 8]: 134 [2021/03/02 17:46:51.537423, 4, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir) vfs_ChDir to /tmp [2021/03/02 17:46:51.537448, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir) vfs_ChDir: vfs_ChDir got /tmp [2021/03/02 17:46:51.537466, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:293(print_impersonation_info) print_impersonation_info: Impersonated user: uid=(1000,1000), gid=(0,1000), cwd=[/tmp] [2021/03/02 17:46:51.537483, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.537497, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_tcon_global.tdb 2: 3: 4: [2021/03/02 17:46:51.537514, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 74A48162 [2021/03/02 17:46:51.537529, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f521ce0 [2021/03/02 17:46:51.537550, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:710(smbXsrv_tcon_global_store) [2021/03/02 17:46:51.537561, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store) smbXsrv_tcon_global_store: key '74A48162' stored [2021/03/02 17:46:51.537575, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_tcon_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000003 (3) info : union smbXsrv_tcon_globalU(case 0) info0 : * info0: struct smbXsrv_tcon_global0 db_rec : * tcon_global_id : 0x74a48162 (1956938082) tcon_wire_id : 0x74a48162 (1956938082) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'tmp' encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET [2021/03/02 17:46:51.537715, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 74A48162 [2021/03/02 17:46:51.537730, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_tcon_global.tdb [2021/03/02 17:46:51.537743, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:876(smbXsrv_tcon_update) [2021/03/02 17:46:51.537752, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_tcon.c:882(smbXsrv_tcon_update) smbXsrv_tcon_update: global_id (0x74a48162) stored [2021/03/02 17:46:51.537765, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &tcon_blob: struct smbXsrv_tconB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_tconU(case 0) info0 : * info0: struct smbXsrv_tcon table : * db_rec : NULL local_id : 0x74a48162 (1956938082) global : * global: struct smbXsrv_tcon_global0 db_rec : NULL tcon_global_id : 0x74a48162 (1956938082) tcon_wire_id : 0x74a48162 (1956938082) server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) creation_time : Tue Mar 2 05:46:52 PM 2021 PST share_name : 'tmp' encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET session_global_id : 0x28e211f9 (685904377) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET status : NT_STATUS_OK idle_time : Tue Mar 2 05:46:52 PM 2021 PST compat : * [2021/03/02 17:46:51.537967, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_create.c:713(smbd_smb2_create_send) smbd_smb2_create_send: name [testdir] [2021/03/02 17:46:51.537984, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_create.c:819(smbd_smb2_create_send) smbd_smb2_create_send: open execution phase [2021/03/02 17:46:51.538010, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/filename.c:978(unix_convert) unix_convert: Called on file [testdir] [2021/03/02 17:46:51.538028, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/statcache.c:286(stat_cache_lookup) stat_cache_lookup: lookup failed for name [0000000000000000@TESTDIR] [2021/03/02 17:46:51.538043, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/filename.c:1162(unix_convert) unix_convert: Begin: name [testdir] dirpath [.] name [testdir] [2021/03/02 17:46:51.538067, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/statcache.c:168(stat_cache_add) stat_cache_add: Added entry (564b5f570fe0:size 18) 0000000000000000@TESTDIR -> 0000000000000000@testdir [2021/03/02 17:46:51.538083, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/filename.c:1182(unix_convert) unix_convert: Conversion of base_name finished [testdir] -> [testdir] [2021/03/02 17:46:51.538096, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/filename.c:1357(unix_convert) unix_convert: Conversion finished [testdir] -> [testdir] [2021/03/02 17:46:51.538111, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1326(check_reduced_name) check_reduced_name: check_reduced_name [testdir] [/tmp] [2021/03/02 17:46:51.538130, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1388(check_reduced_name) check_reduced_name realpath [testdir] -> [/tmp/testdir] [2021/03/02 17:46:51.538144, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1494(check_reduced_name) check_reduced_name: testdir reduced to /tmp/testdir [2021/03/02 17:46:51.538160, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/files.c:445(openat_pathref_fsp) openat_pathref_fsp: smb_fname [testdir] [2021/03/02 17:46:51.538175, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/files.c:74(fsp_new) fsp_new: allocated files structure (1 used) [2021/03/02 17:46:51.538196, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/files.c:1343(file_name_hash) file_name_hash: /tmp/testdir hash 0x214b7d06 [2021/03/02 17:46:51.538218, 4, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir) vfs_ChDir to testdir [2021/03/02 17:46:51.538242, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir) vfs_ChDir: vfs_ChDir got /tmp/testdir [2021/03/02 17:46:51.538256, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1326(check_reduced_name) check_reduced_name: check_reduced_name [.] [/tmp] [2021/03/02 17:46:51.538271, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1388(check_reduced_name) check_reduced_name realpath [.] -> [/tmp/testdir] [2021/03/02 17:46:51.538285, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1494(check_reduced_name) check_reduced_name: . reduced to /tmp/testdir [2021/03/02 17:46:51.538309, 4, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir) vfs_ChDir to /tmp [2021/03/02 17:46:51.538328, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir) vfs_ChDir: vfs_ChDir got /tmp [2021/03/02 17:46:51.538342, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:931(fd_openat) fd_openat: name testdir, flags = 0200000 mode = 00, fd = 8 [2021/03/02 17:46:51.538357, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/files.c:551(openat_pathref_fsp) openat_pathref_fsp: fsp [testdir]: OK [2021/03/02 17:46:51.538371, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:6110(create_file_default) create_file_default: create_file: access_mask = 0x1 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 private_flags = 0x0 ea_list = (nil), sd = (nil), fname = testdir [2021/03/02 17:46:51.538388, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:5597(create_file_unixpath) create_file_unixpath: create_file_unixpath: access_mask = 0x1 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 private_flags = 0x0 ea_list = (nil), sd = (nil), fname = testdir [2021/03/02 17:46:51.538407, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_open_global.tdb [2021/03/02 17:46:51.538421, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_open_global.tdb 2: 3: 4: [2021/03/02 17:46:51.538437, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key BADD100D [2021/03/02 17:46:51.538462, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f559070 [2021/03/02 17:46:51.538477, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_open.c:632(smbXsrv_open_global_verify_record) smbXsrv_open_global_verify_record: empty value [2021/03/02 17:46:51.538532, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_open.c:750(smbXsrv_open_global_store) smbXsrv_open_global_store: key 'BADD100D' stored [2021/03/02 17:46:51.538549, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_open_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000001 (1) info : union smbXsrv_open_globalU(case 0) info0 : * info0: struct smbXsrv_open_global0 db_rec : * server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) open_global_id : 0xbadd100d (3135049741) open_persistent_id : 0x00000000badd100d (3135049741) open_volatile_id : 0x00000000d1c16881 (3519113345) open_owner : S-1-5-21-1914782597-1700840410-671320589-1000 open_time : Tue Mar 2 05:46:52 PM 2021 PST create_guid : 00000000-0000-0000-0000-000000000000 client_guid : 9c9bdd8f-8682-430c-a4a1-caada7aa032c app_instance_id : 00000000-0000-0000-0000-000000000000 disconnect_time : NTTIME(0) durable_timeout_msec : 0x00000000 (0) durable : 0x00 (0) backend_cookie : DATA_BLOB length=0 channel_sequence : 0x0000 (0) channel_generation : 0x0000000000000000 (0) lock_sequence_array: ARRAY(64) [0000] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ [0010] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ [0020] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ [0030] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ [2021/03/02 17:46:51.538791, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key BADD100D [2021/03/02 17:46:51.538806, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_open_global.tdb [2021/03/02 17:46:51.538826, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/smbXsrv_open.c:916(smbXsrv_open_create) smbXsrv_open_create: global_id (0xbadd100d) stored [2021/03/02 17:46:51.538839, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &open_blob: struct smbXsrv_openB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_openU(case 0) info0 : * info0: struct smbXsrv_open table : * db_rec : NULL local_id : 0xd1c16881 (3519113345) global : * global: struct smbXsrv_open_global0 db_rec : NULL server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) open_global_id : 0xbadd100d (3135049741) open_persistent_id : 0x00000000badd100d (3135049741) open_volatile_id : 0x00000000d1c16881 (3519113345) open_owner : S-1-5-21-1914782597-1700840410-671320589-1000 open_time : Tue Mar 2 05:46:52 PM 2021 PST create_guid : 00000000-0000-0000-0000-000000000000 client_guid : 9c9bdd8f-8682-430c-a4a1-caada7aa032c app_instance_id : 00000000-0000-0000-0000-000000000000 disconnect_time : NTTIME(0) durable_timeout_msec : 0x00000000 (0) durable : 0x00 (0) backend_cookie : DATA_BLOB length=0 channel_sequence : 0x0000 (0) channel_generation : 0x0000000000000000 (0) lock_sequence_array: ARRAY(64) [0000] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ [0010] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ [0020] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ [0030] FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ........ ........ status : NT_STATUS_OK idle_time : Tue Mar 2 05:46:52 PM 2021 PST compat : NULL flags : 0x00 (0) 0: SMBXSRV_OPEN_NEED_REPLAY_CACHE 0: SMBXSRV_OPEN_HAVE_REPLAY_CACHE create_action : 0x00000000 (0) request_count : 0x0000000000000000 (0) pre_request_count : 0x0000000000000000 (0) [2021/03/02 17:46:51.539148, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/files.c:132(fsp_bind_smb) fsp_bind_smb: fsp [testdir] mid [7] [2021/03/02 17:46:51.539169, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/dosmode.c:181(unix_mode) unix_mode: unix_mode(testdir) returning 0666 [2021/03/02 17:46:51.539183, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:3543(open_file_ntcreate) open_file_ntcreate: fname=testdir, dos_attrs=0x0 access_mask=0x1 share_access=0x7 create_disposition = 0x1 create_options=0x0 unix mode=0666 oplock_request=0 private_flags = 0x0 [2021/03/02 17:46:51.539214, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/dosmode.c:386(fget_ea_dos_attribute) fget_ea_dos_attribute: Cannot get attribute from EA on file testdir: Error = No data available [2021/03/02 17:46:51.539233, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:3731(open_file_ntcreate) open_file_ntcreate: fname=testdir, after mapping access_mask=0x1 [2021/03/02 17:46:51.539248, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:3834(open_file_ntcreate) calling open_file with flags=0x0 flags2=0x800 mode=0666, access_mask = 0x1, open_access_mask = 0x1 [2021/03/02 17:46:51.539262, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:3478(posix_get_nt_acl) posix_get_nt_acl: called for file testdir [2021/03/02 17:46:51.539301, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/passdb/lookup_sid.c:1190(xid_to_sid) xid_to_sid: UID 1000 -> S-1-5-21-1914782597-1700840410-671320589-1000 from cache [2021/03/02 17:46:51.539328, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.539350, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.539365, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.539378, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.539391, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.539433, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.539449, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 1000 -> S-1-22-2-1000 fallback [2021/03/02 17:46:51.539466, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2774(canonicalise_acl) canonicalise_acl: Access ace entries before arrange : [2021/03/02 17:46:51.539480, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2787(canonicalise_acl) canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms r-x [2021/03/02 17:46:51.539496, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2787(canonicalise_acl) canon_ace index 1. Type = allow SID = S-1-22-2-1000 gid 1000 SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx [2021/03/02 17:46:51.539517, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2787(canonicalise_acl) canon_ace index 2. Type = allow SID = S-1-5-21-1914782597-1700840410-671320589-1000 uid 1000 SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx [2021/03/02 17:46:51.539534, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:848(print_canon_ace_list) print_canon_ace_list: canonicalise_acl: ace entries after arrange canon_ace index 0. Type = allow SID = S-1-5-21-1914782597-1700840410-671320589-1000 uid 1000 SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx canon_ace index 1. Type = allow SID = S-1-22-2-1000 gid 1000 SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms r-x [2021/03/02 17:46:51.539568, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:1111(map_canon_ace_perms) map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff [2021/03/02 17:46:51.539581, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:1111(map_canon_ace_perms) map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff [2021/03/02 17:46:51.539595, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:1111(map_canon_ace_perms) map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9 [2021/03/02 17:46:51.539615, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:181(smbd_check_access_rights_sd) smbd_check_access_rights_sd: File [testdir] requesting [0x1] returning [0x1] (NT_STATUS_OK) [2021/03/02 17:46:51.539652, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:4471(open_directory) open_directory: opening directory testdir, access_mask = 0x1, share_access = 0x7 create_options = 0x0, create_disposition = 0x1, file_attributes = 0x10 [2021/03/02 17:46:51.539669, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:3478(posix_get_nt_acl) posix_get_nt_acl: called for file testdir [2021/03/02 17:46:51.539700, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/passdb/lookup_sid.c:1190(xid_to_sid) xid_to_sid: UID 1000 -> S-1-5-21-1914782597-1700840410-671320589-1000 from cache [2021/03/02 17:46:51.539725, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.539743, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.539757, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.539771, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.539783, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.539823, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.539840, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 1000 -> S-1-22-2-1000 fallback [2021/03/02 17:46:51.539856, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2774(canonicalise_acl) canonicalise_acl: Access ace entries before arrange : [2021/03/02 17:46:51.539875, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2787(canonicalise_acl) canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms r-x [2021/03/02 17:46:51.539892, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2787(canonicalise_acl) canon_ace index 1. Type = allow SID = S-1-22-2-1000 gid 1000 SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx [2021/03/02 17:46:51.539909, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:2787(canonicalise_acl) canon_ace index 2. Type = allow SID = S-1-5-21-1914782597-1700840410-671320589-1000 uid 1000 SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx [2021/03/02 17:46:51.539927, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:848(print_canon_ace_list) print_canon_ace_list: canonicalise_acl: ace entries after arrange canon_ace index 0. Type = allow SID = S-1-5-21-1914782597-1700840410-671320589-1000 uid 1000 SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx canon_ace index 1. Type = allow SID = S-1-22-2-1000 gid 1000 SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms r-x [2021/03/02 17:46:51.539963, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:1111(map_canon_ace_perms) map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff [2021/03/02 17:46:51.539976, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:1111(map_canon_ace_perms) map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff [2021/03/02 17:46:51.539990, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=acls] ../../source3/smbd/posix_acls.c:1111(map_canon_ace_perms) map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9 [2021/03/02 17:46:51.540008, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:181(smbd_check_access_rights_sd) smbd_check_access_rights_sd: File [testdir] requesting [0x1] returning [0x1] (NT_STATUS_OK) [2021/03/02 17:46:51.540032, 4, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir) vfs_ChDir to testdir [2021/03/02 17:46:51.540053, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir) vfs_ChDir: vfs_ChDir got /tmp/testdir [2021/03/02 17:46:51.540067, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1326(check_reduced_name) check_reduced_name: check_reduced_name [.] [/tmp] [2021/03/02 17:46:51.540082, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1388(check_reduced_name) check_reduced_name realpath [.] -> [/tmp/testdir] [2021/03/02 17:46:51.540095, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1494(check_reduced_name) check_reduced_name: . reduced to /tmp/testdir [2021/03/02 17:46:51.540114, 4, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir) vfs_ChDir to /tmp [2021/03/02 17:46:51.540134, 5, pid=592878, effective(1000, 1000), real(1000, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir) vfs_ChDir: vfs_ChDir got /tmp [2021/03/02 17:46:51.540148, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:931(fd_openat) fd_openat: name testdir, flags = 0200000 mode = 00, fd = 8 [2021/03/02 17:46:51.558905, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:452(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: No watchers [2021/03/02 17:46:51.558954, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:46:51.558976, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/locking.tdb [2021/03/02 17:46:51.558992, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/locking.tdb 2: 3: 4: [2021/03/02 17:46:51.562832, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:295(share_mode_memcache_fetch) share_mode_memcache_fetch: failed to find entry for key 64769:113115321:0 [2021/03/02 17:46:51.562880, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:621(parse_share_modes) parse_share_modes: [2021/03/02 17:46:51.562897, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) d: struct share_mode_data unique_content_epoch : 0x67d4fe57196257b2 (7481884531010721714) flags : 0x01c8 (456) 1: SHARE_MODE_SHARE_DELETE 1: SHARE_MODE_SHARE_WRITE 1: SHARE_MODE_SHARE_READ 0: SHARE_MODE_ACCESS_DELETE 0: SHARE_MODE_ACCESS_WRITE 1: SHARE_MODE_ACCESS_READ 0: SHARE_MODE_LEASE_HANDLE 0: SHARE_MODE_LEASE_WRITE 0: SHARE_MODE_LEASE_READ servicepath : * servicepath : '/tmp' base_name : * base_name : 'testdir' stream_name : NULL num_delete_tokens : 0x00000000 (0) delete_tokens: ARRAY(0) old_write_time : NTTIME(0) changed_write_time : NTTIME(0) fresh : 0x00 (0) modified : 0x00 (0) id: struct file_id devid : 0x000000000000fd01 (64769) inode : 0x0000000006be00b9 (113115321) extid : 0x0000000000000000 (0) [2021/03/02 17:46:51.563045, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:943(get_share_mode_lock) get_share_mode_lock: Returning 64769:113115321:0 (data_refcount=1 key_refcount=1) [2021/03/02 17:46:51.563062, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/locking.c:962(find_delete_on_close_token) find_delete_on_close_token: name_hash = 0x214b7d06 [2021/03/02 17:46:51.563085, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:2053(share_mode_forall_entries) share_mode_forall_entries: num_share_modes=41 [2021/03/02 17:46:51.563104, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[0]: [2021/03/02 17:46:51.563119, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bf3 (592883) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xf02da37f7ec9a418 (-1140075362671549416) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.541183 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.563249, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[0]: modified=0, e.stale=0 [2021/03/02 17:46:51.563266, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[1]: [2021/03/02 17:46:51.563280, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bf2 (592882) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xb0299d430b83d40d (-5752894137707539443) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.523398 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.563401, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[1]: modified=0, e.stale=0 [2021/03/02 17:46:51.563418, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[2]: [2021/03/02 17:46:51.563432, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bf1 (592881) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x94440303250244ca (-7763076545639201590) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.506405 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.563557, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[2]: modified=0, e.stale=0 [2021/03/02 17:46:51.563574, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[3]: [2021/03/02 17:46:51.563589, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bea (592874) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xed83caaee944d33c (-1331998212184812740) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.448164 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.563707, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[3]: modified=0, e.stale=0 [2021/03/02 17:46:51.563723, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[4]: [2021/03/02 17:46:51.563738, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be9 (592873) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x24aabae046eff64d (2642129603831789133) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.431568 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.563851, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[4]: modified=0, e.stale=0 [2021/03/02 17:46:51.563867, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[5]: [2021/03/02 17:46:51.563884, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be8 (592872) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x2818d1fafdde4e40 (2889290036889407040) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.471950 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.563994, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[5]: modified=0, e.stale=0 [2021/03/02 17:46:51.564011, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[6]: [2021/03/02 17:46:51.564025, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be7 (592871) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x9b8d7f1be73b3fd9 (-7237989268294254631) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.429493 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.564134, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[6]: modified=0, e.stale=0 [2021/03/02 17:46:51.564150, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[7]: [2021/03/02 17:46:51.564164, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be6 (592870) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x5a4545ac77ed567a (6504681843855283834) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.467802 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.564281, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[7]: modified=0, e.stale=0 [2021/03/02 17:46:51.564297, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[8]: [2021/03/02 17:46:51.564312, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be5 (592869) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x5faf362539fc8f4f (6894789088042061647) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.438888 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.564423, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[8]: modified=0, e.stale=0 [2021/03/02 17:46:51.564440, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[9]: [2021/03/02 17:46:51.564454, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be4 (592868) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x0ab3663474a25869 (771072336691615849) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.386901 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.564566, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[9]: modified=0, e.stale=0 [2021/03/02 17:46:51.564583, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[10]: [2021/03/02 17:46:51.564596, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be3 (592867) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x3fadf06937f5e4d1 (4588587930061497553) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.462917 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.564711, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[10]: modified=0, e.stale=0 [2021/03/02 17:46:51.564728, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[11]: [2021/03/02 17:46:51.564742, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be2 (592866) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xb14b99b4f411a683 (-5671270303275047293) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.407964 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.564854, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[11]: modified=0, e.stale=0 [2021/03/02 17:46:51.564874, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[12]: [2021/03/02 17:46:51.564888, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be1 (592865) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xe89e1fd0cbb1206b (-1684874228958945173) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.415151 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.565002, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[12]: modified=0, e.stale=0 [2021/03/02 17:46:51.565018, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[13]: [2021/03/02 17:46:51.565032, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090be0 (592864) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xfca2b81a92585f16 (-242429005660659946) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.389894 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.565144, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[13]: modified=0, e.stale=0 [2021/03/02 17:46:51.565160, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[14]: [2021/03/02 17:46:51.565172, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bdf (592863) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x5ffe579d27b3d757 (6917062410175240023) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.356694 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.565290, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[14]: modified=0, e.stale=0 [2021/03/02 17:46:51.565305, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[15]: [2021/03/02 17:46:51.565319, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bde (592862) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1c167f682436a888 (2023945167810504840) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.423527 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.565427, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[15]: modified=0, e.stale=0 [2021/03/02 17:46:51.565443, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[16]: [2021/03/02 17:46:51.565457, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bdd (592861) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xaf279f45f169f9ca (-5825512470228633142) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.379984 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.565573, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[16]: modified=0, e.stale=0 [2021/03/02 17:46:51.565589, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[17]: [2021/03/02 17:46:51.565602, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bdc (592860) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x80d52339e938450d (-9163379135182519027) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.400006 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.565713, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[17]: modified=0, e.stale=0 [2021/03/02 17:46:51.565729, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[18]: [2021/03/02 17:46:51.565743, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bdb (592859) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xc6f9acd965e88981 (-4109063135281247871) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.375851 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.565857, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[18]: modified=0, e.stale=0 [2021/03/02 17:46:51.565875, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[19]: [2021/03/02 17:46:51.565890, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bda (592858) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xdd69b1c7527d1603 (-2492265449132321277) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.388086 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.566002, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[19]: modified=0, e.stale=0 [2021/03/02 17:46:51.566020, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[20]: [2021/03/02 17:46:51.566035, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd9 (592857) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x57f496e1e7f796af (6337856472620701359) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.381229 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.566150, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[20]: modified=0, e.stale=0 [2021/03/02 17:46:51.566174, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[21]: [2021/03/02 17:46:51.566188, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd8 (592856) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x265cd0eef33ba0a8 (2764313996000207016) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.323351 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.566306, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[21]: modified=0, e.stale=0 [2021/03/02 17:46:51.566323, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[22]: [2021/03/02 17:46:51.566337, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd7 (592855) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xe7a2abcccc8ac101 (-1755652008627748607) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.357760 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.566444, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[22]: modified=0, e.stale=0 [2021/03/02 17:46:51.566460, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[23]: [2021/03/02 17:46:51.566474, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd6 (592854) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x3267af34e39d0190 (3632064266189472144) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.304133 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.566594, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[23]: modified=0, e.stale=0 [2021/03/02 17:46:51.566612, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[24]: [2021/03/02 17:46:51.566626, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd5 (592853) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xb41526d69f0a459a (-5470423469138492006) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.275899 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.566741, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[24]: modified=0, e.stale=0 [2021/03/02 17:46:51.566757, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[25]: [2021/03/02 17:46:51.566770, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd4 (592852) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xcb96d935729b574c (-3776592413924305076) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.294739 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.566898, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[25]: modified=0, e.stale=0 [2021/03/02 17:46:51.566914, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[26]: [2021/03/02 17:46:51.566928, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd3 (592851) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x613096a520a6a227 (7003263056522682919) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.336030 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.567044, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[26]: modified=0, e.stale=0 [2021/03/02 17:46:51.567060, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[27]: [2021/03/02 17:46:51.567074, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd2 (592850) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xb064c2a6063dd2ff (-5736246007038094593) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.335941 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.567186, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[27]: modified=0, e.stale=0 [2021/03/02 17:46:51.567202, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[28]: [2021/03/02 17:46:51.567214, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd1 (592849) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xaef3a7df07009646 (-5840139715432376762) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.328254 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.567333, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[28]: modified=0, e.stale=0 [2021/03/02 17:46:51.567350, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[29]: [2021/03/02 17:46:51.567364, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bd0 (592848) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xc62137380ae33245 (-4169991066128010683) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.279707 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.567476, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[29]: modified=0, e.stale=0 [2021/03/02 17:46:51.567497, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[30]: [2021/03/02 17:46:51.567512, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bcf (592847) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x84702874e0e5de37 (-8903571980856992201) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.316004 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.567622, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[30]: modified=0, e.stale=0 [2021/03/02 17:46:51.567638, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[31]: [2021/03/02 17:46:51.567652, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bce (592846) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x2e348c4cc7006e2e (3329440285917736494) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.301686 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.567765, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[31]: modified=0, e.stale=0 [2021/03/02 17:46:51.567783, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[32]: [2021/03/02 17:46:51.567796, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bcd (592845) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x6ef2495d20eeaa77 (7994532952869350007) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.297513 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.567918, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[32]: modified=0, e.stale=0 [2021/03/02 17:46:51.567935, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[33]: [2021/03/02 17:46:51.567948, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bcc (592844) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xfade25a80daeb0a1 (-369816715683516255) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.203449 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.568060, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[33]: modified=0, e.stale=0 [2021/03/02 17:46:51.568075, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[34]: [2021/03/02 17:46:51.568088, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bcb (592843) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x6af531d8bd868888 (7707121144276879496) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.281141 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.568209, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[34]: modified=0, e.stale=0 [2021/03/02 17:46:51.568225, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[35]: [2021/03/02 17:46:51.568238, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bca (592842) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x81f992c4b3a49bf5 (-9081065800090739723) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.255459 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.568351, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[35]: modified=0, e.stale=0 [2021/03/02 17:46:51.568366, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[36]: [2021/03/02 17:46:51.568380, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bc9 (592841) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xd9c7f3bc2473e27e (-2753964657722793346) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.251835 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.568491, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[36]: modified=0, e.stale=0 [2021/03/02 17:46:51.568507, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[37]: [2021/03/02 17:46:51.568520, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bc8 (592840) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xdaade5dc84d4695a (-2689240667186239142) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.223243 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.568630, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[37]: modified=0, e.stale=0 [2021/03/02 17:46:51.568645, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[38]: [2021/03/02 17:46:51.568658, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bc7 (592839) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xf216bf6590a7e654 (-1002403424103831980) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.209689 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.568762, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[38]: modified=0, e.stale=0 [2021/03/02 17:46:51.568782, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[39]: [2021/03/02 17:46:51.568796, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bc6 (592838) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0xdbdfefa3a5854ad9 (-2603098573461173543) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.238106 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.568902, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[39]: modified=0, e.stale=0 [2021/03/02 17:46:51.568918, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1961(share_mode_for_one_entry) share_mode_for_one_entry: entry[40]: [2021/03/02 17:46:51.568931, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &e: struct share_mode_entry pid: struct server_id pid : 0x0000000000090bc5 (592837) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x9e9e9ebe3ff9258a (-7016996629442386550) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.268135 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.569034, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1970(share_mode_for_one_entry) share_mode_for_one_entry: entry[40]: modified=0, e.stale=0 [2021/03/02 17:46:51.569048, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:2072(share_mode_forall_entries) share_mode_forall_entries: num_share_entries=41, writeback=0 [2021/03/02 17:46:51.569062, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:1701(share_conflict) share_conflict: existing access_mask = 0x1, existing share access = 0x7, access_mask = 0x1, share_access = 0x7 [2021/03/02 17:46:51.569081, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:1732(share_conflict) share_conflict: conflict=false [2021/03/02 17:46:51.569095, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:1977(open_mode_check) open_mode_check: No conflict due to share_mode_flags access [2021/03/02 17:46:51.569153, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1806(set_share_mode) set_share_mode: num_share_modes=41 [2021/03/02 17:46:51.569169, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1749(share_mode_entry_find) share_mode_entry_find: left=0, right=40, middle=20, middle_ptr=0x564b5f56e244 [2021/03/02 17:46:51.569186, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1749(share_mode_entry_find) share_mode_entry_find: left=0, right=19, middle=9, middle_ptr=0x564b5f56dc98 [2021/03/02 17:46:51.569202, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1749(share_mode_entry_find) share_mode_entry_find: left=0, right=8, middle=4, middle_ptr=0x564b5f56da04 [2021/03/02 17:46:51.569216, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1749(share_mode_entry_find) share_mode_entry_find: left=0, right=3, middle=1, middle_ptr=0x564b5f56d878 [2021/03/02 17:46:51.569231, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1749(share_mode_entry_find) share_mode_entry_find: left=2, right=3, middle=2, middle_ptr=0x564b5f56d8fc [2021/03/02 17:46:51.569247, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1749(share_mode_entry_find) share_mode_entry_find: left=3, right=3, middle=3, middle_ptr=0x564b5f56d980 [2021/03/02 17:46:51.569262, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:371(share_mode_entry_put) share_mode_entry_put: share_mode_entry: [2021/03/02 17:46:51.569277, 1, pid=592878, effective(1000, 1000), real(1000, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) discard_const_p(void, e): struct share_mode_entry pid: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) op_mid : 0x0000000000000007 (7) op_type : 0x0000 (0) client_guid : 00000000-0000-0000-0000-000000000000 lease_key: struct smb2_lease_key data: ARRAY(2) data : 0x0000000000000000 (0) data : 0x0000000000000000 (0) access_mask : 0x00000081 (129) share_access : 0x00000007 (7) private_options : 0x00000000 (0) time : Tue Mar 2 05:46:51 PM 2021 PST.538189 share_file_id : 0x0000000000000002 (2) uid : 0x000003e8 (1000) flags : 0x0000 (0) name_hash : 0x214b7d06 (558595334) stale : 0x00 (0) [2021/03/02 17:46:51.569393, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1850(set_share_mode) set_share_mode: idx=3, found=0 [2021/03/02 17:46:51.569408, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1878(set_share_mode) set_share_mode: dbufs[0]=(0x564b5f56d7f4, 396) [2021/03/02 17:46:51.569421, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1878(set_share_mode) set_share_mode: dbufs[1]=(0x7ffcecc0ad50, 132) [2021/03/02 17:46:51.569438, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:1878(set_share_mode) set_share_mode: dbufs[2]=(0x564b5f56d980, 5016) [2021/03/02 17:46:51.569461, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592880:4 [2021/03/02 17:46:51.569503, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.569523, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.569537, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.569552, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.569565, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.569611, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592880 [2021/03/02 17:46:51.582837, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.582863, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592879:8 [2021/03/02 17:46:51.582906, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.582925, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.582939, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.582953, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.582967, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.583012, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592879 [2021/03/02 17:46:51.583044, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583061, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592875:6 [2021/03/02 17:46:51.583094, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583111, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583125, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583145, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.583159, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.583203, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592875 [2021/03/02 17:46:51.583234, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583251, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592877:5 [2021/03/02 17:46:51.583283, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583301, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583314, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583327, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.583338, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.583382, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592877 [2021/03/02 17:46:51.583412, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583428, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592876:6 [2021/03/02 17:46:51.583459, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583475, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583488, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583501, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.583515, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.583557, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592876 [2021/03/02 17:46:51.583585, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583600, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592885:2 [2021/03/02 17:46:51.583630, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583652, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583667, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583681, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.583694, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.583736, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592885 [2021/03/02 17:46:51.583765, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583781, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592884:3 [2021/03/02 17:46:51.583811, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583828, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583840, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583854, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.583867, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.583906, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592884 [2021/03/02 17:46:51.583935, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.583951, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592887:1 [2021/03/02 17:46:51.583981, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.583997, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.584010, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.584023, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.584036, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.584079, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592887 [2021/03/02 17:46:51.584115, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.584132, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592896:1 [2021/03/02 17:46:51.584162, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.584179, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.584192, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.584204, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.584215, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.584258, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592896 [2021/03/02 17:46:51.584289, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.587216, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:46:51.587241, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=locking] ../../source3/locking/share_mode_lock.c:644(share_mode_data_store) share_mode_data_store: not modified [2021/03/02 17:46:51.587263, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592880:5 [2021/03/02 17:46:51.587285, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592880 [2021/03/02 17:46:51.587390, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592892:1 [2021/03/02 17:46:51.587427, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.587445, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.587459, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.587472, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.587485, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.587530, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592892 [2021/03/02 17:46:51.587559, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.587580, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592890:1 [2021/03/02 17:46:51.587611, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.587628, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.587641, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.587654, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.587667, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.587708, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592890 [2021/03/02 17:46:51.587736, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.587751, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592875:7 [2021/03/02 17:46:51.587771, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592875 [2021/03/02 17:46:51.587855, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592879:9 [2021/03/02 17:46:51.587878, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592879 [2021/03/02 17:46:51.587899, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:465(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: Alerting 592877:6 [2021/03/02 17:46:51.587919, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592877 [2021/03/02 17:46:51.587951, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:46:51.587966, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/locking.tdb [2021/03/02 17:46:51.587981, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:6055(create_file_unixpath) create_file_unixpath: info=1 [2021/03/02 17:46:51.587994, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/open.c:6243(create_file_default) create_file: info=1 [2021/03/02 17:46:51.588008, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_create.c:1319(smbd_smb2_create_after_exec) smbd_smb2_create_send: response construction phase [2021/03/02 17:46:51.588022, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/dosmode.c:739(fdos_mode) fdos_mode: testdir [2021/03/02 17:46:51.588040, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/dosmode.c:386(fget_ea_dos_attribute) fget_ea_dos_attribute: Cannot get attribute from EA on file testdir: Error = No data available [2021/03/02 17:46:51.588063, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/dosmode.c:72(dos_mode_debug_print) dos_mode_debug_print: fdos_mode returning (0x10): "d" [2021/03/02 17:46:51.588079, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_create.c:1548(smbd_smb2_create_finish) smbd_smb2_create_finish: testdir - fnum 3519113345 [2021/03/02 17:46:51.588100, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [7] idx[1] status[NT_STATUS_OK] body[88] dyn[yes:0] at ../../source3/smbd/smb2_create.c:405 [2021/03/02 17:46:51.588115, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 1/8192, total granted/max/low/range 8192/8192/8/8192 [2021/03/02 17:46:51.588593, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.588609, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 8 (position 8) from bitmap [2021/03/02 17:46:51.588624, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_NOTIFY] mid = 8 [2021/03/02 17:46:51.588641, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:326(change_to_user_impersonate) change_to_user_impersonate: Skipping user change - already user [2021/03/02 17:46:51.588662, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:293(print_impersonation_info) print_impersonation_info: Impersonated user: uid=(1000,1000), gid=(0,1000), cwd=[/tmp] [2021/03/02 17:46:51.588681, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:2593(smbd_smb2_request_verify_creditcharge) smbd_smb2_request_verify_creditcharge: mid 8, CreditCharge: 1, NeededCharge: 1 [2021/03/02 17:46:51.588697, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_notify.c:232(smbd_smb2_notify_send) smbd_smb2_notify_send: testdir - fnum 3519113345 [2021/03/02 17:46:51.588720, 3, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_notify.c:251(smbd_smb2_notify_send) smbd_smb2_notify_send: notify change called on testdir, filter = FILE_NAME|DIR_NAME|ATTRIBUTES|SIZE|LAST_WRITE|LAST_ACCESS|CREATION|EA|SECURITY|STREAM_NAME|STREAM_SIZE|STREAM_WRITE, recursive = 1 [2021/03/02 17:46:51.588736, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/notify_msg.c:154(notify_add) notify_add: path=[/tmp/testdir], filter=4095, subdir_filter=4095, private_data=0x564b5f50f540 [2021/03/02 17:46:51.588866, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.588884, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(685904377) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.588897, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.588911, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.588924, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.588974, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm.c:1445(messaging_dgm_send) messaging_dgm_send: Sending message to 592731 [2021/03/02 17:46:51.589008, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.589025, 10, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/notify.c:347(change_notify_add_request) change_notify_add_request: Adding request for testdir: max_param = 1000 smbd_smb2_request_pending_queue: req->current_idx = 1 req->in.vector[0].iov_len = 0 req->in.vector[1].iov_len = 0 req->in.vector[2].iov_len = 64 req->in.vector[3].iov_len = 32 req->in.vector[4].iov_len = 0 req->out.vector[0].iov_len = 4 req->out.vector[1].iov_len = 0 req->out.vector[2].iov_len = 64 req->out.vector[3].iov_len = 8 req->out.vector[4].iov_len = 0 [2021/03/02 17:46:51.591992, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:2192(smbd_smb2_request_pending_timer) smbd_smb2_request_pending_queue: opcode[SMB2_OP_NOTIFY] mid 8 going async [2021/03/02 17:46:51.592012, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 1/8192, total granted/max/low/range 8192/8192/9/8192 [2021/03/02 17:46:51.592027, 10, pid=592878, effective(1000, 1000), real(1000, 0), class=smb2] ../../source3/smbd/smb2_server.c:2297(smbd_smb2_request_pending_timer) state->vector[0/5].iov_len = 4 state->vector[1/5].iov_len = 0 state->vector[2/5].iov_len = 64 state->vector[3/5].iov_len = 8 state->vector[4/5].iov_len = 1 [2021/03/02 17:47:00.857992, 4, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:47:00.858018, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:47:00.858032, 5, pid=592878, effective(1000, 1000), real(1000, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:47:00.858061, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:47:00.858105, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:47:00.858121, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:47:00.858133, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:47:00.858155, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:47:00.858171, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:47:00.858184, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:47:00.858197, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:47:00.858220, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:47:00.869847, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:47:00.869897, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:399(g_lock_trylock) g_lock_trylock: 592934 has an exclusive lock [2021/03/02 17:47:00.869954, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:47:00.883694, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:426(messaging_recv_cb) messaging_recv_cb: Received message 0xfa3 len 8 (num_fds:0) from 592934 [2021/03/02 17:47:00.883729, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:654(g_lock_lock_retry) g_lock_lock_retry: watch_recv returned NT_STATUS_OK [2021/03/02 17:47:00.893340, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:399(g_lock_trylock) g_lock_trylock: 592918 has an exclusive lock [2021/03/02 17:47:00.893391, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:47:00.898072, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:426(messaging_recv_cb) messaging_recv_cb: Received message 0xfa3 len 8 (num_fds:0) from 592918 [2021/03/02 17:47:00.898103, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:654(g_lock_lock_retry) g_lock_lock_retry: watch_recv returned NT_STATUS_OK [2021/03/02 17:47:00.905233, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:399(g_lock_trylock) g_lock_trylock: 592918 has an exclusive lock [2021/03/02 17:47:00.905269, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:47:00.909886, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:426(messaging_recv_cb) messaging_recv_cb: Received message 0xfa3 len 8 (num_fds:0) from 592918 [2021/03/02 17:47:00.909947, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:654(g_lock_lock_retry) g_lock_lock_retry: watch_recv returned NT_STATUS_OK [2021/03/02 17:47:00.917498, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:399(g_lock_trylock) g_lock_trylock: 592912 has an exclusive lock [2021/03/02 17:47:00.917534, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:47:00.923576, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:426(messaging_recv_cb) messaging_recv_cb: Received message 0xfa3 len 8 (num_fds:0) from 592912 [2021/03/02 17:47:00.923594, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:654(g_lock_lock_retry) g_lock_lock_retry: watch_recv returned NT_STATUS_OK [2021/03/02 17:47:00.930363, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:399(g_lock_trylock) g_lock_trylock: 592912 has an exclusive lock [2021/03/02 17:47:00.930400, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:426(dbwrap_watched_do_locked) dbwrap_watched_do_locked: dbwrap_watched_do_locked_fn returned NT_STATUS_OK [2021/03/02 17:47:00.935728, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:426(messaging_recv_cb) messaging_recv_cb: Received message 0xfa3 len 8 (num_fds:0) from 592912 [2021/03/02 17:47:00.935754, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/g_lock.c:654(g_lock_lock_retry) g_lock_lock_retry: watch_recv returned NT_STATUS_OK [2021/03/02 17:47:00.942417, 0, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/fault.c:172(smb_panic_log) =============================================================== [2021/03/02 17:47:00.942463, 0, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/fault.c:173(smb_panic_log) INTERNAL ERROR: Signal 7: Bus error in pid 592878 (4.15.0pre1-GIT-1c9add54750) [2021/03/02 17:47:00.942477, 0, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/fault.c:177(smb_panic_log) If you are running a recent Samba version, and if you think this problem is not yet fixed in the latest versions, please consider reporting this bug, see https://wiki.samba.org/index.php/Bug_Reporting [2021/03/02 17:47:00.942492, 0, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/fault.c:182(smb_panic_log) =============================================================== [2021/03/02 17:47:00.942504, 0, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/fault.c:183(smb_panic_log) PANIC (pid 592878): Signal 7: Bus error in 4.15.0pre1-GIT-1c9add54750 [2021/03/02 17:47:00.942569, 0, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/fault.c:245(log_stack_trace) BACKTRACE: #0 log_stack_trace + 0x3b [ip=0x7f852358a03c] [sp=0x7ffcecc098e0] #1 smb_panic_log + 0x1b5 [ip=0x7f8523589fb0] [sp=0x7ffcecc0a1f0] #2 smb_panic + 0x1c [ip=0x7f8523589fcf] [sp=0x7ffcecc0a210] #3 fault_report + 0x91 [ip=0x7f8523589ad6] [sp=0x7ffcecc0a230] #4 sig_fault + 0x19 [ip=0x7f8523589aef] [sp=0x7ffcecc0a2e0] #5 funlockfile + 0x60 [ip=0x7f8522b90bb0] [sp=0x7ffcecc0a300] #6 __pthread_mutex_lock_full + 0x415 [ip=0x7f8522b874d5] [sp=0x7ffcecc0a8a0] #7 chain_mutex_lock + 0x27 [ip=0x7f85222b22c1] [sp=0x7ffcecc0a900] #8 tdb_mutex_lock + 0xa5 [ip=0x7f85222b240c] [sp=0x7ffcecc0a930] #9 fcntl_lock + 0x55 [ip=0x7f85222a622b] [sp=0x7ffcecc0a9b0] #10 tdb_brlock + 0xa2 [ip=0x7f85222a63ff] [sp=0x7ffcecc0aa20] #11 tdb_nest_lock + 0x1ba [ip=0x7f85222a69f0] [sp=0x7ffcecc0aa60] #12 tdb_lock_list + 0x7d [ip=0x7f85222a6c4e] [sp=0x7ffcecc0aaa0] #13 tdb_lock + 0x2e [ip=0x7f85222a6cef] [sp=0x7ffcecc0aae0] #14 tdb_chainlock + 0x5d [ip=0x7f85222a7742] [sp=0x7ffcecc0ab20] #15 db_tdb_do_locked + 0xa2 [ip=0x7f85222c4e64] [sp=0x7ffcecc0ab60] #16 dbwrap_do_locked + 0x8c [ip=0x7f85222c122e] [sp=0x7ffcecc0ac30] #17 dbwrap_watched_do_locked + 0xc3 [ip=0x7f852305f31f] [sp=0x7ffcecc0ac80] #18 dbwrap_do_locked + 0x8c [ip=0x7f85222c122e] [sp=0x7ffcecc0ad30] #19 g_lock_lock_retry + 0x1cd [ip=0x7f8523063d5c] [sp=0x7ffcecc0ad80] #20 _tevent_req_notify_callback + 0x6e [ip=0x7f8523103120] [sp=0x7ffcecc0ae10] #21 tevent_req_finish + 0x108 [ip=0x7f8523103289] [sp=0x7ffcecc0ae30] #22 _tevent_req_done + 0x29 [ip=0x7f85231032b9] [sp=0x7ffcecc0ae80] #23 dbwrap_watched_watch_done + 0x109 [ip=0x7f852306188e] [sp=0x7ffcecc0aea0] #24 _tevent_req_notify_callback + 0x6e [ip=0x7f8523103120] [sp=0x7ffcecc0aef0] #25 tevent_req_finish + 0x108 [ip=0x7f8523103289] [sp=0x7ffcecc0af10] #26 tevent_req_trigger + 0x53 [ip=0x7f85231033c9] [sp=0x7ffcecc0af60] #27 tevent_common_invoke_immediate_handler + 0x1a3 [ip=0x7f8523101ea9] [sp=0x7ffcecc0afa0] #28 tevent_common_loop_immediate + 0x3b [ip=0x7f8523101fc4] [sp=0x7ffcecc0b050] #29 epoll_event_loop_once + 0xa2 [ip=0x7f852310cc29] [sp=0x7ffcecc0b080] #30 std_event_loop_once + 0x60 [ip=0x7f8523109379] [sp=0x7ffcecc0b0d0] #31 _tevent_loop_once + 0x126 [ip=0x7f85231006f6] [sp=0x7ffcecc0b110] #32 tevent_req_poll + 0x29 [ip=0x7f8523103571] [sp=0x7ffcecc0b150] #33 tevent_req_poll_ntstatus + 0x2b [ip=0x7f8522ffd954] [sp=0x7ffcecc0b180] #34 g_lock_lock + 0x265 [ip=0x7f8523064430] [sp=0x7ffcecc0b1c0] #35 get_share_mode_lock + 0x21f [ip=0x7f8523380627] [sp=0x7ffcecc0b260] #36 get_existing_share_mode_lock + 0x38 [ip=0x7f852337409c] [sp=0x7ffcecc0b360] #37 close_directory + 0x131 [ip=0x7f85232b48c6] [sp=0x7ffcecc0b3a0] #38 close_file + 0x461 [ip=0x7f85232b52ad] [sp=0x7ffcecc0b440] #39 file_close_user + 0x51 [ip=0x7f8523218340] [sp=0x7ffcecc0b4a0] #40 smbXsrv_session_logoff + 0x9e [ip=0x7f8523331110] [sp=0x7ffcecc0b4d0] #41 smbXsrv_session_clear_and_logoff + 0xc6 [ip=0x7f852332fb2f] [sp=0x7ffcecc0b540] #42 smbXsrv_session_logoff_all_callback + 0xe4 [ip=0x7f8523331720] [sp=0x7ffcecc0b580] #43 db_rbt_traverse_internal + 0x136 [ip=0x7f85222c4276] [sp=0x7ffcecc0b5e0] #44 db_rbt_traverse + 0xab [ip=0x7f85222c446c] [sp=0x7ffcecc0b6a0] #45 dbwrap_traverse + 0x39 [ip=0x7f85222c0c16] [sp=0x7ffcecc0b6f0] #46 smbXsrv_session_logoff_all + 0xc9 [ip=0x7f852333153a] [sp=0x7ffcecc0b730] #47 exit_server_common + 0x2f9 [ip=0x7f8523339ed3] [sp=0x7ffcecc0b770] #48 smbd_exit_server_cleanly + 0x21 [ip=0x7f852333a304] [sp=0x7ffcecc0b7d0] #49 exit_server_cleanly + 0x2c [ip=0x7f8522d60607] [sp=0x7ffcecc0b7f0] #50 smbd_sig_term_handler + 0x2e [ip=0x7f85232d4f5f] [sp=0x7ffcecc0b810] #51 tevent_common_invoke_signal_handler + 0x128 [ip=0x7f8523108c3c] [sp=0x7ffcecc0b850] #52 tevent_common_check_signal + 0x205 [ip=0x7f8523108f4b] [sp=0x7ffcecc0b8a0] #53 epoll_event_loop + 0x11e [ip=0x7f852310c341] [sp=0x7ffcecc0b990] #54 epoll_event_loop_once + 0x13c [ip=0x7f852310ccc3] [sp=0x7ffcecc0b9f0] #55 std_event_loop_once + 0x60 [ip=0x7f8523109379] [sp=0x7ffcecc0ba40] #56 _tevent_loop_once + 0x126 [ip=0x7f85231006f6] [sp=0x7ffcecc0ba80] #57 tevent_common_loop_wait + 0x29 [ip=0x7f8523100a60] [sp=0x7ffcecc0bac0] #58 std_event_loop_wait + 0x60 [ip=0x7f852310941f] [sp=0x7ffcecc0baf0] #59 _tevent_loop_wait + 0x2f [ip=0x7f8523100b07] [sp=0x7ffcecc0bb30] #60 smbd_process + 0xd24 [ip=0x7f85232dd597] [sp=0x7ffcecc0bb50] #61 smbd_accept_connection + 0x3fa [ip=0x564b5e70d01f] [sp=0x7ffcecc0bc20] #62 tevent_common_invoke_fd_handler + 0x109 [ip=0x7f852310158d] [sp=0x7ffcecc0bd10] #63 epoll_event_loop + 0x3a9 [ip=0x7f852310c5cc] [sp=0x7ffcecc0bd50] #64 epoll_event_loop_once + 0x13c [ip=0x7f852310ccc3] [sp=0x7ffcecc0bdb0] #65 std_event_loop_once + 0x60 [ip=0x7f8523109379] [sp=0x7ffcecc0be00] #66 _tevent_loop_once + 0x126 [ip=0x7f85231006f6] [sp=0x7ffcecc0be40] #67 tevent_common_loop_wait + 0x29 [ip=0x7f8523100a60] [sp=0x7ffcecc0be80] #68 std_event_loop_wait + 0x60 [ip=0x7f852310941f] [sp=0x7ffcecc0beb0] #69 _tevent_loop_wait + 0x2f [ip=0x7f8523100b07] [sp=0x7ffcecc0bef0] #70 smbd_parent_loop + 0xa9 [ip=0x564b5e70dd95] [sp=0x7ffcecc0bf10] #71 main + 0x1acb [ip=0x564b5e71017f] [sp=0x7ffcecc0bf50] #72 __libc_start_main + 0xf2 [ip=0x7f85229bacb2] [sp=0x7ffcecc0c320] #73 _start + 0x2e [ip=0x564b5e70514e] [sp=0x7ffcecc0c3f0] [2021/03/02 17:47:00.978597, 0, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:839(smb_panic_s3) smb_panic(): calling panic action [/bin/sleep 90000]