1 /* AF_RXRPC tracepoints
3 * Copyright (C) 2016 Red Hat, Inc. All Rights Reserved.
4 * Written by David Howells (dhowells@redhat.com)
6 * This program is free software; you can redistribute it and/or
7 * modify it under the terms of the GNU General Public Licence
8 * as published by the Free Software Foundation; either version
9 * 2 of the Licence, or (at your option) any later version.
12 #define TRACE_SYSTEM rxrpc
14 #if !defined(_TRACE_RXRPC_H) || defined(TRACE_HEADER_MULTI_READ)
15 #define _TRACE_RXRPC_H
17 #include <linux/tracepoint.h>
19 TRACE_EVENT(rxrpc_conn,
20 TP_PROTO(struct rxrpc_connection *conn, enum rxrpc_conn_trace op,
21 int usage, const void *where),
23 TP_ARGS(conn, op, usage, where),
26 __field(struct rxrpc_connection *, conn )
29 __field(const void *, where )
35 __entry->usage = usage;
36 __entry->where = where;
39 TP_printk("C=%p %s u=%d sp=%pSR",
41 rxrpc_conn_traces[__entry->op],
46 TRACE_EVENT(rxrpc_client,
47 TP_PROTO(struct rxrpc_connection *conn, int channel,
48 enum rxrpc_client_trace op),
50 TP_ARGS(conn, channel, op),
53 __field(struct rxrpc_connection *, conn )
55 __field(int, channel )
57 __field(enum rxrpc_client_trace, op )
58 __field(enum rxrpc_conn_cache_state, cs )
63 __entry->channel = channel;
64 __entry->usage = atomic_read(&conn->usage);
66 __entry->cid = conn->proto.cid;
67 __entry->cs = conn->cache_state;
70 TP_printk("C=%p h=%2d %s %s i=%08x u=%d",
73 rxrpc_client_traces[__entry->op],
74 rxrpc_conn_cache_states[__entry->cs],
79 TRACE_EVENT(rxrpc_call,
80 TP_PROTO(struct rxrpc_call *call, enum rxrpc_call_trace op,
81 int usage, const void *where, const void *aux),
83 TP_ARGS(call, op, usage, where, aux),
86 __field(struct rxrpc_call *, call )
89 __field(const void *, where )
90 __field(const void *, aux )
96 __entry->usage = usage;
97 __entry->where = where;
101 TP_printk("c=%p %s u=%d sp=%pSR a=%p",
103 rxrpc_call_traces[__entry->op],
109 TRACE_EVENT(rxrpc_skb,
110 TP_PROTO(struct sk_buff *skb, enum rxrpc_skb_trace op,
111 int usage, int mod_count, const void *where),
113 TP_ARGS(skb, op, usage, mod_count, where),
116 __field(struct sk_buff *, skb )
117 __field(enum rxrpc_skb_trace, op )
119 __field(int, mod_count )
120 __field(const void *, where )
126 __entry->usage = usage;
127 __entry->mod_count = mod_count;
128 __entry->where = where;
131 TP_printk("s=%p %s u=%d m=%d p=%pSR",
133 rxrpc_skb_traces[__entry->op],
139 TRACE_EVENT(rxrpc_rx_packet,
140 TP_PROTO(struct rxrpc_skb_priv *sp),
145 __field_struct(struct rxrpc_host_header, hdr )
149 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
152 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s",
153 __entry->hdr.epoch, __entry->hdr.cid,
154 __entry->hdr.callNumber, __entry->hdr.serviceId,
155 __entry->hdr.serial, __entry->hdr.seq,
156 __entry->hdr.type, __entry->hdr.flags,
157 __entry->hdr.type <= 15 ? rxrpc_pkts[__entry->hdr.type] : "?UNK")
160 TRACE_EVENT(rxrpc_rx_done,
161 TP_PROTO(int result, int abort_code),
163 TP_ARGS(result, abort_code),
166 __field(int, result )
167 __field(int, abort_code )
171 __entry->result = result;
172 __entry->abort_code = abort_code;
175 TP_printk("r=%d a=%d", __entry->result, __entry->abort_code)
178 TRACE_EVENT(rxrpc_abort,
179 TP_PROTO(const char *why, u32 cid, u32 call_id, rxrpc_seq_t seq,
180 int abort_code, int error),
182 TP_ARGS(why, cid, call_id, seq, abort_code, error),
185 __array(char, why, 4 )
187 __field(u32, call_id )
188 __field(rxrpc_seq_t, seq )
189 __field(int, abort_code )
194 memcpy(__entry->why, why, 4);
196 __entry->call_id = call_id;
197 __entry->abort_code = abort_code;
198 __entry->error = error;
202 TP_printk("%08x:%08x s=%u a=%d e=%d %s",
203 __entry->cid, __entry->call_id, __entry->seq,
204 __entry->abort_code, __entry->error, __entry->why)
207 TRACE_EVENT(rxrpc_transmit,
208 TP_PROTO(struct rxrpc_call *call, enum rxrpc_transmit_trace why),
213 __field(struct rxrpc_call *, call )
214 __field(enum rxrpc_transmit_trace, why )
215 __field(rxrpc_seq_t, tx_hard_ack )
216 __field(rxrpc_seq_t, tx_top )
220 __entry->call = call;
222 __entry->tx_hard_ack = call->tx_hard_ack;
223 __entry->tx_top = call->tx_top;
226 TP_printk("c=%p %s f=%08x n=%u",
228 rxrpc_transmit_traces[__entry->why],
229 __entry->tx_hard_ack + 1,
230 __entry->tx_top - __entry->tx_hard_ack)
233 TRACE_EVENT(rxrpc_rx_ack,
234 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t first, u8 reason, u8 n_acks),
236 TP_ARGS(call, first, reason, n_acks),
239 __field(struct rxrpc_call *, call )
240 __field(rxrpc_seq_t, first )
246 __entry->call = call;
247 __entry->first = first;
248 __entry->reason = reason;
249 __entry->n_acks = n_acks;
252 TP_printk("c=%p %s f=%08x n=%u",
254 rxrpc_ack_names[__entry->reason],
259 TRACE_EVENT(rxrpc_tx_data,
260 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq,
261 rxrpc_serial_t serial, u8 flags, bool retrans, bool lose),
263 TP_ARGS(call, seq, serial, flags, retrans, lose),
266 __field(struct rxrpc_call *, call )
267 __field(rxrpc_seq_t, seq )
268 __field(rxrpc_serial_t, serial )
270 __field(bool, retrans )
275 __entry->call = call;
277 __entry->serial = serial;
278 __entry->flags = flags;
279 __entry->retrans = retrans;
280 __entry->lose = lose;
283 TP_printk("c=%p DATA %08x q=%08x fl=%02x%s%s",
288 __entry->retrans ? " *RETRANS*" : "",
289 __entry->lose ? " *LOSE*" : "")
292 TRACE_EVENT(rxrpc_tx_ack,
293 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
294 rxrpc_seq_t ack_first, rxrpc_serial_t ack_serial,
295 u8 reason, u8 n_acks),
297 TP_ARGS(call, serial, ack_first, ack_serial, reason, n_acks),
300 __field(struct rxrpc_call *, call )
301 __field(rxrpc_serial_t, serial )
302 __field(rxrpc_seq_t, ack_first )
303 __field(rxrpc_serial_t, ack_serial )
309 __entry->call = call;
310 __entry->serial = serial;
311 __entry->ack_first = ack_first;
312 __entry->ack_serial = ack_serial;
313 __entry->reason = reason;
314 __entry->n_acks = n_acks;
317 TP_printk(" c=%p ACK %08x %s f=%08x r=%08x n=%u",
320 rxrpc_ack_names[__entry->reason],
326 TRACE_EVENT(rxrpc_receive,
327 TP_PROTO(struct rxrpc_call *call, enum rxrpc_receive_trace why,
328 rxrpc_serial_t serial, rxrpc_seq_t seq),
330 TP_ARGS(call, why, serial, seq),
333 __field(struct rxrpc_call *, call )
334 __field(enum rxrpc_receive_trace, why )
335 __field(rxrpc_serial_t, serial )
336 __field(rxrpc_seq_t, seq )
337 __field(rxrpc_seq_t, hard_ack )
338 __field(rxrpc_seq_t, top )
342 __entry->call = call;
344 __entry->serial = serial;
346 __entry->hard_ack = call->rx_hard_ack;
347 __entry->top = call->rx_top;
350 TP_printk("c=%p %s r=%08x q=%08x w=%08x-%08x",
352 rxrpc_receive_traces[__entry->why],
359 TRACE_EVENT(rxrpc_recvmsg,
360 TP_PROTO(struct rxrpc_call *call, enum rxrpc_recvmsg_trace why,
361 rxrpc_seq_t seq, unsigned int offset, unsigned int len,
364 TP_ARGS(call, why, seq, offset, len, ret),
367 __field(struct rxrpc_call *, call )
368 __field(enum rxrpc_recvmsg_trace, why )
369 __field(rxrpc_seq_t, seq )
370 __field(unsigned int, offset )
371 __field(unsigned int, len )
376 __entry->call = call;
379 __entry->offset = offset;
384 TP_printk("c=%p %s q=%08x o=%u l=%u ret=%d",
386 rxrpc_recvmsg_traces[__entry->why],
393 TRACE_EVENT(rxrpc_rtt_tx,
394 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_tx_trace why,
395 rxrpc_serial_t send_serial),
397 TP_ARGS(call, why, send_serial),
400 __field(struct rxrpc_call *, call )
401 __field(enum rxrpc_rtt_tx_trace, why )
402 __field(rxrpc_serial_t, send_serial )
406 __entry->call = call;
408 __entry->send_serial = send_serial;
411 TP_printk("c=%p %s sr=%08x",
413 rxrpc_rtt_tx_traces[__entry->why],
414 __entry->send_serial)
417 TRACE_EVENT(rxrpc_rtt_rx,
418 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_rx_trace why,
419 rxrpc_serial_t send_serial, rxrpc_serial_t resp_serial,
420 s64 rtt, u8 nr, s64 avg),
422 TP_ARGS(call, why, send_serial, resp_serial, rtt, nr, avg),
425 __field(struct rxrpc_call *, call )
426 __field(enum rxrpc_rtt_rx_trace, why )
428 __field(rxrpc_serial_t, send_serial )
429 __field(rxrpc_serial_t, resp_serial )
435 __entry->call = call;
437 __entry->send_serial = send_serial;
438 __entry->resp_serial = resp_serial;
444 TP_printk("c=%p %s sr=%08x rr=%08x rtt=%lld nr=%u avg=%lld",
446 rxrpc_rtt_rx_traces[__entry->why],
447 __entry->send_serial,
448 __entry->resp_serial,
454 TRACE_EVENT(rxrpc_timer,
455 TP_PROTO(struct rxrpc_call *call, enum rxrpc_timer_trace why,
456 ktime_t now, unsigned long now_j),
458 TP_ARGS(call, why, now, now_j),
461 __field(struct rxrpc_call *, call )
462 __field(enum rxrpc_timer_trace, why )
463 __field_struct(ktime_t, now )
464 __field_struct(ktime_t, expire_at )
465 __field_struct(ktime_t, ack_at )
466 __field_struct(ktime_t, resend_at )
467 __field(unsigned long, now_j )
468 __field(unsigned long, timer )
472 __entry->call = call;
475 __entry->expire_at = call->expire_at;
476 __entry->ack_at = call->ack_at;
477 __entry->resend_at = call->resend_at;
478 __entry->now_j = now_j;
479 __entry->timer = call->timer.expires;
482 TP_printk("c=%p %s x=%lld a=%lld r=%lld t=%ld",
484 rxrpc_timer_traces[__entry->why],
485 ktime_to_ns(ktime_sub(__entry->expire_at, __entry->now)),
486 ktime_to_ns(ktime_sub(__entry->ack_at, __entry->now)),
487 ktime_to_ns(ktime_sub(__entry->resend_at, __entry->now)),
488 __entry->timer - __entry->now_j)
491 TRACE_EVENT(rxrpc_rx_lose,
492 TP_PROTO(struct rxrpc_skb_priv *sp),
497 __field_struct(struct rxrpc_host_header, hdr )
501 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
504 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s *LOSE*",
505 __entry->hdr.epoch, __entry->hdr.cid,
506 __entry->hdr.callNumber, __entry->hdr.serviceId,
507 __entry->hdr.serial, __entry->hdr.seq,
508 __entry->hdr.type, __entry->hdr.flags,
509 __entry->hdr.type <= 15 ? rxrpc_pkts[__entry->hdr.type] : "?UNK")
512 TRACE_EVENT(rxrpc_propose_ack,
513 TP_PROTO(struct rxrpc_call *call, enum rxrpc_propose_ack_trace why,
514 u8 ack_reason, rxrpc_serial_t serial, bool immediate,
515 bool background, enum rxrpc_propose_ack_outcome outcome),
517 TP_ARGS(call, why, ack_reason, serial, immediate, background,
521 __field(struct rxrpc_call *, call )
522 __field(enum rxrpc_propose_ack_trace, why )
523 __field(rxrpc_serial_t, serial )
524 __field(u8, ack_reason )
525 __field(bool, immediate )
526 __field(bool, background )
527 __field(enum rxrpc_propose_ack_outcome, outcome )
531 __entry->call = call;
533 __entry->serial = serial;
534 __entry->ack_reason = ack_reason;
535 __entry->immediate = immediate;
536 __entry->background = background;
537 __entry->outcome = outcome;
540 TP_printk("c=%p %s %s r=%08x i=%u b=%u%s",
542 rxrpc_propose_ack_traces[__entry->why],
543 rxrpc_ack_names[__entry->ack_reason],
547 rxrpc_propose_ack_outcomes[__entry->outcome])
550 TRACE_EVENT(rxrpc_retransmit,
551 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq, u8 annotation,
554 TP_ARGS(call, seq, annotation, expiry),
557 __field(struct rxrpc_call *, call )
558 __field(rxrpc_seq_t, seq )
559 __field(u8, annotation )
560 __field(s64, expiry )
564 __entry->call = call;
566 __entry->annotation = annotation;
567 __entry->expiry = expiry;
570 TP_printk("c=%p q=%x a=%02x xp=%lld",
577 TRACE_EVENT(rxrpc_congest,
578 TP_PROTO(struct rxrpc_call *call, struct rxrpc_ack_summary *summary,
579 rxrpc_serial_t ack_serial, enum rxrpc_congest_change change),
581 TP_ARGS(call, summary, ack_serial, change),
584 __field(struct rxrpc_call *, call )
585 __field(enum rxrpc_congest_change, change )
586 __field(rxrpc_seq_t, hard_ack )
587 __field(rxrpc_seq_t, top )
588 __field(rxrpc_seq_t, lowest_nak )
589 __field(rxrpc_serial_t, ack_serial )
590 __field_struct(struct rxrpc_ack_summary, sum )
594 __entry->call = call;
595 __entry->change = change;
596 __entry->hard_ack = call->tx_hard_ack;
597 __entry->top = call->tx_top;
598 __entry->lowest_nak = call->acks_lowest_nak;
599 __entry->ack_serial = ack_serial;
600 memcpy(&__entry->sum, summary, sizeof(__entry->sum));
603 TP_printk("c=%p %08x %s %08x %s cw=%u ss=%u nr=%u,%u nw=%u,%u r=%u b=%u u=%u d=%u l=%x%s%s%s",
606 rxrpc_ack_names[__entry->sum.ack_reason],
608 rxrpc_congest_modes[__entry->sum.mode],
610 __entry->sum.ssthresh,
611 __entry->sum.nr_acks, __entry->sum.nr_nacks,
612 __entry->sum.nr_new_acks, __entry->sum.nr_new_nacks,
613 __entry->sum.nr_rot_new_acks,
614 __entry->top - __entry->hard_ack,
615 __entry->sum.cumulative_acks,
616 __entry->sum.dup_acks,
617 __entry->lowest_nak, __entry->sum.new_low_nack ? "!" : "",
618 rxrpc_congest_changes[__entry->change],
619 __entry->sum.retrans_timeo ? " rTxTo" : "")
622 #endif /* _TRACE_RXRPC_H */
624 /* This part must be outside protection */
625 #include <trace/define_trace.h>