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_create_dfs_pathat(struct vfs_handle_struct *handle,
327 struct files_struct *dirfsp,
328 const struct smb_filename *smb_fname,
329 const struct referral *reflist,
330 size_t referral_count)
333 struct timespec ts1,ts2;
335 struct smb_filename *full_fname = NULL;
337 full_fname = full_path_from_dirfsp_atname(talloc_tos(),
340 if (full_fname == NULL) {
341 return NT_STATUS_NO_MEMORY;
344 clock_gettime_mono(&ts1);
345 result = SMB_VFS_NEXT_CREATE_DFS_PATHAT(handle,
350 clock_gettime_mono(&ts2);
351 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
353 if (timediff > audit_timeout) {
354 smb_time_audit_log_smb_fname("create_dfs_pathat",
358 TALLOC_FREE(full_fname);
362 static NTSTATUS smb_time_audit_read_dfs_pathat(struct vfs_handle_struct *handle,
364 struct files_struct *dirfsp,
365 struct smb_filename *smb_fname,
366 struct referral **ppreflist,
367 size_t *preferral_count)
370 struct timespec ts1,ts2;
373 clock_gettime_mono(&ts1);
374 result = SMB_VFS_NEXT_READ_DFS_PATHAT(handle,
380 clock_gettime_mono(&ts2);
381 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
383 if (timediff > audit_timeout) {
384 smb_time_audit_log("read_dfs_pathat", timediff);
390 static NTSTATUS smb_time_audit_snap_check_path(struct vfs_handle_struct *handle,
392 const char *service_path,
396 struct timespec ts1,ts2;
399 clock_gettime_mono(&ts1);
400 status = SMB_VFS_NEXT_SNAP_CHECK_PATH(handle, mem_ctx, service_path,
402 clock_gettime_mono(&ts2);
403 timediff = nsec_time_diff(&ts2, &ts1) * 1.0e-9;
405 if (timediff > audit_timeout) {
406 smb_time_audit_log("snap_check_path", timediff);
412 static NTSTATUS smb_time_audit_snap_create(struct vfs_handle_struct *handle,
414 const char *base_volume,
421 struct timespec ts1,ts2;
424 clock_gettime_mono(&ts1);
425 status = SMB_VFS_NEXT_SNAP_CREATE(handle, mem_ctx, base_volume, tstamp,
426 rw, base_path, snap_path);
427 clock_gettime_mono(&ts2);
428 timediff = nsec_time_diff(&ts2 ,&ts1) * 1.0e-9;
430 if (timediff > audit_timeout) {
431 smb_time_audit_log("snap_create", timediff);
437 static NTSTATUS smb_time_audit_snap_delete(struct vfs_handle_struct *handle,
443 struct timespec ts1,ts2;
446 clock_gettime_mono(&ts1);
447 status = SMB_VFS_NEXT_SNAP_DELETE(handle, mem_ctx, base_path,
449 clock_gettime_mono(&ts2);
450 timediff = nsec_time_diff(&ts2, &ts1) * 1.0e-9;
452 if (timediff > audit_timeout) {
453 smb_time_audit_log("snap_delete", timediff);
459 static DIR *smb_time_audit_fdopendir(vfs_handle_struct *handle,
461 const char *mask, uint32_t attr)
464 struct timespec ts1,ts2;
467 clock_gettime_mono(&ts1);
468 result = SMB_VFS_NEXT_FDOPENDIR(handle, fsp, mask, attr);
469 clock_gettime_mono(&ts2);
470 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
472 if (timediff > audit_timeout) {
473 smb_time_audit_log_fsp("fdopendir", timediff, fsp);
479 static struct dirent *smb_time_audit_readdir(vfs_handle_struct *handle,
480 struct files_struct *dirfsp,
482 SMB_STRUCT_STAT *sbuf)
484 struct dirent *result;
485 struct timespec ts1,ts2;
488 clock_gettime_mono(&ts1);
489 result = SMB_VFS_NEXT_READDIR(handle, dirfsp, dirp, sbuf);
490 clock_gettime_mono(&ts2);
491 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
493 if (timediff > audit_timeout) {
494 smb_time_audit_log("readdir", timediff);
500 static void smb_time_audit_seekdir(vfs_handle_struct *handle,
501 DIR *dirp, long offset)
503 struct timespec ts1,ts2;
506 clock_gettime_mono(&ts1);
507 SMB_VFS_NEXT_SEEKDIR(handle, dirp, offset);
508 clock_gettime_mono(&ts2);
509 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
511 if (timediff > audit_timeout) {
512 smb_time_audit_log("seekdir", timediff);
517 static long smb_time_audit_telldir(vfs_handle_struct *handle,
521 struct timespec ts1,ts2;
524 clock_gettime_mono(&ts1);
525 result = SMB_VFS_NEXT_TELLDIR(handle, dirp);
526 clock_gettime_mono(&ts2);
527 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
529 if (timediff > audit_timeout) {
530 smb_time_audit_log("telldir", timediff);
536 static void smb_time_audit_rewinddir(vfs_handle_struct *handle,
539 struct timespec ts1,ts2;
542 clock_gettime_mono(&ts1);
543 SMB_VFS_NEXT_REWINDDIR(handle, dirp);
544 clock_gettime_mono(&ts2);
545 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
547 if (timediff > audit_timeout) {
548 smb_time_audit_log("rewinddir", timediff);
553 static int smb_time_audit_mkdirat(vfs_handle_struct *handle,
554 struct files_struct *dirfsp,
555 const struct smb_filename *smb_fname,
558 struct smb_filename *full_fname = NULL;
560 struct timespec ts1,ts2;
563 full_fname = full_path_from_dirfsp_atname(talloc_tos(),
566 if (full_fname == NULL) {
571 clock_gettime_mono(&ts1);
572 result = SMB_VFS_NEXT_MKDIRAT(handle,
576 clock_gettime_mono(&ts2);
577 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
579 if (timediff > audit_timeout) {
580 smb_time_audit_log_smb_fname("mkdirat",
585 TALLOC_FREE(full_fname);
590 static int smb_time_audit_closedir(vfs_handle_struct *handle,
594 struct timespec ts1,ts2;
597 clock_gettime_mono(&ts1);
598 result = SMB_VFS_NEXT_CLOSEDIR(handle, dirp);
599 clock_gettime_mono(&ts2);
600 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
602 if (timediff > audit_timeout) {
603 smb_time_audit_log("closedir", timediff);
609 static int smb_time_audit_openat(vfs_handle_struct *handle,
610 const struct files_struct *dirfsp,
611 const struct smb_filename *smb_fname,
612 struct files_struct *fsp,
617 struct timespec ts1,ts2;
620 clock_gettime_mono(&ts1);
621 result = SMB_VFS_NEXT_OPENAT(handle,
627 clock_gettime_mono(&ts2);
628 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
630 if (timediff > audit_timeout) {
631 smb_time_audit_log_fsp("openat", timediff, fsp);
637 static NTSTATUS smb_time_audit_create_file(vfs_handle_struct *handle,
638 struct smb_request *req,
639 struct smb_filename *fname,
640 uint32_t access_mask,
641 uint32_t share_access,
642 uint32_t create_disposition,
643 uint32_t create_options,
644 uint32_t file_attributes,
645 uint32_t oplock_request,
646 const struct smb2_lease *lease,
647 uint64_t allocation_size,
648 uint32_t private_flags,
649 struct security_descriptor *sd,
650 struct ea_list *ea_list,
651 files_struct **result_fsp,
653 const struct smb2_create_blobs *in_context_blobs,
654 struct smb2_create_blobs *out_context_blobs)
657 struct timespec ts1,ts2;
660 clock_gettime_mono(&ts1);
661 result = SMB_VFS_NEXT_CREATE_FILE(
665 access_mask, /* access_mask */
666 share_access, /* share_access */
667 create_disposition, /* create_disposition*/
668 create_options, /* create_options */
669 file_attributes, /* file_attributes */
670 oplock_request, /* oplock_request */
672 allocation_size, /* allocation_size */
675 ea_list, /* ea_list */
676 result_fsp, /* result */
678 in_context_blobs, out_context_blobs); /* create context */
679 clock_gettime_mono(&ts2);
680 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
682 if (timediff > audit_timeout) {
684 * can't use result_fsp this time, may have
685 * invalid content causing smbd crash
687 smb_time_audit_log_smb_fname("create_file", timediff,
694 static int smb_time_audit_close(vfs_handle_struct *handle, files_struct *fsp)
697 struct timespec ts1,ts2;
700 clock_gettime_mono(&ts1);
701 result = SMB_VFS_NEXT_CLOSE(handle, fsp);
702 clock_gettime_mono(&ts2);
703 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
705 if (timediff > audit_timeout) {
706 smb_time_audit_log_fsp("close", timediff, fsp);
712 static ssize_t smb_time_audit_pread(vfs_handle_struct *handle,
714 void *data, size_t n, off_t offset)
717 struct timespec ts1,ts2;
720 clock_gettime_mono(&ts1);
721 result = SMB_VFS_NEXT_PREAD(handle, fsp, data, n, offset);
722 clock_gettime_mono(&ts2);
723 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
725 if (timediff > audit_timeout) {
726 smb_time_audit_log_fsp("pread", timediff, fsp);
732 struct smb_time_audit_pread_state {
733 struct files_struct *fsp;
735 struct vfs_aio_state vfs_aio_state;
738 static void smb_time_audit_pread_done(struct tevent_req *subreq);
740 static struct tevent_req *smb_time_audit_pread_send(
741 struct vfs_handle_struct *handle, TALLOC_CTX *mem_ctx,
742 struct tevent_context *ev, struct files_struct *fsp,
743 void *data, size_t n, off_t offset)
745 struct tevent_req *req, *subreq;
746 struct smb_time_audit_pread_state *state;
748 req = tevent_req_create(mem_ctx, &state,
749 struct smb_time_audit_pread_state);
755 subreq = SMB_VFS_NEXT_PREAD_SEND(state, ev, handle, fsp, data,
757 if (tevent_req_nomem(subreq, req)) {
758 return tevent_req_post(req, ev);
760 tevent_req_set_callback(subreq, smb_time_audit_pread_done, req);
764 static void smb_time_audit_pread_done(struct tevent_req *subreq)
766 struct tevent_req *req = tevent_req_callback_data(
767 subreq, struct tevent_req);
768 struct smb_time_audit_pread_state *state = tevent_req_data(
769 req, struct smb_time_audit_pread_state);
771 state->ret = SMB_VFS_PREAD_RECV(subreq, &state->vfs_aio_state);
773 tevent_req_done(req);
776 static ssize_t smb_time_audit_pread_recv(struct tevent_req *req,
777 struct vfs_aio_state *vfs_aio_state)
779 struct smb_time_audit_pread_state *state = tevent_req_data(
780 req, struct smb_time_audit_pread_state);
783 timediff = state->vfs_aio_state.duration * 1.0e-9;
785 if (timediff > audit_timeout) {
786 smb_time_audit_log_fsp("async pread", timediff, state->fsp);
789 if (tevent_req_is_unix_error(req, &vfs_aio_state->error)) {
792 *vfs_aio_state = state->vfs_aio_state;
796 static ssize_t smb_time_audit_pwrite(vfs_handle_struct *handle,
798 const void *data, size_t n,
802 struct timespec ts1,ts2;
805 clock_gettime_mono(&ts1);
806 result = SMB_VFS_NEXT_PWRITE(handle, fsp, data, n, offset);
807 clock_gettime_mono(&ts2);
808 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
810 if (timediff > audit_timeout) {
811 smb_time_audit_log_fsp("pwrite", timediff, fsp);
817 struct smb_time_audit_pwrite_state {
818 struct files_struct *fsp;
820 struct vfs_aio_state vfs_aio_state;
823 static void smb_time_audit_pwrite_done(struct tevent_req *subreq);
825 static struct tevent_req *smb_time_audit_pwrite_send(
826 struct vfs_handle_struct *handle, TALLOC_CTX *mem_ctx,
827 struct tevent_context *ev, struct files_struct *fsp,
828 const void *data, size_t n, off_t offset)
830 struct tevent_req *req, *subreq;
831 struct smb_time_audit_pwrite_state *state;
833 req = tevent_req_create(mem_ctx, &state,
834 struct smb_time_audit_pwrite_state);
840 subreq = SMB_VFS_NEXT_PWRITE_SEND(state, ev, handle, fsp, data,
842 if (tevent_req_nomem(subreq, req)) {
843 return tevent_req_post(req, ev);
845 tevent_req_set_callback(subreq, smb_time_audit_pwrite_done, req);
849 static void smb_time_audit_pwrite_done(struct tevent_req *subreq)
851 struct tevent_req *req = tevent_req_callback_data(
852 subreq, struct tevent_req);
853 struct smb_time_audit_pwrite_state *state = tevent_req_data(
854 req, struct smb_time_audit_pwrite_state);
856 state->ret = SMB_VFS_PWRITE_RECV(subreq, &state->vfs_aio_state);
858 tevent_req_done(req);
861 static ssize_t smb_time_audit_pwrite_recv(struct tevent_req *req,
862 struct vfs_aio_state *vfs_aio_state)
864 struct smb_time_audit_pwrite_state *state = tevent_req_data(
865 req, struct smb_time_audit_pwrite_state);
868 timediff = state->vfs_aio_state.duration * 1.0e-9;
870 if (timediff > audit_timeout) {
871 smb_time_audit_log_fsp("async pwrite", timediff, state->fsp);
874 if (tevent_req_is_unix_error(req, &vfs_aio_state->error)) {
877 *vfs_aio_state = state->vfs_aio_state;
881 static off_t smb_time_audit_lseek(vfs_handle_struct *handle,
883 off_t offset, int whence)
886 struct timespec ts1,ts2;
889 clock_gettime_mono(&ts1);
890 result = SMB_VFS_NEXT_LSEEK(handle, fsp, offset, whence);
891 clock_gettime_mono(&ts2);
892 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
894 if (timediff > audit_timeout) {
895 smb_time_audit_log_fsp("lseek", timediff, fsp);
901 static ssize_t smb_time_audit_sendfile(vfs_handle_struct *handle, int tofd,
902 files_struct *fromfsp,
903 const DATA_BLOB *hdr, off_t offset,
907 struct timespec ts1,ts2;
910 clock_gettime_mono(&ts1);
911 result = SMB_VFS_NEXT_SENDFILE(handle, tofd, fromfsp, hdr, offset, n);
912 clock_gettime_mono(&ts2);
913 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
915 if (timediff > audit_timeout) {
916 smb_time_audit_log_fsp("sendfile", timediff, fromfsp);
922 static ssize_t smb_time_audit_recvfile(vfs_handle_struct *handle, int fromfd,
928 struct timespec ts1,ts2;
931 clock_gettime_mono(&ts1);
932 result = SMB_VFS_NEXT_RECVFILE(handle, fromfd, tofsp, offset, n);
933 clock_gettime_mono(&ts2);
934 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
936 if (timediff > audit_timeout) {
937 smb_time_audit_log_fsp("recvfile", timediff, tofsp);
943 static int smb_time_audit_renameat(vfs_handle_struct *handle,
944 files_struct *srcfsp,
945 const struct smb_filename *oldname,
946 files_struct *dstfsp,
947 const struct smb_filename *newname)
950 struct timespec ts1,ts2;
953 clock_gettime_mono(&ts1);
954 result = SMB_VFS_NEXT_RENAMEAT(handle,
959 clock_gettime_mono(&ts2);
960 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
962 if (timediff > audit_timeout) {
963 smb_time_audit_log_smb_fname("renameat", timediff, newname);
969 struct smb_time_audit_fsync_state {
970 struct files_struct *fsp;
972 struct vfs_aio_state vfs_aio_state;
975 static void smb_time_audit_fsync_done(struct tevent_req *subreq);
977 static struct tevent_req *smb_time_audit_fsync_send(
978 struct vfs_handle_struct *handle, TALLOC_CTX *mem_ctx,
979 struct tevent_context *ev, struct files_struct *fsp)
981 struct tevent_req *req, *subreq;
982 struct smb_time_audit_fsync_state *state;
984 req = tevent_req_create(mem_ctx, &state,
985 struct smb_time_audit_fsync_state);
991 subreq = SMB_VFS_NEXT_FSYNC_SEND(state, ev, handle, fsp);
992 if (tevent_req_nomem(subreq, req)) {
993 return tevent_req_post(req, ev);
995 tevent_req_set_callback(subreq, smb_time_audit_fsync_done, req);
999 static void smb_time_audit_fsync_done(struct tevent_req *subreq)
1001 struct tevent_req *req = tevent_req_callback_data(
1002 subreq, struct tevent_req);
1003 struct smb_time_audit_fsync_state *state = tevent_req_data(
1004 req, struct smb_time_audit_fsync_state);
1006 state->ret = SMB_VFS_FSYNC_RECV(subreq, &state->vfs_aio_state);
1007 TALLOC_FREE(subreq);
1008 tevent_req_done(req);
1011 static int smb_time_audit_fsync_recv(struct tevent_req *req,
1012 struct vfs_aio_state *vfs_aio_state)
1014 struct smb_time_audit_fsync_state *state = tevent_req_data(
1015 req, struct smb_time_audit_fsync_state);
1018 timediff = state->vfs_aio_state.duration * 1.0e-9;
1020 if (timediff > audit_timeout) {
1021 smb_time_audit_log_fsp("async fsync", timediff, state->fsp);
1024 if (tevent_req_is_unix_error(req, &vfs_aio_state->error)) {
1027 *vfs_aio_state = state->vfs_aio_state;
1031 static int smb_time_audit_stat(vfs_handle_struct *handle,
1032 struct smb_filename *fname)
1035 struct timespec ts1,ts2;
1038 clock_gettime_mono(&ts1);
1039 result = SMB_VFS_NEXT_STAT(handle, fname);
1040 clock_gettime_mono(&ts2);
1041 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1043 if (timediff > audit_timeout) {
1044 smb_time_audit_log_smb_fname("stat", timediff, fname);
1050 static int smb_time_audit_fstat(vfs_handle_struct *handle, files_struct *fsp,
1051 SMB_STRUCT_STAT *sbuf)
1054 struct timespec ts1,ts2;
1057 clock_gettime_mono(&ts1);
1058 result = SMB_VFS_NEXT_FSTAT(handle, fsp, sbuf);
1059 clock_gettime_mono(&ts2);
1060 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1062 if (timediff > audit_timeout) {
1063 smb_time_audit_log_fsp("fstat", timediff, fsp);
1069 static int smb_time_audit_lstat(vfs_handle_struct *handle,
1070 struct smb_filename *path)
1073 struct timespec ts1,ts2;
1076 clock_gettime_mono(&ts1);
1077 result = SMB_VFS_NEXT_LSTAT(handle, path);
1078 clock_gettime_mono(&ts2);
1079 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1081 if (timediff > audit_timeout) {
1082 smb_time_audit_log_smb_fname("lstat", timediff, path);
1088 static uint64_t smb_time_audit_get_alloc_size(vfs_handle_struct *handle,
1090 const SMB_STRUCT_STAT *sbuf)
1093 struct timespec ts1,ts2;
1096 clock_gettime_mono(&ts1);
1097 result = SMB_VFS_NEXT_GET_ALLOC_SIZE(handle, fsp, sbuf);
1098 clock_gettime_mono(&ts2);
1099 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1101 if (timediff > audit_timeout) {
1102 smb_time_audit_log_fsp("get_alloc_size", timediff, fsp);
1108 static int smb_time_audit_unlinkat(vfs_handle_struct *handle,
1109 struct files_struct *dirfsp,
1110 const struct smb_filename *path,
1113 struct smb_filename *full_fname = NULL;
1115 struct timespec ts1,ts2;
1118 full_fname = full_path_from_dirfsp_atname(talloc_tos(),
1121 if (full_fname == NULL) {
1125 clock_gettime_mono(&ts1);
1126 result = SMB_VFS_NEXT_UNLINKAT(handle,
1130 clock_gettime_mono(&ts2);
1131 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1133 if (timediff > audit_timeout) {
1134 smb_time_audit_log_smb_fname("unlinkat", timediff, full_fname);
1137 TALLOC_FREE(full_fname);
1141 static int smb_time_audit_fchmod(vfs_handle_struct *handle, files_struct *fsp,
1145 struct timespec ts1,ts2;
1148 clock_gettime_mono(&ts1);
1149 result = SMB_VFS_NEXT_FCHMOD(handle, fsp, mode);
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("fchmod", timediff, fsp);
1160 static int smb_time_audit_fchown(vfs_handle_struct *handle, files_struct *fsp,
1161 uid_t uid, gid_t gid)
1164 struct timespec ts1,ts2;
1167 clock_gettime_mono(&ts1);
1168 result = SMB_VFS_NEXT_FCHOWN(handle, fsp, uid, gid);
1169 clock_gettime_mono(&ts2);
1170 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1172 if (timediff > audit_timeout) {
1173 smb_time_audit_log_fsp("fchown", timediff, fsp);
1179 static int smb_time_audit_lchown(vfs_handle_struct *handle,
1180 const struct smb_filename *smb_fname,
1185 struct timespec ts1,ts2;
1188 clock_gettime_mono(&ts1);
1189 result = SMB_VFS_NEXT_LCHOWN(handle, smb_fname, uid, gid);
1190 clock_gettime_mono(&ts2);
1191 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1193 if (timediff > audit_timeout) {
1194 smb_time_audit_log_fname("lchown",
1196 smb_fname->base_name);
1202 static int smb_time_audit_chdir(vfs_handle_struct *handle,
1203 const struct smb_filename *smb_fname)
1206 struct timespec ts1,ts2;
1209 clock_gettime_mono(&ts1);
1210 result = SMB_VFS_NEXT_CHDIR(handle, smb_fname);
1211 clock_gettime_mono(&ts2);
1212 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1214 if (timediff > audit_timeout) {
1215 smb_time_audit_log_fname("chdir",
1217 smb_fname->base_name);
1223 static struct smb_filename *smb_time_audit_getwd(vfs_handle_struct *handle,
1224 TALLOC_CTX *mem_ctx)
1226 struct smb_filename *result;
1227 struct timespec ts1,ts2;
1230 clock_gettime_mono(&ts1);
1231 result = SMB_VFS_NEXT_GETWD(handle, mem_ctx);
1232 clock_gettime_mono(&ts2);
1233 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1235 if (timediff > audit_timeout) {
1236 smb_time_audit_log("getwd", timediff);
1242 static int smb_time_audit_fntimes(vfs_handle_struct *handle,
1244 struct smb_file_time *ft)
1247 struct timespec ts1,ts2;
1250 clock_gettime_mono(&ts1);
1251 result = SMB_VFS_NEXT_FNTIMES(handle, fsp, ft);
1252 clock_gettime_mono(&ts2);
1253 timediff = nsec_time_diff(&ts2, &ts1) * 1.0e-9;
1255 if (timediff > audit_timeout) {
1256 smb_time_audit_log_fsp("fntimes", timediff, fsp);
1262 static int smb_time_audit_ftruncate(vfs_handle_struct *handle,
1267 struct timespec ts1,ts2;
1270 clock_gettime_mono(&ts1);
1271 result = SMB_VFS_NEXT_FTRUNCATE(handle, fsp, len);
1272 clock_gettime_mono(&ts2);
1273 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1275 if (timediff > audit_timeout) {
1276 smb_time_audit_log_fsp("ftruncate", timediff, fsp);
1282 static int smb_time_audit_fallocate(vfs_handle_struct *handle,
1289 int saved_errno = 0;
1290 struct timespec ts1,ts2;
1293 clock_gettime_mono(&ts1);
1294 result = SMB_VFS_NEXT_FALLOCATE(handle, fsp, mode, offset, len);
1296 saved_errno = errno;
1298 clock_gettime_mono(&ts2);
1299 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1301 if (timediff > audit_timeout) {
1302 smb_time_audit_log_fsp("fallocate", timediff, fsp);
1305 errno = saved_errno;
1310 static bool smb_time_audit_lock(vfs_handle_struct *handle, files_struct *fsp,
1311 int op, off_t offset, off_t count,
1315 struct timespec ts1,ts2;
1318 clock_gettime_mono(&ts1);
1319 result = SMB_VFS_NEXT_LOCK(handle, fsp, op, offset, count, type);
1320 clock_gettime_mono(&ts2);
1321 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1323 if (timediff > audit_timeout) {
1324 smb_time_audit_log_fsp("lock", timediff, fsp);
1330 static int smb_time_audit_kernel_flock(struct vfs_handle_struct *handle,
1331 struct files_struct *fsp,
1332 uint32_t share_access,
1333 uint32_t access_mask)
1336 struct timespec ts1,ts2;
1339 clock_gettime_mono(&ts1);
1340 result = SMB_VFS_NEXT_KERNEL_FLOCK(handle, fsp, share_access,
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("kernel_flock", timediff, fsp);
1352 static int smb_time_audit_fcntl(struct vfs_handle_struct *handle,
1353 struct files_struct *fsp,
1354 int cmd, va_list cmd_arg)
1357 va_list dup_cmd_arg;
1359 struct timespec ts1,ts2;
1362 va_copy(dup_cmd_arg, cmd_arg);
1363 arg = va_arg(dup_cmd_arg, void *);
1364 clock_gettime_mono(&ts1);
1365 result = SMB_VFS_NEXT_FCNTL(handle, fsp, cmd, arg);
1366 clock_gettime_mono(&ts2);
1367 va_end(dup_cmd_arg);
1369 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1370 if (timediff > audit_timeout) {
1371 smb_time_audit_log_fsp("kernel_flock", timediff, fsp);
1377 static int smb_time_audit_linux_setlease(vfs_handle_struct *handle,
1382 struct timespec ts1,ts2;
1385 clock_gettime_mono(&ts1);
1386 result = SMB_VFS_NEXT_LINUX_SETLEASE(handle, fsp, leasetype);
1387 clock_gettime_mono(&ts2);
1388 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1390 if (timediff > audit_timeout) {
1391 smb_time_audit_log_fsp("linux_setlease", timediff, fsp);
1397 static bool smb_time_audit_getlock(vfs_handle_struct *handle,
1399 off_t *poffset, off_t *pcount,
1400 int *ptype, pid_t *ppid)
1403 struct timespec ts1,ts2;
1406 clock_gettime_mono(&ts1);
1407 result = SMB_VFS_NEXT_GETLOCK(handle, fsp, poffset, pcount, ptype,
1409 clock_gettime_mono(&ts2);
1410 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1412 if (timediff > audit_timeout) {
1413 smb_time_audit_log_fsp("getlock", timediff, fsp);
1419 static int smb_time_audit_symlinkat(vfs_handle_struct *handle,
1420 const struct smb_filename *link_contents,
1421 struct files_struct *dirfsp,
1422 const struct smb_filename *new_smb_fname)
1424 struct smb_filename *full_fname = NULL;
1426 struct timespec ts1,ts2;
1429 full_fname = full_path_from_dirfsp_atname(talloc_tos(),
1432 if (full_fname == NULL) {
1437 clock_gettime_mono(&ts1);
1438 result = SMB_VFS_NEXT_SYMLINKAT(handle,
1442 clock_gettime_mono(&ts2);
1443 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1445 if (timediff > audit_timeout) {
1446 smb_time_audit_log_fname("symlinkat", timediff,
1447 full_fname->base_name);
1450 TALLOC_FREE(full_fname);
1454 static int smb_time_audit_readlinkat(vfs_handle_struct *handle,
1455 const struct files_struct *dirfsp,
1456 const struct smb_filename *smb_fname,
1460 struct smb_filename *full_fname = NULL;
1462 struct timespec ts1,ts2;
1465 full_fname = full_path_from_dirfsp_atname(talloc_tos(),
1468 if (full_fname == NULL) {
1473 clock_gettime_mono(&ts1);
1474 result = SMB_VFS_NEXT_READLINKAT(handle,
1479 clock_gettime_mono(&ts2);
1480 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1482 if (timediff > audit_timeout) {
1483 smb_time_audit_log_fname("readlinkat", timediff,
1484 full_fname->base_name);
1487 TALLOC_FREE(full_fname);
1491 static int smb_time_audit_linkat(vfs_handle_struct *handle,
1492 files_struct *srcfsp,
1493 const struct smb_filename *old_smb_fname,
1494 files_struct *dstfsp,
1495 const struct smb_filename *new_smb_fname,
1498 struct smb_filename *new_full_fname = NULL;
1500 struct timespec ts1,ts2;
1503 new_full_fname = full_path_from_dirfsp_atname(talloc_tos(),
1506 if (new_full_fname == NULL) {
1511 clock_gettime_mono(&ts1);
1512 result = SMB_VFS_NEXT_LINKAT(handle,
1518 clock_gettime_mono(&ts2);
1519 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1521 if (timediff > audit_timeout) {
1522 smb_time_audit_log_fname("linkat", timediff,
1523 new_full_fname->base_name);
1526 TALLOC_FREE(new_full_fname);
1530 static int smb_time_audit_mknodat(vfs_handle_struct *handle,
1531 files_struct *dirfsp,
1532 const struct smb_filename *smb_fname,
1536 struct smb_filename *full_fname = NULL;
1538 struct timespec ts1,ts2;
1541 full_fname = full_path_from_dirfsp_atname(talloc_tos(),
1544 if (full_fname == NULL) {
1549 clock_gettime_mono(&ts1);
1550 result = SMB_VFS_NEXT_MKNODAT(handle,
1555 clock_gettime_mono(&ts2);
1556 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1558 if (timediff > audit_timeout) {
1559 smb_time_audit_log_smb_fname("mknodat", timediff, full_fname);
1562 TALLOC_FREE(full_fname);
1566 static struct smb_filename *smb_time_audit_realpath(vfs_handle_struct *handle,
1568 const struct smb_filename *smb_fname)
1570 struct smb_filename *result_fname;
1571 struct timespec ts1,ts2;
1574 clock_gettime_mono(&ts1);
1575 result_fname = SMB_VFS_NEXT_REALPATH(handle, ctx, smb_fname);
1576 clock_gettime_mono(&ts2);
1577 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1579 if (timediff > audit_timeout) {
1580 smb_time_audit_log_fname("realpath", timediff,
1581 smb_fname->base_name);
1584 return result_fname;
1587 static int smb_time_audit_chflags(vfs_handle_struct *handle,
1588 const struct smb_filename *smb_fname,
1592 struct timespec ts1,ts2;
1595 clock_gettime_mono(&ts1);
1596 result = SMB_VFS_NEXT_CHFLAGS(handle, smb_fname, flags);
1597 clock_gettime_mono(&ts2);
1598 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1600 if (timediff > audit_timeout) {
1601 smb_time_audit_log_smb_fname("chflags", timediff, smb_fname);
1607 static struct file_id smb_time_audit_file_id_create(struct vfs_handle_struct *handle,
1608 const SMB_STRUCT_STAT *sbuf)
1610 struct file_id id_zero;
1611 struct file_id result;
1612 struct timespec ts1,ts2;
1615 ZERO_STRUCT(id_zero);
1617 clock_gettime_mono(&ts1);
1618 result = SMB_VFS_NEXT_FILE_ID_CREATE(handle, sbuf);
1619 clock_gettime_mono(&ts2);
1620 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1622 if (timediff > audit_timeout) {
1623 smb_time_audit_log("file_id_create", timediff);
1629 static uint64_t smb_time_audit_fs_file_id(struct vfs_handle_struct *handle,
1630 const SMB_STRUCT_STAT *sbuf)
1633 struct timespec ts1,ts2;
1636 clock_gettime_mono(&ts1);
1637 result = SMB_VFS_NEXT_FS_FILE_ID(handle, sbuf);
1638 clock_gettime_mono(&ts2);
1639 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1641 if (timediff > audit_timeout) {
1642 smb_time_audit_log("fs_file_id", timediff);
1648 static NTSTATUS smb_time_audit_fstreaminfo(vfs_handle_struct *handle,
1649 struct files_struct *fsp,
1650 TALLOC_CTX *mem_ctx,
1651 unsigned int *pnum_streams,
1652 struct stream_struct **pstreams)
1655 struct timespec ts1,ts2;
1658 clock_gettime_mono(&ts1);
1659 result = SMB_VFS_NEXT_FSTREAMINFO(handle, fsp, mem_ctx,
1660 pnum_streams, pstreams);
1661 clock_gettime_mono(&ts2);
1662 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1664 if (timediff > audit_timeout) {
1665 smb_time_audit_log_fsp("fstreaminfo", timediff, fsp);
1671 static int smb_time_audit_get_real_filename(struct vfs_handle_struct *handle,
1672 const struct smb_filename *path,
1674 TALLOC_CTX *mem_ctx,
1678 struct timespec ts1,ts2;
1681 clock_gettime_mono(&ts1);
1682 result = SMB_VFS_NEXT_GET_REAL_FILENAME(handle, path, name, mem_ctx,
1684 clock_gettime_mono(&ts2);
1685 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1687 if (timediff > audit_timeout) {
1688 smb_time_audit_log_fname("get_real_filename",
1689 timediff, path->base_name);
1695 static const char *smb_time_audit_connectpath(vfs_handle_struct *handle,
1696 const struct smb_filename *smb_fname)
1699 struct timespec ts1,ts2;
1702 clock_gettime_mono(&ts1);
1703 result = SMB_VFS_NEXT_CONNECTPATH(handle, smb_fname);
1704 clock_gettime_mono(&ts2);
1705 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1707 if (timediff > audit_timeout) {
1708 smb_time_audit_log_fname("connectpath", timediff,
1709 smb_fname->base_name);
1715 static NTSTATUS smb_time_audit_brl_lock_windows(struct vfs_handle_struct *handle,
1716 struct byte_range_lock *br_lck,
1717 struct lock_struct *plock)
1720 struct timespec ts1,ts2;
1723 clock_gettime_mono(&ts1);
1724 result = SMB_VFS_NEXT_BRL_LOCK_WINDOWS(handle, br_lck, plock);
1725 clock_gettime_mono(&ts2);
1726 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1728 if (timediff > audit_timeout) {
1729 smb_time_audit_log_fsp("brl_lock_windows", timediff,
1736 static bool smb_time_audit_brl_unlock_windows(struct vfs_handle_struct *handle,
1737 struct byte_range_lock *br_lck,
1738 const struct lock_struct *plock)
1741 struct timespec ts1,ts2;
1744 clock_gettime_mono(&ts1);
1745 result = SMB_VFS_NEXT_BRL_UNLOCK_WINDOWS(handle, br_lck, plock);
1746 clock_gettime_mono(&ts2);
1747 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1749 if (timediff > audit_timeout) {
1750 smb_time_audit_log_fsp("brl_unlock_windows", timediff,
1757 static bool smb_time_audit_strict_lock_check(struct vfs_handle_struct *handle,
1758 struct files_struct *fsp,
1759 struct lock_struct *plock)
1762 struct timespec ts1,ts2;
1765 clock_gettime_mono(&ts1);
1766 result = SMB_VFS_NEXT_STRICT_LOCK_CHECK(handle, fsp, plock);
1767 clock_gettime_mono(&ts2);
1768 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1770 if (timediff > audit_timeout) {
1771 smb_time_audit_log_fsp("strict_lock_check", timediff, fsp);
1777 static NTSTATUS smb_time_audit_translate_name(struct vfs_handle_struct *handle,
1779 enum vfs_translate_direction direction,
1780 TALLOC_CTX *mem_ctx,
1784 struct timespec ts1,ts2;
1787 clock_gettime_mono(&ts1);
1788 result = SMB_VFS_NEXT_TRANSLATE_NAME(handle, name, direction, mem_ctx,
1790 clock_gettime_mono(&ts2);
1791 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1793 if (timediff > audit_timeout) {
1794 smb_time_audit_log_fname("translate_name", timediff, name);
1800 static NTSTATUS smb_time_audit_parent_pathname(struct vfs_handle_struct *handle,
1801 TALLOC_CTX *mem_ctx,
1802 const struct smb_filename *smb_fname_in,
1803 struct smb_filename **parent_dir_out,
1804 struct smb_filename **atname_out)
1807 struct timespec ts1,ts2;
1810 clock_gettime_mono(&ts1);
1811 result = SMB_VFS_NEXT_PARENT_PATHNAME(handle,
1816 clock_gettime_mono(&ts2);
1817 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1819 if (timediff > audit_timeout) {
1820 smb_time_audit_log_fname("parent_pathname",
1822 smb_fname_in->base_name);
1828 static NTSTATUS smb_time_audit_fsctl(struct vfs_handle_struct *handle,
1829 struct files_struct *fsp,
1833 const uint8_t *_in_data,
1835 uint8_t **_out_data,
1836 uint32_t max_out_len,
1840 struct timespec ts1,ts2;
1843 clock_gettime_mono(&ts1);
1844 result = SMB_VFS_NEXT_FSCTL(handle,
1854 clock_gettime_mono(&ts2);
1855 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1857 if (timediff > audit_timeout) {
1858 smb_time_audit_log_fsp("fsctl", timediff, fsp);
1864 struct smb_time_audit_get_dos_attributes_state {
1865 struct vfs_aio_state aio_state;
1866 files_struct *dir_fsp;
1867 const struct smb_filename *smb_fname;
1871 static void smb_time_audit_get_dos_attributes_done(struct tevent_req *subreq);
1873 static struct tevent_req *smb_time_audit_get_dos_attributes_send(
1874 TALLOC_CTX *mem_ctx,
1875 struct tevent_context *ev,
1876 struct vfs_handle_struct *handle,
1877 files_struct *dir_fsp,
1878 struct smb_filename *smb_fname)
1880 struct tevent_req *req = NULL;
1881 struct smb_time_audit_get_dos_attributes_state *state = NULL;
1882 struct tevent_req *subreq = NULL;
1884 req = tevent_req_create(mem_ctx, &state,
1885 struct smb_time_audit_get_dos_attributes_state);
1889 *state = (struct smb_time_audit_get_dos_attributes_state) {
1891 .smb_fname = smb_fname,
1894 subreq = SMB_VFS_NEXT_GET_DOS_ATTRIBUTES_SEND(mem_ctx,
1899 if (tevent_req_nomem(subreq, req)) {
1900 return tevent_req_post(req, ev);
1902 tevent_req_set_callback(subreq,
1903 smb_time_audit_get_dos_attributes_done,
1909 static void smb_time_audit_get_dos_attributes_done(struct tevent_req *subreq)
1911 struct tevent_req *req =
1912 tevent_req_callback_data(subreq,
1914 struct smb_time_audit_get_dos_attributes_state *state =
1915 tevent_req_data(req,
1916 struct smb_time_audit_get_dos_attributes_state);
1919 status = SMB_VFS_NEXT_GET_DOS_ATTRIBUTES_RECV(subreq,
1922 TALLOC_FREE(subreq);
1923 if (tevent_req_nterror(req, status)) {
1927 tevent_req_done(req);
1931 static NTSTATUS smb_time_audit_get_dos_attributes_recv(struct tevent_req *req,
1932 struct vfs_aio_state *aio_state,
1935 struct smb_time_audit_get_dos_attributes_state *state =
1936 tevent_req_data(req,
1937 struct smb_time_audit_get_dos_attributes_state);
1941 timediff = state->aio_state.duration * 1.0e-9;
1943 if (timediff > audit_timeout) {
1944 smb_time_audit_log_at("async get_dos_attributes",
1950 if (tevent_req_is_nterror(req, &status)) {
1951 tevent_req_received(req);
1955 *aio_state = state->aio_state;
1956 *dosmode = state->dosmode;
1957 tevent_req_received(req);
1958 return NT_STATUS_OK;
1961 static NTSTATUS smb_time_fget_dos_attributes(struct vfs_handle_struct *handle,
1962 struct files_struct *fsp,
1966 struct timespec ts1,ts2;
1969 clock_gettime_mono(&ts1);
1970 result = SMB_VFS_NEXT_FGET_DOS_ATTRIBUTES(handle,
1973 clock_gettime_mono(&ts2);
1974 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1976 if (timediff > audit_timeout) {
1977 smb_time_audit_log_fsp("fget_dos_attributes", timediff, fsp);
1983 static NTSTATUS smb_time_fset_dos_attributes(struct vfs_handle_struct *handle,
1984 struct files_struct *fsp,
1988 struct timespec ts1,ts2;
1991 clock_gettime_mono(&ts1);
1992 result = SMB_VFS_NEXT_FSET_DOS_ATTRIBUTES(handle,
1995 clock_gettime_mono(&ts2);
1996 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1998 if (timediff > audit_timeout) {
1999 smb_time_audit_log_fsp("fset_dos_attributes", timediff, fsp);
2005 struct time_audit_offload_read_state {
2006 struct vfs_handle_struct *handle;
2007 struct timespec ts_send;
2008 DATA_BLOB token_blob;
2011 static void smb_time_audit_offload_read_done(struct tevent_req *subreq);
2013 static struct tevent_req *smb_time_audit_offload_read_send(
2014 TALLOC_CTX *mem_ctx,
2015 struct tevent_context *ev,
2016 struct vfs_handle_struct *handle,
2017 struct files_struct *fsp,
2023 struct tevent_req *req = NULL;
2024 struct tevent_req *subreq = NULL;
2025 struct time_audit_offload_read_state *state = NULL;
2027 req = tevent_req_create(mem_ctx, &state,
2028 struct time_audit_offload_read_state);
2032 state->handle = handle;
2033 clock_gettime_mono(&state->ts_send);
2035 subreq = SMB_VFS_NEXT_OFFLOAD_READ_SEND(mem_ctx, ev,
2039 if (tevent_req_nomem(subreq, req)) {
2040 return tevent_req_post(req, ev);
2043 tevent_req_set_callback(subreq, smb_time_audit_offload_read_done, req);
2047 static void smb_time_audit_offload_read_done(struct tevent_req *subreq)
2049 struct tevent_req *req = tevent_req_callback_data(
2050 subreq, struct tevent_req);
2051 struct time_audit_offload_read_state *state = tevent_req_data(
2052 req, struct time_audit_offload_read_state);
2055 status = SMB_VFS_NEXT_OFFLOAD_READ_RECV(subreq,
2058 &state->token_blob);
2059 TALLOC_FREE(subreq);
2060 if (tevent_req_nterror(req, status)) {
2063 tevent_req_done(req);
2066 static NTSTATUS smb_time_audit_offload_read_recv(
2067 struct tevent_req *req,
2068 struct vfs_handle_struct *handle,
2069 TALLOC_CTX *mem_ctx,
2070 DATA_BLOB *token_blob)
2072 struct time_audit_offload_read_state *state = tevent_req_data(
2073 req, struct time_audit_offload_read_state);
2074 struct timespec ts_recv;
2078 clock_gettime_mono(&ts_recv);
2079 timediff = nsec_time_diff(&ts_recv, &state->ts_send) * 1.0e-9;
2080 if (timediff > audit_timeout) {
2081 smb_time_audit_log("offload_read", timediff);
2084 if (tevent_req_is_nterror(req, &status)) {
2085 tevent_req_received(req);
2089 token_blob->length = state->token_blob.length;
2090 token_blob->data = talloc_move(mem_ctx, &state->token_blob.data);
2092 tevent_req_received(req);
2093 return NT_STATUS_OK;
2096 struct time_audit_offload_write_state {
2097 struct timespec ts_send;
2098 struct vfs_handle_struct *handle;
2101 static void smb_time_audit_offload_write_done(struct tevent_req *subreq);
2103 static struct tevent_req *smb_time_audit_offload_write_send(struct vfs_handle_struct *handle,
2104 TALLOC_CTX *mem_ctx,
2105 struct tevent_context *ev,
2108 off_t transfer_offset,
2109 struct files_struct *dest_fsp,
2113 struct tevent_req *req;
2114 struct tevent_req *subreq;
2115 struct time_audit_offload_write_state *state;
2117 req = tevent_req_create(mem_ctx, &state,
2118 struct time_audit_offload_write_state);
2123 state->handle = handle;
2124 clock_gettime_mono(&state->ts_send);
2125 subreq = SMB_VFS_NEXT_OFFLOAD_WRITE_SEND(handle, state, ev,
2126 fsctl, token, transfer_offset,
2127 dest_fsp, dest_off, num);
2128 if (tevent_req_nomem(subreq, req)) {
2129 return tevent_req_post(req, ev);
2132 tevent_req_set_callback(subreq, smb_time_audit_offload_write_done, req);
2136 static void smb_time_audit_offload_write_done(struct tevent_req *subreq)
2138 struct tevent_req *req = tevent_req_callback_data(
2139 subreq, struct tevent_req);
2140 struct time_audit_offload_write_state *state = tevent_req_data(
2141 req, struct time_audit_offload_write_state);
2144 status = SMB_VFS_NEXT_OFFLOAD_WRITE_RECV(state->handle,
2147 TALLOC_FREE(subreq);
2148 if (tevent_req_nterror(req, status)) {
2151 tevent_req_done(req);
2154 static NTSTATUS smb_time_audit_offload_write_recv(struct vfs_handle_struct *handle,
2155 struct tevent_req *req,
2158 struct time_audit_offload_write_state *state = tevent_req_data(
2159 req, struct time_audit_offload_write_state);
2160 struct timespec ts_recv;
2164 clock_gettime_mono(&ts_recv);
2165 timediff = nsec_time_diff(&ts_recv, &state->ts_send)*1.0e-9;
2166 if (timediff > audit_timeout) {
2167 smb_time_audit_log("offload_write", timediff);
2170 *copied = state->copied;
2171 if (tevent_req_is_nterror(req, &status)) {
2172 tevent_req_received(req);
2176 tevent_req_received(req);
2177 return NT_STATUS_OK;
2180 static NTSTATUS smb_time_audit_fget_compression(vfs_handle_struct *handle,
2181 TALLOC_CTX *mem_ctx,
2182 struct files_struct *fsp,
2183 uint16_t *_compression_fmt)
2186 struct timespec ts1,ts2;
2189 clock_gettime_mono(&ts1);
2190 result = SMB_VFS_NEXT_FGET_COMPRESSION(handle, mem_ctx, fsp,
2192 clock_gettime_mono(&ts2);
2193 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2195 if (timediff > audit_timeout) {
2196 smb_time_audit_log_fsp("get_compression",
2203 static NTSTATUS smb_time_audit_set_compression(vfs_handle_struct *handle,
2204 TALLOC_CTX *mem_ctx,
2205 struct files_struct *fsp,
2206 uint16_t compression_fmt)
2209 struct timespec ts1,ts2;
2212 clock_gettime_mono(&ts1);
2213 result = SMB_VFS_NEXT_SET_COMPRESSION(handle, mem_ctx, fsp,
2215 clock_gettime_mono(&ts2);
2216 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2218 if (timediff > audit_timeout) {
2219 smb_time_audit_log_fsp("set_compression", timediff, fsp);
2225 static NTSTATUS smb_time_audit_freaddir_attr(struct vfs_handle_struct *handle,
2226 struct files_struct *fsp,
2227 TALLOC_CTX *mem_ctx,
2228 struct readdir_attr_data **pattr_data)
2231 struct timespec ts1, ts2;
2234 clock_gettime_mono(&ts1);
2235 status = SMB_VFS_NEXT_FREADDIR_ATTR(handle, fsp, mem_ctx, pattr_data);
2236 clock_gettime_mono(&ts2);
2237 timediff = nsec_time_diff(&ts2, &ts1) * 1.0e-9;
2239 if (timediff > audit_timeout) {
2240 smb_time_audit_log_fsp("freaddir_attr", timediff, fsp);
2246 static NTSTATUS smb_time_audit_fget_nt_acl(vfs_handle_struct *handle,
2248 uint32_t security_info,
2249 TALLOC_CTX *mem_ctx,
2250 struct security_descriptor **ppdesc)
2253 struct timespec ts1,ts2;
2256 clock_gettime_mono(&ts1);
2257 result = SMB_VFS_NEXT_FGET_NT_ACL(handle, fsp, security_info,
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_fsp("fget_nt_acl", timediff, fsp);
2269 static NTSTATUS smb_time_audit_fset_nt_acl(vfs_handle_struct *handle,
2271 uint32_t security_info_sent,
2272 const struct security_descriptor *psd)
2275 struct timespec ts1,ts2;
2278 clock_gettime_mono(&ts1);
2279 result = SMB_VFS_NEXT_FSET_NT_ACL(handle, fsp, security_info_sent,
2281 clock_gettime_mono(&ts2);
2282 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2284 if (timediff > audit_timeout) {
2285 smb_time_audit_log_fsp("fset_nt_acl", timediff, fsp);
2291 static NTSTATUS smb_time_audit_audit_file(struct vfs_handle_struct *handle,
2292 struct smb_filename *smb_fname,
2293 struct security_acl *sacl,
2294 uint32_t access_requested,
2295 uint32_t access_denied)
2298 struct timespec ts1,ts2;
2301 clock_gettime_mono(&ts1);
2302 result = SMB_VFS_NEXT_AUDIT_FILE(handle,
2307 clock_gettime_mono(&ts2);
2308 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2310 if (timediff > audit_timeout) {
2311 smb_time_audit_log_fname("audit_file",
2313 smb_fname->base_name);
2319 static SMB_ACL_T smb_time_audit_sys_acl_get_fd(vfs_handle_struct *handle,
2321 SMB_ACL_TYPE_T type,
2322 TALLOC_CTX *mem_ctx)
2325 struct timespec ts1,ts2;
2328 clock_gettime_mono(&ts1);
2329 result = SMB_VFS_NEXT_SYS_ACL_GET_FD(handle, fsp, type, mem_ctx);
2330 clock_gettime_mono(&ts2);
2331 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2333 if (timediff > audit_timeout) {
2334 smb_time_audit_log_fsp("sys_acl_get_fd", timediff, fsp);
2341 static int smb_time_audit_sys_acl_blob_get_file(vfs_handle_struct *handle,
2342 const struct smb_filename *smb_fname,
2343 TALLOC_CTX *mem_ctx,
2344 char **blob_description,
2348 struct timespec ts1,ts2;
2351 clock_gettime_mono(&ts1);
2352 result = SMB_VFS_NEXT_SYS_ACL_BLOB_GET_FILE(handle, smb_fname,
2353 mem_ctx, blob_description, blob);
2354 clock_gettime_mono(&ts2);
2355 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2357 if (timediff > audit_timeout) {
2358 smb_time_audit_log("sys_acl_blob_get_file", timediff);
2364 static int smb_time_audit_sys_acl_blob_get_fd(vfs_handle_struct *handle,
2366 TALLOC_CTX *mem_ctx,
2367 char **blob_description,
2371 struct timespec ts1,ts2;
2374 clock_gettime_mono(&ts1);
2375 result = SMB_VFS_NEXT_SYS_ACL_BLOB_GET_FD(handle, fsp, mem_ctx, blob_description, blob);
2376 clock_gettime_mono(&ts2);
2377 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2379 if (timediff > audit_timeout) {
2380 smb_time_audit_log("sys_acl_blob_get_fd", timediff);
2386 static int smb_time_audit_sys_acl_set_fd(vfs_handle_struct *handle,
2388 SMB_ACL_TYPE_T type,
2392 struct timespec ts1,ts2;
2395 clock_gettime_mono(&ts1);
2396 result = SMB_VFS_NEXT_SYS_ACL_SET_FD(handle, fsp, type, theacl);
2397 clock_gettime_mono(&ts2);
2398 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2400 if (timediff > audit_timeout) {
2401 smb_time_audit_log_fsp("sys_acl_set_fd", timediff, fsp);
2407 static int smb_time_audit_sys_acl_delete_def_fd(vfs_handle_struct *handle,
2411 struct timespec ts1,ts2;
2414 clock_gettime_mono(&ts1);
2415 result = SMB_VFS_NEXT_SYS_ACL_DELETE_DEF_FD(handle, fsp);
2416 clock_gettime_mono(&ts2);
2417 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2419 if (timediff > audit_timeout) {
2420 smb_time_audit_log_fsp("sys_acl_delete_def_fd", timediff, fsp);
2426 static ssize_t smb_time_audit_getxattr(struct vfs_handle_struct *handle,
2427 const struct smb_filename *smb_fname,
2433 struct timespec ts1,ts2;
2436 clock_gettime_mono(&ts1);
2437 result = SMB_VFS_NEXT_GETXATTR(handle, smb_fname, name, value, size);
2438 clock_gettime_mono(&ts2);
2439 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2441 if (timediff > audit_timeout) {
2442 smb_time_audit_log_fname("getxattr", timediff,
2443 smb_fname->base_name);
2449 struct smb_time_audit_getxattrat_state {
2450 struct vfs_aio_state aio_state;
2451 files_struct *dir_fsp;
2452 const struct smb_filename *smb_fname;
2453 const char *xattr_name;
2455 uint8_t *xattr_value;
2458 static void smb_time_audit_getxattrat_done(struct tevent_req *subreq);
2460 static struct tevent_req *smb_time_audit_getxattrat_send(
2461 TALLOC_CTX *mem_ctx,
2462 struct tevent_context *ev,
2463 struct vfs_handle_struct *handle,
2464 files_struct *dir_fsp,
2465 const struct smb_filename *smb_fname,
2466 const char *xattr_name,
2469 struct tevent_req *req = NULL;
2470 struct tevent_req *subreq = NULL;
2471 struct smb_time_audit_getxattrat_state *state = NULL;
2473 req = tevent_req_create(mem_ctx, &state,
2474 struct smb_time_audit_getxattrat_state);
2478 *state = (struct smb_time_audit_getxattrat_state) {
2480 .smb_fname = smb_fname,
2481 .xattr_name = xattr_name,
2484 subreq = SMB_VFS_NEXT_GETXATTRAT_SEND(state,
2491 if (tevent_req_nomem(subreq, req)) {
2492 return tevent_req_post(req, ev);
2494 tevent_req_set_callback(subreq, smb_time_audit_getxattrat_done, req);
2499 static void smb_time_audit_getxattrat_done(struct tevent_req *subreq)
2501 struct tevent_req *req = tevent_req_callback_data(
2502 subreq, struct tevent_req);
2503 struct smb_time_audit_getxattrat_state *state = tevent_req_data(
2504 req, struct smb_time_audit_getxattrat_state);
2506 state->xattr_size = SMB_VFS_NEXT_GETXATTRAT_RECV(subreq,
2509 &state->xattr_value);
2510 TALLOC_FREE(subreq);
2511 if (state->xattr_size == -1) {
2512 tevent_req_error(req, state->aio_state.error);
2516 tevent_req_done(req);
2519 static ssize_t smb_time_audit_getxattrat_recv(struct tevent_req *req,
2520 struct vfs_aio_state *aio_state,
2521 TALLOC_CTX *mem_ctx,
2522 uint8_t **xattr_value)
2524 struct smb_time_audit_getxattrat_state *state = tevent_req_data(
2525 req, struct smb_time_audit_getxattrat_state);
2529 timediff = state->aio_state.duration * 1.0e-9;
2531 if (timediff > audit_timeout) {
2532 smb_time_audit_log_at("async getxattrat",
2538 if (tevent_req_is_unix_error(req, &aio_state->error)) {
2539 tevent_req_received(req);
2543 *aio_state = state->aio_state;
2544 xattr_size = state->xattr_size;
2545 if (xattr_value != NULL) {
2546 *xattr_value = talloc_move(mem_ctx, &state->xattr_value);
2549 tevent_req_received(req);
2553 static ssize_t smb_time_audit_fgetxattr(struct vfs_handle_struct *handle,
2554 struct files_struct *fsp,
2555 const char *name, void *value,
2559 struct timespec ts1,ts2;
2562 clock_gettime_mono(&ts1);
2563 result = SMB_VFS_NEXT_FGETXATTR(handle, fsp, name, value, size);
2564 clock_gettime_mono(&ts2);
2565 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2567 if (timediff > audit_timeout) {
2568 smb_time_audit_log_fsp("fgetxattr", timediff, fsp);
2574 static ssize_t smb_time_audit_flistxattr(struct vfs_handle_struct *handle,
2575 struct files_struct *fsp, char *list,
2579 struct timespec ts1,ts2;
2582 clock_gettime_mono(&ts1);
2583 result = SMB_VFS_NEXT_FLISTXATTR(handle, fsp, list, size);
2584 clock_gettime_mono(&ts2);
2585 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2587 if (timediff > audit_timeout) {
2588 smb_time_audit_log_fsp("flistxattr", timediff, fsp);
2594 static int smb_time_audit_fremovexattr(struct vfs_handle_struct *handle,
2595 struct files_struct *fsp,
2599 struct timespec ts1,ts2;
2602 clock_gettime_mono(&ts1);
2603 result = SMB_VFS_NEXT_FREMOVEXATTR(handle, fsp, name);
2604 clock_gettime_mono(&ts2);
2605 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2607 if (timediff > audit_timeout) {
2608 smb_time_audit_log_fsp("fremovexattr", timediff, fsp);
2614 static int smb_time_audit_fsetxattr(struct vfs_handle_struct *handle,
2615 struct files_struct *fsp, const char *name,
2616 const void *value, size_t size, int flags)
2619 struct timespec ts1,ts2;
2622 clock_gettime_mono(&ts1);
2623 result = SMB_VFS_NEXT_FSETXATTR(handle, fsp, name, value, size, flags);
2624 clock_gettime_mono(&ts2);
2625 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2627 if (timediff > audit_timeout) {
2628 smb_time_audit_log_fsp("fsetxattr", timediff, fsp);
2634 static bool smb_time_audit_aio_force(struct vfs_handle_struct *handle,
2635 struct files_struct *fsp)
2638 struct timespec ts1,ts2;
2641 clock_gettime_mono(&ts1);
2642 result = SMB_VFS_NEXT_AIO_FORCE(handle, fsp);
2643 clock_gettime_mono(&ts2);
2644 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2646 if (timediff > audit_timeout) {
2647 smb_time_audit_log_fsp("aio_force", timediff, fsp);
2653 static NTSTATUS smb_time_audit_durable_cookie(struct vfs_handle_struct *handle,
2654 struct files_struct *fsp,
2655 TALLOC_CTX *mem_ctx,
2659 struct timespec ts1,ts2;
2662 clock_gettime_mono(&ts1);
2663 result = SMB_VFS_NEXT_DURABLE_COOKIE(handle, fsp, mem_ctx, cookie);
2664 clock_gettime_mono(&ts2);
2665 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2667 if (timediff > audit_timeout) {
2668 smb_time_audit_log_fsp("durable_cookie", timediff, fsp);
2674 static NTSTATUS smb_time_audit_durable_disconnect(struct vfs_handle_struct *handle,
2675 struct files_struct *fsp,
2676 const DATA_BLOB old_cookie,
2677 TALLOC_CTX *mem_ctx,
2678 DATA_BLOB *new_cookie)
2681 struct timespec ts1,ts2;
2684 clock_gettime_mono(&ts1);
2685 result = SMB_VFS_NEXT_DURABLE_DISCONNECT(handle, fsp, old_cookie,
2686 mem_ctx, new_cookie);
2687 clock_gettime_mono(&ts2);
2688 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2690 if (timediff > audit_timeout) {
2691 smb_time_audit_log_fsp("durable_disconnect", timediff, fsp);
2697 static NTSTATUS smb_time_audit_durable_reconnect(struct vfs_handle_struct *handle,
2698 struct smb_request *smb1req,
2699 struct smbXsrv_open *op,
2700 const DATA_BLOB old_cookie,
2701 TALLOC_CTX *mem_ctx,
2702 struct files_struct **fsp,
2703 DATA_BLOB *new_cookie)
2706 struct timespec ts1,ts2;
2709 clock_gettime_mono(&ts1);
2710 result = SMB_VFS_NEXT_DURABLE_RECONNECT(handle, smb1req, op, old_cookie,
2711 mem_ctx, fsp, new_cookie);
2712 clock_gettime_mono(&ts2);
2713 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2715 if (timediff > audit_timeout) {
2716 smb_time_audit_log("durable_reconnect", timediff);
2722 /* VFS operations */
2724 static struct vfs_fn_pointers vfs_time_audit_fns = {
2725 .connect_fn = smb_time_audit_connect,
2726 .disconnect_fn = smb_time_audit_disconnect,
2727 .disk_free_fn = smb_time_audit_disk_free,
2728 .get_quota_fn = smb_time_audit_get_quota,
2729 .set_quota_fn = smb_time_audit_set_quota,
2730 .get_shadow_copy_data_fn = smb_time_audit_get_shadow_copy_data,
2731 .statvfs_fn = smb_time_audit_statvfs,
2732 .fs_capabilities_fn = smb_time_audit_fs_capabilities,
2733 .get_dfs_referrals_fn = smb_time_audit_get_dfs_referrals,
2734 .create_dfs_pathat_fn = smb_time_audit_create_dfs_pathat,
2735 .read_dfs_pathat_fn = smb_time_audit_read_dfs_pathat,
2736 .fdopendir_fn = smb_time_audit_fdopendir,
2737 .readdir_fn = smb_time_audit_readdir,
2738 .seekdir_fn = smb_time_audit_seekdir,
2739 .telldir_fn = smb_time_audit_telldir,
2740 .rewind_dir_fn = smb_time_audit_rewinddir,
2741 .mkdirat_fn = smb_time_audit_mkdirat,
2742 .closedir_fn = smb_time_audit_closedir,
2743 .openat_fn = smb_time_audit_openat,
2744 .create_file_fn = smb_time_audit_create_file,
2745 .close_fn = smb_time_audit_close,
2746 .pread_fn = smb_time_audit_pread,
2747 .pread_send_fn = smb_time_audit_pread_send,
2748 .pread_recv_fn = smb_time_audit_pread_recv,
2749 .pwrite_fn = smb_time_audit_pwrite,
2750 .pwrite_send_fn = smb_time_audit_pwrite_send,
2751 .pwrite_recv_fn = smb_time_audit_pwrite_recv,
2752 .lseek_fn = smb_time_audit_lseek,
2753 .sendfile_fn = smb_time_audit_sendfile,
2754 .recvfile_fn = smb_time_audit_recvfile,
2755 .renameat_fn = smb_time_audit_renameat,
2756 .fsync_send_fn = smb_time_audit_fsync_send,
2757 .fsync_recv_fn = smb_time_audit_fsync_recv,
2758 .stat_fn = smb_time_audit_stat,
2759 .fstat_fn = smb_time_audit_fstat,
2760 .lstat_fn = smb_time_audit_lstat,
2761 .get_alloc_size_fn = smb_time_audit_get_alloc_size,
2762 .unlinkat_fn = smb_time_audit_unlinkat,
2763 .fchmod_fn = smb_time_audit_fchmod,
2764 .fchown_fn = smb_time_audit_fchown,
2765 .lchown_fn = smb_time_audit_lchown,
2766 .chdir_fn = smb_time_audit_chdir,
2767 .getwd_fn = smb_time_audit_getwd,
2768 .fntimes_fn = smb_time_audit_fntimes,
2769 .ftruncate_fn = smb_time_audit_ftruncate,
2770 .fallocate_fn = smb_time_audit_fallocate,
2771 .lock_fn = smb_time_audit_lock,
2772 .kernel_flock_fn = smb_time_audit_kernel_flock,
2773 .fcntl_fn = smb_time_audit_fcntl,
2774 .linux_setlease_fn = smb_time_audit_linux_setlease,
2775 .getlock_fn = smb_time_audit_getlock,
2776 .symlinkat_fn = smb_time_audit_symlinkat,
2777 .readlinkat_fn = smb_time_audit_readlinkat,
2778 .linkat_fn = smb_time_audit_linkat,
2779 .mknodat_fn = smb_time_audit_mknodat,
2780 .realpath_fn = smb_time_audit_realpath,
2781 .chflags_fn = smb_time_audit_chflags,
2782 .file_id_create_fn = smb_time_audit_file_id_create,
2783 .fs_file_id_fn = smb_time_audit_fs_file_id,
2784 .offload_read_send_fn = smb_time_audit_offload_read_send,
2785 .offload_read_recv_fn = smb_time_audit_offload_read_recv,
2786 .offload_write_send_fn = smb_time_audit_offload_write_send,
2787 .offload_write_recv_fn = smb_time_audit_offload_write_recv,
2788 .fget_compression_fn = smb_time_audit_fget_compression,
2789 .set_compression_fn = smb_time_audit_set_compression,
2790 .snap_check_path_fn = smb_time_audit_snap_check_path,
2791 .snap_create_fn = smb_time_audit_snap_create,
2792 .snap_delete_fn = smb_time_audit_snap_delete,
2793 .fstreaminfo_fn = smb_time_audit_fstreaminfo,
2794 .get_real_filename_fn = smb_time_audit_get_real_filename,
2795 .connectpath_fn = smb_time_audit_connectpath,
2796 .brl_lock_windows_fn = smb_time_audit_brl_lock_windows,
2797 .brl_unlock_windows_fn = smb_time_audit_brl_unlock_windows,
2798 .strict_lock_check_fn = smb_time_audit_strict_lock_check,
2799 .translate_name_fn = smb_time_audit_translate_name,
2800 .parent_pathname_fn = smb_time_audit_parent_pathname,
2801 .fsctl_fn = smb_time_audit_fsctl,
2802 .get_dos_attributes_send_fn = smb_time_audit_get_dos_attributes_send,
2803 .get_dos_attributes_recv_fn = smb_time_audit_get_dos_attributes_recv,
2804 .fget_dos_attributes_fn = smb_time_fget_dos_attributes,
2805 .fset_dos_attributes_fn = smb_time_fset_dos_attributes,
2806 .fget_nt_acl_fn = smb_time_audit_fget_nt_acl,
2807 .fset_nt_acl_fn = smb_time_audit_fset_nt_acl,
2808 .audit_file_fn = smb_time_audit_audit_file,
2809 .sys_acl_get_fd_fn = smb_time_audit_sys_acl_get_fd,
2810 .sys_acl_blob_get_file_fn = smb_time_audit_sys_acl_blob_get_file,
2811 .sys_acl_blob_get_fd_fn = smb_time_audit_sys_acl_blob_get_fd,
2812 .sys_acl_set_fd_fn = smb_time_audit_sys_acl_set_fd,
2813 .sys_acl_delete_def_fd_fn = smb_time_audit_sys_acl_delete_def_fd,
2814 .getxattr_fn = smb_time_audit_getxattr,
2815 .getxattrat_send_fn = smb_time_audit_getxattrat_send,
2816 .getxattrat_recv_fn = smb_time_audit_getxattrat_recv,
2817 .fgetxattr_fn = smb_time_audit_fgetxattr,
2818 .flistxattr_fn = smb_time_audit_flistxattr,
2819 .fremovexattr_fn = smb_time_audit_fremovexattr,
2820 .fsetxattr_fn = smb_time_audit_fsetxattr,
2821 .aio_force_fn = smb_time_audit_aio_force,
2822 .durable_cookie_fn = smb_time_audit_durable_cookie,
2823 .durable_disconnect_fn = smb_time_audit_durable_disconnect,
2824 .durable_reconnect_fn = smb_time_audit_durable_reconnect,
2825 .freaddir_attr_fn = smb_time_audit_freaddir_attr,
2830 NTSTATUS vfs_time_audit_init(TALLOC_CTX *ctx)
2832 smb_vfs_assert_all_fns(&vfs_time_audit_fns, "time_audit");
2834 audit_timeout = (double)lp_parm_int(-1, "time_audit", "timeout",
2836 return smb_register_vfs(SMB_VFS_INTERFACE_VERSION, "time_audit",
2837 &vfs_time_audit_fns);