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>
20 * Define enums for tracing information.
22 * These should all be kept sorted, making it easier to match the string
23 * mapping tables further on.
25 #ifndef __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY
26 #define __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY
28 enum rxrpc_skb_trace {
34 rxrpc_skb_rx_received,
45 enum rxrpc_conn_trace {
47 rxrpc_conn_new_client,
48 rxrpc_conn_new_service,
49 rxrpc_conn_put_client,
50 rxrpc_conn_put_service,
52 rxrpc_conn_reap_service,
56 enum rxrpc_client_trace {
57 rxrpc_client_activate_chans,
59 rxrpc_client_chan_activate,
60 rxrpc_client_chan_disconnect,
61 rxrpc_client_chan_pass,
62 rxrpc_client_chan_unstarted,
66 rxrpc_client_duplicate,
69 rxrpc_client_to_active,
70 rxrpc_client_to_culled,
72 rxrpc_client_to_inactive,
73 rxrpc_client_to_upgrade,
74 rxrpc_client_to_waiting,
78 enum rxrpc_call_trace {
82 rxrpc_call_got_kernel,
83 rxrpc_call_got_userid,
84 rxrpc_call_new_client,
85 rxrpc_call_new_service,
87 rxrpc_call_put_kernel,
88 rxrpc_call_put_noqueue,
89 rxrpc_call_put_userid,
91 rxrpc_call_queued_ref,
96 enum rxrpc_transmit_trace {
97 rxrpc_transmit_await_reply,
100 rxrpc_transmit_queue_last,
101 rxrpc_transmit_rotate,
102 rxrpc_transmit_rotate_last,
106 enum rxrpc_receive_trace {
109 rxrpc_receive_incoming,
111 rxrpc_receive_queue_last,
112 rxrpc_receive_rotate,
115 enum rxrpc_recvmsg_trace {
117 rxrpc_recvmsg_data_return,
118 rxrpc_recvmsg_dequeue,
123 rxrpc_recvmsg_requeue,
124 rxrpc_recvmsg_return,
125 rxrpc_recvmsg_terminal,
126 rxrpc_recvmsg_to_be_accepted,
130 enum rxrpc_rtt_tx_trace {
135 enum rxrpc_rtt_rx_trace {
136 rxrpc_rtt_rx_ping_response,
137 rxrpc_rtt_rx_requested_ack,
140 enum rxrpc_timer_trace {
143 rxrpc_timer_init_for_reply,
144 rxrpc_timer_init_for_send_reply,
145 rxrpc_timer_set_for_ack,
146 rxrpc_timer_set_for_ping,
147 rxrpc_timer_set_for_resend,
148 rxrpc_timer_set_for_send,
151 enum rxrpc_propose_ack_trace {
152 rxrpc_propose_ack_client_tx_end,
153 rxrpc_propose_ack_input_data,
154 rxrpc_propose_ack_ping_for_lost_ack,
155 rxrpc_propose_ack_ping_for_lost_reply,
156 rxrpc_propose_ack_ping_for_params,
157 rxrpc_propose_ack_processing_op,
158 rxrpc_propose_ack_respond_to_ack,
159 rxrpc_propose_ack_respond_to_ping,
160 rxrpc_propose_ack_retry_tx,
161 rxrpc_propose_ack_rotate_rx,
162 rxrpc_propose_ack_terminal_ack,
165 enum rxrpc_propose_ack_outcome {
166 rxrpc_propose_ack_subsume,
167 rxrpc_propose_ack_update,
168 rxrpc_propose_ack_use,
171 enum rxrpc_congest_change {
172 rxrpc_cong_begin_retransmission,
173 rxrpc_cong_cleared_nacks,
174 rxrpc_cong_new_low_nack,
175 rxrpc_cong_no_change,
177 rxrpc_cong_retransmit_again,
178 rxrpc_cong_rtt_window_end,
182 #endif /* end __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY */
185 * Declare tracing information enums and their string mappings for display.
187 #define rxrpc_skb_traces \
188 EM(rxrpc_skb_rx_cleaned, "Rx CLN") \
189 EM(rxrpc_skb_rx_freed, "Rx FRE") \
190 EM(rxrpc_skb_rx_got, "Rx GOT") \
191 EM(rxrpc_skb_rx_lost, "Rx *L*") \
192 EM(rxrpc_skb_rx_purged, "Rx PUR") \
193 EM(rxrpc_skb_rx_received, "Rx RCV") \
194 EM(rxrpc_skb_rx_rotated, "Rx ROT") \
195 EM(rxrpc_skb_rx_seen, "Rx SEE") \
196 EM(rxrpc_skb_tx_cleaned, "Tx CLN") \
197 EM(rxrpc_skb_tx_freed, "Tx FRE") \
198 EM(rxrpc_skb_tx_got, "Tx GOT") \
199 EM(rxrpc_skb_tx_new, "Tx NEW") \
200 EM(rxrpc_skb_tx_rotated, "Tx ROT") \
201 E_(rxrpc_skb_tx_seen, "Tx SEE")
203 #define rxrpc_conn_traces \
204 EM(rxrpc_conn_got, "GOT") \
205 EM(rxrpc_conn_new_client, "NWc") \
206 EM(rxrpc_conn_new_service, "NWs") \
207 EM(rxrpc_conn_put_client, "PTc") \
208 EM(rxrpc_conn_put_service, "PTs") \
209 EM(rxrpc_conn_queued, "QUE") \
210 EM(rxrpc_conn_reap_service, "RPs") \
211 E_(rxrpc_conn_seen, "SEE")
213 #define rxrpc_client_traces \
214 EM(rxrpc_client_activate_chans, "Activa") \
215 EM(rxrpc_client_alloc, "Alloc ") \
216 EM(rxrpc_client_chan_activate, "ChActv") \
217 EM(rxrpc_client_chan_disconnect, "ChDisc") \
218 EM(rxrpc_client_chan_pass, "ChPass") \
219 EM(rxrpc_client_chan_unstarted, "ChUnst") \
220 EM(rxrpc_client_cleanup, "Clean ") \
221 EM(rxrpc_client_count, "Count ") \
222 EM(rxrpc_client_discard, "Discar") \
223 EM(rxrpc_client_duplicate, "Duplic") \
224 EM(rxrpc_client_exposed, "Expose") \
225 EM(rxrpc_client_replace, "Replac") \
226 EM(rxrpc_client_to_active, "->Actv") \
227 EM(rxrpc_client_to_culled, "->Cull") \
228 EM(rxrpc_client_to_idle, "->Idle") \
229 EM(rxrpc_client_to_inactive, "->Inac") \
230 EM(rxrpc_client_to_upgrade, "->Upgd") \
231 EM(rxrpc_client_to_waiting, "->Wait") \
232 E_(rxrpc_client_uncount, "Uncoun")
234 #define rxrpc_conn_cache_states \
235 EM(RXRPC_CONN_CLIENT_INACTIVE, "Inac") \
236 EM(RXRPC_CONN_CLIENT_WAITING, "Wait") \
237 EM(RXRPC_CONN_CLIENT_ACTIVE, "Actv") \
238 EM(RXRPC_CONN_CLIENT_UPGRADE, "Upgd") \
239 EM(RXRPC_CONN_CLIENT_CULLED, "Cull") \
240 E_(RXRPC_CONN_CLIENT_IDLE, "Idle") \
242 #define rxrpc_call_traces \
243 EM(rxrpc_call_connected, "CON") \
244 EM(rxrpc_call_error, "*E*") \
245 EM(rxrpc_call_got, "GOT") \
246 EM(rxrpc_call_got_kernel, "Gke") \
247 EM(rxrpc_call_got_userid, "Gus") \
248 EM(rxrpc_call_new_client, "NWc") \
249 EM(rxrpc_call_new_service, "NWs") \
250 EM(rxrpc_call_put, "PUT") \
251 EM(rxrpc_call_put_kernel, "Pke") \
252 EM(rxrpc_call_put_noqueue, "PNQ") \
253 EM(rxrpc_call_put_userid, "Pus") \
254 EM(rxrpc_call_queued, "QUE") \
255 EM(rxrpc_call_queued_ref, "QUR") \
256 EM(rxrpc_call_release, "RLS") \
257 E_(rxrpc_call_seen, "SEE")
259 #define rxrpc_transmit_traces \
260 EM(rxrpc_transmit_await_reply, "AWR") \
261 EM(rxrpc_transmit_end, "END") \
262 EM(rxrpc_transmit_queue, "QUE") \
263 EM(rxrpc_transmit_queue_last, "QLS") \
264 EM(rxrpc_transmit_rotate, "ROT") \
265 EM(rxrpc_transmit_rotate_last, "RLS") \
266 E_(rxrpc_transmit_wait, "WAI")
268 #define rxrpc_receive_traces \
269 EM(rxrpc_receive_end, "END") \
270 EM(rxrpc_receive_front, "FRN") \
271 EM(rxrpc_receive_incoming, "INC") \
272 EM(rxrpc_receive_queue, "QUE") \
273 EM(rxrpc_receive_queue_last, "QLS") \
274 E_(rxrpc_receive_rotate, "ROT")
276 #define rxrpc_recvmsg_traces \
277 EM(rxrpc_recvmsg_cont, "CONT") \
278 EM(rxrpc_recvmsg_data_return, "DATA") \
279 EM(rxrpc_recvmsg_dequeue, "DEQU") \
280 EM(rxrpc_recvmsg_enter, "ENTR") \
281 EM(rxrpc_recvmsg_full, "FULL") \
282 EM(rxrpc_recvmsg_hole, "HOLE") \
283 EM(rxrpc_recvmsg_next, "NEXT") \
284 EM(rxrpc_recvmsg_requeue, "REQU") \
285 EM(rxrpc_recvmsg_return, "RETN") \
286 EM(rxrpc_recvmsg_terminal, "TERM") \
287 EM(rxrpc_recvmsg_to_be_accepted, "TBAC") \
288 E_(rxrpc_recvmsg_wait, "WAIT")
290 #define rxrpc_rtt_tx_traces \
291 EM(rxrpc_rtt_tx_data, "DATA") \
292 E_(rxrpc_rtt_tx_ping, "PING")
294 #define rxrpc_rtt_rx_traces \
295 EM(rxrpc_rtt_rx_ping_response, "PONG") \
296 E_(rxrpc_rtt_rx_requested_ack, "RACK")
298 #define rxrpc_timer_traces \
299 EM(rxrpc_timer_begin, "Begin ") \
300 EM(rxrpc_timer_expired, "*EXPR*") \
301 EM(rxrpc_timer_init_for_reply, "IniRpl") \
302 EM(rxrpc_timer_init_for_send_reply, "SndRpl") \
303 EM(rxrpc_timer_set_for_ack, "SetAck") \
304 EM(rxrpc_timer_set_for_ping, "SetPng") \
305 EM(rxrpc_timer_set_for_resend, "SetRTx") \
306 E_(rxrpc_timer_set_for_send, "SetTx ")
308 #define rxrpc_propose_ack_traces \
309 EM(rxrpc_propose_ack_client_tx_end, "ClTxEnd") \
310 EM(rxrpc_propose_ack_input_data, "DataIn ") \
311 EM(rxrpc_propose_ack_ping_for_lost_ack, "LostAck") \
312 EM(rxrpc_propose_ack_ping_for_lost_reply, "LostRpl") \
313 EM(rxrpc_propose_ack_ping_for_params, "Params ") \
314 EM(rxrpc_propose_ack_processing_op, "ProcOp ") \
315 EM(rxrpc_propose_ack_respond_to_ack, "Rsp2Ack") \
316 EM(rxrpc_propose_ack_respond_to_ping, "Rsp2Png") \
317 EM(rxrpc_propose_ack_retry_tx, "RetryTx") \
318 EM(rxrpc_propose_ack_rotate_rx, "RxAck ") \
319 E_(rxrpc_propose_ack_terminal_ack, "ClTerm ")
321 #define rxrpc_propose_ack_outcomes \
322 EM(rxrpc_propose_ack_subsume, " Subsume") \
323 EM(rxrpc_propose_ack_update, " Update") \
324 E_(rxrpc_propose_ack_use, "")
326 #define rxrpc_congest_modes \
327 EM(RXRPC_CALL_CONGEST_AVOIDANCE, "CongAvoid") \
328 EM(RXRPC_CALL_FAST_RETRANSMIT, "FastReTx ") \
329 EM(RXRPC_CALL_PACKET_LOSS, "PktLoss ") \
330 E_(RXRPC_CALL_SLOW_START, "SlowStart")
332 #define rxrpc_congest_changes \
333 EM(rxrpc_cong_begin_retransmission, " Retrans") \
334 EM(rxrpc_cong_cleared_nacks, " Cleared") \
335 EM(rxrpc_cong_new_low_nack, " NewLowN") \
336 EM(rxrpc_cong_no_change, " -") \
337 EM(rxrpc_cong_progress, " Progres") \
338 EM(rxrpc_cong_retransmit_again, " ReTxAgn") \
339 EM(rxrpc_cong_rtt_window_end, " RttWinE") \
340 E_(rxrpc_cong_saw_nack, " SawNack")
344 EM(RXRPC_PACKET_TYPE_DATA, "DATA") \
345 EM(RXRPC_PACKET_TYPE_ACK, "ACK") \
346 EM(RXRPC_PACKET_TYPE_BUSY, "BUSY") \
347 EM(RXRPC_PACKET_TYPE_ABORT, "ABORT") \
348 EM(RXRPC_PACKET_TYPE_ACKALL, "ACKALL") \
349 EM(RXRPC_PACKET_TYPE_CHALLENGE, "CHALL") \
350 EM(RXRPC_PACKET_TYPE_RESPONSE, "RESP") \
351 EM(RXRPC_PACKET_TYPE_DEBUG, "DEBUG") \
356 EM(RXRPC_PACKET_TYPE_VERSION, "VERSION") \
360 #define rxrpc_ack_names \
362 EM(RXRPC_ACK_REQUESTED, "REQ") \
363 EM(RXRPC_ACK_DUPLICATE, "DUP") \
364 EM(RXRPC_ACK_OUT_OF_SEQUENCE, "OOS") \
365 EM(RXRPC_ACK_EXCEEDS_WINDOW, "WIN") \
366 EM(RXRPC_ACK_NOSPACE, "MEM") \
367 EM(RXRPC_ACK_PING, "PNG") \
368 EM(RXRPC_ACK_PING_RESPONSE, "PNR") \
369 EM(RXRPC_ACK_DELAY, "DLY") \
370 EM(RXRPC_ACK_IDLE, "IDL") \
371 E_(RXRPC_ACK__INVALID, "-?-")
374 * Export enum symbols via userspace.
378 #define EM(a, b) TRACE_DEFINE_ENUM(a);
379 #define E_(a, b) TRACE_DEFINE_ENUM(a);
385 rxrpc_transmit_traces;
386 rxrpc_receive_traces;
387 rxrpc_recvmsg_traces;
391 rxrpc_propose_ack_traces;
392 rxrpc_propose_ack_outcomes;
393 rxrpc_congest_changes;
396 * Now redefine the EM() and E_() macros to map the enums to the strings that
397 * will be printed in the output.
401 #define EM(a, b) { a, b },
402 #define E_(a, b) { a, b }
404 TRACE_EVENT(rxrpc_conn,
405 TP_PROTO(struct rxrpc_connection *conn, enum rxrpc_conn_trace op,
406 int usage, const void *where),
408 TP_ARGS(conn, op, usage, where),
411 __field(struct rxrpc_connection *, conn )
414 __field(const void *, where )
418 __entry->conn = conn;
420 __entry->usage = usage;
421 __entry->where = where;
424 TP_printk("C=%p %s u=%d sp=%pSR",
426 __print_symbolic(__entry->op, rxrpc_conn_traces),
431 TRACE_EVENT(rxrpc_client,
432 TP_PROTO(struct rxrpc_connection *conn, int channel,
433 enum rxrpc_client_trace op),
435 TP_ARGS(conn, channel, op),
438 __field(struct rxrpc_connection *, conn )
440 __field(int, channel )
442 __field(enum rxrpc_client_trace, op )
443 __field(enum rxrpc_conn_cache_state, cs )
447 __entry->conn = conn;
448 __entry->channel = channel;
449 __entry->usage = atomic_read(&conn->usage);
451 __entry->cid = conn->proto.cid;
452 __entry->cs = conn->cache_state;
455 TP_printk("C=%p h=%2d %s %s i=%08x u=%d",
458 __print_symbolic(__entry->op, rxrpc_client_traces),
459 __print_symbolic(__entry->cs, rxrpc_conn_cache_states),
464 TRACE_EVENT(rxrpc_call,
465 TP_PROTO(struct rxrpc_call *call, enum rxrpc_call_trace op,
466 int usage, const void *where, const void *aux),
468 TP_ARGS(call, op, usage, where, aux),
471 __field(struct rxrpc_call *, call )
474 __field(const void *, where )
475 __field(const void *, aux )
479 __entry->call = call;
481 __entry->usage = usage;
482 __entry->where = where;
486 TP_printk("c=%p %s u=%d sp=%pSR a=%p",
488 __print_symbolic(__entry->op, rxrpc_call_traces),
494 TRACE_EVENT(rxrpc_skb,
495 TP_PROTO(struct sk_buff *skb, enum rxrpc_skb_trace op,
496 int usage, int mod_count, const void *where),
498 TP_ARGS(skb, op, usage, mod_count, where),
501 __field(struct sk_buff *, skb )
502 __field(enum rxrpc_skb_trace, op )
504 __field(int, mod_count )
505 __field(const void *, where )
511 __entry->usage = usage;
512 __entry->mod_count = mod_count;
513 __entry->where = where;
516 TP_printk("s=%p %s u=%d m=%d p=%pSR",
518 __print_symbolic(__entry->op, rxrpc_skb_traces),
524 TRACE_EVENT(rxrpc_rx_packet,
525 TP_PROTO(struct rxrpc_skb_priv *sp),
530 __field_struct(struct rxrpc_host_header, hdr )
534 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
537 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s",
538 __entry->hdr.epoch, __entry->hdr.cid,
539 __entry->hdr.callNumber, __entry->hdr.serviceId,
540 __entry->hdr.serial, __entry->hdr.seq,
541 __entry->hdr.type, __entry->hdr.flags,
542 __entry->hdr.type <= 15 ?
543 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
546 TRACE_EVENT(rxrpc_rx_done,
547 TP_PROTO(int result, int abort_code),
549 TP_ARGS(result, abort_code),
552 __field(int, result )
553 __field(int, abort_code )
557 __entry->result = result;
558 __entry->abort_code = abort_code;
561 TP_printk("r=%d a=%d", __entry->result, __entry->abort_code)
564 TRACE_EVENT(rxrpc_abort,
565 TP_PROTO(const char *why, u32 cid, u32 call_id, rxrpc_seq_t seq,
566 int abort_code, int error),
568 TP_ARGS(why, cid, call_id, seq, abort_code, error),
571 __array(char, why, 4 )
573 __field(u32, call_id )
574 __field(rxrpc_seq_t, seq )
575 __field(int, abort_code )
580 memcpy(__entry->why, why, 4);
582 __entry->call_id = call_id;
583 __entry->abort_code = abort_code;
584 __entry->error = error;
588 TP_printk("%08x:%08x s=%u a=%d e=%d %s",
589 __entry->cid, __entry->call_id, __entry->seq,
590 __entry->abort_code, __entry->error, __entry->why)
593 TRACE_EVENT(rxrpc_transmit,
594 TP_PROTO(struct rxrpc_call *call, enum rxrpc_transmit_trace why),
599 __field(struct rxrpc_call *, call )
600 __field(enum rxrpc_transmit_trace, why )
601 __field(rxrpc_seq_t, tx_hard_ack )
602 __field(rxrpc_seq_t, tx_top )
603 __field(int, tx_winsize )
607 __entry->call = call;
609 __entry->tx_hard_ack = call->tx_hard_ack;
610 __entry->tx_top = call->tx_top;
611 __entry->tx_winsize = call->tx_winsize;
614 TP_printk("c=%p %s f=%08x n=%u/%u",
616 __print_symbolic(__entry->why, rxrpc_transmit_traces),
617 __entry->tx_hard_ack + 1,
618 __entry->tx_top - __entry->tx_hard_ack,
622 TRACE_EVENT(rxrpc_rx_data,
623 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq,
624 rxrpc_serial_t serial, u8 flags, u8 anno),
626 TP_ARGS(call, seq, serial, flags, anno),
629 __field(struct rxrpc_call *, call )
630 __field(rxrpc_seq_t, seq )
631 __field(rxrpc_serial_t, serial )
637 __entry->call = call;
639 __entry->serial = serial;
640 __entry->flags = flags;
641 __entry->anno = anno;
644 TP_printk("c=%p DATA %08x q=%08x fl=%02x a=%02x",
652 TRACE_EVENT(rxrpc_rx_ack,
653 TP_PROTO(struct rxrpc_call *call,
654 rxrpc_serial_t serial, rxrpc_serial_t ack_serial,
655 rxrpc_seq_t first, rxrpc_seq_t prev, u8 reason, u8 n_acks),
657 TP_ARGS(call, serial, ack_serial, first, prev, reason, n_acks),
660 __field(struct rxrpc_call *, call )
661 __field(rxrpc_serial_t, serial )
662 __field(rxrpc_serial_t, ack_serial )
663 __field(rxrpc_seq_t, first )
664 __field(rxrpc_seq_t, prev )
670 __entry->call = call;
671 __entry->serial = serial;
672 __entry->ack_serial = ack_serial;
673 __entry->first = first;
674 __entry->prev = prev;
675 __entry->reason = reason;
676 __entry->n_acks = n_acks;
679 TP_printk("c=%p %08x %s r=%08x f=%08x p=%08x n=%u",
682 __print_symbolic(__entry->reason, rxrpc_ack_names),
689 TRACE_EVENT(rxrpc_rx_abort,
690 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
693 TP_ARGS(call, serial, abort_code),
696 __field(struct rxrpc_call *, call )
697 __field(rxrpc_serial_t, serial )
698 __field(u32, abort_code )
702 __entry->call = call;
703 __entry->serial = serial;
704 __entry->abort_code = abort_code;
707 TP_printk("c=%p ABORT %08x ac=%d",
713 TRACE_EVENT(rxrpc_rx_rwind_change,
714 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
715 u32 rwind, bool wake),
717 TP_ARGS(call, serial, rwind, wake),
720 __field(struct rxrpc_call *, call )
721 __field(rxrpc_serial_t, serial )
727 __entry->call = call;
728 __entry->serial = serial;
729 __entry->rwind = rwind;
730 __entry->wake = wake;
733 TP_printk("c=%p %08x rw=%u%s",
737 __entry->wake ? " wake" : "")
740 TRACE_EVENT(rxrpc_tx_data,
741 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq,
742 rxrpc_serial_t serial, u8 flags, bool retrans, bool lose),
744 TP_ARGS(call, seq, serial, flags, retrans, lose),
747 __field(struct rxrpc_call *, call )
748 __field(rxrpc_seq_t, seq )
749 __field(rxrpc_serial_t, serial )
751 __field(bool, retrans )
756 __entry->call = call;
758 __entry->serial = serial;
759 __entry->flags = flags;
760 __entry->retrans = retrans;
761 __entry->lose = lose;
764 TP_printk("c=%p DATA %08x q=%08x fl=%02x%s%s",
769 __entry->retrans ? " *RETRANS*" : "",
770 __entry->lose ? " *LOSE*" : "")
773 TRACE_EVENT(rxrpc_tx_ack,
774 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
775 rxrpc_seq_t ack_first, rxrpc_serial_t ack_serial,
776 u8 reason, u8 n_acks),
778 TP_ARGS(call, serial, ack_first, ack_serial, reason, n_acks),
781 __field(struct rxrpc_call *, call )
782 __field(rxrpc_serial_t, serial )
783 __field(rxrpc_seq_t, ack_first )
784 __field(rxrpc_serial_t, ack_serial )
790 __entry->call = call;
791 __entry->serial = serial;
792 __entry->ack_first = ack_first;
793 __entry->ack_serial = ack_serial;
794 __entry->reason = reason;
795 __entry->n_acks = n_acks;
798 TP_printk(" c=%p ACK %08x %s f=%08x r=%08x n=%u",
801 __print_symbolic(__entry->reason, rxrpc_ack_names),
807 TRACE_EVENT(rxrpc_receive,
808 TP_PROTO(struct rxrpc_call *call, enum rxrpc_receive_trace why,
809 rxrpc_serial_t serial, rxrpc_seq_t seq),
811 TP_ARGS(call, why, serial, seq),
814 __field(struct rxrpc_call *, call )
815 __field(enum rxrpc_receive_trace, why )
816 __field(rxrpc_serial_t, serial )
817 __field(rxrpc_seq_t, seq )
818 __field(rxrpc_seq_t, hard_ack )
819 __field(rxrpc_seq_t, top )
823 __entry->call = call;
825 __entry->serial = serial;
827 __entry->hard_ack = call->rx_hard_ack;
828 __entry->top = call->rx_top;
831 TP_printk("c=%p %s r=%08x q=%08x w=%08x-%08x",
833 __print_symbolic(__entry->why, rxrpc_receive_traces),
840 TRACE_EVENT(rxrpc_recvmsg,
841 TP_PROTO(struct rxrpc_call *call, enum rxrpc_recvmsg_trace why,
842 rxrpc_seq_t seq, unsigned int offset, unsigned int len,
845 TP_ARGS(call, why, seq, offset, len, ret),
848 __field(struct rxrpc_call *, call )
849 __field(enum rxrpc_recvmsg_trace, why )
850 __field(rxrpc_seq_t, seq )
851 __field(unsigned int, offset )
852 __field(unsigned int, len )
857 __entry->call = call;
860 __entry->offset = offset;
865 TP_printk("c=%p %s q=%08x o=%u l=%u ret=%d",
867 __print_symbolic(__entry->why, rxrpc_recvmsg_traces),
874 TRACE_EVENT(rxrpc_rtt_tx,
875 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_tx_trace why,
876 rxrpc_serial_t send_serial),
878 TP_ARGS(call, why, send_serial),
881 __field(struct rxrpc_call *, call )
882 __field(enum rxrpc_rtt_tx_trace, why )
883 __field(rxrpc_serial_t, send_serial )
887 __entry->call = call;
889 __entry->send_serial = send_serial;
892 TP_printk("c=%p %s sr=%08x",
894 __print_symbolic(__entry->why, rxrpc_rtt_tx_traces),
895 __entry->send_serial)
898 TRACE_EVENT(rxrpc_rtt_rx,
899 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_rx_trace why,
900 rxrpc_serial_t send_serial, rxrpc_serial_t resp_serial,
901 s64 rtt, u8 nr, s64 avg),
903 TP_ARGS(call, why, send_serial, resp_serial, rtt, nr, avg),
906 __field(struct rxrpc_call *, call )
907 __field(enum rxrpc_rtt_rx_trace, why )
909 __field(rxrpc_serial_t, send_serial )
910 __field(rxrpc_serial_t, resp_serial )
916 __entry->call = call;
918 __entry->send_serial = send_serial;
919 __entry->resp_serial = resp_serial;
925 TP_printk("c=%p %s sr=%08x rr=%08x rtt=%lld nr=%u avg=%lld",
927 __print_symbolic(__entry->why, rxrpc_rtt_rx_traces),
928 __entry->send_serial,
929 __entry->resp_serial,
935 TRACE_EVENT(rxrpc_timer,
936 TP_PROTO(struct rxrpc_call *call, enum rxrpc_timer_trace why,
937 ktime_t now, unsigned long now_j),
939 TP_ARGS(call, why, now, now_j),
942 __field(struct rxrpc_call *, call )
943 __field(enum rxrpc_timer_trace, why )
944 __field_struct(ktime_t, now )
945 __field_struct(ktime_t, expire_at )
946 __field_struct(ktime_t, ack_at )
947 __field_struct(ktime_t, resend_at )
948 __field(unsigned long, now_j )
949 __field(unsigned long, timer )
953 __entry->call = call;
956 __entry->expire_at = call->expire_at;
957 __entry->ack_at = call->ack_at;
958 __entry->resend_at = call->resend_at;
959 __entry->now_j = now_j;
960 __entry->timer = call->timer.expires;
963 TP_printk("c=%p %s x=%lld a=%lld r=%lld t=%ld",
965 __print_symbolic(__entry->why, rxrpc_timer_traces),
966 ktime_to_ns(ktime_sub(__entry->expire_at, __entry->now)),
967 ktime_to_ns(ktime_sub(__entry->ack_at, __entry->now)),
968 ktime_to_ns(ktime_sub(__entry->resend_at, __entry->now)),
969 __entry->timer - __entry->now_j)
972 TRACE_EVENT(rxrpc_rx_lose,
973 TP_PROTO(struct rxrpc_skb_priv *sp),
978 __field_struct(struct rxrpc_host_header, hdr )
982 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
985 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s *LOSE*",
986 __entry->hdr.epoch, __entry->hdr.cid,
987 __entry->hdr.callNumber, __entry->hdr.serviceId,
988 __entry->hdr.serial, __entry->hdr.seq,
989 __entry->hdr.type, __entry->hdr.flags,
990 __entry->hdr.type <= 15 ?
991 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
994 TRACE_EVENT(rxrpc_propose_ack,
995 TP_PROTO(struct rxrpc_call *call, enum rxrpc_propose_ack_trace why,
996 u8 ack_reason, rxrpc_serial_t serial, bool immediate,
997 bool background, enum rxrpc_propose_ack_outcome outcome),
999 TP_ARGS(call, why, ack_reason, serial, immediate, background,
1003 __field(struct rxrpc_call *, call )
1004 __field(enum rxrpc_propose_ack_trace, why )
1005 __field(rxrpc_serial_t, serial )
1006 __field(u8, ack_reason )
1007 __field(bool, immediate )
1008 __field(bool, background )
1009 __field(enum rxrpc_propose_ack_outcome, outcome )
1013 __entry->call = call;
1015 __entry->serial = serial;
1016 __entry->ack_reason = ack_reason;
1017 __entry->immediate = immediate;
1018 __entry->background = background;
1019 __entry->outcome = outcome;
1022 TP_printk("c=%p %s %s r=%08x i=%u b=%u%s",
1024 __print_symbolic(__entry->why, rxrpc_propose_ack_traces),
1025 __print_symbolic(__entry->ack_reason, rxrpc_ack_names),
1028 __entry->background,
1029 __print_symbolic(__entry->outcome, rxrpc_propose_ack_outcomes))
1032 TRACE_EVENT(rxrpc_retransmit,
1033 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq, u8 annotation,
1036 TP_ARGS(call, seq, annotation, expiry),
1039 __field(struct rxrpc_call *, call )
1040 __field(rxrpc_seq_t, seq )
1041 __field(u8, annotation )
1042 __field(s64, expiry )
1046 __entry->call = call;
1048 __entry->annotation = annotation;
1049 __entry->expiry = expiry;
1052 TP_printk("c=%p q=%x a=%02x xp=%lld",
1055 __entry->annotation,
1059 TRACE_EVENT(rxrpc_congest,
1060 TP_PROTO(struct rxrpc_call *call, struct rxrpc_ack_summary *summary,
1061 rxrpc_serial_t ack_serial, enum rxrpc_congest_change change),
1063 TP_ARGS(call, summary, ack_serial, change),
1066 __field(struct rxrpc_call *, call )
1067 __field(enum rxrpc_congest_change, change )
1068 __field(rxrpc_seq_t, hard_ack )
1069 __field(rxrpc_seq_t, top )
1070 __field(rxrpc_seq_t, lowest_nak )
1071 __field(rxrpc_serial_t, ack_serial )
1072 __field_struct(struct rxrpc_ack_summary, sum )
1076 __entry->call = call;
1077 __entry->change = change;
1078 __entry->hard_ack = call->tx_hard_ack;
1079 __entry->top = call->tx_top;
1080 __entry->lowest_nak = call->acks_lowest_nak;
1081 __entry->ack_serial = ack_serial;
1082 memcpy(&__entry->sum, summary, sizeof(__entry->sum));
1085 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",
1087 __entry->ack_serial,
1088 __print_symbolic(__entry->sum.ack_reason, rxrpc_ack_names),
1090 __print_symbolic(__entry->sum.mode, rxrpc_congest_modes),
1092 __entry->sum.ssthresh,
1093 __entry->sum.nr_acks, __entry->sum.nr_nacks,
1094 __entry->sum.nr_new_acks, __entry->sum.nr_new_nacks,
1095 __entry->sum.nr_rot_new_acks,
1096 __entry->top - __entry->hard_ack,
1097 __entry->sum.cumulative_acks,
1098 __entry->sum.dup_acks,
1099 __entry->lowest_nak, __entry->sum.new_low_nack ? "!" : "",
1100 __print_symbolic(__entry->change, rxrpc_congest_changes),
1101 __entry->sum.retrans_timeo ? " rTxTo" : "")
1104 TRACE_EVENT(rxrpc_disconnect_call,
1105 TP_PROTO(struct rxrpc_call *call),
1110 __field(struct rxrpc_call *, call )
1111 __field(u32, abort_code )
1115 __entry->call = call;
1116 __entry->abort_code = call->abort_code;
1119 TP_printk("c=%p ab=%08x",
1121 __entry->abort_code)
1124 TRACE_EVENT(rxrpc_improper_term,
1125 TP_PROTO(struct rxrpc_call *call),
1130 __field(struct rxrpc_call *, call )
1131 __field(u32, abort_code )
1135 __entry->call = call;
1136 __entry->abort_code = call->abort_code;
1139 TP_printk("c=%p ab=%08x",
1141 __entry->abort_code)
1144 TRACE_EVENT(rxrpc_rx_eproto,
1145 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
1148 TP_ARGS(call, serial, why),
1151 __field(struct rxrpc_call *, call )
1152 __field(rxrpc_serial_t, serial )
1153 __field(const char *, why )
1157 __entry->call = call;
1158 __entry->serial = serial;
1162 TP_printk("c=%p EPROTO %08x %s",
1168 TRACE_EVENT(rxrpc_connect_call,
1169 TP_PROTO(struct rxrpc_call *call),
1174 __field(struct rxrpc_call *, call )
1175 __field(unsigned long, user_call_ID )
1177 __field(u32, call_id )
1181 __entry->call = call;
1182 __entry->user_call_ID = call->user_call_ID;
1183 __entry->cid = call->cid;
1184 __entry->call_id = call->call_id;
1187 TP_printk("c=%p u=%p %08x:%08x",
1189 (void *)__entry->user_call_ID,
1194 #endif /* _TRACE_RXRPC_H */
1196 /* This part must be outside protection */
1197 #include <trace/define_trace.h>