xref: /openbmc/linux/fs/nfsd/trace.h (revision 65294c1f)
1b2441318SGreg Kroah-Hartman /* SPDX-License-Identifier: GPL-2.0 */
231ef83dcSChristoph Hellwig /*
331ef83dcSChristoph Hellwig  * Copyright (c) 2014 Christoph Hellwig.
431ef83dcSChristoph Hellwig  */
531ef83dcSChristoph Hellwig #undef TRACE_SYSTEM
631ef83dcSChristoph Hellwig #define TRACE_SYSTEM nfsd
731ef83dcSChristoph Hellwig 
831ef83dcSChristoph Hellwig #if !defined(_NFSD_TRACE_H) || defined(TRACE_HEADER_MULTI_READ)
931ef83dcSChristoph Hellwig #define _NFSD_TRACE_H
1031ef83dcSChristoph Hellwig 
1131ef83dcSChristoph Hellwig #include <linux/tracepoint.h>
126e8b50d1SJeff Layton #include "nfsfh.h"
136e8b50d1SJeff Layton 
14fff4080bSChuck Lever TRACE_EVENT(nfsd_compound,
15fff4080bSChuck Lever 	TP_PROTO(const struct svc_rqst *rqst,
16fff4080bSChuck Lever 		 u32 args_opcnt),
17fff4080bSChuck Lever 	TP_ARGS(rqst, args_opcnt),
18fff4080bSChuck Lever 	TP_STRUCT__entry(
19fff4080bSChuck Lever 		__field(u32, xid)
20fff4080bSChuck Lever 		__field(u32, args_opcnt)
21fff4080bSChuck Lever 	),
22fff4080bSChuck Lever 	TP_fast_assign(
23fff4080bSChuck Lever 		__entry->xid = be32_to_cpu(rqst->rq_xid);
24fff4080bSChuck Lever 		__entry->args_opcnt = args_opcnt;
25fff4080bSChuck Lever 	),
26fff4080bSChuck Lever 	TP_printk("xid=0x%08x opcnt=%u",
27fff4080bSChuck Lever 		__entry->xid, __entry->args_opcnt)
28fff4080bSChuck Lever )
29fff4080bSChuck Lever 
30fff4080bSChuck Lever TRACE_EVENT(nfsd_compound_status,
31fff4080bSChuck Lever 	TP_PROTO(u32 args_opcnt,
32fff4080bSChuck Lever 		 u32 resp_opcnt,
33fff4080bSChuck Lever 		 __be32 status,
34fff4080bSChuck Lever 		 const char *name),
35fff4080bSChuck Lever 	TP_ARGS(args_opcnt, resp_opcnt, status, name),
36fff4080bSChuck Lever 	TP_STRUCT__entry(
37fff4080bSChuck Lever 		__field(u32, args_opcnt)
38fff4080bSChuck Lever 		__field(u32, resp_opcnt)
39fff4080bSChuck Lever 		__field(int, status)
40fff4080bSChuck Lever 		__string(name, name)
41fff4080bSChuck Lever 	),
42fff4080bSChuck Lever 	TP_fast_assign(
43fff4080bSChuck Lever 		__entry->args_opcnt = args_opcnt;
44fff4080bSChuck Lever 		__entry->resp_opcnt = resp_opcnt;
45fff4080bSChuck Lever 		__entry->status = be32_to_cpu(status);
46fff4080bSChuck Lever 		__assign_str(name, name);
47fff4080bSChuck Lever 	),
48fff4080bSChuck Lever 	TP_printk("op=%u/%u %s status=%d",
49fff4080bSChuck Lever 		__entry->resp_opcnt, __entry->args_opcnt,
50fff4080bSChuck Lever 		__get_str(name), __entry->status)
51fff4080bSChuck Lever )
52fff4080bSChuck Lever 
536e8b50d1SJeff Layton DECLARE_EVENT_CLASS(nfsd_io_class,
546e8b50d1SJeff Layton 	TP_PROTO(struct svc_rqst *rqstp,
556e8b50d1SJeff Layton 		 struct svc_fh	*fhp,
566e8b50d1SJeff Layton 		 loff_t		offset,
5779e0b4e2SChuck Lever 		 unsigned long	len),
586e8b50d1SJeff Layton 	TP_ARGS(rqstp, fhp, offset, len),
596e8b50d1SJeff Layton 	TP_STRUCT__entry(
60afa720a0SChuck Lever 		__field(u32, xid)
61afa720a0SChuck Lever 		__field(u32, fh_hash)
626e8b50d1SJeff Layton 		__field(loff_t, offset)
6379e0b4e2SChuck Lever 		__field(unsigned long, len)
646e8b50d1SJeff Layton 	),
656e8b50d1SJeff Layton 	TP_fast_assign(
66afa720a0SChuck Lever 		__entry->xid = be32_to_cpu(rqstp->rq_xid);
6779e0b4e2SChuck Lever 		__entry->fh_hash = knfsd_fh_hash(&fhp->fh_handle);
686e8b50d1SJeff Layton 		__entry->offset = offset;
696e8b50d1SJeff Layton 		__entry->len = len;
706e8b50d1SJeff Layton 	),
7179e0b4e2SChuck Lever 	TP_printk("xid=0x%08x fh_hash=0x%08x offset=%lld len=%lu",
72afa720a0SChuck Lever 		  __entry->xid, __entry->fh_hash,
736e8b50d1SJeff Layton 		  __entry->offset, __entry->len)
746e8b50d1SJeff Layton )
756e8b50d1SJeff Layton 
766e8b50d1SJeff Layton #define DEFINE_NFSD_IO_EVENT(name)		\
77f394b62bSChuck Lever DEFINE_EVENT(nfsd_io_class, nfsd_##name,	\
786e8b50d1SJeff Layton 	TP_PROTO(struct svc_rqst *rqstp,	\
796e8b50d1SJeff Layton 		 struct svc_fh	*fhp,		\
806e8b50d1SJeff Layton 		 loff_t		offset,		\
8179e0b4e2SChuck Lever 		 unsigned long	len),		\
826e8b50d1SJeff Layton 	TP_ARGS(rqstp, fhp, offset, len))
836e8b50d1SJeff Layton 
846e8b50d1SJeff Layton DEFINE_NFSD_IO_EVENT(read_start);
8587c5942eSChuck Lever DEFINE_NFSD_IO_EVENT(read_splice);
8687c5942eSChuck Lever DEFINE_NFSD_IO_EVENT(read_vector);
876e8b50d1SJeff Layton DEFINE_NFSD_IO_EVENT(read_io_done);
886e8b50d1SJeff Layton DEFINE_NFSD_IO_EVENT(read_done);
896e8b50d1SJeff Layton DEFINE_NFSD_IO_EVENT(write_start);
906e8b50d1SJeff Layton DEFINE_NFSD_IO_EVENT(write_opened);
916e8b50d1SJeff Layton DEFINE_NFSD_IO_EVENT(write_io_done);
926e8b50d1SJeff Layton DEFINE_NFSD_IO_EVENT(write_done);
9331ef83dcSChristoph Hellwig 
94d890be15SChuck Lever DECLARE_EVENT_CLASS(nfsd_err_class,
95d890be15SChuck Lever 	TP_PROTO(struct svc_rqst *rqstp,
96d890be15SChuck Lever 		 struct svc_fh	*fhp,
97d890be15SChuck Lever 		 loff_t		offset,
98d890be15SChuck Lever 		 int		status),
99d890be15SChuck Lever 	TP_ARGS(rqstp, fhp, offset, status),
100d890be15SChuck Lever 	TP_STRUCT__entry(
101d890be15SChuck Lever 		__field(u32, xid)
102d890be15SChuck Lever 		__field(u32, fh_hash)
103d890be15SChuck Lever 		__field(loff_t, offset)
104d890be15SChuck Lever 		__field(int, status)
105d890be15SChuck Lever 	),
106d890be15SChuck Lever 	TP_fast_assign(
107d890be15SChuck Lever 		__entry->xid = be32_to_cpu(rqstp->rq_xid);
108d890be15SChuck Lever 		__entry->fh_hash = knfsd_fh_hash(&fhp->fh_handle);
109d890be15SChuck Lever 		__entry->offset = offset;
110d890be15SChuck Lever 		__entry->status = status;
111d890be15SChuck Lever 	),
112d890be15SChuck Lever 	TP_printk("xid=0x%08x fh_hash=0x%08x offset=%lld status=%d",
113d890be15SChuck Lever 		  __entry->xid, __entry->fh_hash,
114d890be15SChuck Lever 		  __entry->offset, __entry->status)
115d890be15SChuck Lever )
116d890be15SChuck Lever 
117d890be15SChuck Lever #define DEFINE_NFSD_ERR_EVENT(name)		\
118d890be15SChuck Lever DEFINE_EVENT(nfsd_err_class, nfsd_##name,	\
119d890be15SChuck Lever 	TP_PROTO(struct svc_rqst *rqstp,	\
120d890be15SChuck Lever 		 struct svc_fh	*fhp,		\
121d890be15SChuck Lever 		 loff_t		offset,		\
122d890be15SChuck Lever 		 int		len),		\
123d890be15SChuck Lever 	TP_ARGS(rqstp, fhp, offset, len))
124d890be15SChuck Lever 
12587c5942eSChuck Lever DEFINE_NFSD_ERR_EVENT(read_err);
126d890be15SChuck Lever DEFINE_NFSD_ERR_EVENT(write_err);
127d890be15SChuck Lever 
128825213e5SJeff Layton #include "state.h"
12965294c1fSJeff Layton #include "filecache.h"
13065294c1fSJeff Layton #include "vfs.h"
131825213e5SJeff Layton 
13231ef83dcSChristoph Hellwig DECLARE_EVENT_CLASS(nfsd_stateid_class,
13331ef83dcSChristoph Hellwig 	TP_PROTO(stateid_t *stp),
13431ef83dcSChristoph Hellwig 	TP_ARGS(stp),
13531ef83dcSChristoph Hellwig 	TP_STRUCT__entry(
13631ef83dcSChristoph Hellwig 		__field(u32, cl_boot)
13731ef83dcSChristoph Hellwig 		__field(u32, cl_id)
13831ef83dcSChristoph Hellwig 		__field(u32, si_id)
13931ef83dcSChristoph Hellwig 		__field(u32, si_generation)
14031ef83dcSChristoph Hellwig 	),
14131ef83dcSChristoph Hellwig 	TP_fast_assign(
14231ef83dcSChristoph Hellwig 		__entry->cl_boot = stp->si_opaque.so_clid.cl_boot;
14331ef83dcSChristoph Hellwig 		__entry->cl_id = stp->si_opaque.so_clid.cl_id;
14431ef83dcSChristoph Hellwig 		__entry->si_id = stp->si_opaque.so_id;
14531ef83dcSChristoph Hellwig 		__entry->si_generation = stp->si_generation;
14631ef83dcSChristoph Hellwig 	),
14731ef83dcSChristoph Hellwig 	TP_printk("client %08x:%08x stateid %08x:%08x",
14831ef83dcSChristoph Hellwig 		__entry->cl_boot,
14931ef83dcSChristoph Hellwig 		__entry->cl_id,
15031ef83dcSChristoph Hellwig 		__entry->si_id,
15131ef83dcSChristoph Hellwig 		__entry->si_generation)
15231ef83dcSChristoph Hellwig )
15331ef83dcSChristoph Hellwig 
15431ef83dcSChristoph Hellwig #define DEFINE_STATEID_EVENT(name) \
155f394b62bSChuck Lever DEFINE_EVENT(nfsd_stateid_class, nfsd_##name, \
15631ef83dcSChristoph Hellwig 	TP_PROTO(stateid_t *stp), \
15731ef83dcSChristoph Hellwig 	TP_ARGS(stp))
15831ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layoutstate_alloc);
15931ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layoutstate_unhash);
16031ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layoutstate_free);
16131ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layout_get_lookup_fail);
16231ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layout_commit_lookup_fail);
16331ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layout_return_lookup_fail);
16431ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layout_recall);
16531ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layout_recall_done);
16631ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layout_recall_fail);
16731ef83dcSChristoph Hellwig DEFINE_STATEID_EVENT(layout_recall_release);
16831ef83dcSChristoph Hellwig 
16965294c1fSJeff Layton #define show_nf_flags(val)						\
17065294c1fSJeff Layton 	__print_flags(val, "|",						\
17165294c1fSJeff Layton 		{ 1 << NFSD_FILE_HASHED,	"HASHED" },		\
17265294c1fSJeff Layton 		{ 1 << NFSD_FILE_PENDING,	"PENDING" },		\
17365294c1fSJeff Layton 		{ 1 << NFSD_FILE_BREAK_READ,	"BREAK_READ" },		\
17465294c1fSJeff Layton 		{ 1 << NFSD_FILE_BREAK_WRITE,	"BREAK_WRITE" },	\
17565294c1fSJeff Layton 		{ 1 << NFSD_FILE_REFERENCED,	"REFERENCED"})
17665294c1fSJeff Layton 
17765294c1fSJeff Layton /* FIXME: This should probably be fleshed out in the future. */
17865294c1fSJeff Layton #define show_nf_may(val)						\
17965294c1fSJeff Layton 	__print_flags(val, "|",						\
18065294c1fSJeff Layton 		{ NFSD_MAY_READ,		"READ" },		\
18165294c1fSJeff Layton 		{ NFSD_MAY_WRITE,		"WRITE" },		\
18265294c1fSJeff Layton 		{ NFSD_MAY_NOT_BREAK_LEASE,	"NOT_BREAK_LEASE" })
18365294c1fSJeff Layton 
18465294c1fSJeff Layton DECLARE_EVENT_CLASS(nfsd_file_class,
18565294c1fSJeff Layton 	TP_PROTO(struct nfsd_file *nf),
18665294c1fSJeff Layton 	TP_ARGS(nf),
18765294c1fSJeff Layton 	TP_STRUCT__entry(
18865294c1fSJeff Layton 		__field(unsigned int, nf_hashval)
18965294c1fSJeff Layton 		__field(void *, nf_inode)
19065294c1fSJeff Layton 		__field(int, nf_ref)
19165294c1fSJeff Layton 		__field(unsigned long, nf_flags)
19265294c1fSJeff Layton 		__field(unsigned char, nf_may)
19365294c1fSJeff Layton 		__field(struct file *, nf_file)
19465294c1fSJeff Layton 	),
19565294c1fSJeff Layton 	TP_fast_assign(
19665294c1fSJeff Layton 		__entry->nf_hashval = nf->nf_hashval;
19765294c1fSJeff Layton 		__entry->nf_inode = nf->nf_inode;
19865294c1fSJeff Layton 		__entry->nf_ref = atomic_read(&nf->nf_ref);
19965294c1fSJeff Layton 		__entry->nf_flags = nf->nf_flags;
20065294c1fSJeff Layton 		__entry->nf_may = nf->nf_may;
20165294c1fSJeff Layton 		__entry->nf_file = nf->nf_file;
20265294c1fSJeff Layton 	),
20365294c1fSJeff Layton 	TP_printk("hash=0x%x inode=0x%p ref=%d flags=%s may=%s file=%p",
20465294c1fSJeff Layton 		__entry->nf_hashval,
20565294c1fSJeff Layton 		__entry->nf_inode,
20665294c1fSJeff Layton 		__entry->nf_ref,
20765294c1fSJeff Layton 		show_nf_flags(__entry->nf_flags),
20865294c1fSJeff Layton 		show_nf_may(__entry->nf_may),
20965294c1fSJeff Layton 		__entry->nf_file)
21065294c1fSJeff Layton )
21165294c1fSJeff Layton 
21265294c1fSJeff Layton #define DEFINE_NFSD_FILE_EVENT(name) \
21365294c1fSJeff Layton DEFINE_EVENT(nfsd_file_class, name, \
21465294c1fSJeff Layton 	TP_PROTO(struct nfsd_file *nf), \
21565294c1fSJeff Layton 	TP_ARGS(nf))
21665294c1fSJeff Layton 
21765294c1fSJeff Layton DEFINE_NFSD_FILE_EVENT(nfsd_file_alloc);
21865294c1fSJeff Layton DEFINE_NFSD_FILE_EVENT(nfsd_file_put_final);
21965294c1fSJeff Layton DEFINE_NFSD_FILE_EVENT(nfsd_file_unhash);
22065294c1fSJeff Layton DEFINE_NFSD_FILE_EVENT(nfsd_file_put);
22165294c1fSJeff Layton DEFINE_NFSD_FILE_EVENT(nfsd_file_unhash_and_release_locked);
22265294c1fSJeff Layton 
22365294c1fSJeff Layton TRACE_EVENT(nfsd_file_acquire,
22465294c1fSJeff Layton 	TP_PROTO(struct svc_rqst *rqstp, unsigned int hash,
22565294c1fSJeff Layton 		 struct inode *inode, unsigned int may_flags,
22665294c1fSJeff Layton 		 struct nfsd_file *nf, __be32 status),
22765294c1fSJeff Layton 
22865294c1fSJeff Layton 	TP_ARGS(rqstp, hash, inode, may_flags, nf, status),
22965294c1fSJeff Layton 
23065294c1fSJeff Layton 	TP_STRUCT__entry(
23165294c1fSJeff Layton 		__field(__be32, xid)
23265294c1fSJeff Layton 		__field(unsigned int, hash)
23365294c1fSJeff Layton 		__field(void *, inode)
23465294c1fSJeff Layton 		__field(unsigned int, may_flags)
23565294c1fSJeff Layton 		__field(int, nf_ref)
23665294c1fSJeff Layton 		__field(unsigned long, nf_flags)
23765294c1fSJeff Layton 		__field(unsigned char, nf_may)
23865294c1fSJeff Layton 		__field(struct file *, nf_file)
23965294c1fSJeff Layton 		__field(__be32, status)
24065294c1fSJeff Layton 	),
24165294c1fSJeff Layton 
24265294c1fSJeff Layton 	TP_fast_assign(
24365294c1fSJeff Layton 		__entry->xid = rqstp->rq_xid;
24465294c1fSJeff Layton 		__entry->hash = hash;
24565294c1fSJeff Layton 		__entry->inode = inode;
24665294c1fSJeff Layton 		__entry->may_flags = may_flags;
24765294c1fSJeff Layton 		__entry->nf_ref = nf ? atomic_read(&nf->nf_ref) : 0;
24865294c1fSJeff Layton 		__entry->nf_flags = nf ? nf->nf_flags : 0;
24965294c1fSJeff Layton 		__entry->nf_may = nf ? nf->nf_may : 0;
25065294c1fSJeff Layton 		__entry->nf_file = nf ? nf->nf_file : NULL;
25165294c1fSJeff Layton 		__entry->status = status;
25265294c1fSJeff Layton 	),
25365294c1fSJeff Layton 
25465294c1fSJeff Layton 	TP_printk("xid=0x%x hash=0x%x inode=0x%p may_flags=%s ref=%d nf_flags=%s nf_may=%s nf_file=0x%p status=%u",
25565294c1fSJeff Layton 			be32_to_cpu(__entry->xid), __entry->hash, __entry->inode,
25665294c1fSJeff Layton 			show_nf_may(__entry->may_flags), __entry->nf_ref,
25765294c1fSJeff Layton 			show_nf_flags(__entry->nf_flags),
25865294c1fSJeff Layton 			show_nf_may(__entry->nf_may), __entry->nf_file,
25965294c1fSJeff Layton 			be32_to_cpu(__entry->status))
26065294c1fSJeff Layton );
26165294c1fSJeff Layton 
26265294c1fSJeff Layton DECLARE_EVENT_CLASS(nfsd_file_search_class,
26365294c1fSJeff Layton 	TP_PROTO(struct inode *inode, unsigned int hash, int found),
26465294c1fSJeff Layton 	TP_ARGS(inode, hash, found),
26565294c1fSJeff Layton 	TP_STRUCT__entry(
26665294c1fSJeff Layton 		__field(struct inode *, inode)
26765294c1fSJeff Layton 		__field(unsigned int, hash)
26865294c1fSJeff Layton 		__field(int, found)
26965294c1fSJeff Layton 	),
27065294c1fSJeff Layton 	TP_fast_assign(
27165294c1fSJeff Layton 		__entry->inode = inode;
27265294c1fSJeff Layton 		__entry->hash = hash;
27365294c1fSJeff Layton 		__entry->found = found;
27465294c1fSJeff Layton 	),
27565294c1fSJeff Layton 	TP_printk("hash=0x%x inode=0x%p found=%d", __entry->hash,
27665294c1fSJeff Layton 			__entry->inode, __entry->found)
27765294c1fSJeff Layton );
27865294c1fSJeff Layton 
27965294c1fSJeff Layton #define DEFINE_NFSD_FILE_SEARCH_EVENT(name)				\
28065294c1fSJeff Layton DEFINE_EVENT(nfsd_file_search_class, name,				\
28165294c1fSJeff Layton 	TP_PROTO(struct inode *inode, unsigned int hash, int found),	\
28265294c1fSJeff Layton 	TP_ARGS(inode, hash, found))
28365294c1fSJeff Layton 
28465294c1fSJeff Layton DEFINE_NFSD_FILE_SEARCH_EVENT(nfsd_file_close_inode_sync);
28565294c1fSJeff Layton DEFINE_NFSD_FILE_SEARCH_EVENT(nfsd_file_close_inode);
28665294c1fSJeff Layton DEFINE_NFSD_FILE_SEARCH_EVENT(nfsd_file_is_cached);
28765294c1fSJeff Layton 
28865294c1fSJeff Layton TRACE_EVENT(nfsd_file_fsnotify_handle_event,
28965294c1fSJeff Layton 	TP_PROTO(struct inode *inode, u32 mask),
29065294c1fSJeff Layton 	TP_ARGS(inode, mask),
29165294c1fSJeff Layton 	TP_STRUCT__entry(
29265294c1fSJeff Layton 		__field(struct inode *, inode)
29365294c1fSJeff Layton 		__field(unsigned int, nlink)
29465294c1fSJeff Layton 		__field(umode_t, mode)
29565294c1fSJeff Layton 		__field(u32, mask)
29665294c1fSJeff Layton 	),
29765294c1fSJeff Layton 	TP_fast_assign(
29865294c1fSJeff Layton 		__entry->inode = inode;
29965294c1fSJeff Layton 		__entry->nlink = inode->i_nlink;
30065294c1fSJeff Layton 		__entry->mode = inode->i_mode;
30165294c1fSJeff Layton 		__entry->mask = mask;
30265294c1fSJeff Layton 	),
30365294c1fSJeff Layton 	TP_printk("inode=0x%p nlink=%u mode=0%ho mask=0x%x", __entry->inode,
30465294c1fSJeff Layton 			__entry->nlink, __entry->mode, __entry->mask)
30565294c1fSJeff Layton );
30665294c1fSJeff Layton 
30731ef83dcSChristoph Hellwig #endif /* _NFSD_TRACE_H */
30831ef83dcSChristoph Hellwig 
30931ef83dcSChristoph Hellwig #undef TRACE_INCLUDE_PATH
31031ef83dcSChristoph Hellwig #define TRACE_INCLUDE_PATH .
31131ef83dcSChristoph Hellwig #define TRACE_INCLUDE_FILE trace
31231ef83dcSChristoph Hellwig #include <trace/define_trace.h>
313