1 /* SPDX-License-Identifier: GPL-2.0-or-later */
2 /* AF_RXRPC tracepoints
4 * Copyright (C) 2016 Red Hat, Inc. All Rights Reserved.
5 * Written by David Howells (dhowells@redhat.com)
8 #define TRACE_SYSTEM rxrpc
10 #if !defined(_TRACE_RXRPC_H) || defined(TRACE_HEADER_MULTI_READ)
11 #define _TRACE_RXRPC_H
13 #include <linux/tracepoint.h>
14 #include <linux/errqueue.h>
17 * Define enums for tracing information.
19 * These should all be kept sorted, making it easier to match the string
20 * mapping tables further on.
22 #ifndef __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY
23 #define __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY
25 enum rxrpc_skb_trace {
36 rxrpc_skb_unshared_nomem,
39 enum rxrpc_local_trace {
42 rxrpc_local_processing,
47 enum rxrpc_peer_trace {
50 rxrpc_peer_processing,
54 enum rxrpc_conn_trace {
56 rxrpc_conn_new_client,
57 rxrpc_conn_new_service,
58 rxrpc_conn_put_client,
59 rxrpc_conn_put_service,
61 rxrpc_conn_reap_service,
65 enum rxrpc_client_trace {
66 rxrpc_client_activate_chans,
68 rxrpc_client_chan_activate,
69 rxrpc_client_chan_disconnect,
70 rxrpc_client_chan_pass,
71 rxrpc_client_chan_wait_failed,
74 rxrpc_client_duplicate,
77 rxrpc_client_to_active,
81 enum rxrpc_call_trace {
85 rxrpc_call_got_kernel,
87 rxrpc_call_got_userid,
88 rxrpc_call_new_client,
89 rxrpc_call_new_service,
91 rxrpc_call_put_kernel,
92 rxrpc_call_put_noqueue,
93 rxrpc_call_put_notimer,
95 rxrpc_call_put_userid,
97 rxrpc_call_queued_ref,
102 enum rxrpc_transmit_trace {
103 rxrpc_transmit_await_reply,
105 rxrpc_transmit_queue,
106 rxrpc_transmit_queue_last,
107 rxrpc_transmit_rotate,
108 rxrpc_transmit_rotate_last,
112 enum rxrpc_receive_trace {
115 rxrpc_receive_incoming,
117 rxrpc_receive_queue_last,
118 rxrpc_receive_rotate,
121 enum rxrpc_recvmsg_trace {
123 rxrpc_recvmsg_data_return,
124 rxrpc_recvmsg_dequeue,
129 rxrpc_recvmsg_requeue,
130 rxrpc_recvmsg_return,
131 rxrpc_recvmsg_terminal,
132 rxrpc_recvmsg_to_be_accepted,
136 enum rxrpc_rtt_tx_trace {
139 rxrpc_rtt_tx_no_slot,
143 enum rxrpc_rtt_rx_trace {
146 rxrpc_rtt_rx_obsolete,
147 rxrpc_rtt_rx_ping_response,
148 rxrpc_rtt_rx_requested_ack,
151 enum rxrpc_timer_trace {
154 rxrpc_timer_exp_hard,
155 rxrpc_timer_exp_idle,
156 rxrpc_timer_exp_keepalive,
157 rxrpc_timer_exp_lost_ack,
158 rxrpc_timer_exp_normal,
159 rxrpc_timer_exp_ping,
160 rxrpc_timer_exp_resend,
162 rxrpc_timer_init_for_reply,
163 rxrpc_timer_init_for_send_reply,
165 rxrpc_timer_set_for_ack,
166 rxrpc_timer_set_for_hard,
167 rxrpc_timer_set_for_idle,
168 rxrpc_timer_set_for_keepalive,
169 rxrpc_timer_set_for_lost_ack,
170 rxrpc_timer_set_for_normal,
171 rxrpc_timer_set_for_ping,
172 rxrpc_timer_set_for_resend,
173 rxrpc_timer_set_for_send,
176 enum rxrpc_propose_ack_trace {
177 rxrpc_propose_ack_client_tx_end,
178 rxrpc_propose_ack_input_data,
179 rxrpc_propose_ack_ping_for_check_life,
180 rxrpc_propose_ack_ping_for_keepalive,
181 rxrpc_propose_ack_ping_for_lost_ack,
182 rxrpc_propose_ack_ping_for_lost_reply,
183 rxrpc_propose_ack_ping_for_params,
184 rxrpc_propose_ack_processing_op,
185 rxrpc_propose_ack_respond_to_ack,
186 rxrpc_propose_ack_respond_to_ping,
187 rxrpc_propose_ack_retry_tx,
188 rxrpc_propose_ack_rotate_rx,
189 rxrpc_propose_ack_terminal_ack,
192 enum rxrpc_propose_ack_outcome {
193 rxrpc_propose_ack_subsume,
194 rxrpc_propose_ack_update,
195 rxrpc_propose_ack_use,
198 enum rxrpc_congest_change {
199 rxrpc_cong_begin_retransmission,
200 rxrpc_cong_cleared_nacks,
201 rxrpc_cong_new_low_nack,
202 rxrpc_cong_no_change,
204 rxrpc_cong_retransmit_again,
205 rxrpc_cong_rtt_window_end,
209 enum rxrpc_tx_point {
210 rxrpc_tx_point_call_abort,
211 rxrpc_tx_point_call_ack,
212 rxrpc_tx_point_call_data_frag,
213 rxrpc_tx_point_call_data_nofrag,
214 rxrpc_tx_point_call_final_resend,
215 rxrpc_tx_point_conn_abort,
216 rxrpc_tx_point_rxkad_challenge,
217 rxrpc_tx_point_rxkad_response,
218 rxrpc_tx_point_reject,
219 rxrpc_tx_point_version_keepalive,
220 rxrpc_tx_point_version_reply,
223 #endif /* end __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY */
226 * Declare tracing information enums and their string mappings for display.
228 #define rxrpc_skb_traces \
229 EM(rxrpc_skb_cleaned, "CLN") \
230 EM(rxrpc_skb_freed, "FRE") \
231 EM(rxrpc_skb_got, "GOT") \
232 EM(rxrpc_skb_lost, "*L*") \
233 EM(rxrpc_skb_new, "NEW") \
234 EM(rxrpc_skb_purged, "PUR") \
235 EM(rxrpc_skb_received, "RCV") \
236 EM(rxrpc_skb_rotated, "ROT") \
237 EM(rxrpc_skb_seen, "SEE") \
238 EM(rxrpc_skb_unshared, "UNS") \
239 E_(rxrpc_skb_unshared_nomem, "US0")
241 #define rxrpc_local_traces \
242 EM(rxrpc_local_got, "GOT") \
243 EM(rxrpc_local_new, "NEW") \
244 EM(rxrpc_local_processing, "PRO") \
245 EM(rxrpc_local_put, "PUT") \
246 E_(rxrpc_local_queued, "QUE")
248 #define rxrpc_peer_traces \
249 EM(rxrpc_peer_got, "GOT") \
250 EM(rxrpc_peer_new, "NEW") \
251 EM(rxrpc_peer_processing, "PRO") \
252 E_(rxrpc_peer_put, "PUT")
254 #define rxrpc_conn_traces \
255 EM(rxrpc_conn_got, "GOT") \
256 EM(rxrpc_conn_new_client, "NWc") \
257 EM(rxrpc_conn_new_service, "NWs") \
258 EM(rxrpc_conn_put_client, "PTc") \
259 EM(rxrpc_conn_put_service, "PTs") \
260 EM(rxrpc_conn_queued, "QUE") \
261 EM(rxrpc_conn_reap_service, "RPs") \
262 E_(rxrpc_conn_seen, "SEE")
264 #define rxrpc_client_traces \
265 EM(rxrpc_client_activate_chans, "Activa") \
266 EM(rxrpc_client_alloc, "Alloc ") \
267 EM(rxrpc_client_chan_activate, "ChActv") \
268 EM(rxrpc_client_chan_disconnect, "ChDisc") \
269 EM(rxrpc_client_chan_pass, "ChPass") \
270 EM(rxrpc_client_chan_wait_failed, "ChWtFl") \
271 EM(rxrpc_client_cleanup, "Clean ") \
272 EM(rxrpc_client_discard, "Discar") \
273 EM(rxrpc_client_duplicate, "Duplic") \
274 EM(rxrpc_client_exposed, "Expose") \
275 EM(rxrpc_client_replace, "Replac") \
276 EM(rxrpc_client_to_active, "->Actv") \
277 E_(rxrpc_client_to_idle, "->Idle")
279 #define rxrpc_call_traces \
280 EM(rxrpc_call_connected, "CON") \
281 EM(rxrpc_call_error, "*E*") \
282 EM(rxrpc_call_got, "GOT") \
283 EM(rxrpc_call_got_kernel, "Gke") \
284 EM(rxrpc_call_got_timer, "GTM") \
285 EM(rxrpc_call_got_userid, "Gus") \
286 EM(rxrpc_call_new_client, "NWc") \
287 EM(rxrpc_call_new_service, "NWs") \
288 EM(rxrpc_call_put, "PUT") \
289 EM(rxrpc_call_put_kernel, "Pke") \
290 EM(rxrpc_call_put_noqueue, "PnQ") \
291 EM(rxrpc_call_put_notimer, "PnT") \
292 EM(rxrpc_call_put_timer, "PTM") \
293 EM(rxrpc_call_put_userid, "Pus") \
294 EM(rxrpc_call_queued, "QUE") \
295 EM(rxrpc_call_queued_ref, "QUR") \
296 EM(rxrpc_call_release, "RLS") \
297 E_(rxrpc_call_seen, "SEE")
299 #define rxrpc_transmit_traces \
300 EM(rxrpc_transmit_await_reply, "AWR") \
301 EM(rxrpc_transmit_end, "END") \
302 EM(rxrpc_transmit_queue, "QUE") \
303 EM(rxrpc_transmit_queue_last, "QLS") \
304 EM(rxrpc_transmit_rotate, "ROT") \
305 EM(rxrpc_transmit_rotate_last, "RLS") \
306 E_(rxrpc_transmit_wait, "WAI")
308 #define rxrpc_receive_traces \
309 EM(rxrpc_receive_end, "END") \
310 EM(rxrpc_receive_front, "FRN") \
311 EM(rxrpc_receive_incoming, "INC") \
312 EM(rxrpc_receive_queue, "QUE") \
313 EM(rxrpc_receive_queue_last, "QLS") \
314 E_(rxrpc_receive_rotate, "ROT")
316 #define rxrpc_recvmsg_traces \
317 EM(rxrpc_recvmsg_cont, "CONT") \
318 EM(rxrpc_recvmsg_data_return, "DATA") \
319 EM(rxrpc_recvmsg_dequeue, "DEQU") \
320 EM(rxrpc_recvmsg_enter, "ENTR") \
321 EM(rxrpc_recvmsg_full, "FULL") \
322 EM(rxrpc_recvmsg_hole, "HOLE") \
323 EM(rxrpc_recvmsg_next, "NEXT") \
324 EM(rxrpc_recvmsg_requeue, "REQU") \
325 EM(rxrpc_recvmsg_return, "RETN") \
326 EM(rxrpc_recvmsg_terminal, "TERM") \
327 EM(rxrpc_recvmsg_to_be_accepted, "TBAC") \
328 E_(rxrpc_recvmsg_wait, "WAIT")
330 #define rxrpc_rtt_tx_traces \
331 EM(rxrpc_rtt_tx_cancel, "CNCE") \
332 EM(rxrpc_rtt_tx_data, "DATA") \
333 EM(rxrpc_rtt_tx_no_slot, "FULL") \
334 E_(rxrpc_rtt_tx_ping, "PING")
336 #define rxrpc_rtt_rx_traces \
337 EM(rxrpc_rtt_rx_cancel, "CNCL") \
338 EM(rxrpc_rtt_rx_obsolete, "OBSL") \
339 EM(rxrpc_rtt_rx_lost, "LOST") \
340 EM(rxrpc_rtt_rx_ping_response, "PONG") \
341 E_(rxrpc_rtt_rx_requested_ack, "RACK")
343 #define rxrpc_timer_traces \
344 EM(rxrpc_timer_begin, "Begin ") \
345 EM(rxrpc_timer_expired, "*EXPR*") \
346 EM(rxrpc_timer_exp_ack, "ExpAck") \
347 EM(rxrpc_timer_exp_hard, "ExpHrd") \
348 EM(rxrpc_timer_exp_idle, "ExpIdl") \
349 EM(rxrpc_timer_exp_keepalive, "ExpKA ") \
350 EM(rxrpc_timer_exp_lost_ack, "ExpLoA") \
351 EM(rxrpc_timer_exp_normal, "ExpNml") \
352 EM(rxrpc_timer_exp_ping, "ExpPng") \
353 EM(rxrpc_timer_exp_resend, "ExpRsn") \
354 EM(rxrpc_timer_init_for_reply, "IniRpl") \
355 EM(rxrpc_timer_init_for_send_reply, "SndRpl") \
356 EM(rxrpc_timer_restart, "Restrt") \
357 EM(rxrpc_timer_set_for_ack, "SetAck") \
358 EM(rxrpc_timer_set_for_hard, "SetHrd") \
359 EM(rxrpc_timer_set_for_idle, "SetIdl") \
360 EM(rxrpc_timer_set_for_keepalive, "KeepAl") \
361 EM(rxrpc_timer_set_for_lost_ack, "SetLoA") \
362 EM(rxrpc_timer_set_for_normal, "SetNml") \
363 EM(rxrpc_timer_set_for_ping, "SetPng") \
364 EM(rxrpc_timer_set_for_resend, "SetRTx") \
365 E_(rxrpc_timer_set_for_send, "SetSnd")
367 #define rxrpc_propose_ack_traces \
368 EM(rxrpc_propose_ack_client_tx_end, "ClTxEnd") \
369 EM(rxrpc_propose_ack_input_data, "DataIn ") \
370 EM(rxrpc_propose_ack_ping_for_check_life, "ChkLife") \
371 EM(rxrpc_propose_ack_ping_for_keepalive, "KeepAlv") \
372 EM(rxrpc_propose_ack_ping_for_lost_ack, "LostAck") \
373 EM(rxrpc_propose_ack_ping_for_lost_reply, "LostRpl") \
374 EM(rxrpc_propose_ack_ping_for_params, "Params ") \
375 EM(rxrpc_propose_ack_processing_op, "ProcOp ") \
376 EM(rxrpc_propose_ack_respond_to_ack, "Rsp2Ack") \
377 EM(rxrpc_propose_ack_respond_to_ping, "Rsp2Png") \
378 EM(rxrpc_propose_ack_retry_tx, "RetryTx") \
379 EM(rxrpc_propose_ack_rotate_rx, "RxAck ") \
380 E_(rxrpc_propose_ack_terminal_ack, "ClTerm ")
382 #define rxrpc_propose_ack_outcomes \
383 EM(rxrpc_propose_ack_subsume, " Subsume") \
384 EM(rxrpc_propose_ack_update, " Update") \
385 E_(rxrpc_propose_ack_use, " New")
387 #define rxrpc_congest_modes \
388 EM(RXRPC_CALL_CONGEST_AVOIDANCE, "CongAvoid") \
389 EM(RXRPC_CALL_FAST_RETRANSMIT, "FastReTx ") \
390 EM(RXRPC_CALL_PACKET_LOSS, "PktLoss ") \
391 E_(RXRPC_CALL_SLOW_START, "SlowStart")
393 #define rxrpc_congest_changes \
394 EM(rxrpc_cong_begin_retransmission, " Retrans") \
395 EM(rxrpc_cong_cleared_nacks, " Cleared") \
396 EM(rxrpc_cong_new_low_nack, " NewLowN") \
397 EM(rxrpc_cong_no_change, " -") \
398 EM(rxrpc_cong_progress, " Progres") \
399 EM(rxrpc_cong_retransmit_again, " ReTxAgn") \
400 EM(rxrpc_cong_rtt_window_end, " RttWinE") \
401 E_(rxrpc_cong_saw_nack, " SawNack")
405 EM(RXRPC_PACKET_TYPE_DATA, "DATA") \
406 EM(RXRPC_PACKET_TYPE_ACK, "ACK") \
407 EM(RXRPC_PACKET_TYPE_BUSY, "BUSY") \
408 EM(RXRPC_PACKET_TYPE_ABORT, "ABORT") \
409 EM(RXRPC_PACKET_TYPE_ACKALL, "ACKALL") \
410 EM(RXRPC_PACKET_TYPE_CHALLENGE, "CHALL") \
411 EM(RXRPC_PACKET_TYPE_RESPONSE, "RESP") \
412 EM(RXRPC_PACKET_TYPE_DEBUG, "DEBUG") \
417 EM(RXRPC_PACKET_TYPE_VERSION, "VERSION") \
421 #define rxrpc_ack_names \
423 EM(RXRPC_ACK_REQUESTED, "REQ") \
424 EM(RXRPC_ACK_DUPLICATE, "DUP") \
425 EM(RXRPC_ACK_OUT_OF_SEQUENCE, "OOS") \
426 EM(RXRPC_ACK_EXCEEDS_WINDOW, "WIN") \
427 EM(RXRPC_ACK_NOSPACE, "MEM") \
428 EM(RXRPC_ACK_PING, "PNG") \
429 EM(RXRPC_ACK_PING_RESPONSE, "PNR") \
430 EM(RXRPC_ACK_DELAY, "DLY") \
431 EM(RXRPC_ACK_IDLE, "IDL") \
432 E_(RXRPC_ACK__INVALID, "-?-")
434 #define rxrpc_completions \
435 EM(RXRPC_CALL_SUCCEEDED, "Succeeded") \
436 EM(RXRPC_CALL_REMOTELY_ABORTED, "RemoteAbort") \
437 EM(RXRPC_CALL_LOCALLY_ABORTED, "LocalAbort") \
438 EM(RXRPC_CALL_LOCAL_ERROR, "LocalError") \
439 E_(RXRPC_CALL_NETWORK_ERROR, "NetError")
441 #define rxrpc_tx_points \
442 EM(rxrpc_tx_point_call_abort, "CallAbort") \
443 EM(rxrpc_tx_point_call_ack, "CallAck") \
444 EM(rxrpc_tx_point_call_data_frag, "CallDataFrag") \
445 EM(rxrpc_tx_point_call_data_nofrag, "CallDataNofrag") \
446 EM(rxrpc_tx_point_call_final_resend, "CallFinalResend") \
447 EM(rxrpc_tx_point_conn_abort, "ConnAbort") \
448 EM(rxrpc_tx_point_reject, "Reject") \
449 EM(rxrpc_tx_point_rxkad_challenge, "RxkadChall") \
450 EM(rxrpc_tx_point_rxkad_response, "RxkadResp") \
451 EM(rxrpc_tx_point_version_keepalive, "VerKeepalive") \
452 E_(rxrpc_tx_point_version_reply, "VerReply")
455 * Export enum symbols via userspace.
459 #define EM(a, b) TRACE_DEFINE_ENUM(a);
460 #define E_(a, b) TRACE_DEFINE_ENUM(a);
467 rxrpc_transmit_traces;
468 rxrpc_receive_traces;
469 rxrpc_recvmsg_traces;
473 rxrpc_propose_ack_traces;
474 rxrpc_propose_ack_outcomes;
476 rxrpc_congest_changes;
480 * Now redefine the EM() and E_() macros to map the enums to the strings that
481 * will be printed in the output.
485 #define EM(a, b) { a, b },
486 #define E_(a, b) { a, b }
488 TRACE_EVENT(rxrpc_local,
489 TP_PROTO(unsigned int local_debug_id, enum rxrpc_local_trace op,
490 int usage, const void *where),
492 TP_ARGS(local_debug_id, op, usage, where),
495 __field(unsigned int, local )
498 __field(const void *, where )
502 __entry->local = local_debug_id;
504 __entry->usage = usage;
505 __entry->where = where;
508 TP_printk("L=%08x %s u=%d sp=%pSR",
510 __print_symbolic(__entry->op, rxrpc_local_traces),
515 TRACE_EVENT(rxrpc_peer,
516 TP_PROTO(unsigned int peer_debug_id, enum rxrpc_peer_trace op,
517 int usage, const void *where),
519 TP_ARGS(peer_debug_id, op, usage, where),
522 __field(unsigned int, peer )
525 __field(const void *, where )
529 __entry->peer = peer_debug_id;
531 __entry->usage = usage;
532 __entry->where = where;
535 TP_printk("P=%08x %s u=%d sp=%pSR",
537 __print_symbolic(__entry->op, rxrpc_peer_traces),
542 TRACE_EVENT(rxrpc_conn,
543 TP_PROTO(unsigned int conn_debug_id, enum rxrpc_conn_trace op,
544 int usage, const void *where),
546 TP_ARGS(conn_debug_id, op, usage, where),
549 __field(unsigned int, conn )
552 __field(const void *, where )
556 __entry->conn = conn_debug_id;
558 __entry->usage = usage;
559 __entry->where = where;
562 TP_printk("C=%08x %s u=%d sp=%pSR",
564 __print_symbolic(__entry->op, rxrpc_conn_traces),
569 TRACE_EVENT(rxrpc_client,
570 TP_PROTO(struct rxrpc_connection *conn, int channel,
571 enum rxrpc_client_trace op),
573 TP_ARGS(conn, channel, op),
576 __field(unsigned int, conn )
578 __field(int, channel )
580 __field(enum rxrpc_client_trace, op )
584 __entry->conn = conn ? conn->debug_id : 0;
585 __entry->channel = channel;
586 __entry->usage = conn ? refcount_read(&conn->ref) : -2;
588 __entry->cid = conn ? conn->proto.cid : 0;
591 TP_printk("C=%08x h=%2d %s i=%08x u=%d",
594 __print_symbolic(__entry->op, rxrpc_client_traces),
599 TRACE_EVENT(rxrpc_call,
600 TP_PROTO(unsigned int call_debug_id, enum rxrpc_call_trace op,
601 int usage, const void *where, const void *aux),
603 TP_ARGS(call_debug_id, op, usage, where, aux),
606 __field(unsigned int, call )
609 __field(const void *, where )
610 __field(const void *, aux )
614 __entry->call = call_debug_id;
616 __entry->usage = usage;
617 __entry->where = where;
621 TP_printk("c=%08x %s u=%d sp=%pSR a=%p",
623 __print_symbolic(__entry->op, rxrpc_call_traces),
629 TRACE_EVENT(rxrpc_skb,
630 TP_PROTO(struct sk_buff *skb, enum rxrpc_skb_trace op,
631 int usage, int mod_count, u8 flags, const void *where),
633 TP_ARGS(skb, op, usage, mod_count, flags, where),
636 __field(struct sk_buff *, skb )
637 __field(enum rxrpc_skb_trace, op )
640 __field(int, mod_count )
641 __field(const void *, where )
646 __entry->flags = flags;
648 __entry->usage = usage;
649 __entry->mod_count = mod_count;
650 __entry->where = where;
653 TP_printk("s=%p %cx %s u=%d m=%d p=%pSR",
655 __entry->flags & RXRPC_SKB_TX_BUFFER ? 'T' : 'R',
656 __print_symbolic(__entry->op, rxrpc_skb_traces),
662 TRACE_EVENT(rxrpc_rx_packet,
663 TP_PROTO(struct rxrpc_skb_priv *sp),
668 __field_struct(struct rxrpc_host_header, hdr )
672 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
675 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s",
676 __entry->hdr.epoch, __entry->hdr.cid,
677 __entry->hdr.callNumber, __entry->hdr.serviceId,
678 __entry->hdr.serial, __entry->hdr.seq,
679 __entry->hdr.type, __entry->hdr.flags,
680 __entry->hdr.type <= 15 ?
681 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
684 TRACE_EVENT(rxrpc_rx_done,
685 TP_PROTO(int result, int abort_code),
687 TP_ARGS(result, abort_code),
690 __field(int, result )
691 __field(int, abort_code )
695 __entry->result = result;
696 __entry->abort_code = abort_code;
699 TP_printk("r=%d a=%d", __entry->result, __entry->abort_code)
702 TRACE_EVENT(rxrpc_abort,
703 TP_PROTO(unsigned int call_nr, const char *why, u32 cid, u32 call_id,
704 rxrpc_seq_t seq, int abort_code, int error),
706 TP_ARGS(call_nr, why, cid, call_id, seq, abort_code, error),
709 __field(unsigned int, call_nr )
710 __array(char, why, 4 )
712 __field(u32, call_id )
713 __field(rxrpc_seq_t, seq )
714 __field(int, abort_code )
719 memcpy(__entry->why, why, 4);
720 __entry->call_nr = call_nr;
722 __entry->call_id = call_id;
723 __entry->abort_code = abort_code;
724 __entry->error = error;
728 TP_printk("c=%08x %08x:%08x s=%u a=%d e=%d %s",
730 __entry->cid, __entry->call_id, __entry->seq,
731 __entry->abort_code, __entry->error, __entry->why)
734 TRACE_EVENT(rxrpc_call_complete,
735 TP_PROTO(struct rxrpc_call *call),
740 __field(unsigned int, call )
741 __field(enum rxrpc_call_completion, compl )
743 __field(u32, abort_code )
747 __entry->call = call->debug_id;
748 __entry->compl = call->completion;
749 __entry->error = call->error;
750 __entry->abort_code = call->abort_code;
753 TP_printk("c=%08x %s r=%d ac=%d",
755 __print_symbolic(__entry->compl, rxrpc_completions),
760 TRACE_EVENT(rxrpc_transmit,
761 TP_PROTO(struct rxrpc_call *call, enum rxrpc_transmit_trace why),
766 __field(unsigned int, call )
767 __field(enum rxrpc_transmit_trace, why )
768 __field(rxrpc_seq_t, tx_hard_ack )
769 __field(rxrpc_seq_t, tx_top )
770 __field(int, tx_winsize )
774 __entry->call = call->debug_id;
776 __entry->tx_hard_ack = call->tx_hard_ack;
777 __entry->tx_top = call->tx_top;
778 __entry->tx_winsize = call->tx_winsize;
781 TP_printk("c=%08x %s f=%08x n=%u/%u",
783 __print_symbolic(__entry->why, rxrpc_transmit_traces),
784 __entry->tx_hard_ack + 1,
785 __entry->tx_top - __entry->tx_hard_ack,
789 TRACE_EVENT(rxrpc_rx_data,
790 TP_PROTO(unsigned int call, rxrpc_seq_t seq,
791 rxrpc_serial_t serial, u8 flags, u8 anno),
793 TP_ARGS(call, seq, serial, flags, anno),
796 __field(unsigned int, call )
797 __field(rxrpc_seq_t, seq )
798 __field(rxrpc_serial_t, serial )
804 __entry->call = call;
806 __entry->serial = serial;
807 __entry->flags = flags;
808 __entry->anno = anno;
811 TP_printk("c=%08x DATA %08x q=%08x fl=%02x a=%02x",
819 TRACE_EVENT(rxrpc_rx_ack,
820 TP_PROTO(struct rxrpc_call *call,
821 rxrpc_serial_t serial, rxrpc_serial_t ack_serial,
822 rxrpc_seq_t first, rxrpc_seq_t prev, u8 reason, u8 n_acks),
824 TP_ARGS(call, serial, ack_serial, first, prev, reason, n_acks),
827 __field(unsigned int, call )
828 __field(rxrpc_serial_t, serial )
829 __field(rxrpc_serial_t, ack_serial )
830 __field(rxrpc_seq_t, first )
831 __field(rxrpc_seq_t, prev )
837 __entry->call = call->debug_id;
838 __entry->serial = serial;
839 __entry->ack_serial = ack_serial;
840 __entry->first = first;
841 __entry->prev = prev;
842 __entry->reason = reason;
843 __entry->n_acks = n_acks;
846 TP_printk("c=%08x %08x %s r=%08x f=%08x p=%08x n=%u",
849 __print_symbolic(__entry->reason, rxrpc_ack_names),
856 TRACE_EVENT(rxrpc_rx_abort,
857 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
860 TP_ARGS(call, serial, abort_code),
863 __field(unsigned int, call )
864 __field(rxrpc_serial_t, serial )
865 __field(u32, abort_code )
869 __entry->call = call->debug_id;
870 __entry->serial = serial;
871 __entry->abort_code = abort_code;
874 TP_printk("c=%08x ABORT %08x ac=%d",
880 TRACE_EVENT(rxrpc_rx_rwind_change,
881 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
882 u32 rwind, bool wake),
884 TP_ARGS(call, serial, rwind, wake),
887 __field(unsigned int, call )
888 __field(rxrpc_serial_t, serial )
894 __entry->call = call->debug_id;
895 __entry->serial = serial;
896 __entry->rwind = rwind;
897 __entry->wake = wake;
900 TP_printk("c=%08x %08x rw=%u%s",
904 __entry->wake ? " wake" : "")
907 TRACE_EVENT(rxrpc_tx_packet,
908 TP_PROTO(unsigned int call_id, struct rxrpc_wire_header *whdr,
909 enum rxrpc_tx_point where),
911 TP_ARGS(call_id, whdr, where),
914 __field(unsigned int, call )
915 __field(enum rxrpc_tx_point, where )
916 __field_struct(struct rxrpc_wire_header, whdr )
920 __entry->call = call_id;
921 memcpy(&__entry->whdr, whdr, sizeof(__entry->whdr));
922 __entry->where = where;
925 TP_printk("c=%08x %08x:%08x:%08x:%04x %08x %08x %02x %02x %s %s",
927 ntohl(__entry->whdr.epoch),
928 ntohl(__entry->whdr.cid),
929 ntohl(__entry->whdr.callNumber),
930 ntohs(__entry->whdr.serviceId),
931 ntohl(__entry->whdr.serial),
932 ntohl(__entry->whdr.seq),
933 __entry->whdr.type, __entry->whdr.flags,
934 __entry->whdr.type <= 15 ?
935 __print_symbolic(__entry->whdr.type, rxrpc_pkts) : "?UNK",
936 __print_symbolic(__entry->where, rxrpc_tx_points))
939 TRACE_EVENT(rxrpc_tx_data,
940 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq,
941 rxrpc_serial_t serial, u8 flags, bool retrans, bool lose),
943 TP_ARGS(call, seq, serial, flags, retrans, lose),
946 __field(unsigned int, call )
947 __field(rxrpc_seq_t, seq )
948 __field(rxrpc_serial_t, serial )
950 __field(u32, call_id )
952 __field(bool, retrans )
957 __entry->call = call->debug_id;
958 __entry->cid = call->cid;
959 __entry->call_id = call->call_id;
961 __entry->serial = serial;
962 __entry->flags = flags;
963 __entry->retrans = retrans;
964 __entry->lose = lose;
967 TP_printk("c=%08x DATA %08x:%08x %08x q=%08x fl=%02x%s%s",
974 __entry->retrans ? " *RETRANS*" : "",
975 __entry->lose ? " *LOSE*" : "")
978 TRACE_EVENT(rxrpc_tx_ack,
979 TP_PROTO(unsigned int call, rxrpc_serial_t serial,
980 rxrpc_seq_t ack_first, rxrpc_serial_t ack_serial,
981 u8 reason, u8 n_acks),
983 TP_ARGS(call, serial, ack_first, ack_serial, reason, n_acks),
986 __field(unsigned int, call )
987 __field(rxrpc_serial_t, serial )
988 __field(rxrpc_seq_t, ack_first )
989 __field(rxrpc_serial_t, ack_serial )
995 __entry->call = call;
996 __entry->serial = serial;
997 __entry->ack_first = ack_first;
998 __entry->ack_serial = ack_serial;
999 __entry->reason = reason;
1000 __entry->n_acks = n_acks;
1003 TP_printk(" c=%08x ACK %08x %s f=%08x r=%08x n=%u",
1006 __print_symbolic(__entry->reason, rxrpc_ack_names),
1008 __entry->ack_serial,
1012 TRACE_EVENT(rxrpc_receive,
1013 TP_PROTO(struct rxrpc_call *call, enum rxrpc_receive_trace why,
1014 rxrpc_serial_t serial, rxrpc_seq_t seq),
1016 TP_ARGS(call, why, serial, seq),
1019 __field(unsigned int, call )
1020 __field(enum rxrpc_receive_trace, why )
1021 __field(rxrpc_serial_t, serial )
1022 __field(rxrpc_seq_t, seq )
1023 __field(rxrpc_seq_t, hard_ack )
1024 __field(rxrpc_seq_t, top )
1028 __entry->call = call->debug_id;
1030 __entry->serial = serial;
1032 __entry->hard_ack = call->rx_hard_ack;
1033 __entry->top = call->rx_top;
1036 TP_printk("c=%08x %s r=%08x q=%08x w=%08x-%08x",
1038 __print_symbolic(__entry->why, rxrpc_receive_traces),
1045 TRACE_EVENT(rxrpc_recvmsg,
1046 TP_PROTO(struct rxrpc_call *call, enum rxrpc_recvmsg_trace why,
1047 rxrpc_seq_t seq, unsigned int offset, unsigned int len,
1050 TP_ARGS(call, why, seq, offset, len, ret),
1053 __field(unsigned int, call )
1054 __field(enum rxrpc_recvmsg_trace, why )
1055 __field(rxrpc_seq_t, seq )
1056 __field(unsigned int, offset )
1057 __field(unsigned int, len )
1062 __entry->call = call ? call->debug_id : 0;
1065 __entry->offset = offset;
1070 TP_printk("c=%08x %s q=%08x o=%u l=%u ret=%d",
1072 __print_symbolic(__entry->why, rxrpc_recvmsg_traces),
1079 TRACE_EVENT(rxrpc_rtt_tx,
1080 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_tx_trace why,
1081 int slot, rxrpc_serial_t send_serial),
1083 TP_ARGS(call, why, slot, send_serial),
1086 __field(unsigned int, call )
1087 __field(enum rxrpc_rtt_tx_trace, why )
1089 __field(rxrpc_serial_t, send_serial )
1093 __entry->call = call->debug_id;
1095 __entry->slot = slot;
1096 __entry->send_serial = send_serial;
1099 TP_printk("c=%08x [%d] %s sr=%08x",
1102 __print_symbolic(__entry->why, rxrpc_rtt_tx_traces),
1103 __entry->send_serial)
1106 TRACE_EVENT(rxrpc_rtt_rx,
1107 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_rx_trace why,
1109 rxrpc_serial_t send_serial, rxrpc_serial_t resp_serial,
1112 TP_ARGS(call, why, slot, send_serial, resp_serial, rtt, rto),
1115 __field(unsigned int, call )
1116 __field(enum rxrpc_rtt_rx_trace, why )
1118 __field(rxrpc_serial_t, send_serial )
1119 __field(rxrpc_serial_t, resp_serial )
1125 __entry->call = call->debug_id;
1127 __entry->slot = slot;
1128 __entry->send_serial = send_serial;
1129 __entry->resp_serial = resp_serial;
1134 TP_printk("c=%08x [%d] %s sr=%08x rr=%08x rtt=%u rto=%u",
1137 __print_symbolic(__entry->why, rxrpc_rtt_rx_traces),
1138 __entry->send_serial,
1139 __entry->resp_serial,
1144 TRACE_EVENT(rxrpc_timer,
1145 TP_PROTO(struct rxrpc_call *call, enum rxrpc_timer_trace why,
1148 TP_ARGS(call, why, now),
1151 __field(unsigned int, call )
1152 __field(enum rxrpc_timer_trace, why )
1154 __field(long, ack_at )
1155 __field(long, ack_lost_at )
1156 __field(long, resend_at )
1157 __field(long, ping_at )
1158 __field(long, expect_rx_by )
1159 __field(long, expect_req_by )
1160 __field(long, expect_term_by )
1161 __field(long, timer )
1165 __entry->call = call->debug_id;
1168 __entry->ack_at = call->ack_at;
1169 __entry->ack_lost_at = call->ack_lost_at;
1170 __entry->resend_at = call->resend_at;
1171 __entry->expect_rx_by = call->expect_rx_by;
1172 __entry->expect_req_by = call->expect_req_by;
1173 __entry->expect_term_by = call->expect_term_by;
1174 __entry->timer = call->timer.expires;
1177 TP_printk("c=%08x %s a=%ld la=%ld r=%ld xr=%ld xq=%ld xt=%ld t=%ld",
1179 __print_symbolic(__entry->why, rxrpc_timer_traces),
1180 __entry->ack_at - __entry->now,
1181 __entry->ack_lost_at - __entry->now,
1182 __entry->resend_at - __entry->now,
1183 __entry->expect_rx_by - __entry->now,
1184 __entry->expect_req_by - __entry->now,
1185 __entry->expect_term_by - __entry->now,
1186 __entry->timer - __entry->now)
1189 TRACE_EVENT(rxrpc_rx_lose,
1190 TP_PROTO(struct rxrpc_skb_priv *sp),
1195 __field_struct(struct rxrpc_host_header, hdr )
1199 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
1202 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s *LOSE*",
1203 __entry->hdr.epoch, __entry->hdr.cid,
1204 __entry->hdr.callNumber, __entry->hdr.serviceId,
1205 __entry->hdr.serial, __entry->hdr.seq,
1206 __entry->hdr.type, __entry->hdr.flags,
1207 __entry->hdr.type <= 15 ?
1208 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
1211 TRACE_EVENT(rxrpc_propose_ack,
1212 TP_PROTO(struct rxrpc_call *call, enum rxrpc_propose_ack_trace why,
1213 u8 ack_reason, rxrpc_serial_t serial, bool immediate,
1214 bool background, enum rxrpc_propose_ack_outcome outcome),
1216 TP_ARGS(call, why, ack_reason, serial, immediate, background,
1220 __field(unsigned int, call )
1221 __field(enum rxrpc_propose_ack_trace, why )
1222 __field(rxrpc_serial_t, serial )
1223 __field(u8, ack_reason )
1224 __field(bool, immediate )
1225 __field(bool, background )
1226 __field(enum rxrpc_propose_ack_outcome, outcome )
1230 __entry->call = call->debug_id;
1232 __entry->serial = serial;
1233 __entry->ack_reason = ack_reason;
1234 __entry->immediate = immediate;
1235 __entry->background = background;
1236 __entry->outcome = outcome;
1239 TP_printk("c=%08x %s %s r=%08x i=%u b=%u%s",
1241 __print_symbolic(__entry->why, rxrpc_propose_ack_traces),
1242 __print_symbolic(__entry->ack_reason, rxrpc_ack_names),
1245 __entry->background,
1246 __print_symbolic(__entry->outcome, rxrpc_propose_ack_outcomes))
1249 TRACE_EVENT(rxrpc_retransmit,
1250 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq, u8 annotation,
1253 TP_ARGS(call, seq, annotation, expiry),
1256 __field(unsigned int, call )
1257 __field(rxrpc_seq_t, seq )
1258 __field(u8, annotation )
1259 __field(s64, expiry )
1263 __entry->call = call->debug_id;
1265 __entry->annotation = annotation;
1266 __entry->expiry = expiry;
1269 TP_printk("c=%08x q=%x a=%02x xp=%lld",
1272 __entry->annotation,
1276 TRACE_EVENT(rxrpc_congest,
1277 TP_PROTO(struct rxrpc_call *call, struct rxrpc_ack_summary *summary,
1278 rxrpc_serial_t ack_serial, enum rxrpc_congest_change change),
1280 TP_ARGS(call, summary, ack_serial, change),
1283 __field(unsigned int, call )
1284 __field(enum rxrpc_congest_change, change )
1285 __field(rxrpc_seq_t, hard_ack )
1286 __field(rxrpc_seq_t, top )
1287 __field(rxrpc_seq_t, lowest_nak )
1288 __field(rxrpc_serial_t, ack_serial )
1289 __field_struct(struct rxrpc_ack_summary, sum )
1293 __entry->call = call->debug_id;
1294 __entry->change = change;
1295 __entry->hard_ack = call->tx_hard_ack;
1296 __entry->top = call->tx_top;
1297 __entry->lowest_nak = call->acks_lowest_nak;
1298 __entry->ack_serial = ack_serial;
1299 memcpy(&__entry->sum, summary, sizeof(__entry->sum));
1302 TP_printk("c=%08x r=%08x %s q=%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",
1304 __entry->ack_serial,
1305 __print_symbolic(__entry->sum.ack_reason, rxrpc_ack_names),
1307 __print_symbolic(__entry->sum.mode, rxrpc_congest_modes),
1309 __entry->sum.ssthresh,
1310 __entry->sum.nr_acks, __entry->sum.nr_nacks,
1311 __entry->sum.nr_new_acks, __entry->sum.nr_new_nacks,
1312 __entry->sum.nr_rot_new_acks,
1313 __entry->top - __entry->hard_ack,
1314 __entry->sum.cumulative_acks,
1315 __entry->sum.dup_acks,
1316 __entry->lowest_nak, __entry->sum.new_low_nack ? "!" : "",
1317 __print_symbolic(__entry->change, rxrpc_congest_changes),
1318 __entry->sum.retrans_timeo ? " rTxTo" : "")
1321 TRACE_EVENT(rxrpc_disconnect_call,
1322 TP_PROTO(struct rxrpc_call *call),
1327 __field(unsigned int, call )
1328 __field(u32, abort_code )
1332 __entry->call = call->debug_id;
1333 __entry->abort_code = call->abort_code;
1336 TP_printk("c=%08x ab=%08x",
1338 __entry->abort_code)
1341 TRACE_EVENT(rxrpc_improper_term,
1342 TP_PROTO(struct rxrpc_call *call),
1347 __field(unsigned int, call )
1348 __field(u32, abort_code )
1352 __entry->call = call->debug_id;
1353 __entry->abort_code = call->abort_code;
1356 TP_printk("c=%08x ab=%08x",
1358 __entry->abort_code)
1361 TRACE_EVENT(rxrpc_rx_eproto,
1362 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
1365 TP_ARGS(call, serial, why),
1368 __field(unsigned int, call )
1369 __field(rxrpc_serial_t, serial )
1370 __field(const char *, why )
1374 __entry->call = call ? call->debug_id : 0;
1375 __entry->serial = serial;
1379 TP_printk("c=%08x EPROTO %08x %s",
1385 TRACE_EVENT(rxrpc_connect_call,
1386 TP_PROTO(struct rxrpc_call *call),
1391 __field(unsigned int, call )
1392 __field(unsigned long, user_call_ID )
1394 __field(u32, call_id )
1398 __entry->call = call->debug_id;
1399 __entry->user_call_ID = call->user_call_ID;
1400 __entry->cid = call->cid;
1401 __entry->call_id = call->call_id;
1404 TP_printk("c=%08x u=%p %08x:%08x",
1406 (void *)__entry->user_call_ID,
1411 TRACE_EVENT(rxrpc_resend,
1412 TP_PROTO(struct rxrpc_call *call, int ix),
1417 __field(unsigned int, call )
1419 __array(u8, anno, 64 )
1423 __entry->call = call->debug_id;
1425 memcpy(__entry->anno, call->rxtx_annotations, 64);
1428 TP_printk("c=%08x ix=%u a=%64phN",
1434 TRACE_EVENT(rxrpc_rx_icmp,
1435 TP_PROTO(struct rxrpc_peer *peer, struct sock_extended_err *ee,
1436 struct sockaddr_rxrpc *srx),
1438 TP_ARGS(peer, ee, srx),
1441 __field(unsigned int, peer )
1442 __field_struct(struct sock_extended_err, ee )
1443 __field_struct(struct sockaddr_rxrpc, srx )
1447 __entry->peer = peer->debug_id;
1448 memcpy(&__entry->ee, ee, sizeof(__entry->ee));
1449 memcpy(&__entry->srx, srx, sizeof(__entry->srx));
1452 TP_printk("P=%08x o=%u t=%u c=%u i=%u d=%u e=%d %pISp",
1454 __entry->ee.ee_origin,
1455 __entry->ee.ee_type,
1456 __entry->ee.ee_code,
1457 __entry->ee.ee_info,
1458 __entry->ee.ee_data,
1459 __entry->ee.ee_errno,
1460 &__entry->srx.transport)
1463 TRACE_EVENT(rxrpc_tx_fail,
1464 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial, int ret,
1465 enum rxrpc_tx_point where),
1467 TP_ARGS(debug_id, serial, ret, where),
1470 __field(unsigned int, debug_id )
1471 __field(rxrpc_serial_t, serial )
1473 __field(enum rxrpc_tx_point, where )
1477 __entry->debug_id = debug_id;
1478 __entry->serial = serial;
1480 __entry->where = where;
1483 TP_printk("c=%08x r=%x ret=%d %s",
1487 __print_symbolic(__entry->where, rxrpc_tx_points))
1490 TRACE_EVENT(rxrpc_call_reset,
1491 TP_PROTO(struct rxrpc_call *call),
1496 __field(unsigned int, debug_id )
1498 __field(u32, call_id )
1499 __field(rxrpc_serial_t, call_serial )
1500 __field(rxrpc_serial_t, conn_serial )
1501 __field(rxrpc_seq_t, tx_seq )
1502 __field(rxrpc_seq_t, rx_seq )
1506 __entry->debug_id = call->debug_id;
1507 __entry->cid = call->cid;
1508 __entry->call_id = call->call_id;
1509 __entry->call_serial = call->rx_serial;
1510 __entry->conn_serial = call->conn->hi_serial;
1511 __entry->tx_seq = call->tx_hard_ack;
1512 __entry->rx_seq = call->rx_hard_ack;
1515 TP_printk("c=%08x %08x:%08x r=%08x/%08x tx=%08x rx=%08x",
1517 __entry->cid, __entry->call_id,
1518 __entry->call_serial, __entry->conn_serial,
1519 __entry->tx_seq, __entry->rx_seq)
1522 TRACE_EVENT(rxrpc_notify_socket,
1523 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial),
1525 TP_ARGS(debug_id, serial),
1528 __field(unsigned int, debug_id )
1529 __field(rxrpc_serial_t, serial )
1533 __entry->debug_id = debug_id;
1534 __entry->serial = serial;
1537 TP_printk("c=%08x r=%08x",
1542 TRACE_EVENT(rxrpc_rx_discard_ack,
1543 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial,
1544 rxrpc_seq_t first_soft_ack, rxrpc_seq_t call_ackr_first,
1545 rxrpc_seq_t prev_pkt, rxrpc_seq_t call_ackr_prev),
1547 TP_ARGS(debug_id, serial, first_soft_ack, call_ackr_first,
1548 prev_pkt, call_ackr_prev),
1551 __field(unsigned int, debug_id )
1552 __field(rxrpc_serial_t, serial )
1553 __field(rxrpc_seq_t, first_soft_ack)
1554 __field(rxrpc_seq_t, call_ackr_first)
1555 __field(rxrpc_seq_t, prev_pkt)
1556 __field(rxrpc_seq_t, call_ackr_prev)
1560 __entry->debug_id = debug_id;
1561 __entry->serial = serial;
1562 __entry->first_soft_ack = first_soft_ack;
1563 __entry->call_ackr_first = call_ackr_first;
1564 __entry->prev_pkt = prev_pkt;
1565 __entry->call_ackr_prev = call_ackr_prev;
1568 TP_printk("c=%08x r=%08x %08x<%08x %08x<%08x",
1571 __entry->first_soft_ack,
1572 __entry->call_ackr_first,
1574 __entry->call_ackr_prev)
1577 #endif /* _TRACE_RXRPC_H */
1579 /* This part must be outside protection */
1580 #include <trace/define_trace.h>