2 * Time auditing VFS module for samba. Log time taken for VFS call to syslog
5 * Copyright (C) Abhidnya Chirmule <achirmul@in.ibm.com> 2009
7 * This program is free software; you can redistribute it and/or modify
8 * it under the terms of the GNU General Public License as published by
9 * the Free Software Foundation; either version 3 of the License, or
10 * (at your option) any later version.
12 * This program is distributed in the hope that it will be useful,
13 * but WITHOUT ANY WARRANTY; without even the implied warranty of
14 * MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
15 * GNU General Public License for more details.
17 * You should have received a copy of the GNU General Public License
18 * along with this program; if not, see <http://www.gnu.org/licenses/>.
22 * This module implements logging for time taken for all Samba VFS operations.
24 * vfs objects = time_audit
29 #include "smbd/smbd.h"
31 #include "lib/util/tevent_unix.h"
32 #include "lib/util/tevent_ntstatus.h"
35 #define DBGC_CLASS DBGC_VFS
37 static double audit_timeout
;
39 static void smb_time_audit_log_msg(const char *syscallname
, double elapsed
,
42 DEBUG(0, ("WARNING: VFS call \"%s\" took unexpectedly long "
43 "(%.2f seconds) %s%s-- Validate that file and storage "
44 "subsystems are operating normally\n", syscallname
,
45 elapsed
, (msg
!= NULL
) ? msg
: "",
46 (msg
!= NULL
) ? " " : ""));
49 static void smb_time_audit_log(const char *syscallname
, double elapsed
)
51 smb_time_audit_log_msg(syscallname
, elapsed
, NULL
);
54 static void smb_time_audit_log_fsp(const char *syscallname
, double elapsed
,
55 const struct files_struct
*fsp
)
57 char *base_name
= NULL
;
58 char *connectpath
= NULL
;
62 smb_time_audit_log(syscallname
, elapsed
);
66 connectpath
= fsp
->conn
->connectpath
;
68 base_name
= fsp
->fsp_name
->base_name
;
70 if (connectpath
!= NULL
&& base_name
!= NULL
) {
71 msg
= talloc_asprintf(talloc_tos(), "filename = \"%s/%s\"",
72 connectpath
, base_name
);
73 } else if (connectpath
!= NULL
&& base_name
== NULL
) {
74 msg
= talloc_asprintf(talloc_tos(), "connectpath = \"%s\", "
77 } else if (connectpath
== NULL
&& base_name
!= NULL
) {
78 msg
= talloc_asprintf(talloc_tos(), "connectpath = <NULL>, "
81 } else { /* connectpath == NULL && base_name == NULL */
82 msg
= talloc_asprintf(talloc_tos(), "connectpath = <NULL>, "
83 "base_name = <NULL>");
85 smb_time_audit_log_msg(syscallname
, elapsed
, msg
);
89 static void smb_time_audit_log_at(const char *syscallname
,
91 const struct files_struct
*dir_fsp
,
92 const struct smb_filename
*smb_fname
)
96 msg
= talloc_asprintf(talloc_tos(),
97 "filename = \"%s/%s/%s\"",
98 dir_fsp
->conn
->connectpath
,
99 dir_fsp
->fsp_name
->base_name
,
100 smb_fname
->base_name
);
102 smb_time_audit_log_msg(syscallname
, elapsed
, msg
);
106 static void smb_time_audit_log_fname(const char *syscallname
, double elapsed
,
112 if (getcwd(cwd
, sizeof(cwd
)) == NULL
) {
113 snprintf(cwd
, sizeof(cwd
), "<getcwd() error %d>", errno
);
116 msg
= talloc_asprintf(talloc_tos(),
117 "cwd = \"%s\", filename = \"%s\"",
120 msg
= talloc_asprintf(talloc_tos(),
121 "cwd = \"%s\", filename = <NULL>",
124 smb_time_audit_log_msg(syscallname
, elapsed
, msg
);
128 static void smb_time_audit_log_smb_fname(const char *syscallname
, double elapsed
,
129 const struct smb_filename
*smb_fname
)
131 if (smb_fname
!= NULL
) {
132 smb_time_audit_log_fname(syscallname
, elapsed
,
133 smb_fname
->base_name
);
135 smb_time_audit_log_fname(syscallname
, elapsed
,
136 "smb_fname = <NULL>");
140 static int smb_time_audit_connect(vfs_handle_struct
*handle
,
141 const char *svc
, const char *user
)
144 struct timespec ts1
,ts2
;
151 clock_gettime_mono(&ts1
);
152 result
= SMB_VFS_NEXT_CONNECT(handle
, svc
, user
);
153 clock_gettime_mono(&ts2
);
154 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
155 if (timediff
> audit_timeout
) {
156 smb_time_audit_log_msg("connect", timediff
, user
);
161 static void smb_time_audit_disconnect(vfs_handle_struct
*handle
)
163 struct timespec ts1
,ts2
;
166 clock_gettime_mono(&ts1
);
167 SMB_VFS_NEXT_DISCONNECT(handle
);
168 clock_gettime_mono(&ts2
);
169 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
171 if (timediff
> audit_timeout
) {
172 smb_time_audit_log("disconnect", timediff
);
176 static uint64_t smb_time_audit_disk_free(vfs_handle_struct
*handle
,
177 const struct smb_filename
*smb_fname
,
183 struct timespec ts1
,ts2
;
186 clock_gettime_mono(&ts1
);
187 result
= SMB_VFS_NEXT_DISK_FREE(handle
, smb_fname
, bsize
, dfree
, dsize
);
188 clock_gettime_mono(&ts2
);
189 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
191 /* Don't have a reasonable notion of failure here */
192 if (timediff
> audit_timeout
) {
193 smb_time_audit_log_fname("disk_free",
195 smb_fname
->base_name
);
201 static int smb_time_audit_get_quota(struct vfs_handle_struct
*handle
,
202 const struct smb_filename
*smb_fname
,
203 enum SMB_QUOTA_TYPE qtype
,
208 struct timespec ts1
,ts2
;
211 clock_gettime_mono(&ts1
);
212 result
= SMB_VFS_NEXT_GET_QUOTA(handle
, smb_fname
, qtype
, id
, qt
);
213 clock_gettime_mono(&ts2
);
214 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
216 if (timediff
> audit_timeout
) {
217 smb_time_audit_log_fname("get_quota",
219 smb_fname
->base_name
);
224 static int smb_time_audit_set_quota(struct vfs_handle_struct
*handle
,
225 enum SMB_QUOTA_TYPE qtype
, unid_t id
,
229 struct timespec ts1
,ts2
;
232 clock_gettime_mono(&ts1
);
233 result
= SMB_VFS_NEXT_SET_QUOTA(handle
, qtype
, id
, qt
);
234 clock_gettime_mono(&ts2
);
235 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
237 if (timediff
> audit_timeout
) {
238 smb_time_audit_log("set_quota", timediff
);
244 static int smb_time_audit_get_shadow_copy_data(struct vfs_handle_struct
*handle
,
245 struct files_struct
*fsp
,
246 struct shadow_copy_data
*shadow_copy_data
,
250 struct timespec ts1
,ts2
;
253 clock_gettime_mono(&ts1
);
254 result
= SMB_VFS_NEXT_GET_SHADOW_COPY_DATA(handle
, fsp
,
255 shadow_copy_data
, labels
);
256 clock_gettime_mono(&ts2
);
257 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
259 if (timediff
> audit_timeout
) {
260 smb_time_audit_log_fsp("get_shadow_copy_data", timediff
, fsp
);
266 static int smb_time_audit_statvfs(struct vfs_handle_struct
*handle
,
267 const struct smb_filename
*smb_fname
,
268 struct vfs_statvfs_struct
*statbuf
)
271 struct timespec ts1
,ts2
;
274 clock_gettime_mono(&ts1
);
275 result
= SMB_VFS_NEXT_STATVFS(handle
, smb_fname
, statbuf
);
276 clock_gettime_mono(&ts2
);
277 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
279 if (timediff
> audit_timeout
) {
280 smb_time_audit_log_fname("statvfs", timediff
,
281 smb_fname
->base_name
);
287 static uint32_t smb_time_audit_fs_capabilities(struct vfs_handle_struct
*handle
,
288 enum timestamp_set_resolution
*p_ts_res
)
291 struct timespec ts1
,ts2
;
294 clock_gettime_mono(&ts1
);
295 result
= SMB_VFS_NEXT_FS_CAPABILITIES(handle
, p_ts_res
);
296 clock_gettime_mono(&ts2
);
297 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
299 if (timediff
> audit_timeout
) {
300 smb_time_audit_log("fs_capabilities", timediff
);
306 static NTSTATUS
smb_time_audit_get_dfs_referrals(
307 struct vfs_handle_struct
*handle
,
308 struct dfs_GetDFSReferral
*r
)
311 struct timespec ts1
,ts2
;
314 clock_gettime_mono(&ts1
);
315 result
= SMB_VFS_NEXT_GET_DFS_REFERRALS(handle
, r
);
316 clock_gettime_mono(&ts2
);
317 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
319 if (timediff
> audit_timeout
) {
320 smb_time_audit_log("get_dfs_referrals", timediff
);
326 static NTSTATUS
smb_time_audit_snap_check_path(struct vfs_handle_struct
*handle
,
328 const char *service_path
,
332 struct timespec ts1
,ts2
;
335 clock_gettime_mono(&ts1
);
336 status
= SMB_VFS_NEXT_SNAP_CHECK_PATH(handle
, mem_ctx
, service_path
,
338 clock_gettime_mono(&ts2
);
339 timediff
= nsec_time_diff(&ts2
, &ts1
) * 1.0e-9;
341 if (timediff
> audit_timeout
) {
342 smb_time_audit_log("snap_check_path", timediff
);
348 static NTSTATUS
smb_time_audit_snap_create(struct vfs_handle_struct
*handle
,
350 const char *base_volume
,
357 struct timespec ts1
,ts2
;
360 clock_gettime_mono(&ts1
);
361 status
= SMB_VFS_NEXT_SNAP_CREATE(handle
, mem_ctx
, base_volume
, tstamp
,
362 rw
, base_path
, snap_path
);
363 clock_gettime_mono(&ts2
);
364 timediff
= nsec_time_diff(&ts2
,&ts1
) * 1.0e-9;
366 if (timediff
> audit_timeout
) {
367 smb_time_audit_log("snap_create", timediff
);
373 static NTSTATUS
smb_time_audit_snap_delete(struct vfs_handle_struct
*handle
,
379 struct timespec ts1
,ts2
;
382 clock_gettime_mono(&ts1
);
383 status
= SMB_VFS_NEXT_SNAP_DELETE(handle
, mem_ctx
, base_path
,
385 clock_gettime_mono(&ts2
);
386 timediff
= nsec_time_diff(&ts2
, &ts1
) * 1.0e-9;
388 if (timediff
> audit_timeout
) {
389 smb_time_audit_log("snap_delete", timediff
);
395 static DIR *smb_time_audit_opendir(vfs_handle_struct
*handle
,
396 const struct smb_filename
*smb_fname
,
397 const char *mask
, uint32_t attr
)
400 struct timespec ts1
,ts2
;
403 clock_gettime_mono(&ts1
);
404 result
= SMB_VFS_NEXT_OPENDIR(handle
, smb_fname
, mask
, attr
);
405 clock_gettime_mono(&ts2
);
406 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
408 if (timediff
> audit_timeout
) {
409 smb_time_audit_log_smb_fname("opendir", timediff
, smb_fname
);
415 static DIR *smb_time_audit_fdopendir(vfs_handle_struct
*handle
,
417 const char *mask
, uint32_t attr
)
420 struct timespec ts1
,ts2
;
423 clock_gettime_mono(&ts1
);
424 result
= SMB_VFS_NEXT_FDOPENDIR(handle
, fsp
, mask
, attr
);
425 clock_gettime_mono(&ts2
);
426 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
428 if (timediff
> audit_timeout
) {
429 smb_time_audit_log_fsp("fdopendir", timediff
, fsp
);
435 static struct dirent
*smb_time_audit_readdir(vfs_handle_struct
*handle
,
437 SMB_STRUCT_STAT
*sbuf
)
439 struct dirent
*result
;
440 struct timespec ts1
,ts2
;
443 clock_gettime_mono(&ts1
);
444 result
= SMB_VFS_NEXT_READDIR(handle
, dirp
, sbuf
);
445 clock_gettime_mono(&ts2
);
446 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
448 if (timediff
> audit_timeout
) {
449 smb_time_audit_log("readdir", timediff
);
455 static void smb_time_audit_seekdir(vfs_handle_struct
*handle
,
456 DIR *dirp
, long offset
)
458 struct timespec ts1
,ts2
;
461 clock_gettime_mono(&ts1
);
462 SMB_VFS_NEXT_SEEKDIR(handle
, dirp
, offset
);
463 clock_gettime_mono(&ts2
);
464 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
466 if (timediff
> audit_timeout
) {
467 smb_time_audit_log("seekdir", timediff
);
472 static long smb_time_audit_telldir(vfs_handle_struct
*handle
,
476 struct timespec ts1
,ts2
;
479 clock_gettime_mono(&ts1
);
480 result
= SMB_VFS_NEXT_TELLDIR(handle
, dirp
);
481 clock_gettime_mono(&ts2
);
482 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
484 if (timediff
> audit_timeout
) {
485 smb_time_audit_log("telldir", timediff
);
491 static void smb_time_audit_rewinddir(vfs_handle_struct
*handle
,
494 struct timespec ts1
,ts2
;
497 clock_gettime_mono(&ts1
);
498 SMB_VFS_NEXT_REWINDDIR(handle
, dirp
);
499 clock_gettime_mono(&ts2
);
500 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
502 if (timediff
> audit_timeout
) {
503 smb_time_audit_log("rewinddir", timediff
);
508 static int smb_time_audit_mkdir(vfs_handle_struct
*handle
,
509 const struct smb_filename
*smb_fname
,
513 struct timespec ts1
,ts2
;
516 clock_gettime_mono(&ts1
);
517 result
= SMB_VFS_NEXT_MKDIR(handle
, smb_fname
, mode
);
518 clock_gettime_mono(&ts2
);
519 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
521 if (timediff
> audit_timeout
) {
522 smb_time_audit_log_smb_fname("mkdir",
530 static int smb_time_audit_rmdir(vfs_handle_struct
*handle
,
531 const struct smb_filename
*smb_fname
)
534 struct timespec ts1
,ts2
;
537 clock_gettime_mono(&ts1
);
538 result
= SMB_VFS_NEXT_RMDIR(handle
, smb_fname
);
539 clock_gettime_mono(&ts2
);
540 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
542 if (timediff
> audit_timeout
) {
543 smb_time_audit_log_smb_fname("rmdir",
551 static int smb_time_audit_closedir(vfs_handle_struct
*handle
,
555 struct timespec ts1
,ts2
;
558 clock_gettime_mono(&ts1
);
559 result
= SMB_VFS_NEXT_CLOSEDIR(handle
, dirp
);
560 clock_gettime_mono(&ts2
);
561 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
563 if (timediff
> audit_timeout
) {
564 smb_time_audit_log("closedir", timediff
);
570 static int smb_time_audit_open(vfs_handle_struct
*handle
,
571 struct smb_filename
*fname
,
573 int flags
, mode_t mode
)
576 struct timespec ts1
,ts2
;
579 clock_gettime_mono(&ts1
);
580 result
= SMB_VFS_NEXT_OPEN(handle
, fname
, fsp
, flags
, mode
);
581 clock_gettime_mono(&ts2
);
582 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
584 if (timediff
> audit_timeout
) {
585 smb_time_audit_log_fsp("open", timediff
, fsp
);
591 static NTSTATUS
smb_time_audit_create_file(vfs_handle_struct
*handle
,
592 struct smb_request
*req
,
593 uint16_t root_dir_fid
,
594 struct smb_filename
*fname
,
595 uint32_t access_mask
,
596 uint32_t share_access
,
597 uint32_t create_disposition
,
598 uint32_t create_options
,
599 uint32_t file_attributes
,
600 uint32_t oplock_request
,
601 struct smb2_lease
*lease
,
602 uint64_t allocation_size
,
603 uint32_t private_flags
,
604 struct security_descriptor
*sd
,
605 struct ea_list
*ea_list
,
606 files_struct
**result_fsp
,
608 const struct smb2_create_blobs
*in_context_blobs
,
609 struct smb2_create_blobs
*out_context_blobs
)
612 struct timespec ts1
,ts2
;
615 clock_gettime_mono(&ts1
);
616 result
= SMB_VFS_NEXT_CREATE_FILE(
619 root_dir_fid
, /* root_dir_fid */
621 access_mask
, /* access_mask */
622 share_access
, /* share_access */
623 create_disposition
, /* create_disposition*/
624 create_options
, /* create_options */
625 file_attributes
, /* file_attributes */
626 oplock_request
, /* oplock_request */
628 allocation_size
, /* allocation_size */
631 ea_list
, /* ea_list */
632 result_fsp
, /* result */
634 in_context_blobs
, out_context_blobs
); /* create context */
635 clock_gettime_mono(&ts2
);
636 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
638 if (timediff
> audit_timeout
) {
640 * can't use result_fsp this time, may have
641 * invalid content causing smbd crash
643 smb_time_audit_log_smb_fname("create_file", timediff
,
650 static int smb_time_audit_close(vfs_handle_struct
*handle
, files_struct
*fsp
)
653 struct timespec ts1
,ts2
;
656 clock_gettime_mono(&ts1
);
657 result
= SMB_VFS_NEXT_CLOSE(handle
, fsp
);
658 clock_gettime_mono(&ts2
);
659 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
661 if (timediff
> audit_timeout
) {
662 smb_time_audit_log_fsp("close", timediff
, fsp
);
668 static ssize_t
smb_time_audit_pread(vfs_handle_struct
*handle
,
670 void *data
, size_t n
, off_t offset
)
673 struct timespec ts1
,ts2
;
676 clock_gettime_mono(&ts1
);
677 result
= SMB_VFS_NEXT_PREAD(handle
, fsp
, data
, n
, offset
);
678 clock_gettime_mono(&ts2
);
679 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
681 if (timediff
> audit_timeout
) {
682 smb_time_audit_log_fsp("pread", timediff
, fsp
);
688 struct smb_time_audit_pread_state
{
689 struct files_struct
*fsp
;
691 struct vfs_aio_state vfs_aio_state
;
694 static void smb_time_audit_pread_done(struct tevent_req
*subreq
);
696 static struct tevent_req
*smb_time_audit_pread_send(
697 struct vfs_handle_struct
*handle
, TALLOC_CTX
*mem_ctx
,
698 struct tevent_context
*ev
, struct files_struct
*fsp
,
699 void *data
, size_t n
, off_t offset
)
701 struct tevent_req
*req
, *subreq
;
702 struct smb_time_audit_pread_state
*state
;
704 req
= tevent_req_create(mem_ctx
, &state
,
705 struct smb_time_audit_pread_state
);
711 subreq
= SMB_VFS_NEXT_PREAD_SEND(state
, ev
, handle
, fsp
, data
,
713 if (tevent_req_nomem(subreq
, req
)) {
714 return tevent_req_post(req
, ev
);
716 tevent_req_set_callback(subreq
, smb_time_audit_pread_done
, req
);
720 static void smb_time_audit_pread_done(struct tevent_req
*subreq
)
722 struct tevent_req
*req
= tevent_req_callback_data(
723 subreq
, struct tevent_req
);
724 struct smb_time_audit_pread_state
*state
= tevent_req_data(
725 req
, struct smb_time_audit_pread_state
);
727 state
->ret
= SMB_VFS_PREAD_RECV(subreq
, &state
->vfs_aio_state
);
729 tevent_req_done(req
);
732 static ssize_t
smb_time_audit_pread_recv(struct tevent_req
*req
,
733 struct vfs_aio_state
*vfs_aio_state
)
735 struct smb_time_audit_pread_state
*state
= tevent_req_data(
736 req
, struct smb_time_audit_pread_state
);
739 timediff
= state
->vfs_aio_state
.duration
* 1.0e-9;
741 if (timediff
> audit_timeout
) {
742 smb_time_audit_log_fsp("async pread", timediff
, state
->fsp
);
745 if (tevent_req_is_unix_error(req
, &vfs_aio_state
->error
)) {
748 *vfs_aio_state
= state
->vfs_aio_state
;
752 static ssize_t
smb_time_audit_pwrite(vfs_handle_struct
*handle
,
754 const void *data
, size_t n
,
758 struct timespec ts1
,ts2
;
761 clock_gettime_mono(&ts1
);
762 result
= SMB_VFS_NEXT_PWRITE(handle
, fsp
, data
, n
, offset
);
763 clock_gettime_mono(&ts2
);
764 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
766 if (timediff
> audit_timeout
) {
767 smb_time_audit_log_fsp("pwrite", timediff
, fsp
);
773 struct smb_time_audit_pwrite_state
{
774 struct files_struct
*fsp
;
776 struct vfs_aio_state vfs_aio_state
;
779 static void smb_time_audit_pwrite_done(struct tevent_req
*subreq
);
781 static struct tevent_req
*smb_time_audit_pwrite_send(
782 struct vfs_handle_struct
*handle
, TALLOC_CTX
*mem_ctx
,
783 struct tevent_context
*ev
, struct files_struct
*fsp
,
784 const void *data
, size_t n
, off_t offset
)
786 struct tevent_req
*req
, *subreq
;
787 struct smb_time_audit_pwrite_state
*state
;
789 req
= tevent_req_create(mem_ctx
, &state
,
790 struct smb_time_audit_pwrite_state
);
796 subreq
= SMB_VFS_NEXT_PWRITE_SEND(state
, ev
, handle
, fsp
, data
,
798 if (tevent_req_nomem(subreq
, req
)) {
799 return tevent_req_post(req
, ev
);
801 tevent_req_set_callback(subreq
, smb_time_audit_pwrite_done
, req
);
805 static void smb_time_audit_pwrite_done(struct tevent_req
*subreq
)
807 struct tevent_req
*req
= tevent_req_callback_data(
808 subreq
, struct tevent_req
);
809 struct smb_time_audit_pwrite_state
*state
= tevent_req_data(
810 req
, struct smb_time_audit_pwrite_state
);
812 state
->ret
= SMB_VFS_PWRITE_RECV(subreq
, &state
->vfs_aio_state
);
814 tevent_req_done(req
);
817 static ssize_t
smb_time_audit_pwrite_recv(struct tevent_req
*req
,
818 struct vfs_aio_state
*vfs_aio_state
)
820 struct smb_time_audit_pwrite_state
*state
= tevent_req_data(
821 req
, struct smb_time_audit_pwrite_state
);
824 timediff
= state
->vfs_aio_state
.duration
* 1.0e-9;
826 if (timediff
> audit_timeout
) {
827 smb_time_audit_log_fsp("async pwrite", timediff
, state
->fsp
);
830 if (tevent_req_is_unix_error(req
, &vfs_aio_state
->error
)) {
833 *vfs_aio_state
= state
->vfs_aio_state
;
837 static off_t
smb_time_audit_lseek(vfs_handle_struct
*handle
,
839 off_t offset
, int whence
)
842 struct timespec ts1
,ts2
;
845 clock_gettime_mono(&ts1
);
846 result
= SMB_VFS_NEXT_LSEEK(handle
, fsp
, offset
, whence
);
847 clock_gettime_mono(&ts2
);
848 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
850 if (timediff
> audit_timeout
) {
851 smb_time_audit_log_fsp("lseek", timediff
, fsp
);
857 static ssize_t
smb_time_audit_sendfile(vfs_handle_struct
*handle
, int tofd
,
858 files_struct
*fromfsp
,
859 const DATA_BLOB
*hdr
, off_t offset
,
863 struct timespec ts1
,ts2
;
866 clock_gettime_mono(&ts1
);
867 result
= SMB_VFS_NEXT_SENDFILE(handle
, tofd
, fromfsp
, hdr
, offset
, n
);
868 clock_gettime_mono(&ts2
);
869 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
871 if (timediff
> audit_timeout
) {
872 smb_time_audit_log_fsp("sendfile", timediff
, fromfsp
);
878 static ssize_t
smb_time_audit_recvfile(vfs_handle_struct
*handle
, int fromfd
,
884 struct timespec ts1
,ts2
;
887 clock_gettime_mono(&ts1
);
888 result
= SMB_VFS_NEXT_RECVFILE(handle
, fromfd
, tofsp
, offset
, n
);
889 clock_gettime_mono(&ts2
);
890 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
892 if (timediff
> audit_timeout
) {
893 smb_time_audit_log_fsp("recvfile", timediff
, tofsp
);
899 static int smb_time_audit_rename(vfs_handle_struct
*handle
,
900 const struct smb_filename
*oldname
,
901 const struct smb_filename
*newname
)
904 struct timespec ts1
,ts2
;
907 clock_gettime_mono(&ts1
);
908 result
= SMB_VFS_NEXT_RENAME(handle
, oldname
, newname
);
909 clock_gettime_mono(&ts2
);
910 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
912 if (timediff
> audit_timeout
) {
913 smb_time_audit_log_smb_fname("rename", timediff
, newname
);
919 struct smb_time_audit_fsync_state
{
920 struct files_struct
*fsp
;
922 struct vfs_aio_state vfs_aio_state
;
925 static void smb_time_audit_fsync_done(struct tevent_req
*subreq
);
927 static struct tevent_req
*smb_time_audit_fsync_send(
928 struct vfs_handle_struct
*handle
, TALLOC_CTX
*mem_ctx
,
929 struct tevent_context
*ev
, struct files_struct
*fsp
)
931 struct tevent_req
*req
, *subreq
;
932 struct smb_time_audit_fsync_state
*state
;
934 req
= tevent_req_create(mem_ctx
, &state
,
935 struct smb_time_audit_fsync_state
);
941 subreq
= SMB_VFS_NEXT_FSYNC_SEND(state
, ev
, handle
, fsp
);
942 if (tevent_req_nomem(subreq
, req
)) {
943 return tevent_req_post(req
, ev
);
945 tevent_req_set_callback(subreq
, smb_time_audit_fsync_done
, req
);
949 static void smb_time_audit_fsync_done(struct tevent_req
*subreq
)
951 struct tevent_req
*req
= tevent_req_callback_data(
952 subreq
, struct tevent_req
);
953 struct smb_time_audit_fsync_state
*state
= tevent_req_data(
954 req
, struct smb_time_audit_fsync_state
);
956 state
->ret
= SMB_VFS_FSYNC_RECV(subreq
, &state
->vfs_aio_state
);
958 tevent_req_done(req
);
961 static int smb_time_audit_fsync_recv(struct tevent_req
*req
,
962 struct vfs_aio_state
*vfs_aio_state
)
964 struct smb_time_audit_fsync_state
*state
= tevent_req_data(
965 req
, struct smb_time_audit_fsync_state
);
968 timediff
= state
->vfs_aio_state
.duration
* 1.0e-9;
970 if (timediff
> audit_timeout
) {
971 smb_time_audit_log_fsp("async fsync", timediff
, state
->fsp
);
974 if (tevent_req_is_unix_error(req
, &vfs_aio_state
->error
)) {
977 *vfs_aio_state
= state
->vfs_aio_state
;
981 static int smb_time_audit_stat(vfs_handle_struct
*handle
,
982 struct smb_filename
*fname
)
985 struct timespec ts1
,ts2
;
988 clock_gettime_mono(&ts1
);
989 result
= SMB_VFS_NEXT_STAT(handle
, fname
);
990 clock_gettime_mono(&ts2
);
991 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
993 if (timediff
> audit_timeout
) {
994 smb_time_audit_log_smb_fname("stat", timediff
, fname
);
1000 static int smb_time_audit_fstat(vfs_handle_struct
*handle
, files_struct
*fsp
,
1001 SMB_STRUCT_STAT
*sbuf
)
1004 struct timespec ts1
,ts2
;
1007 clock_gettime_mono(&ts1
);
1008 result
= SMB_VFS_NEXT_FSTAT(handle
, fsp
, sbuf
);
1009 clock_gettime_mono(&ts2
);
1010 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1012 if (timediff
> audit_timeout
) {
1013 smb_time_audit_log_fsp("fstat", timediff
, fsp
);
1019 static int smb_time_audit_lstat(vfs_handle_struct
*handle
,
1020 struct smb_filename
*path
)
1023 struct timespec ts1
,ts2
;
1026 clock_gettime_mono(&ts1
);
1027 result
= SMB_VFS_NEXT_LSTAT(handle
, path
);
1028 clock_gettime_mono(&ts2
);
1029 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1031 if (timediff
> audit_timeout
) {
1032 smb_time_audit_log_smb_fname("lstat", timediff
, path
);
1038 static uint64_t smb_time_audit_get_alloc_size(vfs_handle_struct
*handle
,
1040 const SMB_STRUCT_STAT
*sbuf
)
1043 struct timespec ts1
,ts2
;
1046 clock_gettime_mono(&ts1
);
1047 result
= SMB_VFS_NEXT_GET_ALLOC_SIZE(handle
, fsp
, sbuf
);
1048 clock_gettime_mono(&ts2
);
1049 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1051 if (timediff
> audit_timeout
) {
1052 smb_time_audit_log_fsp("get_alloc_size", timediff
, fsp
);
1058 static int smb_time_audit_unlink(vfs_handle_struct
*handle
,
1059 const struct smb_filename
*path
)
1062 struct timespec ts1
,ts2
;
1065 clock_gettime_mono(&ts1
);
1066 result
= SMB_VFS_NEXT_UNLINK(handle
, path
);
1067 clock_gettime_mono(&ts2
);
1068 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1070 if (timediff
> audit_timeout
) {
1071 smb_time_audit_log_smb_fname("unlink", timediff
, path
);
1077 static int smb_time_audit_chmod(vfs_handle_struct
*handle
,
1078 const struct smb_filename
*smb_fname
,
1082 struct timespec ts1
,ts2
;
1085 clock_gettime_mono(&ts1
);
1086 result
= SMB_VFS_NEXT_CHMOD(handle
, smb_fname
, mode
);
1087 clock_gettime_mono(&ts2
);
1088 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1090 if (timediff
> audit_timeout
) {
1091 smb_time_audit_log_fname("chmod",
1093 smb_fname
->base_name
);
1099 static int smb_time_audit_fchmod(vfs_handle_struct
*handle
, files_struct
*fsp
,
1103 struct timespec ts1
,ts2
;
1106 clock_gettime_mono(&ts1
);
1107 result
= SMB_VFS_NEXT_FCHMOD(handle
, fsp
, mode
);
1108 clock_gettime_mono(&ts2
);
1109 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1111 if (timediff
> audit_timeout
) {
1112 smb_time_audit_log_fsp("fchmod", timediff
, fsp
);
1118 static int smb_time_audit_chown(vfs_handle_struct
*handle
,
1119 const struct smb_filename
*smb_fname
,
1124 struct timespec ts1
,ts2
;
1127 clock_gettime_mono(&ts1
);
1128 result
= SMB_VFS_NEXT_CHOWN(handle
, smb_fname
, uid
, gid
);
1129 clock_gettime_mono(&ts2
);
1130 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1132 if (timediff
> audit_timeout
) {
1133 smb_time_audit_log_fname("chown",
1135 smb_fname
->base_name
);
1141 static int smb_time_audit_fchown(vfs_handle_struct
*handle
, files_struct
*fsp
,
1142 uid_t uid
, gid_t gid
)
1145 struct timespec ts1
,ts2
;
1148 clock_gettime_mono(&ts1
);
1149 result
= SMB_VFS_NEXT_FCHOWN(handle
, fsp
, uid
, gid
);
1150 clock_gettime_mono(&ts2
);
1151 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1153 if (timediff
> audit_timeout
) {
1154 smb_time_audit_log_fsp("fchown", timediff
, fsp
);
1160 static int smb_time_audit_lchown(vfs_handle_struct
*handle
,
1161 const struct smb_filename
*smb_fname
,
1166 struct timespec ts1
,ts2
;
1169 clock_gettime_mono(&ts1
);
1170 result
= SMB_VFS_NEXT_LCHOWN(handle
, smb_fname
, uid
, gid
);
1171 clock_gettime_mono(&ts2
);
1172 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1174 if (timediff
> audit_timeout
) {
1175 smb_time_audit_log_fname("lchown",
1177 smb_fname
->base_name
);
1183 static int smb_time_audit_chdir(vfs_handle_struct
*handle
,
1184 const struct smb_filename
*smb_fname
)
1187 struct timespec ts1
,ts2
;
1190 clock_gettime_mono(&ts1
);
1191 result
= SMB_VFS_NEXT_CHDIR(handle
, smb_fname
);
1192 clock_gettime_mono(&ts2
);
1193 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1195 if (timediff
> audit_timeout
) {
1196 smb_time_audit_log_fname("chdir",
1198 smb_fname
->base_name
);
1204 static struct smb_filename
*smb_time_audit_getwd(vfs_handle_struct
*handle
,
1205 TALLOC_CTX
*mem_ctx
)
1207 struct smb_filename
*result
;
1208 struct timespec ts1
,ts2
;
1211 clock_gettime_mono(&ts1
);
1212 result
= SMB_VFS_NEXT_GETWD(handle
, mem_ctx
);
1213 clock_gettime_mono(&ts2
);
1214 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1216 if (timediff
> audit_timeout
) {
1217 smb_time_audit_log("getwd", timediff
);
1223 static int smb_time_audit_ntimes(vfs_handle_struct
*handle
,
1224 const struct smb_filename
*path
,
1225 struct smb_file_time
*ft
)
1228 struct timespec ts1
,ts2
;
1231 clock_gettime_mono(&ts1
);
1232 result
= SMB_VFS_NEXT_NTIMES(handle
, path
, ft
);
1233 clock_gettime_mono(&ts2
);
1234 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1236 if (timediff
> audit_timeout
) {
1237 smb_time_audit_log_smb_fname("ntimes", timediff
, path
);
1243 static int smb_time_audit_ftruncate(vfs_handle_struct
*handle
,
1248 struct timespec ts1
,ts2
;
1251 clock_gettime_mono(&ts1
);
1252 result
= SMB_VFS_NEXT_FTRUNCATE(handle
, fsp
, len
);
1253 clock_gettime_mono(&ts2
);
1254 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1256 if (timediff
> audit_timeout
) {
1257 smb_time_audit_log_fsp("ftruncate", timediff
, fsp
);
1263 static int smb_time_audit_fallocate(vfs_handle_struct
*handle
,
1270 int saved_errno
= 0;
1271 struct timespec ts1
,ts2
;
1274 clock_gettime_mono(&ts1
);
1275 result
= SMB_VFS_NEXT_FALLOCATE(handle
, fsp
, mode
, offset
, len
);
1277 saved_errno
= errno
;
1279 clock_gettime_mono(&ts2
);
1280 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1282 if (timediff
> audit_timeout
) {
1283 smb_time_audit_log_fsp("fallocate", timediff
, fsp
);
1286 errno
= saved_errno
;
1291 static bool smb_time_audit_lock(vfs_handle_struct
*handle
, files_struct
*fsp
,
1292 int op
, off_t offset
, off_t count
,
1296 struct timespec ts1
,ts2
;
1299 clock_gettime_mono(&ts1
);
1300 result
= SMB_VFS_NEXT_LOCK(handle
, fsp
, op
, offset
, count
, type
);
1301 clock_gettime_mono(&ts2
);
1302 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1304 if (timediff
> audit_timeout
) {
1305 smb_time_audit_log_fsp("lock", timediff
, fsp
);
1311 static int smb_time_audit_kernel_flock(struct vfs_handle_struct
*handle
,
1312 struct files_struct
*fsp
,
1313 uint32_t share_mode
, uint32_t access_mask
)
1316 struct timespec ts1
,ts2
;
1319 clock_gettime_mono(&ts1
);
1320 result
= SMB_VFS_NEXT_KERNEL_FLOCK(handle
, fsp
, share_mode
,
1322 clock_gettime_mono(&ts2
);
1323 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1325 if (timediff
> audit_timeout
) {
1326 smb_time_audit_log_fsp("kernel_flock", timediff
, fsp
);
1332 static int smb_time_audit_linux_setlease(vfs_handle_struct
*handle
,
1337 struct timespec ts1
,ts2
;
1340 clock_gettime_mono(&ts1
);
1341 result
= SMB_VFS_NEXT_LINUX_SETLEASE(handle
, fsp
, leasetype
);
1342 clock_gettime_mono(&ts2
);
1343 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1345 if (timediff
> audit_timeout
) {
1346 smb_time_audit_log_fsp("linux_setlease", timediff
, fsp
);
1352 static bool smb_time_audit_getlock(vfs_handle_struct
*handle
,
1354 off_t
*poffset
, off_t
*pcount
,
1355 int *ptype
, pid_t
*ppid
)
1358 struct timespec ts1
,ts2
;
1361 clock_gettime_mono(&ts1
);
1362 result
= SMB_VFS_NEXT_GETLOCK(handle
, fsp
, poffset
, pcount
, ptype
,
1364 clock_gettime_mono(&ts2
);
1365 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1367 if (timediff
> audit_timeout
) {
1368 smb_time_audit_log_fsp("getlock", timediff
, fsp
);
1374 static int smb_time_audit_symlink(vfs_handle_struct
*handle
,
1375 const char *link_contents
,
1376 const struct smb_filename
*new_smb_fname
)
1379 struct timespec ts1
,ts2
;
1382 clock_gettime_mono(&ts1
);
1383 result
= SMB_VFS_NEXT_SYMLINK(handle
, link_contents
, new_smb_fname
);
1384 clock_gettime_mono(&ts2
);
1385 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1387 if (timediff
> audit_timeout
) {
1388 smb_time_audit_log_fname("symlink", timediff
,
1389 new_smb_fname
->base_name
);
1395 static int smb_time_audit_readlink(vfs_handle_struct
*handle
,
1396 const struct smb_filename
*smb_fname
,
1401 struct timespec ts1
,ts2
;
1404 clock_gettime_mono(&ts1
);
1405 result
= SMB_VFS_NEXT_READLINK(handle
, smb_fname
,
1407 clock_gettime_mono(&ts2
);
1408 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1410 if (timediff
> audit_timeout
) {
1411 smb_time_audit_log_fname("readlink", timediff
,
1412 smb_fname
->base_name
);
1418 static int smb_time_audit_link(vfs_handle_struct
*handle
,
1419 const struct smb_filename
*old_smb_fname
,
1420 const struct smb_filename
*new_smb_fname
)
1423 struct timespec ts1
,ts2
;
1426 clock_gettime_mono(&ts1
);
1427 result
= SMB_VFS_NEXT_LINK(handle
, old_smb_fname
, new_smb_fname
);
1428 clock_gettime_mono(&ts2
);
1429 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1431 if (timediff
> audit_timeout
) {
1432 smb_time_audit_log_fname("link", timediff
,
1433 new_smb_fname
->base_name
);
1439 static int smb_time_audit_mknod(vfs_handle_struct
*handle
,
1440 const struct smb_filename
*smb_fname
,
1445 struct timespec ts1
,ts2
;
1448 clock_gettime_mono(&ts1
);
1449 result
= SMB_VFS_NEXT_MKNOD(handle
, smb_fname
, mode
, dev
);
1450 clock_gettime_mono(&ts2
);
1451 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1453 if (timediff
> audit_timeout
) {
1454 smb_time_audit_log_smb_fname("mknod", timediff
, smb_fname
);
1460 static struct smb_filename
*smb_time_audit_realpath(vfs_handle_struct
*handle
,
1462 const struct smb_filename
*smb_fname
)
1464 struct smb_filename
*result_fname
;
1465 struct timespec ts1
,ts2
;
1468 clock_gettime_mono(&ts1
);
1469 result_fname
= SMB_VFS_NEXT_REALPATH(handle
, ctx
, smb_fname
);
1470 clock_gettime_mono(&ts2
);
1471 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1473 if (timediff
> audit_timeout
) {
1474 smb_time_audit_log_fname("realpath", timediff
,
1475 smb_fname
->base_name
);
1478 return result_fname
;
1481 static int smb_time_audit_chflags(vfs_handle_struct
*handle
,
1482 const struct smb_filename
*smb_fname
,
1486 struct timespec ts1
,ts2
;
1489 clock_gettime_mono(&ts1
);
1490 result
= SMB_VFS_NEXT_CHFLAGS(handle
, smb_fname
, flags
);
1491 clock_gettime_mono(&ts2
);
1492 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1494 if (timediff
> audit_timeout
) {
1495 smb_time_audit_log_smb_fname("chflags", timediff
, smb_fname
);
1501 static struct file_id
smb_time_audit_file_id_create(struct vfs_handle_struct
*handle
,
1502 const SMB_STRUCT_STAT
*sbuf
)
1504 struct file_id id_zero
;
1505 struct file_id result
;
1506 struct timespec ts1
,ts2
;
1509 ZERO_STRUCT(id_zero
);
1511 clock_gettime_mono(&ts1
);
1512 result
= SMB_VFS_NEXT_FILE_ID_CREATE(handle
, sbuf
);
1513 clock_gettime_mono(&ts2
);
1514 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1516 if (timediff
> audit_timeout
) {
1517 smb_time_audit_log("file_id_create", timediff
);
1523 static NTSTATUS
smb_time_audit_streaminfo(vfs_handle_struct
*handle
,
1524 struct files_struct
*fsp
,
1525 const struct smb_filename
*smb_fname
,
1526 TALLOC_CTX
*mem_ctx
,
1527 unsigned int *pnum_streams
,
1528 struct stream_struct
**pstreams
)
1531 struct timespec ts1
,ts2
;
1534 clock_gettime_mono(&ts1
);
1535 result
= SMB_VFS_NEXT_STREAMINFO(handle
, fsp
, smb_fname
, mem_ctx
,
1536 pnum_streams
, pstreams
);
1537 clock_gettime_mono(&ts2
);
1538 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1540 if (timediff
> audit_timeout
) {
1541 smb_time_audit_log_fsp("streaminfo", timediff
, fsp
);
1547 static int smb_time_audit_get_real_filename(struct vfs_handle_struct
*handle
,
1550 TALLOC_CTX
*mem_ctx
,
1554 struct timespec ts1
,ts2
;
1557 clock_gettime_mono(&ts1
);
1558 result
= SMB_VFS_NEXT_GET_REAL_FILENAME(handle
, path
, name
, mem_ctx
,
1560 clock_gettime_mono(&ts2
);
1561 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1563 if (timediff
> audit_timeout
) {
1564 smb_time_audit_log_fname("get_real_filename", timediff
, path
);
1570 static const char *smb_time_audit_connectpath(vfs_handle_struct
*handle
,
1571 const struct smb_filename
*smb_fname
)
1574 struct timespec ts1
,ts2
;
1577 clock_gettime_mono(&ts1
);
1578 result
= SMB_VFS_NEXT_CONNECTPATH(handle
, smb_fname
);
1579 clock_gettime_mono(&ts2
);
1580 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1582 if (timediff
> audit_timeout
) {
1583 smb_time_audit_log_fname("connectpath", timediff
,
1584 smb_fname
->base_name
);
1590 static NTSTATUS
smb_time_audit_brl_lock_windows(struct vfs_handle_struct
*handle
,
1591 struct byte_range_lock
*br_lck
,
1592 struct lock_struct
*plock
,
1596 struct timespec ts1
,ts2
;
1599 clock_gettime_mono(&ts1
);
1600 result
= SMB_VFS_NEXT_BRL_LOCK_WINDOWS(handle
, br_lck
, plock
,
1602 clock_gettime_mono(&ts2
);
1603 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1605 if (timediff
> audit_timeout
) {
1606 smb_time_audit_log_fsp("brl_lock_windows", timediff
,
1613 static bool smb_time_audit_brl_unlock_windows(struct vfs_handle_struct
*handle
,
1614 struct messaging_context
*msg_ctx
,
1615 struct byte_range_lock
*br_lck
,
1616 const struct lock_struct
*plock
)
1619 struct timespec ts1
,ts2
;
1622 clock_gettime_mono(&ts1
);
1623 result
= SMB_VFS_NEXT_BRL_UNLOCK_WINDOWS(handle
, msg_ctx
, br_lck
,
1625 clock_gettime_mono(&ts2
);
1626 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1628 if (timediff
> audit_timeout
) {
1629 smb_time_audit_log_fsp("brl_unlock_windows", timediff
,
1636 static bool smb_time_audit_brl_cancel_windows(struct vfs_handle_struct
*handle
,
1637 struct byte_range_lock
*br_lck
,
1638 struct lock_struct
*plock
)
1641 struct timespec ts1
,ts2
;
1644 clock_gettime_mono(&ts1
);
1645 result
= SMB_VFS_NEXT_BRL_CANCEL_WINDOWS(handle
, br_lck
, plock
);
1646 clock_gettime_mono(&ts2
);
1647 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1649 if (timediff
> audit_timeout
) {
1650 smb_time_audit_log_fsp("brl_cancel_windows", timediff
,
1657 static bool smb_time_audit_strict_lock_check(struct vfs_handle_struct
*handle
,
1658 struct files_struct
*fsp
,
1659 struct lock_struct
*plock
)
1662 struct timespec ts1
,ts2
;
1665 clock_gettime_mono(&ts1
);
1666 result
= SMB_VFS_NEXT_STRICT_LOCK_CHECK(handle
, fsp
, plock
);
1667 clock_gettime_mono(&ts2
);
1668 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1670 if (timediff
> audit_timeout
) {
1671 smb_time_audit_log_fsp("strict_lock_check", timediff
, fsp
);
1677 static NTSTATUS
smb_time_audit_translate_name(struct vfs_handle_struct
*handle
,
1679 enum vfs_translate_direction direction
,
1680 TALLOC_CTX
*mem_ctx
,
1684 struct timespec ts1
,ts2
;
1687 clock_gettime_mono(&ts1
);
1688 result
= SMB_VFS_NEXT_TRANSLATE_NAME(handle
, name
, direction
, mem_ctx
,
1690 clock_gettime_mono(&ts2
);
1691 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1693 if (timediff
> audit_timeout
) {
1694 smb_time_audit_log_fname("translate_name", timediff
, name
);
1700 static NTSTATUS
smb_time_audit_fsctl(struct vfs_handle_struct
*handle
,
1701 struct files_struct
*fsp
,
1705 const uint8_t *_in_data
,
1707 uint8_t **_out_data
,
1708 uint32_t max_out_len
,
1712 struct timespec ts1
,ts2
;
1715 clock_gettime_mono(&ts1
);
1716 result
= SMB_VFS_NEXT_FSCTL(handle
,
1726 clock_gettime_mono(&ts2
);
1727 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1729 if (timediff
> audit_timeout
) {
1730 smb_time_audit_log_fsp("fsctl", timediff
, fsp
);
1736 static NTSTATUS
smb_time_get_dos_attributes(struct vfs_handle_struct
*handle
,
1737 struct smb_filename
*smb_fname
,
1741 struct timespec ts1
,ts2
;
1744 clock_gettime_mono(&ts1
);
1745 result
= SMB_VFS_NEXT_GET_DOS_ATTRIBUTES(handle
,
1748 clock_gettime_mono(&ts2
);
1749 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1751 if (timediff
> audit_timeout
) {
1752 smb_time_audit_log_fname("get_dos_attributes",
1754 smb_fname
->base_name
);
1760 struct smb_time_audit_get_dos_attributes_state
{
1761 struct vfs_aio_state aio_state
;
1762 files_struct
*dir_fsp
;
1763 const struct smb_filename
*smb_fname
;
1767 static void smb_time_audit_get_dos_attributes_done(struct tevent_req
*subreq
);
1769 static struct tevent_req
*smb_time_audit_get_dos_attributes_send(
1770 TALLOC_CTX
*mem_ctx
,
1771 const struct smb_vfs_ev_glue
*evg
,
1772 struct vfs_handle_struct
*handle
,
1773 files_struct
*dir_fsp
,
1774 struct smb_filename
*smb_fname
)
1776 struct tevent_context
*ev
= smb_vfs_ev_glue_ev_ctx(evg
);
1777 struct tevent_req
*req
= NULL
;
1778 struct smb_time_audit_get_dos_attributes_state
*state
= NULL
;
1779 struct tevent_req
*subreq
= NULL
;
1781 req
= tevent_req_create(mem_ctx
, &state
,
1782 struct smb_time_audit_get_dos_attributes_state
);
1786 *state
= (struct smb_time_audit_get_dos_attributes_state
) {
1788 .smb_fname
= smb_fname
,
1791 subreq
= SMB_VFS_NEXT_GET_DOS_ATTRIBUTES_SEND(mem_ctx
,
1796 if (tevent_req_nomem(subreq
, req
)) {
1797 return tevent_req_post(req
, ev
);
1799 tevent_req_set_callback(subreq
,
1800 smb_time_audit_get_dos_attributes_done
,
1806 static void smb_time_audit_get_dos_attributes_done(struct tevent_req
*subreq
)
1808 struct tevent_req
*req
=
1809 tevent_req_callback_data(subreq
,
1811 struct smb_time_audit_get_dos_attributes_state
*state
=
1812 tevent_req_data(req
,
1813 struct smb_time_audit_get_dos_attributes_state
);
1816 status
= SMB_VFS_NEXT_GET_DOS_ATTRIBUTES_RECV(subreq
,
1819 TALLOC_FREE(subreq
);
1820 if (tevent_req_nterror(req
, status
)) {
1824 tevent_req_done(req
);
1828 static NTSTATUS
smb_time_audit_get_dos_attributes_recv(struct tevent_req
*req
,
1829 struct vfs_aio_state
*aio_state
,
1832 struct smb_time_audit_get_dos_attributes_state
*state
=
1833 tevent_req_data(req
,
1834 struct smb_time_audit_get_dos_attributes_state
);
1838 timediff
= state
->aio_state
.duration
* 1.0e-9;
1840 if (timediff
> audit_timeout
) {
1841 smb_time_audit_log_at("async get_dos_attributes",
1847 if (tevent_req_is_nterror(req
, &status
)) {
1848 tevent_req_received(req
);
1852 *aio_state
= state
->aio_state
;
1853 *dosmode
= state
->dosmode
;
1854 tevent_req_received(req
);
1855 return NT_STATUS_OK
;
1858 static NTSTATUS
smb_time_fget_dos_attributes(struct vfs_handle_struct
*handle
,
1859 struct files_struct
*fsp
,
1863 struct timespec ts1
,ts2
;
1866 clock_gettime_mono(&ts1
);
1867 result
= SMB_VFS_NEXT_FGET_DOS_ATTRIBUTES(handle
,
1870 clock_gettime_mono(&ts2
);
1871 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1873 if (timediff
> audit_timeout
) {
1874 smb_time_audit_log_fsp("fget_dos_attributes", timediff
, fsp
);
1880 static NTSTATUS
smb_time_set_dos_attributes(struct vfs_handle_struct
*handle
,
1881 const struct smb_filename
*smb_fname
,
1885 struct timespec ts1
,ts2
;
1888 clock_gettime_mono(&ts1
);
1889 result
= SMB_VFS_NEXT_SET_DOS_ATTRIBUTES(handle
,
1892 clock_gettime_mono(&ts2
);
1893 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1895 if (timediff
> audit_timeout
) {
1896 smb_time_audit_log_fname("set_dos_attributes",
1898 smb_fname
->base_name
);
1904 static NTSTATUS
smb_time_fset_dos_attributes(struct vfs_handle_struct
*handle
,
1905 struct files_struct
*fsp
,
1909 struct timespec ts1
,ts2
;
1912 clock_gettime_mono(&ts1
);
1913 result
= SMB_VFS_NEXT_FSET_DOS_ATTRIBUTES(handle
,
1916 clock_gettime_mono(&ts2
);
1917 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
1919 if (timediff
> audit_timeout
) {
1920 smb_time_audit_log_fsp("fset_dos_attributes", timediff
, fsp
);
1926 struct time_audit_offload_read_state
{
1927 struct vfs_handle_struct
*handle
;
1928 struct timespec ts_send
;
1929 DATA_BLOB token_blob
;
1932 static void smb_time_audit_offload_read_done(struct tevent_req
*subreq
);
1934 static struct tevent_req
*smb_time_audit_offload_read_send(
1935 TALLOC_CTX
*mem_ctx
,
1936 struct tevent_context
*ev
,
1937 struct vfs_handle_struct
*handle
,
1938 struct files_struct
*fsp
,
1944 struct tevent_req
*req
= NULL
;
1945 struct tevent_req
*subreq
= NULL
;
1946 struct time_audit_offload_read_state
*state
= NULL
;
1948 req
= tevent_req_create(mem_ctx
, &state
,
1949 struct time_audit_offload_read_state
);
1953 state
->handle
= handle
;
1954 clock_gettime_mono(&state
->ts_send
);
1956 subreq
= SMB_VFS_NEXT_OFFLOAD_READ_SEND(mem_ctx
, ev
,
1960 if (tevent_req_nomem(subreq
, req
)) {
1961 return tevent_req_post(req
, ev
);
1964 tevent_req_set_callback(subreq
, smb_time_audit_offload_read_done
, req
);
1968 static void smb_time_audit_offload_read_done(struct tevent_req
*subreq
)
1970 struct tevent_req
*req
= tevent_req_callback_data(
1971 subreq
, struct tevent_req
);
1972 struct time_audit_offload_read_state
*state
= tevent_req_data(
1973 req
, struct time_audit_offload_read_state
);
1976 status
= SMB_VFS_NEXT_OFFLOAD_READ_RECV(subreq
,
1979 &state
->token_blob
);
1980 TALLOC_FREE(subreq
);
1981 if (tevent_req_nterror(req
, status
)) {
1984 tevent_req_done(req
);
1987 static NTSTATUS
smb_time_audit_offload_read_recv(
1988 struct tevent_req
*req
,
1989 struct vfs_handle_struct
*handle
,
1990 TALLOC_CTX
*mem_ctx
,
1991 DATA_BLOB
*token_blob
)
1993 struct time_audit_offload_read_state
*state
= tevent_req_data(
1994 req
, struct time_audit_offload_read_state
);
1995 struct timespec ts_recv
;
1999 clock_gettime_mono(&ts_recv
);
2000 timediff
= nsec_time_diff(&ts_recv
, &state
->ts_send
) * 1.0e-9;
2001 if (timediff
> audit_timeout
) {
2002 smb_time_audit_log("offload_read", timediff
);
2005 if (tevent_req_is_nterror(req
, &status
)) {
2006 tevent_req_received(req
);
2010 token_blob
->length
= state
->token_blob
.length
;
2011 token_blob
->data
= talloc_move(mem_ctx
, &state
->token_blob
.data
);
2013 tevent_req_received(req
);
2014 return NT_STATUS_OK
;
2017 struct time_audit_offload_write_state
{
2018 struct timespec ts_send
;
2019 struct vfs_handle_struct
*handle
;
2022 static void smb_time_audit_offload_write_done(struct tevent_req
*subreq
);
2024 static struct tevent_req
*smb_time_audit_offload_write_send(struct vfs_handle_struct
*handle
,
2025 TALLOC_CTX
*mem_ctx
,
2026 struct tevent_context
*ev
,
2029 off_t transfer_offset
,
2030 struct files_struct
*dest_fsp
,
2034 struct tevent_req
*req
;
2035 struct tevent_req
*subreq
;
2036 struct time_audit_offload_write_state
*state
;
2038 req
= tevent_req_create(mem_ctx
, &state
,
2039 struct time_audit_offload_write_state
);
2044 state
->handle
= handle
;
2045 clock_gettime_mono(&state
->ts_send
);
2046 subreq
= SMB_VFS_NEXT_OFFLOAD_WRITE_SEND(handle
, state
, ev
,
2047 fsctl
, token
, transfer_offset
,
2048 dest_fsp
, dest_off
, num
);
2049 if (tevent_req_nomem(subreq
, req
)) {
2050 return tevent_req_post(req
, ev
);
2053 tevent_req_set_callback(subreq
, smb_time_audit_offload_write_done
, req
);
2057 static void smb_time_audit_offload_write_done(struct tevent_req
*subreq
)
2059 struct tevent_req
*req
= tevent_req_callback_data(
2060 subreq
, struct tevent_req
);
2061 struct time_audit_offload_write_state
*state
= tevent_req_data(
2062 req
, struct time_audit_offload_write_state
);
2065 status
= SMB_VFS_NEXT_OFFLOAD_WRITE_RECV(state
->handle
,
2068 TALLOC_FREE(subreq
);
2069 if (tevent_req_nterror(req
, status
)) {
2072 tevent_req_done(req
);
2075 static NTSTATUS
smb_time_audit_offload_write_recv(struct vfs_handle_struct
*handle
,
2076 struct tevent_req
*req
,
2079 struct time_audit_offload_write_state
*state
= tevent_req_data(
2080 req
, struct time_audit_offload_write_state
);
2081 struct timespec ts_recv
;
2085 clock_gettime_mono(&ts_recv
);
2086 timediff
= nsec_time_diff(&ts_recv
, &state
->ts_send
)*1.0e-9;
2087 if (timediff
> audit_timeout
) {
2088 smb_time_audit_log("offload_write", timediff
);
2091 *copied
= state
->copied
;
2092 if (tevent_req_is_nterror(req
, &status
)) {
2093 tevent_req_received(req
);
2097 tevent_req_received(req
);
2098 return NT_STATUS_OK
;
2101 static NTSTATUS
smb_time_audit_get_compression(vfs_handle_struct
*handle
,
2102 TALLOC_CTX
*mem_ctx
,
2103 struct files_struct
*fsp
,
2104 struct smb_filename
*smb_fname
,
2105 uint16_t *_compression_fmt
)
2108 struct timespec ts1
,ts2
;
2111 clock_gettime_mono(&ts1
);
2112 result
= SMB_VFS_NEXT_GET_COMPRESSION(handle
, mem_ctx
, fsp
, smb_fname
,
2114 clock_gettime_mono(&ts2
);
2115 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2117 if (timediff
> audit_timeout
) {
2119 smb_time_audit_log_fsp("get_compression",
2122 smb_time_audit_log_smb_fname("get_compression",
2123 timediff
, smb_fname
);
2130 static NTSTATUS
smb_time_audit_set_compression(vfs_handle_struct
*handle
,
2131 TALLOC_CTX
*mem_ctx
,
2132 struct files_struct
*fsp
,
2133 uint16_t compression_fmt
)
2136 struct timespec ts1
,ts2
;
2139 clock_gettime_mono(&ts1
);
2140 result
= SMB_VFS_NEXT_SET_COMPRESSION(handle
, mem_ctx
, fsp
,
2142 clock_gettime_mono(&ts2
);
2143 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2145 if (timediff
> audit_timeout
) {
2146 smb_time_audit_log_fsp("set_compression", timediff
, fsp
);
2152 static NTSTATUS
smb_time_audit_readdir_attr(struct vfs_handle_struct
*handle
,
2153 const struct smb_filename
*fname
,
2154 TALLOC_CTX
*mem_ctx
,
2155 struct readdir_attr_data
**pattr_data
)
2158 struct timespec ts1
,ts2
;
2161 clock_gettime_mono(&ts1
);
2162 status
= SMB_VFS_NEXT_READDIR_ATTR(handle
, fname
, mem_ctx
, pattr_data
);
2163 clock_gettime_mono(&ts2
);
2164 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2166 if (timediff
> audit_timeout
) {
2167 smb_time_audit_log_smb_fname("readdir_attr", timediff
, fname
);
2173 static NTSTATUS
smb_time_audit_fget_nt_acl(vfs_handle_struct
*handle
,
2175 uint32_t security_info
,
2176 TALLOC_CTX
*mem_ctx
,
2177 struct security_descriptor
**ppdesc
)
2180 struct timespec ts1
,ts2
;
2183 clock_gettime_mono(&ts1
);
2184 result
= SMB_VFS_NEXT_FGET_NT_ACL(handle
, fsp
, security_info
,
2186 clock_gettime_mono(&ts2
);
2187 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2189 if (timediff
> audit_timeout
) {
2190 smb_time_audit_log_fsp("fget_nt_acl", timediff
, fsp
);
2196 static NTSTATUS
smb_time_audit_get_nt_acl(vfs_handle_struct
*handle
,
2197 const struct smb_filename
*smb_fname
,
2198 uint32_t security_info
,
2199 TALLOC_CTX
*mem_ctx
,
2200 struct security_descriptor
**ppdesc
)
2203 struct timespec ts1
,ts2
;
2206 clock_gettime_mono(&ts1
);
2207 result
= SMB_VFS_NEXT_GET_NT_ACL(handle
, smb_fname
, security_info
,
2209 clock_gettime_mono(&ts2
);
2210 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2212 if (timediff
> audit_timeout
) {
2213 smb_time_audit_log_fname("get_nt_acl",
2215 smb_fname
->base_name
);
2221 static NTSTATUS
smb_time_audit_fset_nt_acl(vfs_handle_struct
*handle
,
2223 uint32_t security_info_sent
,
2224 const struct security_descriptor
*psd
)
2227 struct timespec ts1
,ts2
;
2230 clock_gettime_mono(&ts1
);
2231 result
= SMB_VFS_NEXT_FSET_NT_ACL(handle
, fsp
, security_info_sent
,
2233 clock_gettime_mono(&ts2
);
2234 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2236 if (timediff
> audit_timeout
) {
2237 smb_time_audit_log_fsp("fset_nt_acl", timediff
, fsp
);
2243 static NTSTATUS
smb_time_audit_audit_file(struct vfs_handle_struct
*handle
,
2244 struct smb_filename
*smb_fname
,
2245 struct security_acl
*sacl
,
2246 uint32_t access_requested
,
2247 uint32_t access_denied
)
2250 struct timespec ts1
,ts2
;
2253 clock_gettime_mono(&ts1
);
2254 result
= SMB_VFS_NEXT_AUDIT_FILE(handle
,
2259 clock_gettime_mono(&ts2
);
2260 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2262 if (timediff
> audit_timeout
) {
2263 smb_time_audit_log_fname("audit_file",
2265 smb_fname
->base_name
);
2271 static SMB_ACL_T
smb_time_audit_sys_acl_get_file(vfs_handle_struct
*handle
,
2272 const struct smb_filename
*smb_fname
,
2273 SMB_ACL_TYPE_T type
,
2274 TALLOC_CTX
*mem_ctx
)
2277 struct timespec ts1
,ts2
;
2280 clock_gettime_mono(&ts1
);
2281 result
= SMB_VFS_NEXT_SYS_ACL_GET_FILE(handle
, smb_fname
,
2283 clock_gettime_mono(&ts2
);
2284 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2286 if (timediff
> audit_timeout
) {
2287 smb_time_audit_log_fname("sys_acl_get_file", timediff
,
2288 smb_fname
->base_name
);
2294 static SMB_ACL_T
smb_time_audit_sys_acl_get_fd(vfs_handle_struct
*handle
,
2296 TALLOC_CTX
*mem_ctx
)
2299 struct timespec ts1
,ts2
;
2302 clock_gettime_mono(&ts1
);
2303 result
= SMB_VFS_NEXT_SYS_ACL_GET_FD(handle
, fsp
, mem_ctx
);
2304 clock_gettime_mono(&ts2
);
2305 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2307 if (timediff
> audit_timeout
) {
2308 smb_time_audit_log_fsp("sys_acl_get_fd", timediff
, fsp
);
2315 static int smb_time_audit_sys_acl_blob_get_file(vfs_handle_struct
*handle
,
2316 const struct smb_filename
*smb_fname
,
2317 TALLOC_CTX
*mem_ctx
,
2318 char **blob_description
,
2322 struct timespec ts1
,ts2
;
2325 clock_gettime_mono(&ts1
);
2326 result
= SMB_VFS_NEXT_SYS_ACL_BLOB_GET_FILE(handle
, smb_fname
,
2327 mem_ctx
, blob_description
, blob
);
2328 clock_gettime_mono(&ts2
);
2329 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2331 if (timediff
> audit_timeout
) {
2332 smb_time_audit_log("sys_acl_blob_get_file", timediff
);
2338 static int smb_time_audit_sys_acl_blob_get_fd(vfs_handle_struct
*handle
,
2340 TALLOC_CTX
*mem_ctx
,
2341 char **blob_description
,
2345 struct timespec ts1
,ts2
;
2348 clock_gettime_mono(&ts1
);
2349 result
= SMB_VFS_NEXT_SYS_ACL_BLOB_GET_FD(handle
, fsp
, mem_ctx
, blob_description
, blob
);
2350 clock_gettime_mono(&ts2
);
2351 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2353 if (timediff
> audit_timeout
) {
2354 smb_time_audit_log("sys_acl_blob_get_fd", timediff
);
2360 static int smb_time_audit_sys_acl_set_file(vfs_handle_struct
*handle
,
2361 const struct smb_filename
*smb_fname
,
2362 SMB_ACL_TYPE_T acltype
,
2366 struct timespec ts1
,ts2
;
2369 clock_gettime_mono(&ts1
);
2370 result
= SMB_VFS_NEXT_SYS_ACL_SET_FILE(handle
, smb_fname
, acltype
,
2372 clock_gettime_mono(&ts2
);
2373 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2375 if (timediff
> audit_timeout
) {
2376 smb_time_audit_log_fname("sys_acl_set_file", timediff
,
2377 smb_fname
->base_name
);
2383 static int smb_time_audit_sys_acl_set_fd(vfs_handle_struct
*handle
,
2388 struct timespec ts1
,ts2
;
2391 clock_gettime_mono(&ts1
);
2392 result
= SMB_VFS_NEXT_SYS_ACL_SET_FD(handle
, fsp
, theacl
);
2393 clock_gettime_mono(&ts2
);
2394 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2396 if (timediff
> audit_timeout
) {
2397 smb_time_audit_log_fsp("sys_acl_set_fd", timediff
, fsp
);
2403 static int smb_time_audit_sys_acl_delete_def_file(vfs_handle_struct
*handle
,
2404 const struct smb_filename
*smb_fname
)
2407 struct timespec ts1
,ts2
;
2410 clock_gettime_mono(&ts1
);
2411 result
= SMB_VFS_NEXT_SYS_ACL_DELETE_DEF_FILE(handle
, smb_fname
);
2412 clock_gettime_mono(&ts2
);
2413 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2415 if (timediff
> audit_timeout
) {
2416 smb_time_audit_log_fname("sys_acl_delete_def_file", timediff
,
2417 smb_fname
->base_name
);
2423 static ssize_t
smb_time_audit_getxattr(struct vfs_handle_struct
*handle
,
2424 const struct smb_filename
*smb_fname
,
2430 struct timespec ts1
,ts2
;
2433 clock_gettime_mono(&ts1
);
2434 result
= SMB_VFS_NEXT_GETXATTR(handle
, smb_fname
, name
, value
, size
);
2435 clock_gettime_mono(&ts2
);
2436 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2438 if (timediff
> audit_timeout
) {
2439 smb_time_audit_log_fname("getxattr", timediff
,
2440 smb_fname
->base_name
);
2446 struct smb_time_audit_getxattrat_state
{
2447 struct vfs_aio_state aio_state
;
2448 files_struct
*dir_fsp
;
2449 const struct smb_filename
*smb_fname
;
2450 const char *xattr_name
;
2452 uint8_t *xattr_value
;
2455 static void smb_time_audit_getxattrat_done(struct tevent_req
*subreq
);
2457 static struct tevent_req
*smb_time_audit_getxattrat_send(
2458 TALLOC_CTX
*mem_ctx
,
2459 struct tevent_context
*ev
,
2460 struct vfs_handle_struct
*handle
,
2461 files_struct
*dir_fsp
,
2462 const struct smb_filename
*smb_fname
,
2463 const char *xattr_name
,
2466 struct tevent_req
*req
= NULL
;
2467 struct tevent_req
*subreq
= NULL
;
2468 struct smb_time_audit_getxattrat_state
*state
= NULL
;
2470 req
= tevent_req_create(mem_ctx
, &state
,
2471 struct smb_time_audit_getxattrat_state
);
2475 *state
= (struct smb_time_audit_getxattrat_state
) {
2477 .smb_fname
= smb_fname
,
2478 .xattr_name
= xattr_name
,
2481 subreq
= SMB_VFS_NEXT_GETXATTRAT_SEND(state
,
2488 if (tevent_req_nomem(subreq
, req
)) {
2489 return tevent_req_post(req
, ev
);
2491 tevent_req_set_callback(subreq
, smb_time_audit_getxattrat_done
, req
);
2496 static void smb_time_audit_getxattrat_done(struct tevent_req
*subreq
)
2498 struct tevent_req
*req
= tevent_req_callback_data(
2499 subreq
, struct tevent_req
);
2500 struct smb_time_audit_getxattrat_state
*state
= tevent_req_data(
2501 req
, struct smb_time_audit_getxattrat_state
);
2503 state
->xattr_size
= SMB_VFS_NEXT_GETXATTRAT_RECV(subreq
,
2506 &state
->xattr_value
);
2507 TALLOC_FREE(subreq
);
2508 if (state
->xattr_size
== -1) {
2509 tevent_req_error(req
, state
->aio_state
.error
);
2513 tevent_req_done(req
);
2516 static ssize_t
smb_time_audit_getxattrat_recv(struct tevent_req
*req
,
2517 struct vfs_aio_state
*aio_state
,
2518 TALLOC_CTX
*mem_ctx
,
2519 uint8_t **xattr_value
)
2521 struct smb_time_audit_getxattrat_state
*state
= tevent_req_data(
2522 req
, struct smb_time_audit_getxattrat_state
);
2526 timediff
= state
->aio_state
.duration
* 1.0e-9;
2528 if (timediff
> audit_timeout
) {
2529 smb_time_audit_log_at("async getxattrat",
2535 if (tevent_req_is_unix_error(req
, &aio_state
->error
)) {
2536 tevent_req_received(req
);
2540 *aio_state
= state
->aio_state
;
2541 xattr_size
= state
->xattr_size
;
2542 if (xattr_value
!= NULL
) {
2543 *xattr_value
= talloc_move(mem_ctx
, &state
->xattr_value
);
2546 tevent_req_received(req
);
2550 static ssize_t
smb_time_audit_fgetxattr(struct vfs_handle_struct
*handle
,
2551 struct files_struct
*fsp
,
2552 const char *name
, void *value
,
2556 struct timespec ts1
,ts2
;
2559 clock_gettime_mono(&ts1
);
2560 result
= SMB_VFS_NEXT_FGETXATTR(handle
, fsp
, name
, value
, size
);
2561 clock_gettime_mono(&ts2
);
2562 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2564 if (timediff
> audit_timeout
) {
2565 smb_time_audit_log_fsp("fgetxattr", timediff
, fsp
);
2571 static ssize_t
smb_time_audit_listxattr(struct vfs_handle_struct
*handle
,
2572 const struct smb_filename
*smb_fname
,
2577 struct timespec ts1
,ts2
;
2580 clock_gettime_mono(&ts1
);
2581 result
= SMB_VFS_NEXT_LISTXATTR(handle
, smb_fname
, list
, size
);
2582 clock_gettime_mono(&ts2
);
2583 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2585 if (timediff
> audit_timeout
) {
2586 smb_time_audit_log_fname("listxattr", timediff
,
2587 smb_fname
->base_name
);
2593 static ssize_t
smb_time_audit_flistxattr(struct vfs_handle_struct
*handle
,
2594 struct files_struct
*fsp
, char *list
,
2598 struct timespec ts1
,ts2
;
2601 clock_gettime_mono(&ts1
);
2602 result
= SMB_VFS_NEXT_FLISTXATTR(handle
, fsp
, list
, size
);
2603 clock_gettime_mono(&ts2
);
2604 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2606 if (timediff
> audit_timeout
) {
2607 smb_time_audit_log_fsp("flistxattr", timediff
, fsp
);
2613 static int smb_time_audit_removexattr(struct vfs_handle_struct
*handle
,
2614 const struct smb_filename
*smb_fname
,
2618 struct timespec ts1
,ts2
;
2621 clock_gettime_mono(&ts1
);
2622 result
= SMB_VFS_NEXT_REMOVEXATTR(handle
, smb_fname
, name
);
2623 clock_gettime_mono(&ts2
);
2624 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2626 if (timediff
> audit_timeout
) {
2627 smb_time_audit_log_fname("removexattr", timediff
,
2628 smb_fname
->base_name
);
2634 static int smb_time_audit_fremovexattr(struct vfs_handle_struct
*handle
,
2635 struct files_struct
*fsp
,
2639 struct timespec ts1
,ts2
;
2642 clock_gettime_mono(&ts1
);
2643 result
= SMB_VFS_NEXT_FREMOVEXATTR(handle
, fsp
, name
);
2644 clock_gettime_mono(&ts2
);
2645 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2647 if (timediff
> audit_timeout
) {
2648 smb_time_audit_log_fsp("fremovexattr", timediff
, fsp
);
2654 static int smb_time_audit_setxattr(struct vfs_handle_struct
*handle
,
2655 const struct smb_filename
*smb_fname
,
2662 struct timespec ts1
,ts2
;
2665 clock_gettime_mono(&ts1
);
2666 result
= SMB_VFS_NEXT_SETXATTR(handle
, smb_fname
, name
, value
, size
,
2668 clock_gettime_mono(&ts2
);
2669 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2671 if (timediff
> audit_timeout
) {
2672 smb_time_audit_log_fname("setxattr", timediff
,
2673 smb_fname
->base_name
);
2679 static int smb_time_audit_fsetxattr(struct vfs_handle_struct
*handle
,
2680 struct files_struct
*fsp
, const char *name
,
2681 const void *value
, size_t size
, int flags
)
2684 struct timespec ts1
,ts2
;
2687 clock_gettime_mono(&ts1
);
2688 result
= SMB_VFS_NEXT_FSETXATTR(handle
, fsp
, name
, value
, size
, flags
);
2689 clock_gettime_mono(&ts2
);
2690 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2692 if (timediff
> audit_timeout
) {
2693 smb_time_audit_log_fsp("fsetxattr", timediff
, fsp
);
2699 static bool smb_time_audit_aio_force(struct vfs_handle_struct
*handle
,
2700 struct files_struct
*fsp
)
2703 struct timespec ts1
,ts2
;
2706 clock_gettime_mono(&ts1
);
2707 result
= SMB_VFS_NEXT_AIO_FORCE(handle
, fsp
);
2708 clock_gettime_mono(&ts2
);
2709 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2711 if (timediff
> audit_timeout
) {
2712 smb_time_audit_log_fsp("aio_force", timediff
, fsp
);
2718 static NTSTATUS
smb_time_audit_durable_cookie(struct vfs_handle_struct
*handle
,
2719 struct files_struct
*fsp
,
2720 TALLOC_CTX
*mem_ctx
,
2724 struct timespec ts1
,ts2
;
2727 clock_gettime_mono(&ts1
);
2728 result
= SMB_VFS_NEXT_DURABLE_COOKIE(handle
, fsp
, mem_ctx
, cookie
);
2729 clock_gettime_mono(&ts2
);
2730 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2732 if (timediff
> audit_timeout
) {
2733 smb_time_audit_log_fsp("durable_cookie", timediff
, fsp
);
2739 static NTSTATUS
smb_time_audit_durable_disconnect(struct vfs_handle_struct
*handle
,
2740 struct files_struct
*fsp
,
2741 const DATA_BLOB old_cookie
,
2742 TALLOC_CTX
*mem_ctx
,
2743 DATA_BLOB
*new_cookie
)
2746 struct timespec ts1
,ts2
;
2749 clock_gettime_mono(&ts1
);
2750 result
= SMB_VFS_NEXT_DURABLE_DISCONNECT(handle
, fsp
, old_cookie
,
2751 mem_ctx
, new_cookie
);
2752 clock_gettime_mono(&ts2
);
2753 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2755 if (timediff
> audit_timeout
) {
2756 smb_time_audit_log_fsp("durable_disconnect", timediff
, fsp
);
2762 static NTSTATUS
smb_time_audit_durable_reconnect(struct vfs_handle_struct
*handle
,
2763 struct smb_request
*smb1req
,
2764 struct smbXsrv_open
*op
,
2765 const DATA_BLOB old_cookie
,
2766 TALLOC_CTX
*mem_ctx
,
2767 struct files_struct
**fsp
,
2768 DATA_BLOB
*new_cookie
)
2771 struct timespec ts1
,ts2
;
2774 clock_gettime_mono(&ts1
);
2775 result
= SMB_VFS_NEXT_DURABLE_RECONNECT(handle
, smb1req
, op
, old_cookie
,
2776 mem_ctx
, fsp
, new_cookie
);
2777 clock_gettime_mono(&ts2
);
2778 timediff
= nsec_time_diff(&ts2
,&ts1
)*1.0e-9;
2780 if (timediff
> audit_timeout
) {
2781 smb_time_audit_log("durable_reconnect", timediff
);
2787 /* VFS operations */
2789 static struct vfs_fn_pointers vfs_time_audit_fns
= {
2790 .connect_fn
= smb_time_audit_connect
,
2791 .disconnect_fn
= smb_time_audit_disconnect
,
2792 .disk_free_fn
= smb_time_audit_disk_free
,
2793 .get_quota_fn
= smb_time_audit_get_quota
,
2794 .set_quota_fn
= smb_time_audit_set_quota
,
2795 .get_shadow_copy_data_fn
= smb_time_audit_get_shadow_copy_data
,
2796 .statvfs_fn
= smb_time_audit_statvfs
,
2797 .fs_capabilities_fn
= smb_time_audit_fs_capabilities
,
2798 .get_dfs_referrals_fn
= smb_time_audit_get_dfs_referrals
,
2799 .opendir_fn
= smb_time_audit_opendir
,
2800 .fdopendir_fn
= smb_time_audit_fdopendir
,
2801 .readdir_fn
= smb_time_audit_readdir
,
2802 .seekdir_fn
= smb_time_audit_seekdir
,
2803 .telldir_fn
= smb_time_audit_telldir
,
2804 .rewind_dir_fn
= smb_time_audit_rewinddir
,
2805 .mkdir_fn
= smb_time_audit_mkdir
,
2806 .rmdir_fn
= smb_time_audit_rmdir
,
2807 .closedir_fn
= smb_time_audit_closedir
,
2808 .open_fn
= smb_time_audit_open
,
2809 .create_file_fn
= smb_time_audit_create_file
,
2810 .close_fn
= smb_time_audit_close
,
2811 .pread_fn
= smb_time_audit_pread
,
2812 .pread_send_fn
= smb_time_audit_pread_send
,
2813 .pread_recv_fn
= smb_time_audit_pread_recv
,
2814 .pwrite_fn
= smb_time_audit_pwrite
,
2815 .pwrite_send_fn
= smb_time_audit_pwrite_send
,
2816 .pwrite_recv_fn
= smb_time_audit_pwrite_recv
,
2817 .lseek_fn
= smb_time_audit_lseek
,
2818 .sendfile_fn
= smb_time_audit_sendfile
,
2819 .recvfile_fn
= smb_time_audit_recvfile
,
2820 .rename_fn
= smb_time_audit_rename
,
2821 .fsync_send_fn
= smb_time_audit_fsync_send
,
2822 .fsync_recv_fn
= smb_time_audit_fsync_recv
,
2823 .stat_fn
= smb_time_audit_stat
,
2824 .fstat_fn
= smb_time_audit_fstat
,
2825 .lstat_fn
= smb_time_audit_lstat
,
2826 .get_alloc_size_fn
= smb_time_audit_get_alloc_size
,
2827 .unlink_fn
= smb_time_audit_unlink
,
2828 .chmod_fn
= smb_time_audit_chmod
,
2829 .fchmod_fn
= smb_time_audit_fchmod
,
2830 .chown_fn
= smb_time_audit_chown
,
2831 .fchown_fn
= smb_time_audit_fchown
,
2832 .lchown_fn
= smb_time_audit_lchown
,
2833 .chdir_fn
= smb_time_audit_chdir
,
2834 .getwd_fn
= smb_time_audit_getwd
,
2835 .ntimes_fn
= smb_time_audit_ntimes
,
2836 .ftruncate_fn
= smb_time_audit_ftruncate
,
2837 .fallocate_fn
= smb_time_audit_fallocate
,
2838 .lock_fn
= smb_time_audit_lock
,
2839 .kernel_flock_fn
= smb_time_audit_kernel_flock
,
2840 .linux_setlease_fn
= smb_time_audit_linux_setlease
,
2841 .getlock_fn
= smb_time_audit_getlock
,
2842 .symlink_fn
= smb_time_audit_symlink
,
2843 .readlink_fn
= smb_time_audit_readlink
,
2844 .link_fn
= smb_time_audit_link
,
2845 .mknod_fn
= smb_time_audit_mknod
,
2846 .realpath_fn
= smb_time_audit_realpath
,
2847 .chflags_fn
= smb_time_audit_chflags
,
2848 .file_id_create_fn
= smb_time_audit_file_id_create
,
2849 .offload_read_send_fn
= smb_time_audit_offload_read_send
,
2850 .offload_read_recv_fn
= smb_time_audit_offload_read_recv
,
2851 .offload_write_send_fn
= smb_time_audit_offload_write_send
,
2852 .offload_write_recv_fn
= smb_time_audit_offload_write_recv
,
2853 .get_compression_fn
= smb_time_audit_get_compression
,
2854 .set_compression_fn
= smb_time_audit_set_compression
,
2855 .snap_check_path_fn
= smb_time_audit_snap_check_path
,
2856 .snap_create_fn
= smb_time_audit_snap_create
,
2857 .snap_delete_fn
= smb_time_audit_snap_delete
,
2858 .streaminfo_fn
= smb_time_audit_streaminfo
,
2859 .get_real_filename_fn
= smb_time_audit_get_real_filename
,
2860 .connectpath_fn
= smb_time_audit_connectpath
,
2861 .brl_lock_windows_fn
= smb_time_audit_brl_lock_windows
,
2862 .brl_unlock_windows_fn
= smb_time_audit_brl_unlock_windows
,
2863 .brl_cancel_windows_fn
= smb_time_audit_brl_cancel_windows
,
2864 .strict_lock_check_fn
= smb_time_audit_strict_lock_check
,
2865 .translate_name_fn
= smb_time_audit_translate_name
,
2866 .fsctl_fn
= smb_time_audit_fsctl
,
2867 .get_dos_attributes_fn
= smb_time_get_dos_attributes
,
2868 .get_dos_attributes_send_fn
= smb_time_audit_get_dos_attributes_send
,
2869 .get_dos_attributes_recv_fn
= smb_time_audit_get_dos_attributes_recv
,
2870 .fget_dos_attributes_fn
= smb_time_fget_dos_attributes
,
2871 .set_dos_attributes_fn
= smb_time_set_dos_attributes
,
2872 .fset_dos_attributes_fn
= smb_time_fset_dos_attributes
,
2873 .fget_nt_acl_fn
= smb_time_audit_fget_nt_acl
,
2874 .get_nt_acl_fn
= smb_time_audit_get_nt_acl
,
2875 .fset_nt_acl_fn
= smb_time_audit_fset_nt_acl
,
2876 .audit_file_fn
= smb_time_audit_audit_file
,
2877 .sys_acl_get_file_fn
= smb_time_audit_sys_acl_get_file
,
2878 .sys_acl_get_fd_fn
= smb_time_audit_sys_acl_get_fd
,
2879 .sys_acl_blob_get_file_fn
= smb_time_audit_sys_acl_blob_get_file
,
2880 .sys_acl_blob_get_fd_fn
= smb_time_audit_sys_acl_blob_get_fd
,
2881 .sys_acl_set_file_fn
= smb_time_audit_sys_acl_set_file
,
2882 .sys_acl_set_fd_fn
= smb_time_audit_sys_acl_set_fd
,
2883 .sys_acl_delete_def_file_fn
= smb_time_audit_sys_acl_delete_def_file
,
2884 .getxattr_fn
= smb_time_audit_getxattr
,
2885 .getxattrat_send_fn
= smb_time_audit_getxattrat_send
,
2886 .getxattrat_recv_fn
= smb_time_audit_getxattrat_recv
,
2887 .fgetxattr_fn
= smb_time_audit_fgetxattr
,
2888 .listxattr_fn
= smb_time_audit_listxattr
,
2889 .flistxattr_fn
= smb_time_audit_flistxattr
,
2890 .removexattr_fn
= smb_time_audit_removexattr
,
2891 .fremovexattr_fn
= smb_time_audit_fremovexattr
,
2892 .setxattr_fn
= smb_time_audit_setxattr
,
2893 .fsetxattr_fn
= smb_time_audit_fsetxattr
,
2894 .aio_force_fn
= smb_time_audit_aio_force
,
2895 .durable_cookie_fn
= smb_time_audit_durable_cookie
,
2896 .durable_disconnect_fn
= smb_time_audit_durable_disconnect
,
2897 .durable_reconnect_fn
= smb_time_audit_durable_reconnect
,
2898 .readdir_attr_fn
= smb_time_audit_readdir_attr
,
2903 NTSTATUS
vfs_time_audit_init(TALLOC_CTX
*ctx
)
2905 smb_vfs_assert_all_fns(&vfs_time_audit_fns
, "time_audit");
2907 audit_timeout
= (double)lp_parm_int(-1, "time_audit", "timeout",
2909 return smb_register_vfs(SMB_VFS_INTERFACE_VERSION
, "time_audit",
2910 &vfs_time_audit_fns
);