]>
Commit | Line | Data |
---|---|---|
b2441318 | 1 | /* SPDX-License-Identifier: GPL-2.0 */ |
82b0a4c3 TM |
2 | #undef TRACE_SYSTEM |
3 | #define TRACE_SYSTEM sunrpc | |
4 | ||
5 | #if !defined(_TRACE_SUNRPC_H) || defined(TRACE_HEADER_MULTI_READ) | |
6 | #define _TRACE_SUNRPC_H | |
7 | ||
8 | #include <linux/sunrpc/sched.h> | |
9 | #include <linux/sunrpc/clnt.h> | |
860a0d9e | 10 | #include <linux/sunrpc/svc.h> |
1a867a08 | 11 | #include <linux/sunrpc/xprtsock.h> |
83a712e0 | 12 | #include <linux/sunrpc/svc_xprt.h> |
40b5ea0c TM |
13 | #include <net/tcp_states.h> |
14 | #include <linux/net.h> | |
82b0a4c3 TM |
15 | #include <linux/tracepoint.h> |
16 | ||
998024de CL |
17 | TRACE_DEFINE_ENUM(SOCK_STREAM); |
18 | TRACE_DEFINE_ENUM(SOCK_DGRAM); | |
19 | TRACE_DEFINE_ENUM(SOCK_RAW); | |
20 | TRACE_DEFINE_ENUM(SOCK_RDM); | |
21 | TRACE_DEFINE_ENUM(SOCK_SEQPACKET); | |
22 | TRACE_DEFINE_ENUM(SOCK_DCCP); | |
23 | TRACE_DEFINE_ENUM(SOCK_PACKET); | |
24 | ||
25 | #define show_socket_type(type) \ | |
26 | __print_symbolic(type, \ | |
27 | { SOCK_STREAM, "STREAM" }, \ | |
28 | { SOCK_DGRAM, "DGRAM" }, \ | |
29 | { SOCK_RAW, "RAW" }, \ | |
30 | { SOCK_RDM, "RDM" }, \ | |
31 | { SOCK_SEQPACKET, "SEQPACKET" }, \ | |
32 | { SOCK_DCCP, "DCCP" }, \ | |
33 | { SOCK_PACKET, "PACKET" }) | |
34 | ||
35 | /* This list is known to be incomplete, add new enums as needed. */ | |
36 | TRACE_DEFINE_ENUM(AF_UNSPEC); | |
37 | TRACE_DEFINE_ENUM(AF_UNIX); | |
38 | TRACE_DEFINE_ENUM(AF_LOCAL); | |
39 | TRACE_DEFINE_ENUM(AF_INET); | |
40 | TRACE_DEFINE_ENUM(AF_INET6); | |
41 | ||
42 | #define rpc_show_address_family(family) \ | |
43 | __print_symbolic(family, \ | |
44 | { AF_UNSPEC, "AF_UNSPEC" }, \ | |
45 | { AF_UNIX, "AF_UNIX" }, \ | |
46 | { AF_LOCAL, "AF_LOCAL" }, \ | |
47 | { AF_INET, "AF_INET" }, \ | |
48 | { AF_INET6, "AF_INET6" }) | |
49 | ||
c509f15a | 50 | DECLARE_EVENT_CLASS(rpc_xdr_buf_class, |
b20dfc3f | 51 | TP_PROTO( |
c509f15a | 52 | const struct rpc_task *task, |
b20dfc3f CL |
53 | const struct xdr_buf *xdr |
54 | ), | |
55 | ||
c509f15a | 56 | TP_ARGS(task, xdr), |
b20dfc3f CL |
57 | |
58 | TP_STRUCT__entry( | |
c509f15a CL |
59 | __field(unsigned int, task_id) |
60 | __field(unsigned int, client_id) | |
b20dfc3f CL |
61 | __field(const void *, head_base) |
62 | __field(size_t, head_len) | |
63 | __field(const void *, tail_base) | |
64 | __field(size_t, tail_len) | |
65 | __field(unsigned int, page_len) | |
66 | __field(unsigned int, msg_len) | |
67 | ), | |
68 | ||
69 | TP_fast_assign( | |
c509f15a CL |
70 | __entry->task_id = task->tk_pid; |
71 | __entry->client_id = task->tk_client->cl_clid; | |
b20dfc3f CL |
72 | __entry->head_base = xdr->head[0].iov_base; |
73 | __entry->head_len = xdr->head[0].iov_len; | |
74 | __entry->tail_base = xdr->tail[0].iov_base; | |
75 | __entry->tail_len = xdr->tail[0].iov_len; | |
76 | __entry->page_len = xdr->page_len; | |
77 | __entry->msg_len = xdr->len; | |
78 | ), | |
79 | ||
c509f15a CL |
80 | TP_printk("task:%u@%u head=[%p,%zu] page=%u tail=[%p,%zu] len=%u", |
81 | __entry->task_id, __entry->client_id, | |
b20dfc3f CL |
82 | __entry->head_base, __entry->head_len, __entry->page_len, |
83 | __entry->tail_base, __entry->tail_len, __entry->msg_len | |
84 | ) | |
85 | ); | |
86 | ||
c509f15a CL |
87 | #define DEFINE_RPCXDRBUF_EVENT(name) \ |
88 | DEFINE_EVENT(rpc_xdr_buf_class, \ | |
89 | rpc_xdr_##name, \ | |
b20dfc3f | 90 | TP_PROTO( \ |
c509f15a | 91 | const struct rpc_task *task, \ |
b20dfc3f CL |
92 | const struct xdr_buf *xdr \ |
93 | ), \ | |
c509f15a CL |
94 | TP_ARGS(task, xdr)) |
95 | ||
96 | DEFINE_RPCXDRBUF_EVENT(sendto); | |
97 | DEFINE_RPCXDRBUF_EVENT(recvfrom); | |
98 | DEFINE_RPCXDRBUF_EVENT(reply_pages); | |
b20dfc3f | 99 | |
b20dfc3f | 100 | |
42aad0d7 CL |
101 | DECLARE_EVENT_CLASS(rpc_clnt_class, |
102 | TP_PROTO( | |
103 | const struct rpc_clnt *clnt | |
104 | ), | |
105 | ||
106 | TP_ARGS(clnt), | |
107 | ||
108 | TP_STRUCT__entry( | |
109 | __field(unsigned int, client_id) | |
110 | ), | |
111 | ||
112 | TP_fast_assign( | |
113 | __entry->client_id = clnt->cl_clid; | |
114 | ), | |
115 | ||
116 | TP_printk("clid=%u", __entry->client_id) | |
117 | ); | |
118 | ||
119 | #define DEFINE_RPC_CLNT_EVENT(name) \ | |
120 | DEFINE_EVENT(rpc_clnt_class, \ | |
121 | rpc_clnt_##name, \ | |
122 | TP_PROTO( \ | |
123 | const struct rpc_clnt *clnt \ | |
124 | ), \ | |
125 | TP_ARGS(clnt)) | |
126 | ||
127 | DEFINE_RPC_CLNT_EVENT(free); | |
128 | DEFINE_RPC_CLNT_EVENT(killall); | |
129 | DEFINE_RPC_CLNT_EVENT(shutdown); | |
130 | DEFINE_RPC_CLNT_EVENT(release); | |
131 | DEFINE_RPC_CLNT_EVENT(replace_xprt); | |
132 | DEFINE_RPC_CLNT_EVENT(replace_xprt_err); | |
133 | ||
134 | TRACE_EVENT(rpc_clnt_new, | |
135 | TP_PROTO( | |
136 | const struct rpc_clnt *clnt, | |
137 | const struct rpc_xprt *xprt, | |
138 | const char *program, | |
139 | const char *server | |
140 | ), | |
141 | ||
142 | TP_ARGS(clnt, xprt, program, server), | |
143 | ||
144 | TP_STRUCT__entry( | |
145 | __field(unsigned int, client_id) | |
146 | __string(addr, xprt->address_strings[RPC_DISPLAY_ADDR]) | |
147 | __string(port, xprt->address_strings[RPC_DISPLAY_PORT]) | |
148 | __string(program, program) | |
149 | __string(server, server) | |
150 | ), | |
151 | ||
152 | TP_fast_assign( | |
153 | __entry->client_id = clnt->cl_clid; | |
154 | __assign_str(addr, xprt->address_strings[RPC_DISPLAY_ADDR]); | |
155 | __assign_str(port, xprt->address_strings[RPC_DISPLAY_PORT]); | |
156 | __assign_str(program, program) | |
157 | __assign_str(server, server) | |
158 | ), | |
159 | ||
160 | TP_printk("client=%u peer=[%s]:%s program=%s server=%s", | |
161 | __entry->client_id, __get_str(addr), __get_str(port), | |
162 | __get_str(program), __get_str(server)) | |
163 | ); | |
164 | ||
165 | TRACE_EVENT(rpc_clnt_new_err, | |
166 | TP_PROTO( | |
167 | const char *program, | |
168 | const char *server, | |
169 | int error | |
170 | ), | |
171 | ||
172 | TP_ARGS(program, server, error), | |
173 | ||
174 | TP_STRUCT__entry( | |
175 | __field(int, error) | |
176 | __string(program, program) | |
177 | __string(server, server) | |
178 | ), | |
179 | ||
180 | TP_fast_assign( | |
181 | __entry->error = error; | |
182 | __assign_str(program, program) | |
183 | __assign_str(server, server) | |
184 | ), | |
185 | ||
186 | TP_printk("program=%s server=%s error=%d", | |
187 | __get_str(program), __get_str(server), __entry->error) | |
188 | ); | |
189 | ||
190 | TRACE_EVENT(rpc_clnt_clone_err, | |
191 | TP_PROTO( | |
192 | const struct rpc_clnt *clnt, | |
193 | int error | |
194 | ), | |
195 | ||
196 | TP_ARGS(clnt, error), | |
197 | ||
198 | TP_STRUCT__entry( | |
199 | __field(unsigned int, client_id) | |
200 | __field(int, error) | |
201 | ), | |
202 | ||
203 | TP_fast_assign( | |
204 | __entry->client_id = clnt->cl_clid; | |
205 | __entry->error = error; | |
206 | ), | |
207 | ||
208 | TP_printk("client=%u error=%d", __entry->client_id, __entry->error) | |
209 | ); | |
b20dfc3f | 210 | |
b20dfc3f | 211 | |
ff27e9f7 CL |
212 | TRACE_DEFINE_ENUM(RPC_AUTH_OK); |
213 | TRACE_DEFINE_ENUM(RPC_AUTH_BADCRED); | |
214 | TRACE_DEFINE_ENUM(RPC_AUTH_REJECTEDCRED); | |
215 | TRACE_DEFINE_ENUM(RPC_AUTH_BADVERF); | |
216 | TRACE_DEFINE_ENUM(RPC_AUTH_REJECTEDVERF); | |
217 | TRACE_DEFINE_ENUM(RPC_AUTH_TOOWEAK); | |
218 | TRACE_DEFINE_ENUM(RPCSEC_GSS_CREDPROBLEM); | |
219 | TRACE_DEFINE_ENUM(RPCSEC_GSS_CTXPROBLEM); | |
220 | ||
221 | #define rpc_show_auth_stat(status) \ | |
222 | __print_symbolic(status, \ | |
223 | { RPC_AUTH_OK, "AUTH_OK" }, \ | |
224 | { RPC_AUTH_BADCRED, "BADCRED" }, \ | |
225 | { RPC_AUTH_REJECTEDCRED, "REJECTEDCRED" }, \ | |
226 | { RPC_AUTH_BADVERF, "BADVERF" }, \ | |
227 | { RPC_AUTH_REJECTEDVERF, "REJECTEDVERF" }, \ | |
228 | { RPC_AUTH_TOOWEAK, "TOOWEAK" }, \ | |
229 | { RPCSEC_GSS_CREDPROBLEM, "GSS_CREDPROBLEM" }, \ | |
230 | { RPCSEC_GSS_CTXPROBLEM, "GSS_CTXPROBLEM" }) \ | |
231 | ||
5753cba1 SD |
232 | DECLARE_EVENT_CLASS(rpc_task_status, |
233 | ||
e671edb9 | 234 | TP_PROTO(const struct rpc_task *task), |
5753cba1 | 235 | |
e671edb9 | 236 | TP_ARGS(task), |
5753cba1 SD |
237 | |
238 | TP_STRUCT__entry( | |
92cb6c5b TM |
239 | __field(unsigned int, task_id) |
240 | __field(unsigned int, client_id) | |
5753cba1 SD |
241 | __field(int, status) |
242 | ), | |
243 | ||
244 | TP_fast_assign( | |
92cb6c5b TM |
245 | __entry->task_id = task->tk_pid; |
246 | __entry->client_id = task->tk_client->cl_clid; | |
e671edb9 | 247 | __entry->status = task->tk_status; |
5753cba1 SD |
248 | ), |
249 | ||
52069449 | 250 | TP_printk("task:%u@%u status=%d", |
92cb6c5b TM |
251 | __entry->task_id, __entry->client_id, |
252 | __entry->status) | |
5753cba1 | 253 | ); |
dc5820bd CL |
254 | #define DEFINE_RPC_STATUS_EVENT(name) \ |
255 | DEFINE_EVENT(rpc_task_status, rpc_##name##_status, \ | |
256 | TP_PROTO( \ | |
257 | const struct rpc_task *task \ | |
258 | ), \ | |
259 | TP_ARGS(task)) | |
260 | ||
261 | DEFINE_RPC_STATUS_EVENT(call); | |
dc5820bd | 262 | DEFINE_RPC_STATUS_EVENT(connect); |
914cdcc7 | 263 | DEFINE_RPC_STATUS_EVENT(timeout); |
7c8099f6 CL |
264 | DEFINE_RPC_STATUS_EVENT(retry_refresh); |
265 | DEFINE_RPC_STATUS_EVENT(refresh); | |
5753cba1 | 266 | |
c435da68 CL |
267 | TRACE_EVENT(rpc_request, |
268 | TP_PROTO(const struct rpc_task *task), | |
269 | ||
270 | TP_ARGS(task), | |
271 | ||
272 | TP_STRUCT__entry( | |
273 | __field(unsigned int, task_id) | |
274 | __field(unsigned int, client_id) | |
275 | __field(int, version) | |
276 | __field(bool, async) | |
277 | __string(progname, task->tk_client->cl_program->name) | |
278 | __string(procname, rpc_proc_name(task)) | |
279 | ), | |
280 | ||
281 | TP_fast_assign( | |
282 | __entry->task_id = task->tk_pid; | |
283 | __entry->client_id = task->tk_client->cl_clid; | |
284 | __entry->version = task->tk_client->cl_vers; | |
285 | __entry->async = RPC_IS_ASYNC(task); | |
286 | __assign_str(progname, task->tk_client->cl_program->name) | |
287 | __assign_str(procname, rpc_proc_name(task)) | |
288 | ), | |
289 | ||
290 | TP_printk("task:%u@%u %sv%d %s (%ssync)", | |
291 | __entry->task_id, __entry->client_id, | |
292 | __get_str(progname), __entry->version, | |
293 | __get_str(procname), __entry->async ? "a": "" | |
294 | ) | |
295 | ); | |
296 | ||
6f701383 CL |
297 | TRACE_DEFINE_ENUM(RPC_TASK_ASYNC); |
298 | TRACE_DEFINE_ENUM(RPC_TASK_SWAPPER); | |
7a34c8e0 | 299 | TRACE_DEFINE_ENUM(RPC_TASK_NULLCREDS); |
6f701383 CL |
300 | TRACE_DEFINE_ENUM(RPC_CALL_MAJORSEEN); |
301 | TRACE_DEFINE_ENUM(RPC_TASK_ROOTCREDS); | |
302 | TRACE_DEFINE_ENUM(RPC_TASK_DYNAMIC); | |
7a34c8e0 | 303 | TRACE_DEFINE_ENUM(RPC_TASK_NO_ROUND_ROBIN); |
6f701383 CL |
304 | TRACE_DEFINE_ENUM(RPC_TASK_SOFT); |
305 | TRACE_DEFINE_ENUM(RPC_TASK_SOFTCONN); | |
306 | TRACE_DEFINE_ENUM(RPC_TASK_SENT); | |
307 | TRACE_DEFINE_ENUM(RPC_TASK_TIMEOUT); | |
308 | TRACE_DEFINE_ENUM(RPC_TASK_NOCONNECT); | |
309 | TRACE_DEFINE_ENUM(RPC_TASK_NO_RETRANS_TIMEOUT); | |
7a34c8e0 | 310 | TRACE_DEFINE_ENUM(RPC_TASK_CRED_NOREF); |
6f701383 CL |
311 | |
312 | #define rpc_show_task_flags(flags) \ | |
313 | __print_flags(flags, "|", \ | |
314 | { RPC_TASK_ASYNC, "ASYNC" }, \ | |
315 | { RPC_TASK_SWAPPER, "SWAPPER" }, \ | |
7a34c8e0 | 316 | { RPC_TASK_NULLCREDS, "NULLCREDS" }, \ |
6f701383 CL |
317 | { RPC_CALL_MAJORSEEN, "MAJORSEEN" }, \ |
318 | { RPC_TASK_ROOTCREDS, "ROOTCREDS" }, \ | |
319 | { RPC_TASK_DYNAMIC, "DYNAMIC" }, \ | |
7a34c8e0 | 320 | { RPC_TASK_NO_ROUND_ROBIN, "NO_ROUND_ROBIN" }, \ |
6f701383 CL |
321 | { RPC_TASK_SOFT, "SOFT" }, \ |
322 | { RPC_TASK_SOFTCONN, "SOFTCONN" }, \ | |
323 | { RPC_TASK_SENT, "SENT" }, \ | |
324 | { RPC_TASK_TIMEOUT, "TIMEOUT" }, \ | |
325 | { RPC_TASK_NOCONNECT, "NOCONNECT" }, \ | |
7a34c8e0 CL |
326 | { RPC_TASK_NO_RETRANS_TIMEOUT, "NORTO" }, \ |
327 | { RPC_TASK_CRED_NOREF, "CRED_NOREF" }) | |
6f701383 CL |
328 | |
329 | TRACE_DEFINE_ENUM(RPC_TASK_RUNNING); | |
330 | TRACE_DEFINE_ENUM(RPC_TASK_QUEUED); | |
331 | TRACE_DEFINE_ENUM(RPC_TASK_ACTIVE); | |
332 | TRACE_DEFINE_ENUM(RPC_TASK_NEED_XMIT); | |
333 | TRACE_DEFINE_ENUM(RPC_TASK_NEED_RECV); | |
334 | TRACE_DEFINE_ENUM(RPC_TASK_MSG_PIN_WAIT); | |
ae67bd38 | 335 | TRACE_DEFINE_ENUM(RPC_TASK_SIGNALLED); |
6f701383 CL |
336 | |
337 | #define rpc_show_runstate(flags) \ | |
338 | __print_flags(flags, "|", \ | |
339 | { (1UL << RPC_TASK_RUNNING), "RUNNING" }, \ | |
340 | { (1UL << RPC_TASK_QUEUED), "QUEUED" }, \ | |
341 | { (1UL << RPC_TASK_ACTIVE), "ACTIVE" }, \ | |
342 | { (1UL << RPC_TASK_NEED_XMIT), "NEED_XMIT" }, \ | |
343 | { (1UL << RPC_TASK_NEED_RECV), "NEED_RECV" }, \ | |
ae67bd38 TM |
344 | { (1UL << RPC_TASK_MSG_PIN_WAIT), "MSG_PIN_WAIT" }, \ |
345 | { (1UL << RPC_TASK_SIGNALLED), "SIGNALLED" }) | |
6f701383 | 346 | |
82b0a4c3 TM |
347 | DECLARE_EVENT_CLASS(rpc_task_running, |
348 | ||
e671edb9 | 349 | TP_PROTO(const struct rpc_task *task, const void *action), |
82b0a4c3 | 350 | |
e671edb9 | 351 | TP_ARGS(task, action), |
82b0a4c3 TM |
352 | |
353 | TP_STRUCT__entry( | |
92cb6c5b TM |
354 | __field(unsigned int, task_id) |
355 | __field(unsigned int, client_id) | |
82b0a4c3 TM |
356 | __field(const void *, action) |
357 | __field(unsigned long, runstate) | |
358 | __field(int, status) | |
359 | __field(unsigned short, flags) | |
360 | ), | |
361 | ||
362 | TP_fast_assign( | |
e671edb9 CL |
363 | __entry->client_id = task->tk_client ? |
364 | task->tk_client->cl_clid : -1; | |
92cb6c5b | 365 | __entry->task_id = task->tk_pid; |
82b0a4c3 TM |
366 | __entry->action = action; |
367 | __entry->runstate = task->tk_runstate; | |
368 | __entry->status = task->tk_status; | |
369 | __entry->flags = task->tk_flags; | |
370 | ), | |
371 | ||
09686219 | 372 | TP_printk("task:%u@%d flags=%s runstate=%s status=%d action=%ps", |
92cb6c5b | 373 | __entry->task_id, __entry->client_id, |
6f701383 CL |
374 | rpc_show_task_flags(__entry->flags), |
375 | rpc_show_runstate(__entry->runstate), | |
82b0a4c3 TM |
376 | __entry->status, |
377 | __entry->action | |
378 | ) | |
379 | ); | |
dc5820bd CL |
380 | #define DEFINE_RPC_RUNNING_EVENT(name) \ |
381 | DEFINE_EVENT(rpc_task_running, rpc_task_##name, \ | |
382 | TP_PROTO( \ | |
383 | const struct rpc_task *task, \ | |
384 | const void *action \ | |
385 | ), \ | |
386 | TP_ARGS(task, action)) | |
82b0a4c3 | 387 | |
dc5820bd CL |
388 | DEFINE_RPC_RUNNING_EVENT(begin); |
389 | DEFINE_RPC_RUNNING_EVENT(run_action); | |
390 | DEFINE_RPC_RUNNING_EVENT(complete); | |
abf8af78 | 391 | DEFINE_RPC_RUNNING_EVENT(signalled); |
a264abad | 392 | DEFINE_RPC_RUNNING_EVENT(end); |
82b0a4c3 TM |
393 | |
394 | DECLARE_EVENT_CLASS(rpc_task_queued, | |
395 | ||
e671edb9 | 396 | TP_PROTO(const struct rpc_task *task, const struct rpc_wait_queue *q), |
82b0a4c3 | 397 | |
e671edb9 | 398 | TP_ARGS(task, q), |
82b0a4c3 TM |
399 | |
400 | TP_STRUCT__entry( | |
92cb6c5b TM |
401 | __field(unsigned int, task_id) |
402 | __field(unsigned int, client_id) | |
82b0a4c3 TM |
403 | __field(unsigned long, timeout) |
404 | __field(unsigned long, runstate) | |
405 | __field(int, status) | |
406 | __field(unsigned short, flags) | |
85c0d24f | 407 | __string(q_name, rpc_qname(q)) |
82b0a4c3 TM |
408 | ), |
409 | ||
410 | TP_fast_assign( | |
e671edb9 CL |
411 | __entry->client_id = task->tk_client ? |
412 | task->tk_client->cl_clid : -1; | |
92cb6c5b | 413 | __entry->task_id = task->tk_pid; |
5efd1876 | 414 | __entry->timeout = rpc_task_timeout(task); |
82b0a4c3 TM |
415 | __entry->runstate = task->tk_runstate; |
416 | __entry->status = task->tk_status; | |
417 | __entry->flags = task->tk_flags; | |
85c0d24f | 418 | __assign_str(q_name, rpc_qname(q)); |
82b0a4c3 TM |
419 | ), |
420 | ||
6f701383 | 421 | TP_printk("task:%u@%d flags=%s runstate=%s status=%d timeout=%lu queue=%s", |
92cb6c5b | 422 | __entry->task_id, __entry->client_id, |
6f701383 CL |
423 | rpc_show_task_flags(__entry->flags), |
424 | rpc_show_runstate(__entry->runstate), | |
82b0a4c3 TM |
425 | __entry->status, |
426 | __entry->timeout, | |
85c0d24f | 427 | __get_str(q_name) |
82b0a4c3 TM |
428 | ) |
429 | ); | |
dc5820bd CL |
430 | #define DEFINE_RPC_QUEUED_EVENT(name) \ |
431 | DEFINE_EVENT(rpc_task_queued, rpc_task_##name, \ | |
432 | TP_PROTO( \ | |
433 | const struct rpc_task *task, \ | |
434 | const struct rpc_wait_queue *q \ | |
435 | ), \ | |
436 | TP_ARGS(task, q)) | |
82b0a4c3 | 437 | |
dc5820bd CL |
438 | DEFINE_RPC_QUEUED_EVENT(sleep); |
439 | DEFINE_RPC_QUEUED_EVENT(wakeup); | |
82b0a4c3 | 440 | |
e8680a24 CL |
441 | DECLARE_EVENT_CLASS(rpc_failure, |
442 | ||
443 | TP_PROTO(const struct rpc_task *task), | |
444 | ||
445 | TP_ARGS(task), | |
446 | ||
447 | TP_STRUCT__entry( | |
448 | __field(unsigned int, task_id) | |
449 | __field(unsigned int, client_id) | |
450 | ), | |
451 | ||
452 | TP_fast_assign( | |
453 | __entry->task_id = task->tk_pid; | |
454 | __entry->client_id = task->tk_client->cl_clid; | |
455 | ), | |
456 | ||
457 | TP_printk("task:%u@%u", | |
458 | __entry->task_id, __entry->client_id) | |
459 | ); | |
460 | ||
461 | #define DEFINE_RPC_FAILURE(name) \ | |
462 | DEFINE_EVENT(rpc_failure, rpc_bad_##name, \ | |
463 | TP_PROTO( \ | |
464 | const struct rpc_task *task \ | |
465 | ), \ | |
466 | TP_ARGS(task)) | |
467 | ||
468 | DEFINE_RPC_FAILURE(callhdr); | |
7f5667a5 CL |
469 | DEFINE_RPC_FAILURE(verifier); |
470 | ||
471 | DECLARE_EVENT_CLASS(rpc_reply_event, | |
472 | ||
473 | TP_PROTO( | |
474 | const struct rpc_task *task | |
475 | ), | |
476 | ||
477 | TP_ARGS(task), | |
478 | ||
479 | TP_STRUCT__entry( | |
480 | __field(unsigned int, task_id) | |
481 | __field(unsigned int, client_id) | |
482 | __field(u32, xid) | |
483 | __string(progname, task->tk_client->cl_program->name) | |
484 | __field(u32, version) | |
485 | __string(procname, rpc_proc_name(task)) | |
486 | __string(servername, task->tk_xprt->servername) | |
487 | ), | |
488 | ||
489 | TP_fast_assign( | |
490 | __entry->task_id = task->tk_pid; | |
491 | __entry->client_id = task->tk_client->cl_clid; | |
492 | __entry->xid = be32_to_cpu(task->tk_rqstp->rq_xid); | |
493 | __assign_str(progname, task->tk_client->cl_program->name) | |
494 | __entry->version = task->tk_client->cl_vers; | |
495 | __assign_str(procname, rpc_proc_name(task)) | |
496 | __assign_str(servername, task->tk_xprt->servername) | |
497 | ), | |
498 | ||
499 | TP_printk("task:%u@%d server=%s xid=0x%08x %sv%d %s", | |
500 | __entry->task_id, __entry->client_id, __get_str(servername), | |
501 | __entry->xid, __get_str(progname), __entry->version, | |
502 | __get_str(procname)) | |
503 | ) | |
504 | ||
505 | #define DEFINE_RPC_REPLY_EVENT(name) \ | |
506 | DEFINE_EVENT(rpc_reply_event, rpc__##name, \ | |
507 | TP_PROTO( \ | |
508 | const struct rpc_task *task \ | |
509 | ), \ | |
510 | TP_ARGS(task)) | |
511 | ||
512 | DEFINE_RPC_REPLY_EVENT(prog_unavail); | |
513 | DEFINE_RPC_REPLY_EVENT(prog_mismatch); | |
514 | DEFINE_RPC_REPLY_EVENT(proc_unavail); | |
515 | DEFINE_RPC_REPLY_EVENT(garbage_args); | |
516 | DEFINE_RPC_REPLY_EVENT(unparsable); | |
517 | DEFINE_RPC_REPLY_EVENT(mismatch); | |
518 | DEFINE_RPC_REPLY_EVENT(stale_creds); | |
519 | DEFINE_RPC_REPLY_EVENT(bad_creds); | |
520 | DEFINE_RPC_REPLY_EVENT(auth_tooweak); | |
e8680a24 | 521 | |
42ebfc2c CL |
522 | #define DEFINE_RPCB_ERROR_EVENT(name) \ |
523 | DEFINE_EVENT(rpc_reply_event, rpcb_##name##_err, \ | |
524 | TP_PROTO( \ | |
525 | const struct rpc_task *task \ | |
526 | ), \ | |
527 | TP_ARGS(task)) | |
528 | ||
529 | DEFINE_RPCB_ERROR_EVENT(prog_unavail); | |
530 | DEFINE_RPCB_ERROR_EVENT(timeout); | |
531 | DEFINE_RPCB_ERROR_EVENT(bind_version); | |
532 | DEFINE_RPCB_ERROR_EVENT(unreachable); | |
533 | DEFINE_RPCB_ERROR_EVENT(unrecognized); | |
534 | ||
06e234c6 CL |
535 | TRACE_EVENT(rpc_buf_alloc, |
536 | TP_PROTO( | |
537 | const struct rpc_task *task, | |
538 | int status | |
539 | ), | |
540 | ||
541 | TP_ARGS(task, status), | |
542 | ||
543 | TP_STRUCT__entry( | |
544 | __field(unsigned int, task_id) | |
545 | __field(unsigned int, client_id) | |
546 | __field(size_t, callsize) | |
547 | __field(size_t, recvsize) | |
548 | __field(int, status) | |
549 | ), | |
550 | ||
551 | TP_fast_assign( | |
552 | __entry->task_id = task->tk_pid; | |
553 | __entry->client_id = task->tk_client->cl_clid; | |
554 | __entry->callsize = task->tk_rqstp->rq_callsize; | |
555 | __entry->recvsize = task->tk_rqstp->rq_rcvsize; | |
556 | __entry->status = status; | |
557 | ), | |
558 | ||
559 | TP_printk("task:%u@%u callsize=%zu recvsize=%zu status=%d", | |
560 | __entry->task_id, __entry->client_id, | |
561 | __entry->callsize, __entry->recvsize, __entry->status | |
562 | ) | |
563 | ); | |
564 | ||
0125ecbb CL |
565 | TRACE_EVENT(rpc_call_rpcerror, |
566 | TP_PROTO( | |
567 | const struct rpc_task *task, | |
568 | int tk_status, | |
569 | int rpc_status | |
570 | ), | |
571 | ||
572 | TP_ARGS(task, tk_status, rpc_status), | |
573 | ||
574 | TP_STRUCT__entry( | |
575 | __field(unsigned int, task_id) | |
576 | __field(unsigned int, client_id) | |
577 | __field(int, tk_status) | |
578 | __field(int, rpc_status) | |
579 | ), | |
580 | ||
581 | TP_fast_assign( | |
582 | __entry->client_id = task->tk_client->cl_clid; | |
583 | __entry->task_id = task->tk_pid; | |
584 | __entry->tk_status = tk_status; | |
585 | __entry->rpc_status = rpc_status; | |
586 | ), | |
587 | ||
588 | TP_printk("task:%u@%u tk_status=%d rpc_status=%d", | |
589 | __entry->task_id, __entry->client_id, | |
590 | __entry->tk_status, __entry->rpc_status) | |
591 | ); | |
592 | ||
40bf7eb3 CL |
593 | TRACE_EVENT(rpc_stats_latency, |
594 | ||
595 | TP_PROTO( | |
596 | const struct rpc_task *task, | |
597 | ktime_t backlog, | |
598 | ktime_t rtt, | |
599 | ktime_t execute | |
600 | ), | |
601 | ||
602 | TP_ARGS(task, backlog, rtt, execute), | |
603 | ||
604 | TP_STRUCT__entry( | |
98eb6cf2 CL |
605 | __field(unsigned int, task_id) |
606 | __field(unsigned int, client_id) | |
40bf7eb3 CL |
607 | __field(u32, xid) |
608 | __field(int, version) | |
609 | __string(progname, task->tk_client->cl_program->name) | |
610 | __string(procname, rpc_proc_name(task)) | |
611 | __field(unsigned long, backlog) | |
612 | __field(unsigned long, rtt) | |
613 | __field(unsigned long, execute) | |
40bf7eb3 CL |
614 | ), |
615 | ||
616 | TP_fast_assign( | |
98eb6cf2 CL |
617 | __entry->client_id = task->tk_client->cl_clid; |
618 | __entry->task_id = task->tk_pid; | |
40bf7eb3 CL |
619 | __entry->xid = be32_to_cpu(task->tk_rqstp->rq_xid); |
620 | __entry->version = task->tk_client->cl_vers; | |
621 | __assign_str(progname, task->tk_client->cl_program->name) | |
622 | __assign_str(procname, rpc_proc_name(task)) | |
623 | __entry->backlog = ktime_to_us(backlog); | |
624 | __entry->rtt = ktime_to_us(rtt); | |
625 | __entry->execute = ktime_to_us(execute); | |
40bf7eb3 CL |
626 | ), |
627 | ||
98eb6cf2 CL |
628 | TP_printk("task:%u@%d xid=0x%08x %sv%d %s backlog=%lu rtt=%lu execute=%lu", |
629 | __entry->task_id, __entry->client_id, __entry->xid, | |
40bf7eb3 CL |
630 | __get_str(progname), __entry->version, __get_str(procname), |
631 | __entry->backlog, __entry->rtt, __entry->execute) | |
632 | ); | |
633 | ||
5582863f CL |
634 | TRACE_EVENT(rpc_xdr_overflow, |
635 | TP_PROTO( | |
636 | const struct xdr_stream *xdr, | |
637 | size_t requested | |
638 | ), | |
639 | ||
640 | TP_ARGS(xdr, requested), | |
641 | ||
642 | TP_STRUCT__entry( | |
643 | __field(unsigned int, task_id) | |
644 | __field(unsigned int, client_id) | |
645 | __field(int, version) | |
646 | __field(size_t, requested) | |
647 | __field(const void *, end) | |
648 | __field(const void *, p) | |
649 | __field(const void *, head_base) | |
650 | __field(size_t, head_len) | |
651 | __field(const void *, tail_base) | |
652 | __field(size_t, tail_len) | |
653 | __field(unsigned int, page_len) | |
654 | __field(unsigned int, len) | |
655 | __string(progname, | |
656 | xdr->rqst->rq_task->tk_client->cl_program->name) | |
657 | __string(procedure, | |
658 | xdr->rqst->rq_task->tk_msg.rpc_proc->p_name) | |
659 | ), | |
660 | ||
661 | TP_fast_assign( | |
662 | if (xdr->rqst) { | |
663 | const struct rpc_task *task = xdr->rqst->rq_task; | |
664 | ||
665 | __entry->task_id = task->tk_pid; | |
666 | __entry->client_id = task->tk_client->cl_clid; | |
667 | __assign_str(progname, | |
668 | task->tk_client->cl_program->name) | |
669 | __entry->version = task->tk_client->cl_vers; | |
670 | __assign_str(procedure, task->tk_msg.rpc_proc->p_name) | |
671 | } else { | |
672 | __entry->task_id = 0; | |
673 | __entry->client_id = 0; | |
674 | __assign_str(progname, "unknown") | |
675 | __entry->version = 0; | |
676 | __assign_str(procedure, "unknown") | |
677 | } | |
678 | __entry->requested = requested; | |
679 | __entry->end = xdr->end; | |
680 | __entry->p = xdr->p; | |
681 | __entry->head_base = xdr->buf->head[0].iov_base, | |
682 | __entry->head_len = xdr->buf->head[0].iov_len, | |
683 | __entry->page_len = xdr->buf->page_len, | |
684 | __entry->tail_base = xdr->buf->tail[0].iov_base, | |
685 | __entry->tail_len = xdr->buf->tail[0].iov_len, | |
686 | __entry->len = xdr->buf->len; | |
687 | ), | |
688 | ||
689 | TP_printk( | |
690 | "task:%u@%u %sv%d %s requested=%zu p=%p end=%p xdr=[%p,%zu]/%u/[%p,%zu]/%u\n", | |
691 | __entry->task_id, __entry->client_id, | |
692 | __get_str(progname), __entry->version, __get_str(procedure), | |
693 | __entry->requested, __entry->p, __entry->end, | |
694 | __entry->head_base, __entry->head_len, | |
695 | __entry->page_len, | |
696 | __entry->tail_base, __entry->tail_len, | |
697 | __entry->len | |
698 | ) | |
699 | ); | |
700 | ||
7be9cea3 CL |
701 | TRACE_EVENT(rpc_xdr_alignment, |
702 | TP_PROTO( | |
703 | const struct xdr_stream *xdr, | |
704 | size_t offset, | |
705 | unsigned int copied | |
706 | ), | |
707 | ||
708 | TP_ARGS(xdr, offset, copied), | |
709 | ||
710 | TP_STRUCT__entry( | |
711 | __field(unsigned int, task_id) | |
712 | __field(unsigned int, client_id) | |
713 | __field(int, version) | |
714 | __field(size_t, offset) | |
715 | __field(unsigned int, copied) | |
716 | __field(const void *, head_base) | |
717 | __field(size_t, head_len) | |
718 | __field(const void *, tail_base) | |
719 | __field(size_t, tail_len) | |
720 | __field(unsigned int, page_len) | |
721 | __field(unsigned int, len) | |
722 | __string(progname, | |
723 | xdr->rqst->rq_task->tk_client->cl_program->name) | |
724 | __string(procedure, | |
725 | xdr->rqst->rq_task->tk_msg.rpc_proc->p_name) | |
726 | ), | |
727 | ||
728 | TP_fast_assign( | |
729 | const struct rpc_task *task = xdr->rqst->rq_task; | |
730 | ||
731 | __entry->task_id = task->tk_pid; | |
732 | __entry->client_id = task->tk_client->cl_clid; | |
733 | __assign_str(progname, | |
734 | task->tk_client->cl_program->name) | |
735 | __entry->version = task->tk_client->cl_vers; | |
736 | __assign_str(procedure, task->tk_msg.rpc_proc->p_name) | |
737 | ||
738 | __entry->offset = offset; | |
739 | __entry->copied = copied; | |
740 | __entry->head_base = xdr->buf->head[0].iov_base, | |
741 | __entry->head_len = xdr->buf->head[0].iov_len, | |
742 | __entry->page_len = xdr->buf->page_len, | |
743 | __entry->tail_base = xdr->buf->tail[0].iov_base, | |
744 | __entry->tail_len = xdr->buf->tail[0].iov_len, | |
745 | __entry->len = xdr->buf->len; | |
746 | ), | |
747 | ||
748 | TP_printk( | |
749 | "task:%u@%u %sv%d %s offset=%zu copied=%u xdr=[%p,%zu]/%u/[%p,%zu]/%u\n", | |
750 | __entry->task_id, __entry->client_id, | |
751 | __get_str(progname), __entry->version, __get_str(procedure), | |
752 | __entry->offset, __entry->copied, | |
753 | __entry->head_base, __entry->head_len, | |
754 | __entry->page_len, | |
755 | __entry->tail_base, __entry->tail_len, | |
756 | __entry->len | |
757 | ) | |
758 | ); | |
759 | ||
6ba16eef SRRH |
760 | /* |
761 | * First define the enums in the below macros to be exported to userspace | |
762 | * via TRACE_DEFINE_ENUM(). | |
763 | */ | |
764 | #undef EM | |
765 | #undef EMe | |
766 | #define EM(a, b) TRACE_DEFINE_ENUM(a); | |
767 | #define EMe(a, b) TRACE_DEFINE_ENUM(a); | |
768 | ||
769 | #define RPC_SHOW_SOCKET \ | |
770 | EM( SS_FREE, "FREE" ) \ | |
771 | EM( SS_UNCONNECTED, "UNCONNECTED" ) \ | |
82909dc5 CL |
772 | EM( SS_CONNECTING, "CONNECTING" ) \ |
773 | EM( SS_CONNECTED, "CONNECTED" ) \ | |
774 | EMe( SS_DISCONNECTING, "DISCONNECTING" ) | |
6ba16eef | 775 | |
40b5ea0c | 776 | #define rpc_show_socket_state(state) \ |
6ba16eef SRRH |
777 | __print_symbolic(state, RPC_SHOW_SOCKET) |
778 | ||
779 | RPC_SHOW_SOCKET | |
780 | ||
781 | #define RPC_SHOW_SOCK \ | |
782 | EM( TCP_ESTABLISHED, "ESTABLISHED" ) \ | |
783 | EM( TCP_SYN_SENT, "SYN_SENT" ) \ | |
784 | EM( TCP_SYN_RECV, "SYN_RECV" ) \ | |
785 | EM( TCP_FIN_WAIT1, "FIN_WAIT1" ) \ | |
786 | EM( TCP_FIN_WAIT2, "FIN_WAIT2" ) \ | |
787 | EM( TCP_TIME_WAIT, "TIME_WAIT" ) \ | |
788 | EM( TCP_CLOSE, "CLOSE" ) \ | |
789 | EM( TCP_CLOSE_WAIT, "CLOSE_WAIT" ) \ | |
790 | EM( TCP_LAST_ACK, "LAST_ACK" ) \ | |
791 | EM( TCP_LISTEN, "LISTEN" ) \ | |
792 | EMe( TCP_CLOSING, "CLOSING" ) | |
40b5ea0c TM |
793 | |
794 | #define rpc_show_sock_state(state) \ | |
6ba16eef SRRH |
795 | __print_symbolic(state, RPC_SHOW_SOCK) |
796 | ||
797 | RPC_SHOW_SOCK | |
798 | ||
799 | /* | |
800 | * Now redefine the EM() and EMe() macros to map the enums to the strings | |
801 | * that will be printed in the output. | |
802 | */ | |
803 | #undef EM | |
804 | #undef EMe | |
805 | #define EM(a, b) {a, b}, | |
806 | #define EMe(a, b) {a, b} | |
40b5ea0c TM |
807 | |
808 | DECLARE_EVENT_CLASS(xs_socket_event, | |
809 | ||
810 | TP_PROTO( | |
811 | struct rpc_xprt *xprt, | |
812 | struct socket *socket | |
813 | ), | |
814 | ||
815 | TP_ARGS(xprt, socket), | |
816 | ||
817 | TP_STRUCT__entry( | |
818 | __field(unsigned int, socket_state) | |
819 | __field(unsigned int, sock_state) | |
820 | __field(unsigned long long, ino) | |
821 | __string(dstaddr, | |
822 | xprt->address_strings[RPC_DISPLAY_ADDR]) | |
823 | __string(dstport, | |
824 | xprt->address_strings[RPC_DISPLAY_PORT]) | |
825 | ), | |
826 | ||
827 | TP_fast_assign( | |
828 | struct inode *inode = SOCK_INODE(socket); | |
829 | __entry->socket_state = socket->state; | |
830 | __entry->sock_state = socket->sk->sk_state; | |
831 | __entry->ino = (unsigned long long)inode->i_ino; | |
832 | __assign_str(dstaddr, | |
833 | xprt->address_strings[RPC_DISPLAY_ADDR]); | |
834 | __assign_str(dstport, | |
835 | xprt->address_strings[RPC_DISPLAY_PORT]); | |
836 | ), | |
837 | ||
838 | TP_printk( | |
839 | "socket:[%llu] dstaddr=%s/%s " | |
840 | "state=%u (%s) sk_state=%u (%s)", | |
841 | __entry->ino, __get_str(dstaddr), __get_str(dstport), | |
842 | __entry->socket_state, | |
843 | rpc_show_socket_state(__entry->socket_state), | |
844 | __entry->sock_state, | |
845 | rpc_show_sock_state(__entry->sock_state) | |
846 | ) | |
847 | ); | |
848 | #define DEFINE_RPC_SOCKET_EVENT(name) \ | |
849 | DEFINE_EVENT(xs_socket_event, name, \ | |
850 | TP_PROTO( \ | |
851 | struct rpc_xprt *xprt, \ | |
852 | struct socket *socket \ | |
853 | ), \ | |
854 | TP_ARGS(xprt, socket)) | |
855 | ||
856 | DECLARE_EVENT_CLASS(xs_socket_event_done, | |
857 | ||
858 | TP_PROTO( | |
859 | struct rpc_xprt *xprt, | |
860 | struct socket *socket, | |
861 | int error | |
862 | ), | |
863 | ||
864 | TP_ARGS(xprt, socket, error), | |
865 | ||
866 | TP_STRUCT__entry( | |
867 | __field(int, error) | |
868 | __field(unsigned int, socket_state) | |
869 | __field(unsigned int, sock_state) | |
870 | __field(unsigned long long, ino) | |
871 | __string(dstaddr, | |
872 | xprt->address_strings[RPC_DISPLAY_ADDR]) | |
873 | __string(dstport, | |
874 | xprt->address_strings[RPC_DISPLAY_PORT]) | |
875 | ), | |
876 | ||
877 | TP_fast_assign( | |
878 | struct inode *inode = SOCK_INODE(socket); | |
879 | __entry->socket_state = socket->state; | |
880 | __entry->sock_state = socket->sk->sk_state; | |
881 | __entry->ino = (unsigned long long)inode->i_ino; | |
882 | __entry->error = error; | |
883 | __assign_str(dstaddr, | |
884 | xprt->address_strings[RPC_DISPLAY_ADDR]); | |
885 | __assign_str(dstport, | |
886 | xprt->address_strings[RPC_DISPLAY_PORT]); | |
887 | ), | |
888 | ||
889 | TP_printk( | |
890 | "error=%d socket:[%llu] dstaddr=%s/%s " | |
891 | "state=%u (%s) sk_state=%u (%s)", | |
892 | __entry->error, | |
893 | __entry->ino, __get_str(dstaddr), __get_str(dstport), | |
894 | __entry->socket_state, | |
895 | rpc_show_socket_state(__entry->socket_state), | |
896 | __entry->sock_state, | |
897 | rpc_show_sock_state(__entry->sock_state) | |
898 | ) | |
899 | ); | |
900 | #define DEFINE_RPC_SOCKET_EVENT_DONE(name) \ | |
901 | DEFINE_EVENT(xs_socket_event_done, name, \ | |
902 | TP_PROTO( \ | |
903 | struct rpc_xprt *xprt, \ | |
904 | struct socket *socket, \ | |
905 | int error \ | |
906 | ), \ | |
907 | TP_ARGS(xprt, socket, error)) | |
908 | ||
909 | DEFINE_RPC_SOCKET_EVENT(rpc_socket_state_change); | |
910 | DEFINE_RPC_SOCKET_EVENT_DONE(rpc_socket_connect); | |
e8353c76 | 911 | DEFINE_RPC_SOCKET_EVENT_DONE(rpc_socket_error); |
40b5ea0c TM |
912 | DEFINE_RPC_SOCKET_EVENT_DONE(rpc_socket_reset_connection); |
913 | DEFINE_RPC_SOCKET_EVENT(rpc_socket_close); | |
914 | DEFINE_RPC_SOCKET_EVENT(rpc_socket_shutdown); | |
915 | ||
015747d2 CL |
916 | TRACE_EVENT(rpc_socket_nospace, |
917 | TP_PROTO( | |
918 | const struct rpc_rqst *rqst, | |
919 | const struct sock_xprt *transport | |
920 | ), | |
921 | ||
922 | TP_ARGS(rqst, transport), | |
923 | ||
924 | TP_STRUCT__entry( | |
925 | __field(unsigned int, task_id) | |
926 | __field(unsigned int, client_id) | |
927 | __field(unsigned int, total) | |
928 | __field(unsigned int, remaining) | |
929 | ), | |
930 | ||
931 | TP_fast_assign( | |
932 | __entry->task_id = rqst->rq_task->tk_pid; | |
933 | __entry->client_id = rqst->rq_task->tk_client->cl_clid; | |
934 | __entry->total = rqst->rq_slen; | |
935 | __entry->remaining = rqst->rq_slen - transport->xmit.offset; | |
936 | ), | |
937 | ||
938 | TP_printk("task:%u@%u total=%u remaining=%u", | |
939 | __entry->task_id, __entry->client_id, | |
940 | __entry->total, __entry->remaining | |
941 | ) | |
942 | ); | |
943 | ||
94afd9c4 CL |
944 | TRACE_DEFINE_ENUM(XPRT_LOCKED); |
945 | TRACE_DEFINE_ENUM(XPRT_CONNECTED); | |
946 | TRACE_DEFINE_ENUM(XPRT_CONNECTING); | |
947 | TRACE_DEFINE_ENUM(XPRT_CLOSE_WAIT); | |
948 | TRACE_DEFINE_ENUM(XPRT_BOUND); | |
949 | TRACE_DEFINE_ENUM(XPRT_BINDING); | |
950 | TRACE_DEFINE_ENUM(XPRT_CLOSING); | |
951 | TRACE_DEFINE_ENUM(XPRT_CONGESTED); | |
952 | TRACE_DEFINE_ENUM(XPRT_CWND_WAIT); | |
953 | TRACE_DEFINE_ENUM(XPRT_WRITE_SPACE); | |
954 | ||
955 | #define rpc_show_xprt_state(x) \ | |
956 | __print_flags(x, "|", \ | |
957 | { (1UL << XPRT_LOCKED), "LOCKED"}, \ | |
958 | { (1UL << XPRT_CONNECTED), "CONNECTED"}, \ | |
959 | { (1UL << XPRT_CONNECTING), "CONNECTING"}, \ | |
960 | { (1UL << XPRT_CLOSE_WAIT), "CLOSE_WAIT"}, \ | |
961 | { (1UL << XPRT_BOUND), "BOUND"}, \ | |
962 | { (1UL << XPRT_BINDING), "BINDING"}, \ | |
963 | { (1UL << XPRT_CLOSING), "CLOSING"}, \ | |
964 | { (1UL << XPRT_CONGESTED), "CONGESTED"}, \ | |
965 | { (1UL << XPRT_CWND_WAIT), "CWND_WAIT"}, \ | |
966 | { (1UL << XPRT_WRITE_SPACE), "WRITE_SPACE"}) | |
967 | ||
911813d7 CL |
968 | DECLARE_EVENT_CLASS(rpc_xprt_lifetime_class, |
969 | TP_PROTO( | |
970 | const struct rpc_xprt *xprt | |
971 | ), | |
972 | ||
973 | TP_ARGS(xprt), | |
974 | ||
975 | TP_STRUCT__entry( | |
94afd9c4 | 976 | __field(unsigned long, state) |
911813d7 CL |
977 | __string(addr, xprt->address_strings[RPC_DISPLAY_ADDR]) |
978 | __string(port, xprt->address_strings[RPC_DISPLAY_PORT]) | |
979 | ), | |
980 | ||
981 | TP_fast_assign( | |
94afd9c4 | 982 | __entry->state = xprt->state; |
911813d7 CL |
983 | __assign_str(addr, xprt->address_strings[RPC_DISPLAY_ADDR]); |
984 | __assign_str(port, xprt->address_strings[RPC_DISPLAY_PORT]); | |
985 | ), | |
986 | ||
94afd9c4 CL |
987 | TP_printk("peer=[%s]:%s state=%s", |
988 | __get_str(addr), __get_str(port), | |
989 | rpc_show_xprt_state(__entry->state)) | |
911813d7 CL |
990 | ); |
991 | ||
992 | #define DEFINE_RPC_XPRT_LIFETIME_EVENT(name) \ | |
993 | DEFINE_EVENT(rpc_xprt_lifetime_class, \ | |
994 | xprt_##name, \ | |
995 | TP_PROTO( \ | |
996 | const struct rpc_xprt *xprt \ | |
997 | ), \ | |
998 | TP_ARGS(xprt)) | |
999 | ||
1000 | DEFINE_RPC_XPRT_LIFETIME_EVENT(create); | |
db0a86c4 | 1001 | DEFINE_RPC_XPRT_LIFETIME_EVENT(connect); |
911813d7 CL |
1002 | DEFINE_RPC_XPRT_LIFETIME_EVENT(disconnect_auto); |
1003 | DEFINE_RPC_XPRT_LIFETIME_EVENT(disconnect_done); | |
1004 | DEFINE_RPC_XPRT_LIFETIME_EVENT(disconnect_force); | |
1005 | DEFINE_RPC_XPRT_LIFETIME_EVENT(disconnect_cleanup); | |
1006 | DEFINE_RPC_XPRT_LIFETIME_EVENT(destroy); | |
1007 | ||
3705ad64 | 1008 | DECLARE_EVENT_CLASS(rpc_xprt_event, |
dc5820bd CL |
1009 | TP_PROTO( |
1010 | const struct rpc_xprt *xprt, | |
1011 | __be32 xid, | |
1012 | int status | |
1013 | ), | |
3705ad64 JL |
1014 | |
1015 | TP_ARGS(xprt, xid, status), | |
1016 | ||
1017 | TP_STRUCT__entry( | |
a30ccf1a | 1018 | __field(u32, xid) |
3705ad64 JL |
1019 | __field(int, status) |
1020 | __string(addr, xprt->address_strings[RPC_DISPLAY_ADDR]) | |
1021 | __string(port, xprt->address_strings[RPC_DISPLAY_PORT]) | |
1022 | ), | |
1023 | ||
1024 | TP_fast_assign( | |
a30ccf1a | 1025 | __entry->xid = be32_to_cpu(xid); |
3705ad64 JL |
1026 | __entry->status = status; |
1027 | __assign_str(addr, xprt->address_strings[RPC_DISPLAY_ADDR]); | |
1028 | __assign_str(port, xprt->address_strings[RPC_DISPLAY_PORT]); | |
1029 | ), | |
1030 | ||
a30ccf1a CL |
1031 | TP_printk("peer=[%s]:%s xid=0x%08x status=%d", __get_str(addr), |
1032 | __get_str(port), __entry->xid, | |
3705ad64 JL |
1033 | __entry->status) |
1034 | ); | |
dc5820bd CL |
1035 | #define DEFINE_RPC_XPRT_EVENT(name) \ |
1036 | DEFINE_EVENT(rpc_xprt_event, xprt_##name, \ | |
1037 | TP_PROTO( \ | |
1038 | const struct rpc_xprt *xprt, \ | |
1039 | __be32 xid, \ | |
1040 | int status \ | |
1041 | ), \ | |
1042 | TP_ARGS(xprt, xid, status)) | |
3705ad64 | 1043 | |
dc5820bd CL |
1044 | DEFINE_RPC_XPRT_EVENT(timer); |
1045 | DEFINE_RPC_XPRT_EVENT(lookup_rqst); | |
3705ad64 | 1046 | |
0c77668d CL |
1047 | TRACE_EVENT(xprt_transmit, |
1048 | TP_PROTO( | |
1049 | const struct rpc_rqst *rqst, | |
1050 | int status | |
1051 | ), | |
1052 | ||
1053 | TP_ARGS(rqst, status), | |
1054 | ||
1055 | TP_STRUCT__entry( | |
1056 | __field(unsigned int, task_id) | |
1057 | __field(unsigned int, client_id) | |
1058 | __field(u32, xid) | |
1059 | __field(u32, seqno) | |
1060 | __field(int, status) | |
1061 | ), | |
1062 | ||
1063 | TP_fast_assign( | |
1064 | __entry->task_id = rqst->rq_task->tk_pid; | |
f87b543a OK |
1065 | __entry->client_id = rqst->rq_task->tk_client ? |
1066 | rqst->rq_task->tk_client->cl_clid : -1; | |
0c77668d CL |
1067 | __entry->xid = be32_to_cpu(rqst->rq_xid); |
1068 | __entry->seqno = rqst->rq_seqno; | |
1069 | __entry->status = status; | |
1070 | ), | |
1071 | ||
1072 | TP_printk( | |
1073 | "task:%u@%u xid=0x%08x seqno=%u status=%d", | |
1074 | __entry->task_id, __entry->client_id, __entry->xid, | |
1075 | __entry->seqno, __entry->status) | |
1076 | ); | |
1077 | ||
a25a4cb3 CL |
1078 | TRACE_EVENT(xprt_ping, |
1079 | TP_PROTO(const struct rpc_xprt *xprt, int status), | |
1080 | ||
1081 | TP_ARGS(xprt, status), | |
1082 | ||
1083 | TP_STRUCT__entry( | |
1084 | __field(int, status) | |
1085 | __string(addr, xprt->address_strings[RPC_DISPLAY_ADDR]) | |
1086 | __string(port, xprt->address_strings[RPC_DISPLAY_PORT]) | |
1087 | ), | |
1088 | ||
1089 | TP_fast_assign( | |
1090 | __entry->status = status; | |
1091 | __assign_str(addr, xprt->address_strings[RPC_DISPLAY_ADDR]); | |
1092 | __assign_str(port, xprt->address_strings[RPC_DISPLAY_PORT]); | |
1093 | ), | |
1094 | ||
1095 | TP_printk("peer=[%s]:%s status=%d", | |
1096 | __get_str(addr), __get_str(port), __entry->status) | |
1097 | ); | |
1098 | ||
bf7ca707 CL |
1099 | DECLARE_EVENT_CLASS(xprt_writelock_event, |
1100 | TP_PROTO( | |
1101 | const struct rpc_xprt *xprt, const struct rpc_task *task | |
1102 | ), | |
1103 | ||
1104 | TP_ARGS(xprt, task), | |
1105 | ||
1106 | TP_STRUCT__entry( | |
1107 | __field(unsigned int, task_id) | |
1108 | __field(unsigned int, client_id) | |
1109 | __field(unsigned int, snd_task_id) | |
1110 | ), | |
1111 | ||
1112 | TP_fast_assign( | |
1113 | if (task) { | |
1114 | __entry->task_id = task->tk_pid; | |
1115 | __entry->client_id = task->tk_client ? | |
1116 | task->tk_client->cl_clid : -1; | |
1117 | } else { | |
1118 | __entry->task_id = -1; | |
1119 | __entry->client_id = -1; | |
1120 | } | |
1121 | __entry->snd_task_id = xprt->snd_task ? | |
1122 | xprt->snd_task->tk_pid : -1; | |
1123 | ), | |
1124 | ||
1125 | TP_printk("task:%u@%u snd_task:%u", | |
1126 | __entry->task_id, __entry->client_id, | |
1127 | __entry->snd_task_id) | |
1128 | ); | |
1129 | ||
1130 | #define DEFINE_WRITELOCK_EVENT(name) \ | |
1131 | DEFINE_EVENT(xprt_writelock_event, xprt_##name, \ | |
1132 | TP_PROTO( \ | |
1133 | const struct rpc_xprt *xprt, \ | |
1134 | const struct rpc_task *task \ | |
1135 | ), \ | |
1136 | TP_ARGS(xprt, task)) | |
1137 | ||
1138 | DEFINE_WRITELOCK_EVENT(reserve_xprt); | |
1139 | DEFINE_WRITELOCK_EVENT(release_xprt); | |
9ce07ae5 | 1140 | DEFINE_WRITELOCK_EVENT(transmit_queued); |
bf7ca707 CL |
1141 | |
1142 | DECLARE_EVENT_CLASS(xprt_cong_event, | |
1143 | TP_PROTO( | |
1144 | const struct rpc_xprt *xprt, const struct rpc_task *task | |
1145 | ), | |
1146 | ||
1147 | TP_ARGS(xprt, task), | |
1148 | ||
1149 | TP_STRUCT__entry( | |
1150 | __field(unsigned int, task_id) | |
1151 | __field(unsigned int, client_id) | |
1152 | __field(unsigned int, snd_task_id) | |
1153 | __field(unsigned long, cong) | |
1154 | __field(unsigned long, cwnd) | |
1155 | __field(bool, wait) | |
1156 | ), | |
1157 | ||
1158 | TP_fast_assign( | |
1159 | if (task) { | |
1160 | __entry->task_id = task->tk_pid; | |
1161 | __entry->client_id = task->tk_client ? | |
1162 | task->tk_client->cl_clid : -1; | |
1163 | } else { | |
1164 | __entry->task_id = -1; | |
1165 | __entry->client_id = -1; | |
1166 | } | |
1167 | __entry->snd_task_id = xprt->snd_task ? | |
1168 | xprt->snd_task->tk_pid : -1; | |
1169 | __entry->cong = xprt->cong; | |
1170 | __entry->cwnd = xprt->cwnd; | |
1171 | __entry->wait = test_bit(XPRT_CWND_WAIT, &xprt->state); | |
1172 | ), | |
1173 | ||
1174 | TP_printk("task:%u@%u snd_task:%u cong=%lu cwnd=%lu%s", | |
1175 | __entry->task_id, __entry->client_id, | |
1176 | __entry->snd_task_id, __entry->cong, __entry->cwnd, | |
1177 | __entry->wait ? " (wait)" : "") | |
1178 | ); | |
1179 | ||
1180 | #define DEFINE_CONG_EVENT(name) \ | |
1181 | DEFINE_EVENT(xprt_cong_event, xprt_##name, \ | |
1182 | TP_PROTO( \ | |
1183 | const struct rpc_xprt *xprt, \ | |
1184 | const struct rpc_task *task \ | |
1185 | ), \ | |
1186 | TP_ARGS(xprt, task)) | |
1187 | ||
1188 | DEFINE_CONG_EVENT(reserve_cong); | |
1189 | DEFINE_CONG_EVENT(release_cong); | |
1190 | DEFINE_CONG_EVENT(get_cong); | |
1191 | DEFINE_CONG_EVENT(put_cong); | |
1192 | ||
09d2ba0c CL |
1193 | TRACE_EVENT(xprt_reserve, |
1194 | TP_PROTO( | |
1195 | const struct rpc_rqst *rqst | |
1196 | ), | |
1197 | ||
1198 | TP_ARGS(rqst), | |
1199 | ||
1200 | TP_STRUCT__entry( | |
1201 | __field(unsigned int, task_id) | |
1202 | __field(unsigned int, client_id) | |
1203 | __field(u32, xid) | |
1204 | ), | |
1205 | ||
1206 | TP_fast_assign( | |
1207 | __entry->task_id = rqst->rq_task->tk_pid; | |
1208 | __entry->client_id = rqst->rq_task->tk_client->cl_clid; | |
1209 | __entry->xid = be32_to_cpu(rqst->rq_xid); | |
1210 | ), | |
1211 | ||
1212 | TP_printk("task:%u@%u xid=0x%08x", | |
1213 | __entry->task_id, __entry->client_id, __entry->xid | |
1214 | ) | |
1215 | ); | |
1216 | ||
c50b8ee0 TM |
1217 | TRACE_EVENT(xs_stream_read_data, |
1218 | TP_PROTO(struct rpc_xprt *xprt, ssize_t err, size_t total), | |
3705ad64 JL |
1219 | |
1220 | TP_ARGS(xprt, err, total), | |
1221 | ||
1222 | TP_STRUCT__entry( | |
c50b8ee0 TM |
1223 | __field(ssize_t, err) |
1224 | __field(size_t, total) | |
3705ad64 JL |
1225 | __string(addr, xprt ? xprt->address_strings[RPC_DISPLAY_ADDR] : |
1226 | "(null)") | |
1227 | __string(port, xprt ? xprt->address_strings[RPC_DISPLAY_PORT] : | |
1228 | "(null)") | |
1229 | ), | |
1230 | ||
1231 | TP_fast_assign( | |
1232 | __entry->err = err; | |
1233 | __entry->total = total; | |
1234 | __assign_str(addr, xprt ? | |
1235 | xprt->address_strings[RPC_DISPLAY_ADDR] : "(null)"); | |
1236 | __assign_str(port, xprt ? | |
1237 | xprt->address_strings[RPC_DISPLAY_PORT] : "(null)"); | |
1238 | ), | |
1239 | ||
c50b8ee0 | 1240 | TP_printk("peer=[%s]:%s err=%zd total=%zu", __get_str(addr), |
3705ad64 JL |
1241 | __get_str(port), __entry->err, __entry->total) |
1242 | ); | |
1243 | ||
c50b8ee0 | 1244 | TRACE_EVENT(xs_stream_read_request, |
1a867a08 JL |
1245 | TP_PROTO(struct sock_xprt *xs), |
1246 | ||
1247 | TP_ARGS(xs), | |
1248 | ||
1249 | TP_STRUCT__entry( | |
1250 | __string(addr, xs->xprt.address_strings[RPC_DISPLAY_ADDR]) | |
1251 | __string(port, xs->xprt.address_strings[RPC_DISPLAY_PORT]) | |
a30ccf1a | 1252 | __field(u32, xid) |
1a867a08 JL |
1253 | __field(unsigned long, copied) |
1254 | __field(unsigned int, reclen) | |
c50b8ee0 | 1255 | __field(unsigned int, offset) |
1a867a08 JL |
1256 | ), |
1257 | ||
1258 | TP_fast_assign( | |
1259 | __assign_str(addr, xs->xprt.address_strings[RPC_DISPLAY_ADDR]); | |
1260 | __assign_str(port, xs->xprt.address_strings[RPC_DISPLAY_PORT]); | |
d1109aa5 | 1261 | __entry->xid = be32_to_cpu(xs->recv.xid); |
d1109aa5 TM |
1262 | __entry->copied = xs->recv.copied; |
1263 | __entry->reclen = xs->recv.len; | |
1264 | __entry->offset = xs->recv.offset; | |
1a867a08 JL |
1265 | ), |
1266 | ||
c50b8ee0 | 1267 | TP_printk("peer=[%s]:%s xid=0x%08x copied=%lu reclen=%u offset=%u", |
a30ccf1a | 1268 | __get_str(addr), __get_str(port), __entry->xid, |
1a867a08 JL |
1269 | __entry->copied, __entry->reclen, __entry->offset) |
1270 | ); | |
1271 | ||
e465cc3f CL |
1272 | TRACE_EVENT(rpcb_getport, |
1273 | TP_PROTO( | |
1274 | const struct rpc_clnt *clnt, | |
1275 | const struct rpc_task *task, | |
1276 | unsigned int bind_version | |
1277 | ), | |
1278 | ||
1279 | TP_ARGS(clnt, task, bind_version), | |
1280 | ||
1281 | TP_STRUCT__entry( | |
1282 | __field(unsigned int, task_id) | |
1283 | __field(unsigned int, client_id) | |
1284 | __field(unsigned int, program) | |
1285 | __field(unsigned int, version) | |
1286 | __field(int, protocol) | |
1287 | __field(unsigned int, bind_version) | |
1288 | __string(servername, task->tk_xprt->servername) | |
1289 | ), | |
1290 | ||
1291 | TP_fast_assign( | |
1292 | __entry->task_id = task->tk_pid; | |
1293 | __entry->client_id = clnt->cl_clid; | |
1294 | __entry->program = clnt->cl_prog; | |
1295 | __entry->version = clnt->cl_vers; | |
1296 | __entry->protocol = task->tk_xprt->prot; | |
1297 | __entry->bind_version = bind_version; | |
1298 | __assign_str(servername, task->tk_xprt->servername); | |
1299 | ), | |
1300 | ||
1301 | TP_printk("task:%u@%u server=%s program=%u version=%u protocol=%d bind_version=%u", | |
1302 | __entry->task_id, __entry->client_id, __get_str(servername), | |
1303 | __entry->program, __entry->version, __entry->protocol, | |
1304 | __entry->bind_version | |
1305 | ) | |
1306 | ); | |
c509f15a | 1307 | |
ac1ae534 CL |
1308 | TRACE_EVENT(rpcb_setport, |
1309 | TP_PROTO( | |
1310 | const struct rpc_task *task, | |
1311 | int status, | |
1312 | unsigned short port | |
1313 | ), | |
1314 | ||
1315 | TP_ARGS(task, status, port), | |
1316 | ||
1317 | TP_STRUCT__entry( | |
1318 | __field(unsigned int, task_id) | |
1319 | __field(unsigned int, client_id) | |
1320 | __field(int, status) | |
1321 | __field(unsigned short, port) | |
1322 | ), | |
1323 | ||
1324 | TP_fast_assign( | |
1325 | __entry->task_id = task->tk_pid; | |
1326 | __entry->client_id = task->tk_client->cl_clid; | |
1327 | __entry->status = status; | |
1328 | __entry->port = port; | |
1329 | ), | |
1330 | ||
1331 | TP_printk("task:%u@%u status=%d port=%u", | |
1332 | __entry->task_id, __entry->client_id, | |
1333 | __entry->status, __entry->port | |
1334 | ) | |
1335 | ); | |
1336 | ||
c3adcc7d CL |
1337 | TRACE_EVENT(pmap_register, |
1338 | TP_PROTO( | |
1339 | u32 program, | |
1340 | u32 version, | |
1341 | int protocol, | |
1342 | unsigned short port | |
1343 | ), | |
1344 | ||
1345 | TP_ARGS(program, version, protocol, port), | |
1346 | ||
1347 | TP_STRUCT__entry( | |
1348 | __field(unsigned int, program) | |
1349 | __field(unsigned int, version) | |
1350 | __field(int, protocol) | |
1351 | __field(unsigned int, port) | |
1352 | ), | |
1353 | ||
1354 | TP_fast_assign( | |
1355 | __entry->program = program; | |
1356 | __entry->version = version; | |
1357 | __entry->protocol = protocol; | |
1358 | __entry->port = port; | |
1359 | ), | |
1360 | ||
1361 | TP_printk("program=%u version=%u protocol=%d port=%u", | |
1362 | __entry->program, __entry->version, | |
1363 | __entry->protocol, __entry->port | |
1364 | ) | |
1365 | ); | |
1366 | ||
1367 | TRACE_EVENT(rpcb_register, | |
1368 | TP_PROTO( | |
1369 | u32 program, | |
1370 | u32 version, | |
1371 | const char *addr, | |
1372 | const char *netid | |
1373 | ), | |
1374 | ||
1375 | TP_ARGS(program, version, addr, netid), | |
1376 | ||
1377 | TP_STRUCT__entry( | |
1378 | __field(unsigned int, program) | |
1379 | __field(unsigned int, version) | |
1380 | __string(addr, addr) | |
1381 | __string(netid, netid) | |
1382 | ), | |
1383 | ||
1384 | TP_fast_assign( | |
1385 | __entry->program = program; | |
1386 | __entry->version = version; | |
1387 | __assign_str(addr, addr); | |
1388 | __assign_str(netid, netid); | |
1389 | ), | |
1390 | ||
1391 | TP_printk("program=%u version=%u addr=%s netid=%s", | |
1392 | __entry->program, __entry->version, | |
1393 | __get_str(addr), __get_str(netid) | |
1394 | ) | |
1395 | ); | |
1396 | ||
1397 | TRACE_EVENT(rpcb_unregister, | |
1398 | TP_PROTO( | |
1399 | u32 program, | |
1400 | u32 version, | |
1401 | const char *netid | |
1402 | ), | |
1403 | ||
1404 | TP_ARGS(program, version, netid), | |
1405 | ||
1406 | TP_STRUCT__entry( | |
1407 | __field(unsigned int, program) | |
1408 | __field(unsigned int, version) | |
1409 | __string(netid, netid) | |
1410 | ), | |
1411 | ||
1412 | TP_fast_assign( | |
1413 | __entry->program = program; | |
1414 | __entry->version = version; | |
1415 | __assign_str(netid, netid); | |
1416 | ), | |
1417 | ||
1418 | TP_printk("program=%u version=%u netid=%s", | |
1419 | __entry->program, __entry->version, __get_str(netid) | |
1420 | ) | |
1421 | ); | |
1422 | ||
c509f15a CL |
1423 | DECLARE_EVENT_CLASS(svc_xdr_buf_class, |
1424 | TP_PROTO( | |
1425 | const struct svc_rqst *rqst, | |
1426 | const struct xdr_buf *xdr | |
1427 | ), | |
1428 | ||
1429 | TP_ARGS(rqst, xdr), | |
1430 | ||
1431 | TP_STRUCT__entry( | |
1432 | __field(u32, xid) | |
1433 | __field(const void *, head_base) | |
1434 | __field(size_t, head_len) | |
1435 | __field(const void *, tail_base) | |
1436 | __field(size_t, tail_len) | |
1437 | __field(unsigned int, page_len) | |
1438 | __field(unsigned int, msg_len) | |
1439 | ), | |
1440 | ||
1441 | TP_fast_assign( | |
1442 | __entry->xid = be32_to_cpu(rqst->rq_xid); | |
1443 | __entry->head_base = xdr->head[0].iov_base; | |
1444 | __entry->head_len = xdr->head[0].iov_len; | |
1445 | __entry->tail_base = xdr->tail[0].iov_base; | |
1446 | __entry->tail_len = xdr->tail[0].iov_len; | |
1447 | __entry->page_len = xdr->page_len; | |
1448 | __entry->msg_len = xdr->len; | |
1449 | ), | |
1450 | ||
1451 | TP_printk("xid=0x%08x head=[%p,%zu] page=%u tail=[%p,%zu] len=%u", | |
1452 | __entry->xid, | |
1453 | __entry->head_base, __entry->head_len, __entry->page_len, | |
1454 | __entry->tail_base, __entry->tail_len, __entry->msg_len | |
1455 | ) | |
1456 | ); | |
1457 | ||
1458 | #define DEFINE_SVCXDRBUF_EVENT(name) \ | |
1459 | DEFINE_EVENT(svc_xdr_buf_class, \ | |
1460 | svc_xdr_##name, \ | |
1461 | TP_PROTO( \ | |
1462 | const struct svc_rqst *rqst, \ | |
1463 | const struct xdr_buf *xdr \ | |
1464 | ), \ | |
1465 | TP_ARGS(rqst, xdr)) | |
1466 | ||
1467 | DEFINE_SVCXDRBUF_EVENT(recvfrom); | |
1468 | DEFINE_SVCXDRBUF_EVENT(sendto); | |
1469 | ||
a68d5a50 CL |
1470 | /* |
1471 | * from include/linux/sunrpc/svc.h | |
1472 | */ | |
1473 | #define SVC_RQST_FLAG_LIST \ | |
1474 | svc_rqst_flag(SECURE) \ | |
1475 | svc_rqst_flag(LOCAL) \ | |
1476 | svc_rqst_flag(USEDEFERRAL) \ | |
1477 | svc_rqst_flag(DROPME) \ | |
1478 | svc_rqst_flag(SPLICE_OK) \ | |
1479 | svc_rqst_flag(VICTIM) \ | |
1480 | svc_rqst_flag(BUSY) \ | |
1481 | svc_rqst_flag(DATA) \ | |
1482 | svc_rqst_flag_end(AUTHERR) | |
1483 | ||
1484 | #undef svc_rqst_flag | |
1485 | #undef svc_rqst_flag_end | |
1486 | #define svc_rqst_flag(x) TRACE_DEFINE_ENUM(RQ_##x); | |
1487 | #define svc_rqst_flag_end(x) TRACE_DEFINE_ENUM(RQ_##x); | |
1488 | ||
1489 | SVC_RQST_FLAG_LIST | |
1490 | ||
1491 | #undef svc_rqst_flag | |
1492 | #undef svc_rqst_flag_end | |
1493 | #define svc_rqst_flag(x) { BIT(RQ_##x), #x }, | |
1494 | #define svc_rqst_flag_end(x) { BIT(RQ_##x), #x } | |
1495 | ||
30660e04 | 1496 | #define show_rqstp_flags(flags) \ |
a68d5a50 | 1497 | __print_flags(flags, "|", SVC_RQST_FLAG_LIST) |
4d152e2c | 1498 | |
860a0d9e | 1499 | TRACE_EVENT(svc_recv, |
41f306d0 | 1500 | TP_PROTO(struct svc_rqst *rqst, int len), |
860a0d9e | 1501 | |
41f306d0 | 1502 | TP_ARGS(rqst, len), |
860a0d9e JL |
1503 | |
1504 | TP_STRUCT__entry( | |
a30ccf1a | 1505 | __field(u32, xid) |
41f306d0 | 1506 | __field(int, len) |
4d152e2c | 1507 | __field(unsigned long, flags) |
ece200dd | 1508 | __string(addr, rqst->rq_xprt->xpt_remotebuf) |
860a0d9e JL |
1509 | ), |
1510 | ||
1511 | TP_fast_assign( | |
41f306d0 CL |
1512 | __entry->xid = be32_to_cpu(rqst->rq_xid); |
1513 | __entry->len = len; | |
4d152e2c | 1514 | __entry->flags = rqst->rq_flags; |
ece200dd | 1515 | __assign_str(addr, rqst->rq_xprt->xpt_remotebuf); |
860a0d9e JL |
1516 | ), |
1517 | ||
ece200dd CL |
1518 | TP_printk("addr=%s xid=0x%08x len=%d flags=%s", |
1519 | __get_str(addr), __entry->xid, __entry->len, | |
4d152e2c | 1520 | show_rqstp_flags(__entry->flags)) |
860a0d9e JL |
1521 | ); |
1522 | ||
d88ff958 CL |
1523 | TRACE_DEFINE_ENUM(SVC_GARBAGE); |
1524 | TRACE_DEFINE_ENUM(SVC_SYSERR); | |
1525 | TRACE_DEFINE_ENUM(SVC_VALID); | |
1526 | TRACE_DEFINE_ENUM(SVC_NEGATIVE); | |
1527 | TRACE_DEFINE_ENUM(SVC_OK); | |
1528 | TRACE_DEFINE_ENUM(SVC_DROP); | |
1529 | TRACE_DEFINE_ENUM(SVC_CLOSE); | |
1530 | TRACE_DEFINE_ENUM(SVC_DENIED); | |
1531 | TRACE_DEFINE_ENUM(SVC_PENDING); | |
1532 | TRACE_DEFINE_ENUM(SVC_COMPLETE); | |
1533 | ||
ff27e9f7 CL |
1534 | #define svc_show_status(status) \ |
1535 | __print_symbolic(status, \ | |
1536 | { SVC_GARBAGE, "SVC_GARBAGE" }, \ | |
1537 | { SVC_SYSERR, "SVC_SYSERR" }, \ | |
1538 | { SVC_VALID, "SVC_VALID" }, \ | |
1539 | { SVC_NEGATIVE, "SVC_NEGATIVE" }, \ | |
1540 | { SVC_OK, "SVC_OK" }, \ | |
1541 | { SVC_DROP, "SVC_DROP" }, \ | |
1542 | { SVC_CLOSE, "SVC_CLOSE" }, \ | |
1543 | { SVC_DENIED, "SVC_DENIED" }, \ | |
1544 | { SVC_PENDING, "SVC_PENDING" }, \ | |
1545 | { SVC_COMPLETE, "SVC_COMPLETE" }) | |
1546 | ||
1547 | TRACE_EVENT(svc_authenticate, | |
1548 | TP_PROTO(const struct svc_rqst *rqst, int auth_res, __be32 auth_stat), | |
1549 | ||
1550 | TP_ARGS(rqst, auth_res, auth_stat), | |
1551 | ||
1552 | TP_STRUCT__entry( | |
1553 | __field(u32, xid) | |
1554 | __field(unsigned long, svc_status) | |
1555 | __field(unsigned long, auth_stat) | |
1556 | ), | |
1557 | ||
1558 | TP_fast_assign( | |
1559 | __entry->xid = be32_to_cpu(rqst->rq_xid); | |
1560 | __entry->svc_status = auth_res; | |
1561 | __entry->auth_stat = be32_to_cpu(auth_stat); | |
1562 | ), | |
1563 | ||
1564 | TP_printk("xid=0x%08x auth_res=%s auth_stat=%s", | |
1565 | __entry->xid, svc_show_status(__entry->svc_status), | |
1566 | rpc_show_auth_stat(__entry->auth_stat)) | |
1567 | ); | |
1568 | ||
0b9547bf CL |
1569 | TRACE_EVENT(svc_process, |
1570 | TP_PROTO(const struct svc_rqst *rqst, const char *name), | |
1571 | ||
1572 | TP_ARGS(rqst, name), | |
1573 | ||
1574 | TP_STRUCT__entry( | |
1575 | __field(u32, xid) | |
1576 | __field(u32, vers) | |
1577 | __field(u32, proc) | |
1578 | __string(service, name) | |
d4b09acf VA |
1579 | __string(addr, rqst->rq_xprt ? |
1580 | rqst->rq_xprt->xpt_remotebuf : "(null)") | |
0b9547bf CL |
1581 | ), |
1582 | ||
1583 | TP_fast_assign( | |
1584 | __entry->xid = be32_to_cpu(rqst->rq_xid); | |
1585 | __entry->vers = rqst->rq_vers; | |
1586 | __entry->proc = rqst->rq_proc; | |
1587 | __assign_str(service, name); | |
d4b09acf VA |
1588 | __assign_str(addr, rqst->rq_xprt ? |
1589 | rqst->rq_xprt->xpt_remotebuf : "(null)"); | |
0b9547bf CL |
1590 | ), |
1591 | ||
1592 | TP_printk("addr=%s xid=0x%08x service=%s vers=%u proc=%u", | |
1593 | __get_str(addr), __entry->xid, | |
1594 | __get_str(service), __entry->vers, __entry->proc) | |
1595 | ); | |
1596 | ||
104f6351 TM |
1597 | DECLARE_EVENT_CLASS(svc_rqst_event, |
1598 | ||
dc5820bd CL |
1599 | TP_PROTO( |
1600 | const struct svc_rqst *rqst | |
1601 | ), | |
104f6351 TM |
1602 | |
1603 | TP_ARGS(rqst), | |
1604 | ||
1605 | TP_STRUCT__entry( | |
a30ccf1a | 1606 | __field(u32, xid) |
104f6351 | 1607 | __field(unsigned long, flags) |
ece200dd | 1608 | __string(addr, rqst->rq_xprt->xpt_remotebuf) |
104f6351 TM |
1609 | ), |
1610 | ||
1611 | TP_fast_assign( | |
a30ccf1a | 1612 | __entry->xid = be32_to_cpu(rqst->rq_xid); |
104f6351 | 1613 | __entry->flags = rqst->rq_flags; |
ece200dd | 1614 | __assign_str(addr, rqst->rq_xprt->xpt_remotebuf); |
104f6351 TM |
1615 | ), |
1616 | ||
ece200dd CL |
1617 | TP_printk("addr=%s xid=0x%08x flags=%s", |
1618 | __get_str(addr), __entry->xid, | |
1619 | show_rqstp_flags(__entry->flags)) | |
104f6351 | 1620 | ); |
dc5820bd CL |
1621 | #define DEFINE_SVC_RQST_EVENT(name) \ |
1622 | DEFINE_EVENT(svc_rqst_event, svc_##name, \ | |
1623 | TP_PROTO( \ | |
1624 | const struct svc_rqst *rqst \ | |
1625 | ), \ | |
1626 | TP_ARGS(rqst)) | |
104f6351 | 1627 | |
dc5820bd CL |
1628 | DEFINE_SVC_RQST_EVENT(defer); |
1629 | DEFINE_SVC_RQST_EVENT(drop); | |
104f6351 | 1630 | |
860a0d9e JL |
1631 | DECLARE_EVENT_CLASS(svc_rqst_status, |
1632 | ||
1633 | TP_PROTO(struct svc_rqst *rqst, int status), | |
1634 | ||
1635 | TP_ARGS(rqst, status), | |
1636 | ||
1637 | TP_STRUCT__entry( | |
a30ccf1a | 1638 | __field(u32, xid) |
860a0d9e | 1639 | __field(int, status) |
4d152e2c | 1640 | __field(unsigned long, flags) |
ece200dd | 1641 | __string(addr, rqst->rq_xprt->xpt_remotebuf) |
860a0d9e JL |
1642 | ), |
1643 | ||
1644 | TP_fast_assign( | |
a30ccf1a | 1645 | __entry->xid = be32_to_cpu(rqst->rq_xid); |
860a0d9e | 1646 | __entry->status = status; |
4d152e2c | 1647 | __entry->flags = rqst->rq_flags; |
ece200dd | 1648 | __assign_str(addr, rqst->rq_xprt->xpt_remotebuf); |
860a0d9e JL |
1649 | ), |
1650 | ||
ece200dd CL |
1651 | TP_printk("addr=%s xid=0x%08x status=%d flags=%s", |
1652 | __get_str(addr), __entry->xid, | |
1653 | __entry->status, show_rqstp_flags(__entry->flags)) | |
860a0d9e JL |
1654 | ); |
1655 | ||
860a0d9e JL |
1656 | DEFINE_EVENT(svc_rqst_status, svc_send, |
1657 | TP_PROTO(struct svc_rqst *rqst, int status), | |
1658 | TP_ARGS(rqst, status)); | |
1659 | ||
83a712e0 JL |
1660 | #define show_svc_xprt_flags(flags) \ |
1661 | __print_flags(flags, "|", \ | |
1662 | { (1UL << XPT_BUSY), "XPT_BUSY"}, \ | |
1663 | { (1UL << XPT_CONN), "XPT_CONN"}, \ | |
1664 | { (1UL << XPT_CLOSE), "XPT_CLOSE"}, \ | |
1665 | { (1UL << XPT_DATA), "XPT_DATA"}, \ | |
1666 | { (1UL << XPT_TEMP), "XPT_TEMP"}, \ | |
1667 | { (1UL << XPT_DEAD), "XPT_DEAD"}, \ | |
1668 | { (1UL << XPT_CHNGBUF), "XPT_CHNGBUF"}, \ | |
1669 | { (1UL << XPT_DEFERRED), "XPT_DEFERRED"}, \ | |
1670 | { (1UL << XPT_OLD), "XPT_OLD"}, \ | |
1671 | { (1UL << XPT_LISTENER), "XPT_LISTENER"}, \ | |
1672 | { (1UL << XPT_CACHE_AUTH), "XPT_CACHE_AUTH"}, \ | |
03edb90f CL |
1673 | { (1UL << XPT_LOCAL), "XPT_LOCAL"}, \ |
1674 | { (1UL << XPT_KILL_TEMP), "XPT_KILL_TEMP"}, \ | |
1675 | { (1UL << XPT_CONG_CTRL), "XPT_CONG_CTRL"}) | |
83a712e0 | 1676 | |
4b8f380e CL |
1677 | TRACE_EVENT(svc_xprt_create_err, |
1678 | TP_PROTO( | |
1679 | const char *program, | |
1680 | const char *protocol, | |
1681 | struct sockaddr *sap, | |
1682 | const struct svc_xprt *xprt | |
1683 | ), | |
1684 | ||
1685 | TP_ARGS(program, protocol, sap, xprt), | |
1686 | ||
1687 | TP_STRUCT__entry( | |
1688 | __field(long, error) | |
1689 | __string(program, program) | |
1690 | __string(protocol, protocol) | |
1691 | __array(unsigned char, addr, sizeof(struct sockaddr_in6)) | |
1692 | ), | |
1693 | ||
1694 | TP_fast_assign( | |
1695 | __entry->error = PTR_ERR(xprt); | |
1696 | __assign_str(program, program); | |
1697 | __assign_str(protocol, protocol); | |
1698 | memcpy(__entry->addr, sap, sizeof(__entry->addr)); | |
1699 | ), | |
1700 | ||
1701 | TP_printk("addr=%pISpc program=%s protocol=%s error=%ld", | |
1702 | __entry->addr, __get_str(program), __get_str(protocol), | |
1703 | __entry->error) | |
1704 | ); | |
1705 | ||
83a712e0 JL |
1706 | TRACE_EVENT(svc_xprt_do_enqueue, |
1707 | TP_PROTO(struct svc_xprt *xprt, struct svc_rqst *rqst), | |
1708 | ||
1709 | TP_ARGS(xprt, rqst), | |
1710 | ||
1711 | TP_STRUCT__entry( | |
051ac384 PA |
1712 | __field(int, pid) |
1713 | __field(unsigned long, flags) | |
ece200dd | 1714 | __string(addr, xprt->xpt_remotebuf) |
83a712e0 JL |
1715 | ), |
1716 | ||
1717 | TP_fast_assign( | |
051ac384 | 1718 | __entry->pid = rqst? rqst->rq_task->pid : 0; |
ece200dd CL |
1719 | __entry->flags = xprt->xpt_flags; |
1720 | __assign_str(addr, xprt->xpt_remotebuf); | |
83a712e0 JL |
1721 | ), |
1722 | ||
e3e67621 CL |
1723 | TP_printk("addr=%s pid=%d flags=%s", __get_str(addr), |
1724 | __entry->pid, show_svc_xprt_flags(__entry->flags)) | |
83a712e0 JL |
1725 | ); |
1726 | ||
82ea2d76 | 1727 | DECLARE_EVENT_CLASS(svc_xprt_event, |
83a712e0 JL |
1728 | TP_PROTO(struct svc_xprt *xprt), |
1729 | ||
1730 | TP_ARGS(xprt), | |
1731 | ||
1732 | TP_STRUCT__entry( | |
83a712e0 | 1733 | __field(unsigned long, flags) |
ece200dd | 1734 | __string(addr, xprt->xpt_remotebuf) |
83a712e0 JL |
1735 | ), |
1736 | ||
1737 | TP_fast_assign( | |
caa3e106 | 1738 | __entry->flags = xprt->xpt_flags; |
ece200dd | 1739 | __assign_str(addr, xprt->xpt_remotebuf); |
83a712e0 JL |
1740 | ), |
1741 | ||
e3e67621 CL |
1742 | TP_printk("addr=%s flags=%s", __get_str(addr), |
1743 | show_svc_xprt_flags(__entry->flags)) | |
83a712e0 JL |
1744 | ); |
1745 | ||
11bbb0f7 CL |
1746 | #define DEFINE_SVC_XPRT_EVENT(name) \ |
1747 | DEFINE_EVENT(svc_xprt_event, svc_xprt_##name, \ | |
1748 | TP_PROTO( \ | |
1749 | struct svc_xprt *xprt \ | |
1750 | ), \ | |
1751 | TP_ARGS(xprt)) | |
1752 | ||
1753 | DEFINE_SVC_XPRT_EVENT(no_write_space); | |
1754 | DEFINE_SVC_XPRT_EVENT(close); | |
1755 | DEFINE_SVC_XPRT_EVENT(detach); | |
1756 | DEFINE_SVC_XPRT_EVENT(free); | |
1757 | ||
1758 | TRACE_EVENT(svc_xprt_accept, | |
1759 | TP_PROTO( | |
1760 | const struct svc_xprt *xprt, | |
1761 | const char *service | |
1762 | ), | |
1763 | ||
1764 | TP_ARGS(xprt, service), | |
1765 | ||
1766 | TP_STRUCT__entry( | |
1767 | __string(addr, xprt->xpt_remotebuf) | |
1768 | __string(protocol, xprt->xpt_class->xcl_name) | |
1769 | __string(service, service) | |
1770 | ), | |
1771 | ||
1772 | TP_fast_assign( | |
1773 | __assign_str(addr, xprt->xpt_remotebuf); | |
1774 | __assign_str(protocol, xprt->xpt_class->xcl_name) | |
1775 | __assign_str(service, service); | |
1776 | ), | |
1777 | ||
1778 | TP_printk("addr=%s protocol=%s service=%s", | |
1779 | __get_str(addr), __get_str(protocol), __get_str(service) | |
1780 | ) | |
1781 | ); | |
82ea2d76 | 1782 | |
55f5088c CL |
1783 | TRACE_EVENT(svc_xprt_dequeue, |
1784 | TP_PROTO(struct svc_rqst *rqst), | |
1785 | ||
1786 | TP_ARGS(rqst), | |
1787 | ||
1788 | TP_STRUCT__entry( | |
55f5088c CL |
1789 | __field(unsigned long, flags) |
1790 | __field(unsigned long, wakeup) | |
1791 | __string(addr, rqst->rq_xprt->xpt_remotebuf) | |
1792 | ), | |
1793 | ||
1794 | TP_fast_assign( | |
55f5088c CL |
1795 | __entry->flags = rqst->rq_xprt->xpt_flags; |
1796 | __entry->wakeup = ktime_to_us(ktime_sub(ktime_get(), | |
1797 | rqst->rq_qtime)); | |
1798 | __assign_str(addr, rqst->rq_xprt->xpt_remotebuf); | |
1799 | ), | |
1800 | ||
e3e67621 CL |
1801 | TP_printk("addr=%s flags=%s wakeup-us=%lu", __get_str(addr), |
1802 | show_svc_xprt_flags(__entry->flags), __entry->wakeup) | |
55f5088c CL |
1803 | ); |
1804 | ||
83a712e0 JL |
1805 | TRACE_EVENT(svc_wake_up, |
1806 | TP_PROTO(int pid), | |
1807 | ||
1808 | TP_ARGS(pid), | |
1809 | ||
1810 | TP_STRUCT__entry( | |
1811 | __field(int, pid) | |
1812 | ), | |
1813 | ||
1814 | TP_fast_assign( | |
1815 | __entry->pid = pid; | |
1816 | ), | |
1817 | ||
1818 | TP_printk("pid=%d", __entry->pid) | |
1819 | ); | |
1820 | ||
1821 | TRACE_EVENT(svc_handle_xprt, | |
1822 | TP_PROTO(struct svc_xprt *xprt, int len), | |
1823 | ||
1824 | TP_ARGS(xprt, len), | |
1825 | ||
1826 | TP_STRUCT__entry( | |
83a712e0 | 1827 | __field(int, len) |
051ac384 | 1828 | __field(unsigned long, flags) |
ece200dd | 1829 | __string(addr, xprt->xpt_remotebuf) |
83a712e0 JL |
1830 | ), |
1831 | ||
1832 | TP_fast_assign( | |
83a712e0 | 1833 | __entry->len = len; |
ece200dd CL |
1834 | __entry->flags = xprt->xpt_flags; |
1835 | __assign_str(addr, xprt->xpt_remotebuf); | |
83a712e0 JL |
1836 | ), |
1837 | ||
e3e67621 | 1838 | TP_printk("addr=%s len=%d flags=%s", __get_str(addr), |
051ac384 | 1839 | __entry->len, show_svc_xprt_flags(__entry->flags)) |
83a712e0 | 1840 | ); |
104f6351 | 1841 | |
aaba72cd CL |
1842 | TRACE_EVENT(svc_stats_latency, |
1843 | TP_PROTO(const struct svc_rqst *rqst), | |
1844 | ||
1845 | TP_ARGS(rqst), | |
1846 | ||
1847 | TP_STRUCT__entry( | |
1848 | __field(u32, xid) | |
1849 | __field(unsigned long, execute) | |
1850 | __string(addr, rqst->rq_xprt->xpt_remotebuf) | |
1851 | ), | |
1852 | ||
1853 | TP_fast_assign( | |
1854 | __entry->xid = be32_to_cpu(rqst->rq_xid); | |
1855 | __entry->execute = ktime_to_us(ktime_sub(ktime_get(), | |
1856 | rqst->rq_stime)); | |
1857 | __assign_str(addr, rqst->rq_xprt->xpt_remotebuf); | |
1858 | ), | |
1859 | ||
1860 | TP_printk("addr=%s xid=0x%08x execute-us=%lu", | |
1861 | __get_str(addr), __entry->xid, __entry->execute) | |
1862 | ); | |
104f6351 TM |
1863 | |
1864 | DECLARE_EVENT_CLASS(svc_deferred_event, | |
dc5820bd CL |
1865 | TP_PROTO( |
1866 | const struct svc_deferred_req *dr | |
1867 | ), | |
104f6351 TM |
1868 | |
1869 | TP_ARGS(dr), | |
1870 | ||
1871 | TP_STRUCT__entry( | |
8954c5c2 | 1872 | __field(const void *, dr) |
a30ccf1a | 1873 | __field(u32, xid) |
ece200dd | 1874 | __string(addr, dr->xprt->xpt_remotebuf) |
104f6351 TM |
1875 | ), |
1876 | ||
1877 | TP_fast_assign( | |
8954c5c2 | 1878 | __entry->dr = dr; |
a30ccf1a CL |
1879 | __entry->xid = be32_to_cpu(*(__be32 *)(dr->args + |
1880 | (dr->xprt_hlen>>2))); | |
ece200dd | 1881 | __assign_str(addr, dr->xprt->xpt_remotebuf); |
104f6351 TM |
1882 | ), |
1883 | ||
8954c5c2 CL |
1884 | TP_printk("addr=%s dr=%p xid=0x%08x", __get_str(addr), __entry->dr, |
1885 | __entry->xid) | |
104f6351 | 1886 | ); |
8954c5c2 | 1887 | |
dc5820bd | 1888 | #define DEFINE_SVC_DEFERRED_EVENT(name) \ |
8954c5c2 | 1889 | DEFINE_EVENT(svc_deferred_event, svc_defer_##name, \ |
dc5820bd CL |
1890 | TP_PROTO( \ |
1891 | const struct svc_deferred_req *dr \ | |
1892 | ), \ | |
1893 | TP_ARGS(dr)) | |
1894 | ||
1895 | DEFINE_SVC_DEFERRED_EVENT(drop); | |
8954c5c2 CL |
1896 | DEFINE_SVC_DEFERRED_EVENT(queue); |
1897 | DEFINE_SVC_DEFERRED_EVENT(recv); | |
104f6351 | 1898 | |
998024de CL |
1899 | TRACE_EVENT(svcsock_new_socket, |
1900 | TP_PROTO( | |
1901 | const struct socket *socket | |
1902 | ), | |
1903 | ||
1904 | TP_ARGS(socket), | |
1905 | ||
1906 | TP_STRUCT__entry( | |
1907 | __field(unsigned long, type) | |
1908 | __field(unsigned long, family) | |
1909 | __field(bool, listener) | |
1910 | ), | |
1911 | ||
1912 | TP_fast_assign( | |
1913 | __entry->type = socket->type; | |
1914 | __entry->family = socket->sk->sk_family; | |
1915 | __entry->listener = (socket->sk->sk_state == TCP_LISTEN); | |
1916 | ), | |
1917 | ||
1918 | TP_printk("type=%s family=%s%s", | |
1919 | show_socket_type(__entry->type), | |
1920 | rpc_show_address_family(__entry->family), | |
1921 | __entry->listener ? " (listener)" : "" | |
1922 | ) | |
1923 | ); | |
1924 | ||
a5cda73e CL |
1925 | TRACE_EVENT(svcsock_marker, |
1926 | TP_PROTO( | |
1927 | const struct svc_xprt *xprt, | |
1928 | __be32 marker | |
1929 | ), | |
1930 | ||
1931 | TP_ARGS(xprt, marker), | |
1932 | ||
1933 | TP_STRUCT__entry( | |
1934 | __field(unsigned int, length) | |
1935 | __field(bool, last) | |
1936 | __string(addr, xprt->xpt_remotebuf) | |
1937 | ), | |
1938 | ||
1939 | TP_fast_assign( | |
1940 | __entry->length = be32_to_cpu(marker) & RPC_FRAGMENT_SIZE_MASK; | |
1941 | __entry->last = be32_to_cpu(marker) & RPC_LAST_STREAM_FRAGMENT; | |
1942 | __assign_str(addr, xprt->xpt_remotebuf); | |
1943 | ), | |
1944 | ||
1945 | TP_printk("addr=%s length=%u%s", __get_str(addr), | |
1946 | __entry->length, __entry->last ? " (last)" : "") | |
1947 | ); | |
1948 | ||
998024de CL |
1949 | DECLARE_EVENT_CLASS(svcsock_class, |
1950 | TP_PROTO( | |
1951 | const struct svc_xprt *xprt, | |
1952 | ssize_t result | |
1953 | ), | |
1954 | ||
1955 | TP_ARGS(xprt, result), | |
1956 | ||
1957 | TP_STRUCT__entry( | |
1958 | __field(ssize_t, result) | |
1959 | __field(unsigned long, flags) | |
1960 | __string(addr, xprt->xpt_remotebuf) | |
1961 | ), | |
1962 | ||
1963 | TP_fast_assign( | |
1964 | __entry->result = result; | |
1965 | __entry->flags = xprt->xpt_flags; | |
1966 | __assign_str(addr, xprt->xpt_remotebuf); | |
1967 | ), | |
1968 | ||
1969 | TP_printk("addr=%s result=%zd flags=%s", __get_str(addr), | |
1970 | __entry->result, show_svc_xprt_flags(__entry->flags) | |
1971 | ) | |
1972 | ); | |
1973 | ||
1974 | #define DEFINE_SVCSOCK_EVENT(name) \ | |
1975 | DEFINE_EVENT(svcsock_class, svcsock_##name, \ | |
1976 | TP_PROTO( \ | |
1977 | const struct svc_xprt *xprt, \ | |
1978 | ssize_t result \ | |
1979 | ), \ | |
1980 | TP_ARGS(xprt, result)) | |
1981 | ||
1982 | DEFINE_SVCSOCK_EVENT(udp_send); | |
fff1ebb2 CL |
1983 | DEFINE_SVCSOCK_EVENT(udp_recv); |
1984 | DEFINE_SVCSOCK_EVENT(udp_recv_err); | |
998024de | 1985 | DEFINE_SVCSOCK_EVENT(tcp_send); |
7dae1dd7 | 1986 | DEFINE_SVCSOCK_EVENT(tcp_recv); |
6be8c594 CL |
1987 | DEFINE_SVCSOCK_EVENT(tcp_recv_eagain); |
1988 | DEFINE_SVCSOCK_EVENT(tcp_recv_err); | |
998024de CL |
1989 | DEFINE_SVCSOCK_EVENT(data_ready); |
1990 | DEFINE_SVCSOCK_EVENT(write_space); | |
1991 | ||
6be8c594 CL |
1992 | TRACE_EVENT(svcsock_tcp_recv_short, |
1993 | TP_PROTO( | |
1994 | const struct svc_xprt *xprt, | |
1995 | u32 expected, | |
1996 | u32 received | |
1997 | ), | |
1998 | ||
1999 | TP_ARGS(xprt, expected, received), | |
2000 | ||
2001 | TP_STRUCT__entry( | |
2002 | __field(u32, expected) | |
2003 | __field(u32, received) | |
2004 | __field(unsigned long, flags) | |
2005 | __string(addr, xprt->xpt_remotebuf) | |
2006 | ), | |
2007 | ||
2008 | TP_fast_assign( | |
2009 | __entry->expected = expected; | |
2010 | __entry->received = received; | |
2011 | __entry->flags = xprt->xpt_flags; | |
2012 | __assign_str(addr, xprt->xpt_remotebuf); | |
2013 | ), | |
2014 | ||
2015 | TP_printk("addr=%s flags=%s expected=%u received=%u", | |
2016 | __get_str(addr), show_svc_xprt_flags(__entry->flags), | |
2017 | __entry->expected, __entry->received | |
2018 | ) | |
2019 | ); | |
2020 | ||
a0469f46 CL |
2021 | TRACE_EVENT(svcsock_tcp_state, |
2022 | TP_PROTO( | |
2023 | const struct svc_xprt *xprt, | |
2024 | const struct socket *socket | |
2025 | ), | |
2026 | ||
2027 | TP_ARGS(xprt, socket), | |
2028 | ||
2029 | TP_STRUCT__entry( | |
2030 | __field(unsigned long, socket_state) | |
2031 | __field(unsigned long, sock_state) | |
2032 | __field(unsigned long, flags) | |
2033 | __string(addr, xprt->xpt_remotebuf) | |
2034 | ), | |
2035 | ||
2036 | TP_fast_assign( | |
2037 | __entry->socket_state = socket->state; | |
2038 | __entry->sock_state = socket->sk->sk_state; | |
2039 | __entry->flags = xprt->xpt_flags; | |
2040 | __assign_str(addr, xprt->xpt_remotebuf); | |
2041 | ), | |
2042 | ||
2043 | TP_printk("addr=%s state=%s sk_state=%s flags=%s", __get_str(addr), | |
2044 | rpc_show_socket_state(__entry->socket_state), | |
2045 | rpc_show_sock_state(__entry->sock_state), | |
2046 | show_svc_xprt_flags(__entry->flags) | |
2047 | ) | |
2048 | ); | |
2049 | ||
2050 | DECLARE_EVENT_CLASS(svcsock_accept_class, | |
2051 | TP_PROTO( | |
2052 | const struct svc_xprt *xprt, | |
2053 | const char *service, | |
2054 | long status | |
2055 | ), | |
2056 | ||
2057 | TP_ARGS(xprt, service, status), | |
2058 | ||
2059 | TP_STRUCT__entry( | |
2060 | __field(long, status) | |
2061 | __string(service, service) | |
2062 | __array(unsigned char, addr, sizeof(struct sockaddr_in6)) | |
2063 | ), | |
2064 | ||
2065 | TP_fast_assign( | |
2066 | __entry->status = status; | |
2067 | __assign_str(service, service); | |
2068 | memcpy(__entry->addr, &xprt->xpt_local, sizeof(__entry->addr)); | |
2069 | ), | |
2070 | ||
2071 | TP_printk("listener=%pISpc service=%s status=%ld", | |
2072 | __entry->addr, __get_str(service), __entry->status | |
2073 | ) | |
2074 | ); | |
2075 | ||
2076 | #define DEFINE_ACCEPT_EVENT(name) \ | |
2077 | DEFINE_EVENT(svcsock_accept_class, svcsock_##name##_err, \ | |
2078 | TP_PROTO( \ | |
2079 | const struct svc_xprt *xprt, \ | |
2080 | const char *service, \ | |
2081 | long status \ | |
2082 | ), \ | |
2083 | TP_ARGS(xprt, service, status)) | |
2084 | ||
2085 | DEFINE_ACCEPT_EVENT(accept); | |
2086 | DEFINE_ACCEPT_EVENT(getpeername); | |
2087 | ||
78a947f5 TM |
2088 | DECLARE_EVENT_CLASS(cache_event, |
2089 | TP_PROTO( | |
2090 | const struct cache_detail *cd, | |
2091 | const struct cache_head *h | |
2092 | ), | |
2093 | ||
2094 | TP_ARGS(cd, h), | |
2095 | ||
2096 | TP_STRUCT__entry( | |
2097 | __field(const struct cache_head *, h) | |
2098 | __string(name, cd->name) | |
2099 | ), | |
2100 | ||
2101 | TP_fast_assign( | |
2102 | __entry->h = h; | |
2103 | __assign_str(name, cd->name); | |
2104 | ), | |
2105 | ||
2106 | TP_printk("cache=%s entry=%p", __get_str(name), __entry->h) | |
2107 | ); | |
2108 | #define DEFINE_CACHE_EVENT(name) \ | |
2109 | DEFINE_EVENT(cache_event, name, \ | |
2110 | TP_PROTO( \ | |
2111 | const struct cache_detail *cd, \ | |
2112 | const struct cache_head *h \ | |
2113 | ), \ | |
2114 | TP_ARGS(cd, h)) | |
2115 | DEFINE_CACHE_EVENT(cache_entry_expired); | |
2116 | DEFINE_CACHE_EVENT(cache_entry_upcall); | |
2117 | DEFINE_CACHE_EVENT(cache_entry_update); | |
2118 | DEFINE_CACHE_EVENT(cache_entry_make_negative); | |
2119 | DEFINE_CACHE_EVENT(cache_entry_no_listener); | |
2120 | ||
b4af5932 CL |
2121 | DECLARE_EVENT_CLASS(register_class, |
2122 | TP_PROTO( | |
2123 | const char *program, | |
2124 | const u32 version, | |
2125 | const int family, | |
2126 | const unsigned short protocol, | |
2127 | const unsigned short port, | |
2128 | int error | |
2129 | ), | |
2130 | ||
2131 | TP_ARGS(program, version, family, protocol, port, error), | |
2132 | ||
2133 | TP_STRUCT__entry( | |
2134 | __field(u32, version) | |
2135 | __field(unsigned long, family) | |
2136 | __field(unsigned short, protocol) | |
2137 | __field(unsigned short, port) | |
2138 | __field(int, error) | |
2139 | __string(program, program) | |
2140 | ), | |
2141 | ||
2142 | TP_fast_assign( | |
2143 | __entry->version = version; | |
2144 | __entry->family = family; | |
2145 | __entry->protocol = protocol; | |
2146 | __entry->port = port; | |
2147 | __entry->error = error; | |
2148 | __assign_str(program, program); | |
2149 | ), | |
2150 | ||
2151 | TP_printk("program=%sv%u proto=%s port=%u family=%s error=%d", | |
2152 | __get_str(program), __entry->version, | |
2153 | __entry->protocol == IPPROTO_UDP ? "udp" : "tcp", | |
2154 | __entry->port, rpc_show_address_family(__entry->family), | |
2155 | __entry->error | |
2156 | ) | |
2157 | ); | |
2158 | ||
2159 | #define DEFINE_REGISTER_EVENT(name) \ | |
2160 | DEFINE_EVENT(register_class, svc_##name, \ | |
2161 | TP_PROTO( \ | |
2162 | const char *program, \ | |
2163 | const u32 version, \ | |
2164 | const int family, \ | |
2165 | const unsigned short protocol, \ | |
2166 | const unsigned short port, \ | |
2167 | int error \ | |
2168 | ), \ | |
2169 | TP_ARGS(program, version, family, protocol, \ | |
2170 | port, error)) | |
2171 | ||
2172 | DEFINE_REGISTER_EVENT(register); | |
2173 | DEFINE_REGISTER_EVENT(noregister); | |
2174 | ||
2175 | TRACE_EVENT(svc_unregister, | |
2176 | TP_PROTO( | |
2177 | const char *program, | |
2178 | const u32 version, | |
2179 | int error | |
2180 | ), | |
2181 | ||
2182 | TP_ARGS(program, version, error), | |
2183 | ||
2184 | TP_STRUCT__entry( | |
2185 | __field(u32, version) | |
2186 | __field(int, error) | |
2187 | __string(program, program) | |
2188 | ), | |
2189 | ||
2190 | TP_fast_assign( | |
2191 | __entry->version = version; | |
2192 | __entry->error = error; | |
2193 | __assign_str(program, program); | |
2194 | ), | |
2195 | ||
2196 | TP_printk("program=%sv%u error=%d", | |
2197 | __get_str(program), __entry->version, __entry->error | |
2198 | ) | |
2199 | ); | |
2200 | ||
82b0a4c3 TM |
2201 | #endif /* _TRACE_SUNRPC_H */ |
2202 | ||
2203 | #include <trace/define_trace.h> |