s3: VFS: Change SMB_VFS_CHDIR to use const struct smb_filename * instead of const...
[Samba.git] / source3 / modules / vfs_time_audit.c
blob820de3ffa2c2a6ef179e524fc0ea8d81d8e8326a
1 /*
2 * Time auditing VFS module for samba. Log time taken for VFS call to syslog
3 * facility.
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
28 #include "includes.h"
29 #include "smbd/smbd.h"
30 #include "ntioctl.h"
31 #include "lib/util/tevent_unix.h"
32 #include "lib/util/tevent_ntstatus.h"
34 #undef DBGC_CLASS
35 #define DBGC_CLASS DBGC_VFS
37 static double audit_timeout;
39 static void smb_time_audit_log_msg(const char *syscallname, double elapsed,
40 const char *msg)
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;
59 char *msg = NULL;
61 if (fsp == NULL) {
62 smb_time_audit_log(syscallname, elapsed);
63 return;
65 if (fsp->conn)
66 connectpath = fsp->conn->connectpath;
67 if (fsp->fsp_name)
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\", "
75 "base_name = <NULL>",
76 connectpath);
77 } else if (connectpath == NULL && base_name != NULL) {
78 msg = talloc_asprintf(talloc_tos(), "connectpath = <NULL>, "
79 "base_name = \"%s\"",
80 base_name);
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);
86 TALLOC_FREE(msg);
89 static void smb_time_audit_log_fname(const char *syscallname, double elapsed,
90 const char *fname)
92 char cwd[PATH_MAX];
93 char *msg = NULL;
95 if (getcwd(cwd, sizeof(cwd)) == NULL) {
96 snprintf(cwd, sizeof(cwd), "<getcwd() error %d>", errno);
98 if (fname != NULL) {
99 msg = talloc_asprintf(talloc_tos(),
100 "cwd = \"%s\", filename = \"%s\"",
101 cwd, fname);
102 } else {
103 msg = talloc_asprintf(talloc_tos(),
104 "cwd = \"%s\", filename = <NULL>",
105 cwd);
107 smb_time_audit_log_msg(syscallname, elapsed, msg);
108 TALLOC_FREE(msg);
111 static void smb_time_audit_log_smb_fname(const char *syscallname, double elapsed,
112 const struct smb_filename *smb_fname)
114 if (smb_fname != NULL) {
115 smb_time_audit_log_fname(syscallname, elapsed,
116 smb_fname->base_name);
117 } else {
118 smb_time_audit_log_fname(syscallname, elapsed,
119 "smb_fname = <NULL>");
123 static int smb_time_audit_connect(vfs_handle_struct *handle,
124 const char *svc, const char *user)
126 int result;
127 struct timespec ts1,ts2;
128 double timediff;
130 if (!handle) {
131 return -1;
134 clock_gettime_mono(&ts1);
135 result = SMB_VFS_NEXT_CONNECT(handle, svc, user);
136 clock_gettime_mono(&ts2);
137 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
138 if (timediff > audit_timeout) {
139 smb_time_audit_log_msg("connect", timediff, user);
141 return result;
144 static void smb_time_audit_disconnect(vfs_handle_struct *handle)
146 struct timespec ts1,ts2;
147 double timediff;
149 clock_gettime_mono(&ts1);
150 SMB_VFS_NEXT_DISCONNECT(handle);
151 clock_gettime_mono(&ts2);
152 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
154 if (timediff > audit_timeout) {
155 smb_time_audit_log("disconnect", timediff);
159 static uint64_t smb_time_audit_disk_free(vfs_handle_struct *handle,
160 const struct smb_filename *smb_fname,
161 uint64_t *bsize,
162 uint64_t *dfree,
163 uint64_t *dsize)
165 uint64_t result;
166 struct timespec ts1,ts2;
167 double timediff;
169 clock_gettime_mono(&ts1);
170 result = SMB_VFS_NEXT_DISK_FREE(handle, smb_fname, bsize, dfree, dsize);
171 clock_gettime_mono(&ts2);
172 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
174 /* Don't have a reasonable notion of failure here */
175 if (timediff > audit_timeout) {
176 smb_time_audit_log_fname("disk_free",
177 timediff,
178 smb_fname->base_name);
181 return result;
184 static int smb_time_audit_get_quota(struct vfs_handle_struct *handle,
185 const struct smb_filename *smb_fname,
186 enum SMB_QUOTA_TYPE qtype,
187 unid_t id,
188 SMB_DISK_QUOTA *qt)
190 int result;
191 struct timespec ts1,ts2;
192 double timediff;
194 clock_gettime_mono(&ts1);
195 result = SMB_VFS_NEXT_GET_QUOTA(handle, smb_fname, qtype, id, qt);
196 clock_gettime_mono(&ts2);
197 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
199 if (timediff > audit_timeout) {
200 smb_time_audit_log_fname("get_quota",
201 timediff,
202 smb_fname->base_name);
204 return result;
207 static int smb_time_audit_set_quota(struct vfs_handle_struct *handle,
208 enum SMB_QUOTA_TYPE qtype, unid_t id,
209 SMB_DISK_QUOTA *qt)
211 int result;
212 struct timespec ts1,ts2;
213 double timediff;
215 clock_gettime_mono(&ts1);
216 result = SMB_VFS_NEXT_SET_QUOTA(handle, qtype, id, qt);
217 clock_gettime_mono(&ts2);
218 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
220 if (timediff > audit_timeout) {
221 smb_time_audit_log("set_quota", timediff);
224 return result;
227 static int smb_time_audit_get_shadow_copy_data(struct vfs_handle_struct *handle,
228 struct files_struct *fsp,
229 struct shadow_copy_data *shadow_copy_data,
230 bool labels)
232 int result;
233 struct timespec ts1,ts2;
234 double timediff;
236 clock_gettime_mono(&ts1);
237 result = SMB_VFS_NEXT_GET_SHADOW_COPY_DATA(handle, fsp,
238 shadow_copy_data, labels);
239 clock_gettime_mono(&ts2);
240 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
242 if (timediff > audit_timeout) {
243 smb_time_audit_log_fsp("get_shadow_copy_data", timediff, fsp);
246 return result;
249 static int smb_time_audit_statvfs(struct vfs_handle_struct *handle,
250 const struct smb_filename *smb_fname,
251 struct vfs_statvfs_struct *statbuf)
253 int result;
254 struct timespec ts1,ts2;
255 double timediff;
257 clock_gettime_mono(&ts1);
258 result = SMB_VFS_NEXT_STATVFS(handle, smb_fname, statbuf);
259 clock_gettime_mono(&ts2);
260 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
262 if (timediff > audit_timeout) {
263 smb_time_audit_log_fname("statvfs", timediff,
264 smb_fname->base_name);
267 return result;
270 static uint32_t smb_time_audit_fs_capabilities(struct vfs_handle_struct *handle,
271 enum timestamp_set_resolution *p_ts_res)
273 uint32_t result;
274 struct timespec ts1,ts2;
275 double timediff;
277 clock_gettime_mono(&ts1);
278 result = SMB_VFS_NEXT_FS_CAPABILITIES(handle, p_ts_res);
279 clock_gettime_mono(&ts2);
280 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
282 if (timediff > audit_timeout) {
283 smb_time_audit_log("fs_capabilities", timediff);
286 return result;
289 static NTSTATUS smb_time_audit_get_dfs_referrals(
290 struct vfs_handle_struct *handle,
291 struct dfs_GetDFSReferral *r)
293 NTSTATUS result;
294 struct timespec ts1,ts2;
295 double timediff;
297 clock_gettime_mono(&ts1);
298 result = SMB_VFS_NEXT_GET_DFS_REFERRALS(handle, r);
299 clock_gettime_mono(&ts2);
300 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
302 if (timediff > audit_timeout) {
303 smb_time_audit_log("get_dfs_referrals(", timediff);
306 return result;
309 static NTSTATUS smb_time_audit_snap_check_path(struct vfs_handle_struct *handle,
310 TALLOC_CTX *mem_ctx,
311 const char *service_path,
312 char **base_volume)
314 NTSTATUS status;
315 struct timespec ts1,ts2;
316 double timediff;
318 clock_gettime_mono(&ts1);
319 status = SMB_VFS_NEXT_SNAP_CHECK_PATH(handle, mem_ctx, service_path,
320 base_volume);
321 clock_gettime_mono(&ts2);
322 timediff = nsec_time_diff(&ts2, &ts1) * 1.0e-9;
324 if (timediff > audit_timeout) {
325 smb_time_audit_log("snap_check_path", timediff);
328 return status;
331 static NTSTATUS smb_time_audit_snap_create(struct vfs_handle_struct *handle,
332 TALLOC_CTX *mem_ctx,
333 const char *base_volume,
334 time_t *tstamp,
335 bool rw,
336 char **base_path,
337 char **snap_path)
339 NTSTATUS status;
340 struct timespec ts1,ts2;
341 double timediff;
343 clock_gettime_mono(&ts1);
344 status = SMB_VFS_NEXT_SNAP_CREATE(handle, mem_ctx, base_volume, tstamp,
345 rw, base_path, snap_path);
346 clock_gettime_mono(&ts2);
347 timediff = nsec_time_diff(&ts2 ,&ts1) * 1.0e-9;
349 if (timediff > audit_timeout) {
350 smb_time_audit_log("snap_create", timediff);
353 return status;
356 static NTSTATUS smb_time_audit_snap_delete(struct vfs_handle_struct *handle,
357 TALLOC_CTX *mem_ctx,
358 char *base_path,
359 char *snap_path)
361 NTSTATUS status;
362 struct timespec ts1,ts2;
363 double timediff;
365 clock_gettime_mono(&ts1);
366 status = SMB_VFS_NEXT_SNAP_DELETE(handle, mem_ctx, base_path,
367 snap_path);
368 clock_gettime_mono(&ts2);
369 timediff = nsec_time_diff(&ts2, &ts1) * 1.0e-9;
371 if (timediff > audit_timeout) {
372 smb_time_audit_log("snap_delete", timediff);
375 return status;
378 static DIR *smb_time_audit_opendir(vfs_handle_struct *handle,
379 const struct smb_filename *smb_fname,
380 const char *mask, uint32_t attr)
382 DIR *result;
383 struct timespec ts1,ts2;
384 double timediff;
386 clock_gettime_mono(&ts1);
387 result = SMB_VFS_NEXT_OPENDIR(handle, smb_fname, mask, attr);
388 clock_gettime_mono(&ts2);
389 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
391 if (timediff > audit_timeout) {
392 smb_time_audit_log_smb_fname("opendir", timediff, smb_fname);
395 return result;
398 static DIR *smb_time_audit_fdopendir(vfs_handle_struct *handle,
399 files_struct *fsp,
400 const char *mask, uint32_t attr)
402 DIR *result;
403 struct timespec ts1,ts2;
404 double timediff;
406 clock_gettime_mono(&ts1);
407 result = SMB_VFS_NEXT_FDOPENDIR(handle, fsp, mask, attr);
408 clock_gettime_mono(&ts2);
409 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
411 if (timediff > audit_timeout) {
412 smb_time_audit_log_fsp("fdopendir", timediff, fsp);
415 return result;
418 static struct dirent *smb_time_audit_readdir(vfs_handle_struct *handle,
419 DIR *dirp,
420 SMB_STRUCT_STAT *sbuf)
422 struct dirent *result;
423 struct timespec ts1,ts2;
424 double timediff;
426 clock_gettime_mono(&ts1);
427 result = SMB_VFS_NEXT_READDIR(handle, dirp, sbuf);
428 clock_gettime_mono(&ts2);
429 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
431 if (timediff > audit_timeout) {
432 smb_time_audit_log("readdir", timediff);
435 return result;
438 static void smb_time_audit_seekdir(vfs_handle_struct *handle,
439 DIR *dirp, long offset)
441 struct timespec ts1,ts2;
442 double timediff;
444 clock_gettime_mono(&ts1);
445 SMB_VFS_NEXT_SEEKDIR(handle, dirp, offset);
446 clock_gettime_mono(&ts2);
447 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
449 if (timediff > audit_timeout) {
450 smb_time_audit_log("seekdir", timediff);
455 static long smb_time_audit_telldir(vfs_handle_struct *handle,
456 DIR *dirp)
458 long result;
459 struct timespec ts1,ts2;
460 double timediff;
462 clock_gettime_mono(&ts1);
463 result = SMB_VFS_NEXT_TELLDIR(handle, dirp);
464 clock_gettime_mono(&ts2);
465 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
467 if (timediff > audit_timeout) {
468 smb_time_audit_log("telldir", timediff);
471 return result;
474 static void smb_time_audit_rewinddir(vfs_handle_struct *handle,
475 DIR *dirp)
477 struct timespec ts1,ts2;
478 double timediff;
480 clock_gettime_mono(&ts1);
481 SMB_VFS_NEXT_REWINDDIR(handle, dirp);
482 clock_gettime_mono(&ts2);
483 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
485 if (timediff > audit_timeout) {
486 smb_time_audit_log("rewinddir", timediff);
491 static int smb_time_audit_mkdir(vfs_handle_struct *handle,
492 const struct smb_filename *smb_fname,
493 mode_t mode)
495 int result;
496 struct timespec ts1,ts2;
497 double timediff;
499 clock_gettime_mono(&ts1);
500 result = SMB_VFS_NEXT_MKDIR(handle, smb_fname, mode);
501 clock_gettime_mono(&ts2);
502 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
504 if (timediff > audit_timeout) {
505 smb_time_audit_log_smb_fname("mkdir",
506 timediff,
507 smb_fname);
510 return result;
513 static int smb_time_audit_rmdir(vfs_handle_struct *handle,
514 const struct smb_filename *smb_fname)
516 int result;
517 struct timespec ts1,ts2;
518 double timediff;
520 clock_gettime_mono(&ts1);
521 result = SMB_VFS_NEXT_RMDIR(handle, smb_fname);
522 clock_gettime_mono(&ts2);
523 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
525 if (timediff > audit_timeout) {
526 smb_time_audit_log_smb_fname("rmdir",
527 timediff,
528 smb_fname);
531 return result;
534 static int smb_time_audit_closedir(vfs_handle_struct *handle,
535 DIR *dirp)
537 int result;
538 struct timespec ts1,ts2;
539 double timediff;
541 clock_gettime_mono(&ts1);
542 result = SMB_VFS_NEXT_CLOSEDIR(handle, dirp);
543 clock_gettime_mono(&ts2);
544 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
546 if (timediff > audit_timeout) {
547 smb_time_audit_log("closedir", timediff);
550 return result;
553 static void smb_time_audit_init_search_op(vfs_handle_struct *handle,
554 DIR *dirp)
556 struct timespec ts1,ts2;
557 double timediff;
559 clock_gettime_mono(&ts1);
560 SMB_VFS_NEXT_INIT_SEARCH_OP(handle, dirp);
561 clock_gettime_mono(&ts2);
562 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
564 if (timediff > audit_timeout) {
565 smb_time_audit_log("init_search_op", timediff);
569 static int smb_time_audit_open(vfs_handle_struct *handle,
570 struct smb_filename *fname,
571 files_struct *fsp,
572 int flags, mode_t mode)
574 int result;
575 struct timespec ts1,ts2;
576 double timediff;
578 clock_gettime_mono(&ts1);
579 result = SMB_VFS_NEXT_OPEN(handle, fname, fsp, flags, mode);
580 clock_gettime_mono(&ts2);
581 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
583 if (timediff > audit_timeout) {
584 smb_time_audit_log_fsp("open", timediff, fsp);
587 return result;
590 static NTSTATUS smb_time_audit_create_file(vfs_handle_struct *handle,
591 struct smb_request *req,
592 uint16_t root_dir_fid,
593 struct smb_filename *fname,
594 uint32_t access_mask,
595 uint32_t share_access,
596 uint32_t create_disposition,
597 uint32_t create_options,
598 uint32_t file_attributes,
599 uint32_t oplock_request,
600 struct smb2_lease *lease,
601 uint64_t allocation_size,
602 uint32_t private_flags,
603 struct security_descriptor *sd,
604 struct ea_list *ea_list,
605 files_struct **result_fsp,
606 int *pinfo,
607 const struct smb2_create_blobs *in_context_blobs,
608 struct smb2_create_blobs *out_context_blobs)
610 NTSTATUS result;
611 struct timespec ts1,ts2;
612 double timediff;
614 clock_gettime_mono(&ts1);
615 result = SMB_VFS_NEXT_CREATE_FILE(
616 handle, /* handle */
617 req, /* req */
618 root_dir_fid, /* root_dir_fid */
619 fname, /* fname */
620 access_mask, /* access_mask */
621 share_access, /* share_access */
622 create_disposition, /* create_disposition*/
623 create_options, /* create_options */
624 file_attributes, /* file_attributes */
625 oplock_request, /* oplock_request */
626 lease, /* lease */
627 allocation_size, /* allocation_size */
628 private_flags,
629 sd, /* sd */
630 ea_list, /* ea_list */
631 result_fsp, /* result */
632 pinfo,
633 in_context_blobs, out_context_blobs); /* create context */
634 clock_gettime_mono(&ts2);
635 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
637 if (timediff > audit_timeout) {
639 * can't use result_fsp this time, may have
640 * invalid content causing smbd crash
642 smb_time_audit_log_smb_fname("create_file", timediff,
643 fname);
646 return result;
649 static int smb_time_audit_close(vfs_handle_struct *handle, files_struct *fsp)
651 int result;
652 struct timespec ts1,ts2;
653 double timediff;
655 clock_gettime_mono(&ts1);
656 result = SMB_VFS_NEXT_CLOSE(handle, fsp);
657 clock_gettime_mono(&ts2);
658 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
660 if (timediff > audit_timeout) {
661 smb_time_audit_log_fsp("close", timediff, fsp);
664 return result;
667 static ssize_t smb_time_audit_read(vfs_handle_struct *handle,
668 files_struct *fsp, void *data, size_t n)
670 ssize_t result;
671 struct timespec ts1,ts2;
672 double timediff;
674 clock_gettime_mono(&ts1);
675 result = SMB_VFS_NEXT_READ(handle, fsp, data, n);
676 clock_gettime_mono(&ts2);
677 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
679 if (timediff > audit_timeout) {
680 smb_time_audit_log_fsp("read", timediff, fsp);
683 return result;
686 static ssize_t smb_time_audit_pread(vfs_handle_struct *handle,
687 files_struct *fsp,
688 void *data, size_t n, off_t offset)
690 ssize_t result;
691 struct timespec ts1,ts2;
692 double timediff;
694 clock_gettime_mono(&ts1);
695 result = SMB_VFS_NEXT_PREAD(handle, fsp, data, n, offset);
696 clock_gettime_mono(&ts2);
697 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
699 if (timediff > audit_timeout) {
700 smb_time_audit_log_fsp("pread", timediff, fsp);
703 return result;
706 struct smb_time_audit_pread_state {
707 struct files_struct *fsp;
708 ssize_t ret;
709 struct vfs_aio_state vfs_aio_state;
712 static void smb_time_audit_pread_done(struct tevent_req *subreq);
714 static struct tevent_req *smb_time_audit_pread_send(
715 struct vfs_handle_struct *handle, TALLOC_CTX *mem_ctx,
716 struct tevent_context *ev, struct files_struct *fsp,
717 void *data, size_t n, off_t offset)
719 struct tevent_req *req, *subreq;
720 struct smb_time_audit_pread_state *state;
722 req = tevent_req_create(mem_ctx, &state,
723 struct smb_time_audit_pread_state);
724 if (req == NULL) {
725 return NULL;
727 state->fsp = fsp;
729 subreq = SMB_VFS_NEXT_PREAD_SEND(state, ev, handle, fsp, data,
730 n, offset);
731 if (tevent_req_nomem(subreq, req)) {
732 return tevent_req_post(req, ev);
734 tevent_req_set_callback(subreq, smb_time_audit_pread_done, req);
735 return req;
738 static void smb_time_audit_pread_done(struct tevent_req *subreq)
740 struct tevent_req *req = tevent_req_callback_data(
741 subreq, struct tevent_req);
742 struct smb_time_audit_pread_state *state = tevent_req_data(
743 req, struct smb_time_audit_pread_state);
745 state->ret = SMB_VFS_PREAD_RECV(subreq, &state->vfs_aio_state);
746 TALLOC_FREE(subreq);
747 tevent_req_done(req);
750 static ssize_t smb_time_audit_pread_recv(struct tevent_req *req,
751 struct vfs_aio_state *vfs_aio_state)
753 struct smb_time_audit_pread_state *state = tevent_req_data(
754 req, struct smb_time_audit_pread_state);
755 double timediff;
757 timediff = state->vfs_aio_state.duration * 1.0e-9;
759 if (timediff > audit_timeout) {
760 smb_time_audit_log_fsp("async pread", timediff, state->fsp);
763 if (tevent_req_is_unix_error(req, &vfs_aio_state->error)) {
764 return -1;
766 *vfs_aio_state = state->vfs_aio_state;
767 return state->ret;
770 static ssize_t smb_time_audit_write(vfs_handle_struct *handle,
771 files_struct *fsp,
772 const void *data, size_t n)
774 ssize_t result;
775 struct timespec ts1,ts2;
776 double timediff;
778 clock_gettime_mono(&ts1);
779 result = SMB_VFS_NEXT_WRITE(handle, fsp, data, n);
780 clock_gettime_mono(&ts2);
781 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
783 if (timediff > audit_timeout) {
784 smb_time_audit_log_fsp("write", timediff, fsp);
787 return result;
790 static ssize_t smb_time_audit_pwrite(vfs_handle_struct *handle,
791 files_struct *fsp,
792 const void *data, size_t n,
793 off_t offset)
795 ssize_t result;
796 struct timespec ts1,ts2;
797 double timediff;
799 clock_gettime_mono(&ts1);
800 result = SMB_VFS_NEXT_PWRITE(handle, fsp, data, n, offset);
801 clock_gettime_mono(&ts2);
802 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
804 if (timediff > audit_timeout) {
805 smb_time_audit_log_fsp("pwrite", timediff, fsp);
808 return result;
811 struct smb_time_audit_pwrite_state {
812 struct files_struct *fsp;
813 ssize_t ret;
814 struct vfs_aio_state vfs_aio_state;
817 static void smb_time_audit_pwrite_done(struct tevent_req *subreq);
819 static struct tevent_req *smb_time_audit_pwrite_send(
820 struct vfs_handle_struct *handle, TALLOC_CTX *mem_ctx,
821 struct tevent_context *ev, struct files_struct *fsp,
822 const void *data, size_t n, off_t offset)
824 struct tevent_req *req, *subreq;
825 struct smb_time_audit_pwrite_state *state;
827 req = tevent_req_create(mem_ctx, &state,
828 struct smb_time_audit_pwrite_state);
829 if (req == NULL) {
830 return NULL;
832 state->fsp = fsp;
834 subreq = SMB_VFS_NEXT_PWRITE_SEND(state, ev, handle, fsp, data,
835 n, offset);
836 if (tevent_req_nomem(subreq, req)) {
837 return tevent_req_post(req, ev);
839 tevent_req_set_callback(subreq, smb_time_audit_pwrite_done, req);
840 return req;
843 static void smb_time_audit_pwrite_done(struct tevent_req *subreq)
845 struct tevent_req *req = tevent_req_callback_data(
846 subreq, struct tevent_req);
847 struct smb_time_audit_pwrite_state *state = tevent_req_data(
848 req, struct smb_time_audit_pwrite_state);
850 state->ret = SMB_VFS_PWRITE_RECV(subreq, &state->vfs_aio_state);
851 TALLOC_FREE(subreq);
852 tevent_req_done(req);
855 static ssize_t smb_time_audit_pwrite_recv(struct tevent_req *req,
856 struct vfs_aio_state *vfs_aio_state)
858 struct smb_time_audit_pwrite_state *state = tevent_req_data(
859 req, struct smb_time_audit_pwrite_state);
860 double timediff;
862 timediff = state->vfs_aio_state.duration * 1.0e-9;
864 if (timediff > audit_timeout) {
865 smb_time_audit_log_fsp("async pwrite", timediff, state->fsp);
868 if (tevent_req_is_unix_error(req, &vfs_aio_state->error)) {
869 return -1;
871 *vfs_aio_state = state->vfs_aio_state;
872 return state->ret;
875 static off_t smb_time_audit_lseek(vfs_handle_struct *handle,
876 files_struct *fsp,
877 off_t offset, int whence)
879 off_t result;
880 struct timespec ts1,ts2;
881 double timediff;
883 clock_gettime_mono(&ts1);
884 result = SMB_VFS_NEXT_LSEEK(handle, fsp, offset, whence);
885 clock_gettime_mono(&ts2);
886 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
888 if (timediff > audit_timeout) {
889 smb_time_audit_log_fsp("lseek", timediff, fsp);
892 return result;
895 static ssize_t smb_time_audit_sendfile(vfs_handle_struct *handle, int tofd,
896 files_struct *fromfsp,
897 const DATA_BLOB *hdr, off_t offset,
898 size_t n)
900 ssize_t result;
901 struct timespec ts1,ts2;
902 double timediff;
904 clock_gettime_mono(&ts1);
905 result = SMB_VFS_NEXT_SENDFILE(handle, tofd, fromfsp, hdr, offset, n);
906 clock_gettime_mono(&ts2);
907 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
909 if (timediff > audit_timeout) {
910 smb_time_audit_log_fsp("sendfile", timediff, fromfsp);
913 return result;
916 static ssize_t smb_time_audit_recvfile(vfs_handle_struct *handle, int fromfd,
917 files_struct *tofsp,
918 off_t offset,
919 size_t n)
921 ssize_t result;
922 struct timespec ts1,ts2;
923 double timediff;
925 clock_gettime_mono(&ts1);
926 result = SMB_VFS_NEXT_RECVFILE(handle, fromfd, tofsp, offset, n);
927 clock_gettime_mono(&ts2);
928 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
930 if (timediff > audit_timeout) {
931 smb_time_audit_log_fsp("recvfile", timediff, tofsp);
934 return result;
937 static int smb_time_audit_rename(vfs_handle_struct *handle,
938 const struct smb_filename *oldname,
939 const struct smb_filename *newname)
941 int result;
942 struct timespec ts1,ts2;
943 double timediff;
945 clock_gettime_mono(&ts1);
946 result = SMB_VFS_NEXT_RENAME(handle, oldname, newname);
947 clock_gettime_mono(&ts2);
948 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
950 if (timediff > audit_timeout) {
951 smb_time_audit_log_smb_fname("rename", timediff, newname);
954 return result;
957 static int smb_time_audit_fsync(vfs_handle_struct *handle, files_struct *fsp)
959 int result;
960 struct timespec ts1,ts2;
961 double timediff;
963 clock_gettime_mono(&ts1);
964 result = SMB_VFS_NEXT_FSYNC(handle, fsp);
965 clock_gettime_mono(&ts2);
966 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
968 if (timediff > audit_timeout) {
969 smb_time_audit_log_fsp("fsync", timediff, fsp);
972 return result;
975 struct smb_time_audit_fsync_state {
976 struct files_struct *fsp;
977 int ret;
978 struct vfs_aio_state vfs_aio_state;
981 static void smb_time_audit_fsync_done(struct tevent_req *subreq);
983 static struct tevent_req *smb_time_audit_fsync_send(
984 struct vfs_handle_struct *handle, TALLOC_CTX *mem_ctx,
985 struct tevent_context *ev, struct files_struct *fsp)
987 struct tevent_req *req, *subreq;
988 struct smb_time_audit_fsync_state *state;
990 req = tevent_req_create(mem_ctx, &state,
991 struct smb_time_audit_fsync_state);
992 if (req == NULL) {
993 return NULL;
995 state->fsp = fsp;
997 subreq = SMB_VFS_NEXT_FSYNC_SEND(state, ev, handle, fsp);
998 if (tevent_req_nomem(subreq, req)) {
999 return tevent_req_post(req, ev);
1001 tevent_req_set_callback(subreq, smb_time_audit_fsync_done, req);
1002 return req;
1005 static void smb_time_audit_fsync_done(struct tevent_req *subreq)
1007 struct tevent_req *req = tevent_req_callback_data(
1008 subreq, struct tevent_req);
1009 struct smb_time_audit_fsync_state *state = tevent_req_data(
1010 req, struct smb_time_audit_fsync_state);
1012 state->ret = SMB_VFS_FSYNC_RECV(subreq, &state->vfs_aio_state);
1013 TALLOC_FREE(subreq);
1014 tevent_req_done(req);
1017 static int smb_time_audit_fsync_recv(struct tevent_req *req,
1018 struct vfs_aio_state *vfs_aio_state)
1020 struct smb_time_audit_fsync_state *state = tevent_req_data(
1021 req, struct smb_time_audit_fsync_state);
1022 double timediff;
1024 timediff = state->vfs_aio_state.duration * 1.0e-9;
1026 if (timediff > audit_timeout) {
1027 smb_time_audit_log_fsp("async fsync", timediff, state->fsp);
1030 if (tevent_req_is_unix_error(req, &vfs_aio_state->error)) {
1031 return -1;
1033 *vfs_aio_state = state->vfs_aio_state;
1034 return state->ret;
1037 static int smb_time_audit_stat(vfs_handle_struct *handle,
1038 struct smb_filename *fname)
1040 int result;
1041 struct timespec ts1,ts2;
1042 double timediff;
1044 clock_gettime_mono(&ts1);
1045 result = SMB_VFS_NEXT_STAT(handle, fname);
1046 clock_gettime_mono(&ts2);
1047 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1049 if (timediff > audit_timeout) {
1050 smb_time_audit_log_smb_fname("stat", timediff, fname);
1053 return result;
1056 static int smb_time_audit_fstat(vfs_handle_struct *handle, files_struct *fsp,
1057 SMB_STRUCT_STAT *sbuf)
1059 int result;
1060 struct timespec ts1,ts2;
1061 double timediff;
1063 clock_gettime_mono(&ts1);
1064 result = SMB_VFS_NEXT_FSTAT(handle, fsp, sbuf);
1065 clock_gettime_mono(&ts2);
1066 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1068 if (timediff > audit_timeout) {
1069 smb_time_audit_log_fsp("fstat", timediff, fsp);
1072 return result;
1075 static int smb_time_audit_lstat(vfs_handle_struct *handle,
1076 struct smb_filename *path)
1078 int result;
1079 struct timespec ts1,ts2;
1080 double timediff;
1082 clock_gettime_mono(&ts1);
1083 result = SMB_VFS_NEXT_LSTAT(handle, path);
1084 clock_gettime_mono(&ts2);
1085 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1087 if (timediff > audit_timeout) {
1088 smb_time_audit_log_smb_fname("lstat", timediff, path);
1091 return result;
1094 static uint64_t smb_time_audit_get_alloc_size(vfs_handle_struct *handle,
1095 files_struct *fsp,
1096 const SMB_STRUCT_STAT *sbuf)
1098 uint64_t result;
1099 struct timespec ts1,ts2;
1100 double timediff;
1102 clock_gettime_mono(&ts1);
1103 result = SMB_VFS_NEXT_GET_ALLOC_SIZE(handle, fsp, sbuf);
1104 clock_gettime_mono(&ts2);
1105 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1107 if (timediff > audit_timeout) {
1108 smb_time_audit_log_fsp("get_alloc_size", timediff, fsp);
1111 return result;
1114 static int smb_time_audit_unlink(vfs_handle_struct *handle,
1115 const struct smb_filename *path)
1117 int result;
1118 struct timespec ts1,ts2;
1119 double timediff;
1121 clock_gettime_mono(&ts1);
1122 result = SMB_VFS_NEXT_UNLINK(handle, path);
1123 clock_gettime_mono(&ts2);
1124 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1126 if (timediff > audit_timeout) {
1127 smb_time_audit_log_smb_fname("unlink", timediff, path);
1130 return result;
1133 static int smb_time_audit_chmod(vfs_handle_struct *handle,
1134 const struct smb_filename *smb_fname,
1135 mode_t mode)
1137 int result;
1138 struct timespec ts1,ts2;
1139 double timediff;
1141 clock_gettime_mono(&ts1);
1142 result = SMB_VFS_NEXT_CHMOD(handle, smb_fname, mode);
1143 clock_gettime_mono(&ts2);
1144 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1146 if (timediff > audit_timeout) {
1147 smb_time_audit_log_fname("chmod",
1148 timediff,
1149 smb_fname->base_name);
1152 return result;
1155 static int smb_time_audit_fchmod(vfs_handle_struct *handle, files_struct *fsp,
1156 mode_t mode)
1158 int result;
1159 struct timespec ts1,ts2;
1160 double timediff;
1162 clock_gettime_mono(&ts1);
1163 result = SMB_VFS_NEXT_FCHMOD(handle, fsp, mode);
1164 clock_gettime_mono(&ts2);
1165 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1167 if (timediff > audit_timeout) {
1168 smb_time_audit_log_fsp("fchmod", timediff, fsp);
1171 return result;
1174 static int smb_time_audit_chown(vfs_handle_struct *handle,
1175 const struct smb_filename *smb_fname,
1176 uid_t uid,
1177 gid_t gid)
1179 int result;
1180 struct timespec ts1,ts2;
1181 double timediff;
1183 clock_gettime_mono(&ts1);
1184 result = SMB_VFS_NEXT_CHOWN(handle, smb_fname, uid, gid);
1185 clock_gettime_mono(&ts2);
1186 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1188 if (timediff > audit_timeout) {
1189 smb_time_audit_log_fname("chown",
1190 timediff,
1191 smb_fname->base_name);
1194 return result;
1197 static int smb_time_audit_fchown(vfs_handle_struct *handle, files_struct *fsp,
1198 uid_t uid, gid_t gid)
1200 int result;
1201 struct timespec ts1,ts2;
1202 double timediff;
1204 clock_gettime_mono(&ts1);
1205 result = SMB_VFS_NEXT_FCHOWN(handle, fsp, uid, gid);
1206 clock_gettime_mono(&ts2);
1207 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1209 if (timediff > audit_timeout) {
1210 smb_time_audit_log_fsp("fchown", timediff, fsp);
1213 return result;
1216 static int smb_time_audit_lchown(vfs_handle_struct *handle,
1217 const struct smb_filename *smb_fname,
1218 uid_t uid,
1219 gid_t gid)
1221 int result;
1222 struct timespec ts1,ts2;
1223 double timediff;
1225 clock_gettime_mono(&ts1);
1226 result = SMB_VFS_NEXT_LCHOWN(handle, smb_fname, uid, gid);
1227 clock_gettime_mono(&ts2);
1228 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1230 if (timediff > audit_timeout) {
1231 smb_time_audit_log_fname("lchown",
1232 timediff,
1233 smb_fname->base_name);
1236 return result;
1239 static int smb_time_audit_chdir(vfs_handle_struct *handle,
1240 const struct smb_filename *smb_fname)
1242 int result;
1243 struct timespec ts1,ts2;
1244 double timediff;
1246 clock_gettime_mono(&ts1);
1247 result = SMB_VFS_NEXT_CHDIR(handle, smb_fname);
1248 clock_gettime_mono(&ts2);
1249 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1251 if (timediff > audit_timeout) {
1252 smb_time_audit_log_fname("chdir",
1253 timediff,
1254 smb_fname->base_name);
1257 return result;
1260 static char *smb_time_audit_getwd(vfs_handle_struct *handle)
1262 char *result;
1263 struct timespec ts1,ts2;
1264 double timediff;
1266 clock_gettime_mono(&ts1);
1267 result = SMB_VFS_NEXT_GETWD(handle);
1268 clock_gettime_mono(&ts2);
1269 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1271 if (timediff > audit_timeout) {
1272 smb_time_audit_log("getwd", timediff);
1275 return result;
1278 static int smb_time_audit_ntimes(vfs_handle_struct *handle,
1279 const struct smb_filename *path,
1280 struct smb_file_time *ft)
1282 int result;
1283 struct timespec ts1,ts2;
1284 double timediff;
1286 clock_gettime_mono(&ts1);
1287 result = SMB_VFS_NEXT_NTIMES(handle, path, ft);
1288 clock_gettime_mono(&ts2);
1289 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1291 if (timediff > audit_timeout) {
1292 smb_time_audit_log_smb_fname("ntimes", timediff, path);
1295 return result;
1298 static int smb_time_audit_ftruncate(vfs_handle_struct *handle,
1299 files_struct *fsp,
1300 off_t len)
1302 int result;
1303 struct timespec ts1,ts2;
1304 double timediff;
1306 clock_gettime_mono(&ts1);
1307 result = SMB_VFS_NEXT_FTRUNCATE(handle, fsp, len);
1308 clock_gettime_mono(&ts2);
1309 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1311 if (timediff > audit_timeout) {
1312 smb_time_audit_log_fsp("ftruncate", timediff, fsp);
1315 return result;
1318 static int smb_time_audit_fallocate(vfs_handle_struct *handle,
1319 files_struct *fsp,
1320 uint32_t mode,
1321 off_t offset,
1322 off_t len)
1324 int result;
1325 int saved_errno = 0;
1326 struct timespec ts1,ts2;
1327 double timediff;
1329 clock_gettime_mono(&ts1);
1330 result = SMB_VFS_NEXT_FALLOCATE(handle, fsp, mode, offset, len);
1331 if (result == -1) {
1332 saved_errno = errno;
1334 clock_gettime_mono(&ts2);
1335 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1337 if (timediff > audit_timeout) {
1338 smb_time_audit_log_fsp("fallocate", timediff, fsp);
1340 if (result == -1) {
1341 errno = saved_errno;
1343 return result;
1346 static bool smb_time_audit_lock(vfs_handle_struct *handle, files_struct *fsp,
1347 int op, off_t offset, off_t count,
1348 int type)
1350 bool result;
1351 struct timespec ts1,ts2;
1352 double timediff;
1354 clock_gettime_mono(&ts1);
1355 result = SMB_VFS_NEXT_LOCK(handle, fsp, op, offset, count, type);
1356 clock_gettime_mono(&ts2);
1357 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1359 if (timediff > audit_timeout) {
1360 smb_time_audit_log_fsp("lock", timediff, fsp);
1363 return result;
1366 static int smb_time_audit_kernel_flock(struct vfs_handle_struct *handle,
1367 struct files_struct *fsp,
1368 uint32_t share_mode, uint32_t access_mask)
1370 int result;
1371 struct timespec ts1,ts2;
1372 double timediff;
1374 clock_gettime_mono(&ts1);
1375 result = SMB_VFS_NEXT_KERNEL_FLOCK(handle, fsp, share_mode,
1376 access_mask);
1377 clock_gettime_mono(&ts2);
1378 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1380 if (timediff > audit_timeout) {
1381 smb_time_audit_log_fsp("kernel_flock", timediff, fsp);
1384 return result;
1387 static int smb_time_audit_linux_setlease(vfs_handle_struct *handle,
1388 files_struct *fsp,
1389 int leasetype)
1391 int result;
1392 struct timespec ts1,ts2;
1393 double timediff;
1395 clock_gettime_mono(&ts1);
1396 result = SMB_VFS_NEXT_LINUX_SETLEASE(handle, fsp, leasetype);
1397 clock_gettime_mono(&ts2);
1398 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1400 if (timediff > audit_timeout) {
1401 smb_time_audit_log_fsp("linux_setlease", timediff, fsp);
1404 return result;
1407 static bool smb_time_audit_getlock(vfs_handle_struct *handle,
1408 files_struct *fsp,
1409 off_t *poffset, off_t *pcount,
1410 int *ptype, pid_t *ppid)
1412 bool result;
1413 struct timespec ts1,ts2;
1414 double timediff;
1416 clock_gettime_mono(&ts1);
1417 result = SMB_VFS_NEXT_GETLOCK(handle, fsp, poffset, pcount, ptype,
1418 ppid);
1419 clock_gettime_mono(&ts2);
1420 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1422 if (timediff > audit_timeout) {
1423 smb_time_audit_log_fsp("getlock", timediff, fsp);
1426 return result;
1429 static int smb_time_audit_symlink(vfs_handle_struct *handle,
1430 const char *link_contents,
1431 const struct smb_filename *new_smb_fname)
1433 int result;
1434 struct timespec ts1,ts2;
1435 double timediff;
1437 clock_gettime_mono(&ts1);
1438 result = SMB_VFS_NEXT_SYMLINK(handle, link_contents, new_smb_fname);
1439 clock_gettime_mono(&ts2);
1440 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1442 if (timediff > audit_timeout) {
1443 smb_time_audit_log_fname("symlink", timediff,
1444 new_smb_fname->base_name);
1447 return result;
1450 static int smb_time_audit_readlink(vfs_handle_struct *handle,
1451 const struct smb_filename *smb_fname,
1452 char *buf,
1453 size_t bufsiz)
1455 int result;
1456 struct timespec ts1,ts2;
1457 double timediff;
1459 clock_gettime_mono(&ts1);
1460 result = SMB_VFS_NEXT_READLINK(handle, smb_fname,
1461 buf, bufsiz);
1462 clock_gettime_mono(&ts2);
1463 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1465 if (timediff > audit_timeout) {
1466 smb_time_audit_log_fname("readlink", timediff,
1467 smb_fname->base_name);
1470 return result;
1473 static int smb_time_audit_link(vfs_handle_struct *handle,
1474 const struct smb_filename *old_smb_fname,
1475 const struct smb_filename *new_smb_fname)
1477 int result;
1478 struct timespec ts1,ts2;
1479 double timediff;
1481 clock_gettime_mono(&ts1);
1482 result = SMB_VFS_NEXT_LINK(handle, old_smb_fname, new_smb_fname);
1483 clock_gettime_mono(&ts2);
1484 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1486 if (timediff > audit_timeout) {
1487 smb_time_audit_log_fname("link", timediff,
1488 new_smb_fname->base_name);
1491 return result;
1494 static int smb_time_audit_mknod(vfs_handle_struct *handle,
1495 const struct smb_filename *smb_fname,
1496 mode_t mode,
1497 SMB_DEV_T dev)
1499 int result;
1500 struct timespec ts1,ts2;
1501 double timediff;
1503 clock_gettime_mono(&ts1);
1504 result = SMB_VFS_NEXT_MKNOD(handle, smb_fname, mode, dev);
1505 clock_gettime_mono(&ts2);
1506 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1508 if (timediff > audit_timeout) {
1509 smb_time_audit_log_smb_fname("mknod", timediff, smb_fname);
1512 return result;
1515 static char *smb_time_audit_realpath(vfs_handle_struct *handle,
1516 const char *path)
1518 char *result;
1519 struct timespec ts1,ts2;
1520 double timediff;
1522 clock_gettime_mono(&ts1);
1523 result = SMB_VFS_NEXT_REALPATH(handle, path);
1524 clock_gettime_mono(&ts2);
1525 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1527 if (timediff > audit_timeout) {
1528 smb_time_audit_log_fname("realpath", timediff, path);
1531 return result;
1534 static int smb_time_audit_chflags(vfs_handle_struct *handle,
1535 const struct smb_filename *smb_fname,
1536 unsigned int flags)
1538 int result;
1539 struct timespec ts1,ts2;
1540 double timediff;
1542 clock_gettime_mono(&ts1);
1543 result = SMB_VFS_NEXT_CHFLAGS(handle, smb_fname, flags);
1544 clock_gettime_mono(&ts2);
1545 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1547 if (timediff > audit_timeout) {
1548 smb_time_audit_log_smb_fname("chflags", timediff, smb_fname);
1551 return result;
1554 static struct file_id smb_time_audit_file_id_create(struct vfs_handle_struct *handle,
1555 const SMB_STRUCT_STAT *sbuf)
1557 struct file_id id_zero;
1558 struct file_id result;
1559 struct timespec ts1,ts2;
1560 double timediff;
1562 ZERO_STRUCT(id_zero);
1564 clock_gettime_mono(&ts1);
1565 result = SMB_VFS_NEXT_FILE_ID_CREATE(handle, sbuf);
1566 clock_gettime_mono(&ts2);
1567 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1569 if (timediff > audit_timeout) {
1570 smb_time_audit_log("file_id_create", timediff);
1573 return result;
1576 static NTSTATUS smb_time_audit_streaminfo(vfs_handle_struct *handle,
1577 struct files_struct *fsp,
1578 const struct smb_filename *smb_fname,
1579 TALLOC_CTX *mem_ctx,
1580 unsigned int *pnum_streams,
1581 struct stream_struct **pstreams)
1583 NTSTATUS result;
1584 struct timespec ts1,ts2;
1585 double timediff;
1587 clock_gettime_mono(&ts1);
1588 result = SMB_VFS_NEXT_STREAMINFO(handle, fsp, smb_fname, mem_ctx,
1589 pnum_streams, pstreams);
1590 clock_gettime_mono(&ts2);
1591 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1593 if (timediff > audit_timeout) {
1594 smb_time_audit_log_fsp("streaminfo", timediff, fsp);
1597 return result;
1600 static int smb_time_audit_get_real_filename(struct vfs_handle_struct *handle,
1601 const char *path,
1602 const char *name,
1603 TALLOC_CTX *mem_ctx,
1604 char **found_name)
1606 int result;
1607 struct timespec ts1,ts2;
1608 double timediff;
1610 clock_gettime_mono(&ts1);
1611 result = SMB_VFS_NEXT_GET_REAL_FILENAME(handle, path, name, mem_ctx,
1612 found_name);
1613 clock_gettime_mono(&ts2);
1614 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1616 if (timediff > audit_timeout) {
1617 smb_time_audit_log_fname("get_real_filename", timediff, path);
1620 return result;
1623 static const char *smb_time_audit_connectpath(vfs_handle_struct *handle,
1624 const char *fname)
1626 const char *result;
1627 struct timespec ts1,ts2;
1628 double timediff;
1630 clock_gettime_mono(&ts1);
1631 result = SMB_VFS_NEXT_CONNECTPATH(handle, fname);
1632 clock_gettime_mono(&ts2);
1633 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1635 if (timediff > audit_timeout) {
1636 smb_time_audit_log_fname("connectpath", timediff, fname);
1639 return result;
1642 static NTSTATUS smb_time_audit_brl_lock_windows(struct vfs_handle_struct *handle,
1643 struct byte_range_lock *br_lck,
1644 struct lock_struct *plock,
1645 bool blocking_lock)
1647 NTSTATUS result;
1648 struct timespec ts1,ts2;
1649 double timediff;
1651 clock_gettime_mono(&ts1);
1652 result = SMB_VFS_NEXT_BRL_LOCK_WINDOWS(handle, br_lck, plock,
1653 blocking_lock);
1654 clock_gettime_mono(&ts2);
1655 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1657 if (timediff > audit_timeout) {
1658 smb_time_audit_log_fsp("brl_lock_windows", timediff,
1659 brl_fsp(br_lck));
1662 return result;
1665 static bool smb_time_audit_brl_unlock_windows(struct vfs_handle_struct *handle,
1666 struct messaging_context *msg_ctx,
1667 struct byte_range_lock *br_lck,
1668 const struct lock_struct *plock)
1670 bool result;
1671 struct timespec ts1,ts2;
1672 double timediff;
1674 clock_gettime_mono(&ts1);
1675 result = SMB_VFS_NEXT_BRL_UNLOCK_WINDOWS(handle, msg_ctx, br_lck,
1676 plock);
1677 clock_gettime_mono(&ts2);
1678 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1680 if (timediff > audit_timeout) {
1681 smb_time_audit_log_fsp("brl_unlock_windows", timediff,
1682 brl_fsp(br_lck));
1685 return result;
1688 static bool smb_time_audit_brl_cancel_windows(struct vfs_handle_struct *handle,
1689 struct byte_range_lock *br_lck,
1690 struct lock_struct *plock)
1692 bool result;
1693 struct timespec ts1,ts2;
1694 double timediff;
1696 clock_gettime_mono(&ts1);
1697 result = SMB_VFS_NEXT_BRL_CANCEL_WINDOWS(handle, br_lck, plock);
1698 clock_gettime_mono(&ts2);
1699 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1701 if (timediff > audit_timeout) {
1702 smb_time_audit_log_fsp("brl_cancel_windows", timediff,
1703 brl_fsp(br_lck));
1706 return result;
1709 static bool smb_time_audit_strict_lock(struct vfs_handle_struct *handle,
1710 struct files_struct *fsp,
1711 struct lock_struct *plock)
1713 bool result;
1714 struct timespec ts1,ts2;
1715 double timediff;
1717 clock_gettime_mono(&ts1);
1718 result = SMB_VFS_NEXT_STRICT_LOCK(handle, fsp, plock);
1719 clock_gettime_mono(&ts2);
1720 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1722 if (timediff > audit_timeout) {
1723 smb_time_audit_log_fsp("strict_lock", timediff, fsp);
1726 return result;
1729 static void smb_time_audit_strict_unlock(struct vfs_handle_struct *handle,
1730 struct files_struct *fsp,
1731 struct lock_struct *plock)
1733 struct timespec ts1,ts2;
1734 double timediff;
1736 clock_gettime_mono(&ts1);
1737 SMB_VFS_NEXT_STRICT_UNLOCK(handle, fsp, plock);
1738 clock_gettime_mono(&ts2);
1739 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1741 if (timediff > audit_timeout) {
1742 smb_time_audit_log_fsp("strict_unlock", timediff, fsp);
1746 static NTSTATUS smb_time_audit_translate_name(struct vfs_handle_struct *handle,
1747 const char *name,
1748 enum vfs_translate_direction direction,
1749 TALLOC_CTX *mem_ctx,
1750 char **mapped_name)
1752 NTSTATUS result;
1753 struct timespec ts1,ts2;
1754 double timediff;
1756 clock_gettime_mono(&ts1);
1757 result = SMB_VFS_NEXT_TRANSLATE_NAME(handle, name, direction, mem_ctx,
1758 mapped_name);
1759 clock_gettime_mono(&ts2);
1760 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1762 if (timediff > audit_timeout) {
1763 smb_time_audit_log_fname("translate_name", timediff, name);
1766 return result;
1769 static NTSTATUS smb_time_audit_fsctl(struct vfs_handle_struct *handle,
1770 struct files_struct *fsp,
1771 TALLOC_CTX *ctx,
1772 uint32_t function,
1773 uint16_t req_flags,
1774 const uint8_t *_in_data,
1775 uint32_t in_len,
1776 uint8_t **_out_data,
1777 uint32_t max_out_len,
1778 uint32_t *out_len)
1780 NTSTATUS result;
1781 struct timespec ts1,ts2;
1782 double timediff;
1784 clock_gettime_mono(&ts1);
1785 result = SMB_VFS_NEXT_FSCTL(handle,
1786 fsp,
1787 ctx,
1788 function,
1789 req_flags,
1790 _in_data,
1791 in_len,
1792 _out_data,
1793 max_out_len,
1794 out_len);
1795 clock_gettime_mono(&ts2);
1796 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1798 if (timediff > audit_timeout) {
1799 smb_time_audit_log_fsp("fsctl", timediff, fsp);
1802 return result;
1805 static NTSTATUS smb_time_get_dos_attributes(struct vfs_handle_struct *handle,
1806 struct smb_filename *smb_fname,
1807 uint32_t *dosmode)
1809 NTSTATUS result;
1810 struct timespec ts1,ts2;
1811 double timediff;
1813 clock_gettime_mono(&ts1);
1814 result = SMB_VFS_NEXT_GET_DOS_ATTRIBUTES(handle,
1815 smb_fname,
1816 dosmode);
1817 clock_gettime_mono(&ts2);
1818 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1820 if (timediff > audit_timeout) {
1821 smb_time_audit_log_fname("get_dos_attributes",
1822 timediff,
1823 smb_fname->base_name);
1826 return result;
1829 static NTSTATUS smb_time_fget_dos_attributes(struct vfs_handle_struct *handle,
1830 struct files_struct *fsp,
1831 uint32_t *dosmode)
1833 NTSTATUS result;
1834 struct timespec ts1,ts2;
1835 double timediff;
1837 clock_gettime_mono(&ts1);
1838 result = SMB_VFS_NEXT_FGET_DOS_ATTRIBUTES(handle,
1839 fsp,
1840 dosmode);
1841 clock_gettime_mono(&ts2);
1842 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1844 if (timediff > audit_timeout) {
1845 smb_time_audit_log_fsp("fget_dos_attributes", timediff, fsp);
1848 return result;
1851 static NTSTATUS smb_time_set_dos_attributes(struct vfs_handle_struct *handle,
1852 const struct smb_filename *smb_fname,
1853 uint32_t dosmode)
1855 NTSTATUS result;
1856 struct timespec ts1,ts2;
1857 double timediff;
1859 clock_gettime_mono(&ts1);
1860 result = SMB_VFS_NEXT_SET_DOS_ATTRIBUTES(handle,
1861 smb_fname,
1862 dosmode);
1863 clock_gettime_mono(&ts2);
1864 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1866 if (timediff > audit_timeout) {
1867 smb_time_audit_log_fname("set_dos_attributes",
1868 timediff,
1869 smb_fname->base_name);
1872 return result;
1875 static NTSTATUS smb_time_fset_dos_attributes(struct vfs_handle_struct *handle,
1876 struct files_struct *fsp,
1877 uint32_t dosmode)
1879 NTSTATUS result;
1880 struct timespec ts1,ts2;
1881 double timediff;
1883 clock_gettime_mono(&ts1);
1884 result = SMB_VFS_NEXT_FSET_DOS_ATTRIBUTES(handle,
1885 fsp,
1886 dosmode);
1887 clock_gettime_mono(&ts2);
1888 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1890 if (timediff > audit_timeout) {
1891 smb_time_audit_log_fsp("fset_dos_attributes", timediff, fsp);
1894 return result;
1897 struct time_audit_cc_state {
1898 struct timespec ts_send;
1899 struct vfs_handle_struct *handle;
1900 off_t copied;
1902 static void smb_time_audit_copy_chunk_done(struct tevent_req *subreq);
1904 static struct tevent_req *smb_time_audit_copy_chunk_send(struct vfs_handle_struct *handle,
1905 TALLOC_CTX *mem_ctx,
1906 struct tevent_context *ev,
1907 struct files_struct *src_fsp,
1908 off_t src_off,
1909 struct files_struct *dest_fsp,
1910 off_t dest_off,
1911 off_t num,
1912 uint32_t flags)
1914 struct tevent_req *req;
1915 struct tevent_req *subreq;
1916 struct time_audit_cc_state *cc_state;
1918 req = tevent_req_create(mem_ctx, &cc_state, struct time_audit_cc_state);
1919 if (req == NULL) {
1920 return NULL;
1923 cc_state->handle = handle;
1924 clock_gettime_mono(&cc_state->ts_send);
1925 subreq = SMB_VFS_NEXT_COPY_CHUNK_SEND(handle, cc_state, ev,
1926 src_fsp, src_off,
1927 dest_fsp, dest_off, num, flags);
1928 if (tevent_req_nomem(subreq, req)) {
1929 return tevent_req_post(req, ev);
1932 tevent_req_set_callback(subreq, smb_time_audit_copy_chunk_done, req);
1933 return req;
1936 static void smb_time_audit_copy_chunk_done(struct tevent_req *subreq)
1938 struct tevent_req *req = tevent_req_callback_data(
1939 subreq, struct tevent_req);
1940 struct time_audit_cc_state *cc_state
1941 = tevent_req_data(req, struct time_audit_cc_state);
1942 NTSTATUS status;
1944 status = SMB_VFS_NEXT_COPY_CHUNK_RECV(cc_state->handle,
1945 subreq,
1946 &cc_state->copied);
1947 TALLOC_FREE(subreq);
1948 if (tevent_req_nterror(req, status)) {
1949 return;
1951 tevent_req_done(req);
1954 static NTSTATUS smb_time_audit_copy_chunk_recv(struct vfs_handle_struct *handle,
1955 struct tevent_req *req,
1956 off_t *copied)
1958 struct time_audit_cc_state *cc_state
1959 = tevent_req_data(req, struct time_audit_cc_state);
1960 struct timespec ts_recv;
1961 double timediff;
1962 NTSTATUS status;
1964 clock_gettime_mono(&ts_recv);
1965 timediff = nsec_time_diff(&ts_recv, &cc_state->ts_send)*1.0e-9;
1966 if (timediff > audit_timeout) {
1967 smb_time_audit_log("copy_chunk", timediff);
1970 *copied = cc_state->copied;
1971 if (tevent_req_is_nterror(req, &status)) {
1972 tevent_req_received(req);
1973 return status;
1976 tevent_req_received(req);
1977 return NT_STATUS_OK;
1980 static NTSTATUS smb_time_audit_get_compression(vfs_handle_struct *handle,
1981 TALLOC_CTX *mem_ctx,
1982 struct files_struct *fsp,
1983 struct smb_filename *smb_fname,
1984 uint16_t *_compression_fmt)
1986 NTSTATUS result;
1987 struct timespec ts1,ts2;
1988 double timediff;
1990 clock_gettime_mono(&ts1);
1991 result = SMB_VFS_NEXT_GET_COMPRESSION(handle, mem_ctx, fsp, smb_fname,
1992 _compression_fmt);
1993 clock_gettime_mono(&ts2);
1994 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
1996 if (timediff > audit_timeout) {
1997 if (fsp != NULL) {
1998 smb_time_audit_log_fsp("get_compression",
1999 timediff, fsp);
2000 } else {
2001 smb_time_audit_log_smb_fname("get_compression",
2002 timediff, smb_fname);
2006 return result;
2009 static NTSTATUS smb_time_audit_set_compression(vfs_handle_struct *handle,
2010 TALLOC_CTX *mem_ctx,
2011 struct files_struct *fsp,
2012 uint16_t compression_fmt)
2014 NTSTATUS result;
2015 struct timespec ts1,ts2;
2016 double timediff;
2018 clock_gettime_mono(&ts1);
2019 result = SMB_VFS_NEXT_SET_COMPRESSION(handle, mem_ctx, fsp,
2020 compression_fmt);
2021 clock_gettime_mono(&ts2);
2022 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2024 if (timediff > audit_timeout) {
2025 smb_time_audit_log_fsp("set_compression", timediff, fsp);
2028 return result;
2031 static NTSTATUS smb_time_audit_readdir_attr(struct vfs_handle_struct *handle,
2032 const struct smb_filename *fname,
2033 TALLOC_CTX *mem_ctx,
2034 struct readdir_attr_data **pattr_data)
2036 NTSTATUS status;
2037 struct timespec ts1,ts2;
2038 double timediff;
2040 clock_gettime_mono(&ts1);
2041 status = SMB_VFS_NEXT_READDIR_ATTR(handle, fname, mem_ctx, pattr_data);
2042 clock_gettime_mono(&ts2);
2043 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2045 if (timediff > audit_timeout) {
2046 smb_time_audit_log_smb_fname("readdir_attr", timediff, fname);
2049 return status;
2052 static NTSTATUS smb_time_audit_fget_nt_acl(vfs_handle_struct *handle,
2053 files_struct *fsp,
2054 uint32_t security_info,
2055 TALLOC_CTX *mem_ctx,
2056 struct security_descriptor **ppdesc)
2058 NTSTATUS result;
2059 struct timespec ts1,ts2;
2060 double timediff;
2062 clock_gettime_mono(&ts1);
2063 result = SMB_VFS_NEXT_FGET_NT_ACL(handle, fsp, security_info,
2064 mem_ctx, ppdesc);
2065 clock_gettime_mono(&ts2);
2066 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2068 if (timediff > audit_timeout) {
2069 smb_time_audit_log_fsp("fget_nt_acl", timediff, fsp);
2072 return result;
2075 static NTSTATUS smb_time_audit_get_nt_acl(vfs_handle_struct *handle,
2076 const struct smb_filename *smb_fname,
2077 uint32_t security_info,
2078 TALLOC_CTX *mem_ctx,
2079 struct security_descriptor **ppdesc)
2081 NTSTATUS result;
2082 struct timespec ts1,ts2;
2083 double timediff;
2085 clock_gettime_mono(&ts1);
2086 result = SMB_VFS_NEXT_GET_NT_ACL(handle, smb_fname, security_info,
2087 mem_ctx, ppdesc);
2088 clock_gettime_mono(&ts2);
2089 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2091 if (timediff > audit_timeout) {
2092 smb_time_audit_log_fname("get_nt_acl",
2093 timediff,
2094 smb_fname->base_name);
2097 return result;
2100 static NTSTATUS smb_time_audit_fset_nt_acl(vfs_handle_struct *handle,
2101 files_struct *fsp,
2102 uint32_t security_info_sent,
2103 const struct security_descriptor *psd)
2105 NTSTATUS result;
2106 struct timespec ts1,ts2;
2107 double timediff;
2109 clock_gettime_mono(&ts1);
2110 result = SMB_VFS_NEXT_FSET_NT_ACL(handle, fsp, security_info_sent,
2111 psd);
2112 clock_gettime_mono(&ts2);
2113 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2115 if (timediff > audit_timeout) {
2116 smb_time_audit_log_fsp("fset_nt_acl", timediff, fsp);
2119 return result;
2122 static NTSTATUS smb_time_audit_audit_file(struct vfs_handle_struct *handle,
2123 struct smb_filename *smb_fname,
2124 struct security_acl *sacl,
2125 uint32_t access_requested,
2126 uint32_t access_denied)
2128 NTSTATUS result;
2129 struct timespec ts1,ts2;
2130 double timediff;
2132 clock_gettime_mono(&ts1);
2133 result = SMB_VFS_NEXT_AUDIT_FILE(handle,
2134 smb_fname,
2135 sacl,
2136 access_requested,
2137 access_denied);
2138 clock_gettime_mono(&ts2);
2139 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2141 if (timediff > audit_timeout) {
2142 smb_time_audit_log_fname("audit_file",
2143 timediff,
2144 smb_fname->base_name);
2147 return result;
2152 static int smb_time_audit_chmod_acl(vfs_handle_struct *handle,
2153 const struct smb_filename *smb_fname,
2154 mode_t mode)
2156 int result;
2157 struct timespec ts1,ts2;
2158 double timediff;
2160 clock_gettime_mono(&ts1);
2161 result = SMB_VFS_NEXT_CHMOD_ACL(handle, smb_fname, mode);
2162 clock_gettime_mono(&ts2);
2163 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2165 if (timediff > audit_timeout) {
2166 smb_time_audit_log_fname("chmod_acl",
2167 timediff,
2168 smb_fname->base_name);
2171 return result;
2174 static int smb_time_audit_fchmod_acl(vfs_handle_struct *handle,
2175 files_struct *fsp, mode_t mode)
2177 int result;
2178 struct timespec ts1,ts2;
2179 double timediff;
2181 clock_gettime_mono(&ts1);
2182 result = SMB_VFS_NEXT_FCHMOD_ACL(handle, fsp, mode);
2183 clock_gettime_mono(&ts2);
2184 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2186 if (timediff > audit_timeout) {
2187 smb_time_audit_log_fsp("fchmod_acl", timediff, fsp);
2190 return result;
2193 static SMB_ACL_T smb_time_audit_sys_acl_get_file(vfs_handle_struct *handle,
2194 const struct smb_filename *smb_fname,
2195 SMB_ACL_TYPE_T type,
2196 TALLOC_CTX *mem_ctx)
2198 SMB_ACL_T result;
2199 struct timespec ts1,ts2;
2200 double timediff;
2202 clock_gettime_mono(&ts1);
2203 result = SMB_VFS_NEXT_SYS_ACL_GET_FILE(handle, smb_fname,
2204 type, mem_ctx);
2205 clock_gettime_mono(&ts2);
2206 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2208 if (timediff > audit_timeout) {
2209 smb_time_audit_log_fname("sys_acl_get_file", timediff,
2210 smb_fname->base_name);
2213 return result;
2216 static SMB_ACL_T smb_time_audit_sys_acl_get_fd(vfs_handle_struct *handle,
2217 files_struct *fsp,
2218 TALLOC_CTX *mem_ctx)
2220 SMB_ACL_T result;
2221 struct timespec ts1,ts2;
2222 double timediff;
2224 clock_gettime_mono(&ts1);
2225 result = SMB_VFS_NEXT_SYS_ACL_GET_FD(handle, fsp, mem_ctx);
2226 clock_gettime_mono(&ts2);
2227 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2229 if (timediff > audit_timeout) {
2230 smb_time_audit_log_fsp("sys_acl_get_fd", timediff, fsp);
2233 return result;
2237 static int smb_time_audit_sys_acl_blob_get_file(vfs_handle_struct *handle,
2238 const struct smb_filename *smb_fname,
2239 TALLOC_CTX *mem_ctx,
2240 char **blob_description,
2241 DATA_BLOB *blob)
2243 int result;
2244 struct timespec ts1,ts2;
2245 double timediff;
2247 clock_gettime_mono(&ts1);
2248 result = SMB_VFS_NEXT_SYS_ACL_BLOB_GET_FILE(handle, smb_fname,
2249 mem_ctx, blob_description, blob);
2250 clock_gettime_mono(&ts2);
2251 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2253 if (timediff > audit_timeout) {
2254 smb_time_audit_log("sys_acl_blob_get_file", timediff);
2257 return result;
2260 static int smb_time_audit_sys_acl_blob_get_fd(vfs_handle_struct *handle,
2261 files_struct *fsp,
2262 TALLOC_CTX *mem_ctx,
2263 char **blob_description,
2264 DATA_BLOB *blob)
2266 int result;
2267 struct timespec ts1,ts2;
2268 double timediff;
2270 clock_gettime_mono(&ts1);
2271 result = SMB_VFS_NEXT_SYS_ACL_BLOB_GET_FD(handle, fsp, mem_ctx, blob_description, blob);
2272 clock_gettime_mono(&ts2);
2273 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2275 if (timediff > audit_timeout) {
2276 smb_time_audit_log("sys_acl_blob_get_fd", timediff);
2279 return result;
2282 static int smb_time_audit_sys_acl_set_file(vfs_handle_struct *handle,
2283 const struct smb_filename *smb_fname,
2284 SMB_ACL_TYPE_T acltype,
2285 SMB_ACL_T theacl)
2287 int result;
2288 struct timespec ts1,ts2;
2289 double timediff;
2291 clock_gettime_mono(&ts1);
2292 result = SMB_VFS_NEXT_SYS_ACL_SET_FILE(handle, smb_fname, acltype,
2293 theacl);
2294 clock_gettime_mono(&ts2);
2295 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2297 if (timediff > audit_timeout) {
2298 smb_time_audit_log_fname("sys_acl_set_file", timediff,
2299 smb_fname->base_name);
2302 return result;
2305 static int smb_time_audit_sys_acl_set_fd(vfs_handle_struct *handle,
2306 files_struct *fsp,
2307 SMB_ACL_T theacl)
2309 int result;
2310 struct timespec ts1,ts2;
2311 double timediff;
2313 clock_gettime_mono(&ts1);
2314 result = SMB_VFS_NEXT_SYS_ACL_SET_FD(handle, fsp, theacl);
2315 clock_gettime_mono(&ts2);
2316 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2318 if (timediff > audit_timeout) {
2319 smb_time_audit_log_fsp("sys_acl_set_fd", timediff, fsp);
2322 return result;
2325 static int smb_time_audit_sys_acl_delete_def_file(vfs_handle_struct *handle,
2326 const struct smb_filename *smb_fname)
2328 int result;
2329 struct timespec ts1,ts2;
2330 double timediff;
2332 clock_gettime_mono(&ts1);
2333 result = SMB_VFS_NEXT_SYS_ACL_DELETE_DEF_FILE(handle, smb_fname);
2334 clock_gettime_mono(&ts2);
2335 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2337 if (timediff > audit_timeout) {
2338 smb_time_audit_log_fname("sys_acl_delete_def_file", timediff,
2339 smb_fname->base_name);
2342 return result;
2345 static ssize_t smb_time_audit_getxattr(struct vfs_handle_struct *handle,
2346 const struct smb_filename *smb_fname,
2347 const char *name,
2348 void *value,
2349 size_t size)
2351 ssize_t result;
2352 struct timespec ts1,ts2;
2353 double timediff;
2355 clock_gettime_mono(&ts1);
2356 result = SMB_VFS_NEXT_GETXATTR(handle, smb_fname, name, value, size);
2357 clock_gettime_mono(&ts2);
2358 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2360 if (timediff > audit_timeout) {
2361 smb_time_audit_log_fname("getxattr", timediff,
2362 smb_fname->base_name);
2365 return result;
2368 static ssize_t smb_time_audit_fgetxattr(struct vfs_handle_struct *handle,
2369 struct files_struct *fsp,
2370 const char *name, void *value,
2371 size_t size)
2373 ssize_t result;
2374 struct timespec ts1,ts2;
2375 double timediff;
2377 clock_gettime_mono(&ts1);
2378 result = SMB_VFS_NEXT_FGETXATTR(handle, fsp, name, value, size);
2379 clock_gettime_mono(&ts2);
2380 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2382 if (timediff > audit_timeout) {
2383 smb_time_audit_log_fsp("fgetxattr", timediff, fsp);
2386 return result;
2389 static ssize_t smb_time_audit_listxattr(struct vfs_handle_struct *handle,
2390 const struct smb_filename *smb_fname,
2391 char *list,
2392 size_t size)
2394 ssize_t result;
2395 struct timespec ts1,ts2;
2396 double timediff;
2398 clock_gettime_mono(&ts1);
2399 result = SMB_VFS_NEXT_LISTXATTR(handle, smb_fname, list, size);
2400 clock_gettime_mono(&ts2);
2401 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2403 if (timediff > audit_timeout) {
2404 smb_time_audit_log_fname("listxattr", timediff,
2405 smb_fname->base_name);
2408 return result;
2411 static ssize_t smb_time_audit_flistxattr(struct vfs_handle_struct *handle,
2412 struct files_struct *fsp, char *list,
2413 size_t size)
2415 ssize_t result;
2416 struct timespec ts1,ts2;
2417 double timediff;
2419 clock_gettime_mono(&ts1);
2420 result = SMB_VFS_NEXT_FLISTXATTR(handle, fsp, list, size);
2421 clock_gettime_mono(&ts2);
2422 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2424 if (timediff > audit_timeout) {
2425 smb_time_audit_log_fsp("flistxattr", timediff, fsp);
2428 return result;
2431 static int smb_time_audit_removexattr(struct vfs_handle_struct *handle,
2432 const struct smb_filename *smb_fname,
2433 const char *name)
2435 int result;
2436 struct timespec ts1,ts2;
2437 double timediff;
2439 clock_gettime_mono(&ts1);
2440 result = SMB_VFS_NEXT_REMOVEXATTR(handle, smb_fname, name);
2441 clock_gettime_mono(&ts2);
2442 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2444 if (timediff > audit_timeout) {
2445 smb_time_audit_log_fname("removexattr", timediff,
2446 smb_fname->base_name);
2449 return result;
2452 static int smb_time_audit_fremovexattr(struct vfs_handle_struct *handle,
2453 struct files_struct *fsp,
2454 const char *name)
2456 int result;
2457 struct timespec ts1,ts2;
2458 double timediff;
2460 clock_gettime_mono(&ts1);
2461 result = SMB_VFS_NEXT_FREMOVEXATTR(handle, fsp, name);
2462 clock_gettime_mono(&ts2);
2463 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2465 if (timediff > audit_timeout) {
2466 smb_time_audit_log_fsp("fremovexattr", timediff, fsp);
2469 return result;
2472 static int smb_time_audit_setxattr(struct vfs_handle_struct *handle,
2473 const struct smb_filename *smb_fname,
2474 const char *name,
2475 const void *value,
2476 size_t size,
2477 int flags)
2479 int result;
2480 struct timespec ts1,ts2;
2481 double timediff;
2483 clock_gettime_mono(&ts1);
2484 result = SMB_VFS_NEXT_SETXATTR(handle, smb_fname, name, value, size,
2485 flags);
2486 clock_gettime_mono(&ts2);
2487 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2489 if (timediff > audit_timeout) {
2490 smb_time_audit_log_fname("setxattr", timediff,
2491 smb_fname->base_name);
2494 return result;
2497 static int smb_time_audit_fsetxattr(struct vfs_handle_struct *handle,
2498 struct files_struct *fsp, const char *name,
2499 const void *value, size_t size, int flags)
2501 int result;
2502 struct timespec ts1,ts2;
2503 double timediff;
2505 clock_gettime_mono(&ts1);
2506 result = SMB_VFS_NEXT_FSETXATTR(handle, fsp, name, value, size, flags);
2507 clock_gettime_mono(&ts2);
2508 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2510 if (timediff > audit_timeout) {
2511 smb_time_audit_log_fsp("fsetxattr", timediff, fsp);
2514 return result;
2517 static bool smb_time_audit_aio_force(struct vfs_handle_struct *handle,
2518 struct files_struct *fsp)
2520 bool result;
2521 struct timespec ts1,ts2;
2522 double timediff;
2524 clock_gettime_mono(&ts1);
2525 result = SMB_VFS_NEXT_AIO_FORCE(handle, fsp);
2526 clock_gettime_mono(&ts2);
2527 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2529 if (timediff > audit_timeout) {
2530 smb_time_audit_log_fsp("aio_force", timediff, fsp);
2533 return result;
2536 static NTSTATUS smb_time_audit_durable_cookie(struct vfs_handle_struct *handle,
2537 struct files_struct *fsp,
2538 TALLOC_CTX *mem_ctx,
2539 DATA_BLOB *cookie)
2541 NTSTATUS result;
2542 struct timespec ts1,ts2;
2543 double timediff;
2545 clock_gettime_mono(&ts1);
2546 result = SMB_VFS_NEXT_DURABLE_COOKIE(handle, fsp, mem_ctx, cookie);
2547 clock_gettime_mono(&ts2);
2548 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2550 if (timediff > audit_timeout) {
2551 smb_time_audit_log_fsp("durable_cookie", timediff, fsp);
2554 return result;
2557 static NTSTATUS smb_time_audit_durable_disconnect(struct vfs_handle_struct *handle,
2558 struct files_struct *fsp,
2559 const DATA_BLOB old_cookie,
2560 TALLOC_CTX *mem_ctx,
2561 DATA_BLOB *new_cookie)
2563 NTSTATUS result;
2564 struct timespec ts1,ts2;
2565 double timediff;
2567 clock_gettime_mono(&ts1);
2568 result = SMB_VFS_NEXT_DURABLE_DISCONNECT(handle, fsp, old_cookie,
2569 mem_ctx, new_cookie);
2570 clock_gettime_mono(&ts2);
2571 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2573 if (timediff > audit_timeout) {
2574 smb_time_audit_log_fsp("durable_disconnect", timediff, fsp);
2577 return result;
2580 static NTSTATUS smb_time_audit_durable_reconnect(struct vfs_handle_struct *handle,
2581 struct smb_request *smb1req,
2582 struct smbXsrv_open *op,
2583 const DATA_BLOB old_cookie,
2584 TALLOC_CTX *mem_ctx,
2585 struct files_struct **fsp,
2586 DATA_BLOB *new_cookie)
2588 NTSTATUS result;
2589 struct timespec ts1,ts2;
2590 double timediff;
2592 clock_gettime_mono(&ts1);
2593 result = SMB_VFS_NEXT_DURABLE_RECONNECT(handle, smb1req, op, old_cookie,
2594 mem_ctx, fsp, new_cookie);
2595 clock_gettime_mono(&ts2);
2596 timediff = nsec_time_diff(&ts2,&ts1)*1.0e-9;
2598 if (timediff > audit_timeout) {
2599 smb_time_audit_log("durable_reconnect", timediff);
2602 return result;
2605 /* VFS operations */
2607 static struct vfs_fn_pointers vfs_time_audit_fns = {
2608 .connect_fn = smb_time_audit_connect,
2609 .disconnect_fn = smb_time_audit_disconnect,
2610 .disk_free_fn = smb_time_audit_disk_free,
2611 .get_quota_fn = smb_time_audit_get_quota,
2612 .set_quota_fn = smb_time_audit_set_quota,
2613 .get_shadow_copy_data_fn = smb_time_audit_get_shadow_copy_data,
2614 .statvfs_fn = smb_time_audit_statvfs,
2615 .fs_capabilities_fn = smb_time_audit_fs_capabilities,
2616 .get_dfs_referrals_fn = smb_time_audit_get_dfs_referrals,
2617 .opendir_fn = smb_time_audit_opendir,
2618 .fdopendir_fn = smb_time_audit_fdopendir,
2619 .readdir_fn = smb_time_audit_readdir,
2620 .seekdir_fn = smb_time_audit_seekdir,
2621 .telldir_fn = smb_time_audit_telldir,
2622 .rewind_dir_fn = smb_time_audit_rewinddir,
2623 .mkdir_fn = smb_time_audit_mkdir,
2624 .rmdir_fn = smb_time_audit_rmdir,
2625 .closedir_fn = smb_time_audit_closedir,
2626 .init_search_op_fn = smb_time_audit_init_search_op,
2627 .open_fn = smb_time_audit_open,
2628 .create_file_fn = smb_time_audit_create_file,
2629 .close_fn = smb_time_audit_close,
2630 .read_fn = smb_time_audit_read,
2631 .pread_fn = smb_time_audit_pread,
2632 .pread_send_fn = smb_time_audit_pread_send,
2633 .pread_recv_fn = smb_time_audit_pread_recv,
2634 .write_fn = smb_time_audit_write,
2635 .pwrite_fn = smb_time_audit_pwrite,
2636 .pwrite_send_fn = smb_time_audit_pwrite_send,
2637 .pwrite_recv_fn = smb_time_audit_pwrite_recv,
2638 .lseek_fn = smb_time_audit_lseek,
2639 .sendfile_fn = smb_time_audit_sendfile,
2640 .recvfile_fn = smb_time_audit_recvfile,
2641 .rename_fn = smb_time_audit_rename,
2642 .fsync_fn = smb_time_audit_fsync,
2643 .fsync_send_fn = smb_time_audit_fsync_send,
2644 .fsync_recv_fn = smb_time_audit_fsync_recv,
2645 .stat_fn = smb_time_audit_stat,
2646 .fstat_fn = smb_time_audit_fstat,
2647 .lstat_fn = smb_time_audit_lstat,
2648 .get_alloc_size_fn = smb_time_audit_get_alloc_size,
2649 .unlink_fn = smb_time_audit_unlink,
2650 .chmod_fn = smb_time_audit_chmod,
2651 .fchmod_fn = smb_time_audit_fchmod,
2652 .chown_fn = smb_time_audit_chown,
2653 .fchown_fn = smb_time_audit_fchown,
2654 .lchown_fn = smb_time_audit_lchown,
2655 .chdir_fn = smb_time_audit_chdir,
2656 .getwd_fn = smb_time_audit_getwd,
2657 .ntimes_fn = smb_time_audit_ntimes,
2658 .ftruncate_fn = smb_time_audit_ftruncate,
2659 .fallocate_fn = smb_time_audit_fallocate,
2660 .lock_fn = smb_time_audit_lock,
2661 .kernel_flock_fn = smb_time_audit_kernel_flock,
2662 .linux_setlease_fn = smb_time_audit_linux_setlease,
2663 .getlock_fn = smb_time_audit_getlock,
2664 .symlink_fn = smb_time_audit_symlink,
2665 .readlink_fn = smb_time_audit_readlink,
2666 .link_fn = smb_time_audit_link,
2667 .mknod_fn = smb_time_audit_mknod,
2668 .realpath_fn = smb_time_audit_realpath,
2669 .chflags_fn = smb_time_audit_chflags,
2670 .file_id_create_fn = smb_time_audit_file_id_create,
2671 .copy_chunk_send_fn = smb_time_audit_copy_chunk_send,
2672 .copy_chunk_recv_fn = smb_time_audit_copy_chunk_recv,
2673 .get_compression_fn = smb_time_audit_get_compression,
2674 .set_compression_fn = smb_time_audit_set_compression,
2675 .snap_check_path_fn = smb_time_audit_snap_check_path,
2676 .snap_create_fn = smb_time_audit_snap_create,
2677 .snap_delete_fn = smb_time_audit_snap_delete,
2678 .streaminfo_fn = smb_time_audit_streaminfo,
2679 .get_real_filename_fn = smb_time_audit_get_real_filename,
2680 .connectpath_fn = smb_time_audit_connectpath,
2681 .brl_lock_windows_fn = smb_time_audit_brl_lock_windows,
2682 .brl_unlock_windows_fn = smb_time_audit_brl_unlock_windows,
2683 .brl_cancel_windows_fn = smb_time_audit_brl_cancel_windows,
2684 .strict_lock_fn = smb_time_audit_strict_lock,
2685 .strict_unlock_fn = smb_time_audit_strict_unlock,
2686 .translate_name_fn = smb_time_audit_translate_name,
2687 .fsctl_fn = smb_time_audit_fsctl,
2688 .get_dos_attributes_fn = smb_time_get_dos_attributes,
2689 .fget_dos_attributes_fn = smb_time_fget_dos_attributes,
2690 .set_dos_attributes_fn = smb_time_set_dos_attributes,
2691 .fset_dos_attributes_fn = smb_time_fset_dos_attributes,
2692 .fget_nt_acl_fn = smb_time_audit_fget_nt_acl,
2693 .get_nt_acl_fn = smb_time_audit_get_nt_acl,
2694 .fset_nt_acl_fn = smb_time_audit_fset_nt_acl,
2695 .audit_file_fn = smb_time_audit_audit_file,
2696 .chmod_acl_fn = smb_time_audit_chmod_acl,
2697 .fchmod_acl_fn = smb_time_audit_fchmod_acl,
2698 .sys_acl_get_file_fn = smb_time_audit_sys_acl_get_file,
2699 .sys_acl_get_fd_fn = smb_time_audit_sys_acl_get_fd,
2700 .sys_acl_blob_get_file_fn = smb_time_audit_sys_acl_blob_get_file,
2701 .sys_acl_blob_get_fd_fn = smb_time_audit_sys_acl_blob_get_fd,
2702 .sys_acl_set_file_fn = smb_time_audit_sys_acl_set_file,
2703 .sys_acl_set_fd_fn = smb_time_audit_sys_acl_set_fd,
2704 .sys_acl_delete_def_file_fn = smb_time_audit_sys_acl_delete_def_file,
2705 .getxattr_fn = smb_time_audit_getxattr,
2706 .fgetxattr_fn = smb_time_audit_fgetxattr,
2707 .listxattr_fn = smb_time_audit_listxattr,
2708 .flistxattr_fn = smb_time_audit_flistxattr,
2709 .removexattr_fn = smb_time_audit_removexattr,
2710 .fremovexattr_fn = smb_time_audit_fremovexattr,
2711 .setxattr_fn = smb_time_audit_setxattr,
2712 .fsetxattr_fn = smb_time_audit_fsetxattr,
2713 .aio_force_fn = smb_time_audit_aio_force,
2714 .durable_cookie_fn = smb_time_audit_durable_cookie,
2715 .durable_disconnect_fn = smb_time_audit_durable_disconnect,
2716 .durable_reconnect_fn = smb_time_audit_durable_reconnect,
2717 .readdir_attr_fn = smb_time_audit_readdir_attr,
2721 NTSTATUS vfs_time_audit_init(TALLOC_CTX *);
2722 NTSTATUS vfs_time_audit_init(TALLOC_CTX *ctx)
2724 smb_vfs_assert_all_fns(&vfs_time_audit_fns, "time_audit");
2726 audit_timeout = (double)lp_parm_int(-1, "time_audit", "timeout",
2727 10000) / 1000.0;
2728 return smb_register_vfs(SMB_VFS_INTERFACE_VERSION, "time_audit",
2729 &vfs_time_audit_fns);