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_unstarted,
72 rxrpc_client_chan_wait_failed,
76 rxrpc_client_duplicate,
79 rxrpc_client_to_active,
80 rxrpc_client_to_culled,
82 rxrpc_client_to_inactive,
83 rxrpc_client_to_upgrade,
84 rxrpc_client_to_waiting,
88 enum rxrpc_call_trace {
92 rxrpc_call_got_kernel,
93 rxrpc_call_got_userid,
94 rxrpc_call_new_client,
95 rxrpc_call_new_service,
97 rxrpc_call_put_kernel,
98 rxrpc_call_put_noqueue,
99 rxrpc_call_put_userid,
101 rxrpc_call_queued_ref,
106 enum rxrpc_transmit_trace {
107 rxrpc_transmit_await_reply,
109 rxrpc_transmit_queue,
110 rxrpc_transmit_queue_last,
111 rxrpc_transmit_rotate,
112 rxrpc_transmit_rotate_last,
116 enum rxrpc_receive_trace {
119 rxrpc_receive_incoming,
121 rxrpc_receive_queue_last,
122 rxrpc_receive_rotate,
125 enum rxrpc_recvmsg_trace {
127 rxrpc_recvmsg_data_return,
128 rxrpc_recvmsg_dequeue,
133 rxrpc_recvmsg_requeue,
134 rxrpc_recvmsg_return,
135 rxrpc_recvmsg_terminal,
136 rxrpc_recvmsg_to_be_accepted,
140 enum rxrpc_rtt_tx_trace {
145 enum rxrpc_rtt_rx_trace {
146 rxrpc_rtt_rx_ping_response,
147 rxrpc_rtt_rx_requested_ack,
150 enum rxrpc_timer_trace {
153 rxrpc_timer_exp_hard,
154 rxrpc_timer_exp_idle,
155 rxrpc_timer_exp_keepalive,
156 rxrpc_timer_exp_lost_ack,
157 rxrpc_timer_exp_normal,
158 rxrpc_timer_exp_ping,
159 rxrpc_timer_exp_resend,
161 rxrpc_timer_init_for_reply,
162 rxrpc_timer_init_for_send_reply,
164 rxrpc_timer_set_for_ack,
165 rxrpc_timer_set_for_hard,
166 rxrpc_timer_set_for_idle,
167 rxrpc_timer_set_for_keepalive,
168 rxrpc_timer_set_for_lost_ack,
169 rxrpc_timer_set_for_normal,
170 rxrpc_timer_set_for_ping,
171 rxrpc_timer_set_for_resend,
172 rxrpc_timer_set_for_send,
175 enum rxrpc_propose_ack_trace {
176 rxrpc_propose_ack_client_tx_end,
177 rxrpc_propose_ack_input_data,
178 rxrpc_propose_ack_ping_for_check_life,
179 rxrpc_propose_ack_ping_for_keepalive,
180 rxrpc_propose_ack_ping_for_lost_ack,
181 rxrpc_propose_ack_ping_for_lost_reply,
182 rxrpc_propose_ack_ping_for_params,
183 rxrpc_propose_ack_processing_op,
184 rxrpc_propose_ack_respond_to_ack,
185 rxrpc_propose_ack_respond_to_ping,
186 rxrpc_propose_ack_retry_tx,
187 rxrpc_propose_ack_rotate_rx,
188 rxrpc_propose_ack_terminal_ack,
191 enum rxrpc_propose_ack_outcome {
192 rxrpc_propose_ack_subsume,
193 rxrpc_propose_ack_update,
194 rxrpc_propose_ack_use,
197 enum rxrpc_congest_change {
198 rxrpc_cong_begin_retransmission,
199 rxrpc_cong_cleared_nacks,
200 rxrpc_cong_new_low_nack,
201 rxrpc_cong_no_change,
203 rxrpc_cong_retransmit_again,
204 rxrpc_cong_rtt_window_end,
208 enum rxrpc_tx_point {
209 rxrpc_tx_point_call_abort,
210 rxrpc_tx_point_call_ack,
211 rxrpc_tx_point_call_data_frag,
212 rxrpc_tx_point_call_data_nofrag,
213 rxrpc_tx_point_call_final_resend,
214 rxrpc_tx_point_conn_abort,
215 rxrpc_tx_point_rxkad_challenge,
216 rxrpc_tx_point_rxkad_response,
217 rxrpc_tx_point_reject,
218 rxrpc_tx_point_version_keepalive,
219 rxrpc_tx_point_version_reply,
222 #endif /* end __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY */
225 * Declare tracing information enums and their string mappings for display.
227 #define rxrpc_skb_traces \
228 EM(rxrpc_skb_cleaned, "CLN") \
229 EM(rxrpc_skb_freed, "FRE") \
230 EM(rxrpc_skb_got, "GOT") \
231 EM(rxrpc_skb_lost, "*L*") \
232 EM(rxrpc_skb_new, "NEW") \
233 EM(rxrpc_skb_purged, "PUR") \
234 EM(rxrpc_skb_received, "RCV") \
235 EM(rxrpc_skb_rotated, "ROT") \
236 EM(rxrpc_skb_seen, "SEE") \
237 EM(rxrpc_skb_unshared, "UNS") \
238 E_(rxrpc_skb_unshared_nomem, "US0")
240 #define rxrpc_local_traces \
241 EM(rxrpc_local_got, "GOT") \
242 EM(rxrpc_local_new, "NEW") \
243 EM(rxrpc_local_processing, "PRO") \
244 EM(rxrpc_local_put, "PUT") \
245 E_(rxrpc_local_queued, "QUE")
247 #define rxrpc_peer_traces \
248 EM(rxrpc_peer_got, "GOT") \
249 EM(rxrpc_peer_new, "NEW") \
250 EM(rxrpc_peer_processing, "PRO") \
251 E_(rxrpc_peer_put, "PUT")
253 #define rxrpc_conn_traces \
254 EM(rxrpc_conn_got, "GOT") \
255 EM(rxrpc_conn_new_client, "NWc") \
256 EM(rxrpc_conn_new_service, "NWs") \
257 EM(rxrpc_conn_put_client, "PTc") \
258 EM(rxrpc_conn_put_service, "PTs") \
259 EM(rxrpc_conn_queued, "QUE") \
260 EM(rxrpc_conn_reap_service, "RPs") \
261 E_(rxrpc_conn_seen, "SEE")
263 #define rxrpc_client_traces \
264 EM(rxrpc_client_activate_chans, "Activa") \
265 EM(rxrpc_client_alloc, "Alloc ") \
266 EM(rxrpc_client_chan_activate, "ChActv") \
267 EM(rxrpc_client_chan_disconnect, "ChDisc") \
268 EM(rxrpc_client_chan_pass, "ChPass") \
269 EM(rxrpc_client_chan_unstarted, "ChUnst") \
270 EM(rxrpc_client_chan_wait_failed, "ChWtFl") \
271 EM(rxrpc_client_cleanup, "Clean ") \
272 EM(rxrpc_client_count, "Count ") \
273 EM(rxrpc_client_discard, "Discar") \
274 EM(rxrpc_client_duplicate, "Duplic") \
275 EM(rxrpc_client_exposed, "Expose") \
276 EM(rxrpc_client_replace, "Replac") \
277 EM(rxrpc_client_to_active, "->Actv") \
278 EM(rxrpc_client_to_culled, "->Cull") \
279 EM(rxrpc_client_to_idle, "->Idle") \
280 EM(rxrpc_client_to_inactive, "->Inac") \
281 EM(rxrpc_client_to_upgrade, "->Upgd") \
282 EM(rxrpc_client_to_waiting, "->Wait") \
283 E_(rxrpc_client_uncount, "Uncoun")
285 #define rxrpc_conn_cache_states \
286 EM(RXRPC_CONN_CLIENT_INACTIVE, "Inac") \
287 EM(RXRPC_CONN_CLIENT_WAITING, "Wait") \
288 EM(RXRPC_CONN_CLIENT_ACTIVE, "Actv") \
289 EM(RXRPC_CONN_CLIENT_UPGRADE, "Upgd") \
290 EM(RXRPC_CONN_CLIENT_CULLED, "Cull") \
291 E_(RXRPC_CONN_CLIENT_IDLE, "Idle") \
293 #define rxrpc_call_traces \
294 EM(rxrpc_call_connected, "CON") \
295 EM(rxrpc_call_error, "*E*") \
296 EM(rxrpc_call_got, "GOT") \
297 EM(rxrpc_call_got_kernel, "Gke") \
298 EM(rxrpc_call_got_userid, "Gus") \
299 EM(rxrpc_call_new_client, "NWc") \
300 EM(rxrpc_call_new_service, "NWs") \
301 EM(rxrpc_call_put, "PUT") \
302 EM(rxrpc_call_put_kernel, "Pke") \
303 EM(rxrpc_call_put_noqueue, "PNQ") \
304 EM(rxrpc_call_put_userid, "Pus") \
305 EM(rxrpc_call_queued, "QUE") \
306 EM(rxrpc_call_queued_ref, "QUR") \
307 EM(rxrpc_call_release, "RLS") \
308 E_(rxrpc_call_seen, "SEE")
310 #define rxrpc_transmit_traces \
311 EM(rxrpc_transmit_await_reply, "AWR") \
312 EM(rxrpc_transmit_end, "END") \
313 EM(rxrpc_transmit_queue, "QUE") \
314 EM(rxrpc_transmit_queue_last, "QLS") \
315 EM(rxrpc_transmit_rotate, "ROT") \
316 EM(rxrpc_transmit_rotate_last, "RLS") \
317 E_(rxrpc_transmit_wait, "WAI")
319 #define rxrpc_receive_traces \
320 EM(rxrpc_receive_end, "END") \
321 EM(rxrpc_receive_front, "FRN") \
322 EM(rxrpc_receive_incoming, "INC") \
323 EM(rxrpc_receive_queue, "QUE") \
324 EM(rxrpc_receive_queue_last, "QLS") \
325 E_(rxrpc_receive_rotate, "ROT")
327 #define rxrpc_recvmsg_traces \
328 EM(rxrpc_recvmsg_cont, "CONT") \
329 EM(rxrpc_recvmsg_data_return, "DATA") \
330 EM(rxrpc_recvmsg_dequeue, "DEQU") \
331 EM(rxrpc_recvmsg_enter, "ENTR") \
332 EM(rxrpc_recvmsg_full, "FULL") \
333 EM(rxrpc_recvmsg_hole, "HOLE") \
334 EM(rxrpc_recvmsg_next, "NEXT") \
335 EM(rxrpc_recvmsg_requeue, "REQU") \
336 EM(rxrpc_recvmsg_return, "RETN") \
337 EM(rxrpc_recvmsg_terminal, "TERM") \
338 EM(rxrpc_recvmsg_to_be_accepted, "TBAC") \
339 E_(rxrpc_recvmsg_wait, "WAIT")
341 #define rxrpc_rtt_tx_traces \
342 EM(rxrpc_rtt_tx_data, "DATA") \
343 E_(rxrpc_rtt_tx_ping, "PING")
345 #define rxrpc_rtt_rx_traces \
346 EM(rxrpc_rtt_rx_ping_response, "PONG") \
347 E_(rxrpc_rtt_rx_requested_ack, "RACK")
349 #define rxrpc_timer_traces \
350 EM(rxrpc_timer_begin, "Begin ") \
351 EM(rxrpc_timer_expired, "*EXPR*") \
352 EM(rxrpc_timer_exp_ack, "ExpAck") \
353 EM(rxrpc_timer_exp_hard, "ExpHrd") \
354 EM(rxrpc_timer_exp_idle, "ExpIdl") \
355 EM(rxrpc_timer_exp_keepalive, "ExpKA ") \
356 EM(rxrpc_timer_exp_lost_ack, "ExpLoA") \
357 EM(rxrpc_timer_exp_normal, "ExpNml") \
358 EM(rxrpc_timer_exp_ping, "ExpPng") \
359 EM(rxrpc_timer_exp_resend, "ExpRsn") \
360 EM(rxrpc_timer_init_for_reply, "IniRpl") \
361 EM(rxrpc_timer_init_for_send_reply, "SndRpl") \
362 EM(rxrpc_timer_restart, "Restrt") \
363 EM(rxrpc_timer_set_for_ack, "SetAck") \
364 EM(rxrpc_timer_set_for_hard, "SetHrd") \
365 EM(rxrpc_timer_set_for_idle, "SetIdl") \
366 EM(rxrpc_timer_set_for_keepalive, "KeepAl") \
367 EM(rxrpc_timer_set_for_lost_ack, "SetLoA") \
368 EM(rxrpc_timer_set_for_normal, "SetNml") \
369 EM(rxrpc_timer_set_for_ping, "SetPng") \
370 EM(rxrpc_timer_set_for_resend, "SetRTx") \
371 E_(rxrpc_timer_set_for_send, "SetSnd")
373 #define rxrpc_propose_ack_traces \
374 EM(rxrpc_propose_ack_client_tx_end, "ClTxEnd") \
375 EM(rxrpc_propose_ack_input_data, "DataIn ") \
376 EM(rxrpc_propose_ack_ping_for_check_life, "ChkLife") \
377 EM(rxrpc_propose_ack_ping_for_keepalive, "KeepAlv") \
378 EM(rxrpc_propose_ack_ping_for_lost_ack, "LostAck") \
379 EM(rxrpc_propose_ack_ping_for_lost_reply, "LostRpl") \
380 EM(rxrpc_propose_ack_ping_for_params, "Params ") \
381 EM(rxrpc_propose_ack_processing_op, "ProcOp ") \
382 EM(rxrpc_propose_ack_respond_to_ack, "Rsp2Ack") \
383 EM(rxrpc_propose_ack_respond_to_ping, "Rsp2Png") \
384 EM(rxrpc_propose_ack_retry_tx, "RetryTx") \
385 EM(rxrpc_propose_ack_rotate_rx, "RxAck ") \
386 E_(rxrpc_propose_ack_terminal_ack, "ClTerm ")
388 #define rxrpc_propose_ack_outcomes \
389 EM(rxrpc_propose_ack_subsume, " Subsume") \
390 EM(rxrpc_propose_ack_update, " Update") \
391 E_(rxrpc_propose_ack_use, " New")
393 #define rxrpc_congest_modes \
394 EM(RXRPC_CALL_CONGEST_AVOIDANCE, "CongAvoid") \
395 EM(RXRPC_CALL_FAST_RETRANSMIT, "FastReTx ") \
396 EM(RXRPC_CALL_PACKET_LOSS, "PktLoss ") \
397 E_(RXRPC_CALL_SLOW_START, "SlowStart")
399 #define rxrpc_congest_changes \
400 EM(rxrpc_cong_begin_retransmission, " Retrans") \
401 EM(rxrpc_cong_cleared_nacks, " Cleared") \
402 EM(rxrpc_cong_new_low_nack, " NewLowN") \
403 EM(rxrpc_cong_no_change, "") \
404 EM(rxrpc_cong_progress, " Progres") \
405 EM(rxrpc_cong_retransmit_again, " ReTxAgn") \
406 EM(rxrpc_cong_rtt_window_end, " RttWinE") \
407 E_(rxrpc_cong_saw_nack, " SawNack")
411 EM(RXRPC_PACKET_TYPE_DATA, "DATA") \
412 EM(RXRPC_PACKET_TYPE_ACK, "ACK") \
413 EM(RXRPC_PACKET_TYPE_BUSY, "BUSY") \
414 EM(RXRPC_PACKET_TYPE_ABORT, "ABORT") \
415 EM(RXRPC_PACKET_TYPE_ACKALL, "ACKALL") \
416 EM(RXRPC_PACKET_TYPE_CHALLENGE, "CHALL") \
417 EM(RXRPC_PACKET_TYPE_RESPONSE, "RESP") \
418 EM(RXRPC_PACKET_TYPE_DEBUG, "DEBUG") \
423 EM(RXRPC_PACKET_TYPE_VERSION, "VERSION") \
427 #define rxrpc_ack_names \
429 EM(RXRPC_ACK_REQUESTED, "REQ") \
430 EM(RXRPC_ACK_DUPLICATE, "DUP") \
431 EM(RXRPC_ACK_OUT_OF_SEQUENCE, "OOS") \
432 EM(RXRPC_ACK_EXCEEDS_WINDOW, "WIN") \
433 EM(RXRPC_ACK_NOSPACE, "MEM") \
434 EM(RXRPC_ACK_PING, "PNG") \
435 EM(RXRPC_ACK_PING_RESPONSE, "PNR") \
436 EM(RXRPC_ACK_DELAY, "DLY") \
437 EM(RXRPC_ACK_IDLE, "IDL") \
438 E_(RXRPC_ACK__INVALID, "-?-")
440 #define rxrpc_completions \
441 EM(RXRPC_CALL_SUCCEEDED, "Succeeded") \
442 EM(RXRPC_CALL_REMOTELY_ABORTED, "RemoteAbort") \
443 EM(RXRPC_CALL_LOCALLY_ABORTED, "LocalAbort") \
444 EM(RXRPC_CALL_LOCAL_ERROR, "LocalError") \
445 E_(RXRPC_CALL_NETWORK_ERROR, "NetError")
447 #define rxrpc_tx_points \
448 EM(rxrpc_tx_point_call_abort, "CallAbort") \
449 EM(rxrpc_tx_point_call_ack, "CallAck") \
450 EM(rxrpc_tx_point_call_data_frag, "CallDataFrag") \
451 EM(rxrpc_tx_point_call_data_nofrag, "CallDataNofrag") \
452 EM(rxrpc_tx_point_call_final_resend, "CallFinalResend") \
453 EM(rxrpc_tx_point_conn_abort, "ConnAbort") \
454 EM(rxrpc_tx_point_reject, "Reject") \
455 EM(rxrpc_tx_point_rxkad_challenge, "RxkadChall") \
456 EM(rxrpc_tx_point_rxkad_response, "RxkadResp") \
457 EM(rxrpc_tx_point_version_keepalive, "VerKeepalive") \
458 E_(rxrpc_tx_point_version_reply, "VerReply")
461 * Export enum symbols via userspace.
465 #define EM(a, b) TRACE_DEFINE_ENUM(a);
466 #define E_(a, b) TRACE_DEFINE_ENUM(a);
473 rxrpc_transmit_traces;
474 rxrpc_receive_traces;
475 rxrpc_recvmsg_traces;
479 rxrpc_propose_ack_traces;
480 rxrpc_propose_ack_outcomes;
482 rxrpc_congest_changes;
486 * Now redefine the EM() and E_() macros to map the enums to the strings that
487 * will be printed in the output.
491 #define EM(a, b) { a, b },
492 #define E_(a, b) { a, b }
494 TRACE_EVENT(rxrpc_local,
495 TP_PROTO(unsigned int local_debug_id, enum rxrpc_local_trace op,
496 int usage, const void *where),
498 TP_ARGS(local_debug_id, op, usage, where),
501 __field(unsigned int, local )
504 __field(const void *, where )
508 __entry->local = local_debug_id;
510 __entry->usage = usage;
511 __entry->where = where;
514 TP_printk("L=%08x %s u=%d sp=%pSR",
516 __print_symbolic(__entry->op, rxrpc_local_traces),
521 TRACE_EVENT(rxrpc_peer,
522 TP_PROTO(struct rxrpc_peer *peer, enum rxrpc_peer_trace op,
523 int usage, const void *where),
525 TP_ARGS(peer, op, usage, where),
528 __field(unsigned int, peer )
531 __field(const void *, where )
535 __entry->peer = peer->debug_id;
537 __entry->usage = usage;
538 __entry->where = where;
541 TP_printk("P=%08x %s u=%d sp=%pSR",
543 __print_symbolic(__entry->op, rxrpc_peer_traces),
548 TRACE_EVENT(rxrpc_conn,
549 TP_PROTO(struct rxrpc_connection *conn, enum rxrpc_conn_trace op,
550 int usage, const void *where),
552 TP_ARGS(conn, op, usage, where),
555 __field(unsigned int, conn )
558 __field(const void *, where )
562 __entry->conn = conn->debug_id;
564 __entry->usage = usage;
565 __entry->where = where;
568 TP_printk("C=%08x %s u=%d sp=%pSR",
570 __print_symbolic(__entry->op, rxrpc_conn_traces),
575 TRACE_EVENT(rxrpc_client,
576 TP_PROTO(struct rxrpc_connection *conn, int channel,
577 enum rxrpc_client_trace op),
579 TP_ARGS(conn, channel, op),
582 __field(unsigned int, conn )
584 __field(int, channel )
586 __field(enum rxrpc_client_trace, op )
587 __field(enum rxrpc_conn_cache_state, cs )
591 __entry->conn = conn->debug_id;
592 __entry->channel = channel;
593 __entry->usage = atomic_read(&conn->usage);
595 __entry->cid = conn->proto.cid;
596 __entry->cs = conn->cache_state;
599 TP_printk("C=%08x h=%2d %s %s i=%08x u=%d",
602 __print_symbolic(__entry->op, rxrpc_client_traces),
603 __print_symbolic(__entry->cs, rxrpc_conn_cache_states),
608 TRACE_EVENT(rxrpc_call,
609 TP_PROTO(struct rxrpc_call *call, enum rxrpc_call_trace op,
610 int usage, const void *where, const void *aux),
612 TP_ARGS(call, op, usage, where, aux),
615 __field(unsigned int, call )
618 __field(const void *, where )
619 __field(const void *, aux )
623 __entry->call = call->debug_id;
625 __entry->usage = usage;
626 __entry->where = where;
630 TP_printk("c=%08x %s u=%d sp=%pSR a=%p",
632 __print_symbolic(__entry->op, rxrpc_call_traces),
638 TRACE_EVENT(rxrpc_skb,
639 TP_PROTO(struct sk_buff *skb, enum rxrpc_skb_trace op,
640 int usage, int mod_count, u8 flags, const void *where),
642 TP_ARGS(skb, op, usage, mod_count, flags, where),
645 __field(struct sk_buff *, skb )
646 __field(enum rxrpc_skb_trace, op )
649 __field(int, mod_count )
650 __field(const void *, where )
655 __entry->flags = flags;
657 __entry->usage = usage;
658 __entry->mod_count = mod_count;
659 __entry->where = where;
662 TP_printk("s=%p %cx %s u=%d m=%d p=%pSR",
664 __entry->flags & RXRPC_SKB_TX_BUFFER ? 'T' : 'R',
665 __print_symbolic(__entry->op, rxrpc_skb_traces),
671 TRACE_EVENT(rxrpc_rx_packet,
672 TP_PROTO(struct rxrpc_skb_priv *sp),
677 __field_struct(struct rxrpc_host_header, hdr )
681 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
684 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s",
685 __entry->hdr.epoch, __entry->hdr.cid,
686 __entry->hdr.callNumber, __entry->hdr.serviceId,
687 __entry->hdr.serial, __entry->hdr.seq,
688 __entry->hdr.type, __entry->hdr.flags,
689 __entry->hdr.type <= 15 ?
690 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
693 TRACE_EVENT(rxrpc_rx_done,
694 TP_PROTO(int result, int abort_code),
696 TP_ARGS(result, abort_code),
699 __field(int, result )
700 __field(int, abort_code )
704 __entry->result = result;
705 __entry->abort_code = abort_code;
708 TP_printk("r=%d a=%d", __entry->result, __entry->abort_code)
711 TRACE_EVENT(rxrpc_abort,
712 TP_PROTO(unsigned int call_nr, const char *why, u32 cid, u32 call_id,
713 rxrpc_seq_t seq, int abort_code, int error),
715 TP_ARGS(call_nr, why, cid, call_id, seq, abort_code, error),
718 __field(unsigned int, call_nr )
719 __array(char, why, 4 )
721 __field(u32, call_id )
722 __field(rxrpc_seq_t, seq )
723 __field(int, abort_code )
728 memcpy(__entry->why, why, 4);
729 __entry->call_nr = call_nr;
731 __entry->call_id = call_id;
732 __entry->abort_code = abort_code;
733 __entry->error = error;
737 TP_printk("c=%08x %08x:%08x s=%u a=%d e=%d %s",
739 __entry->cid, __entry->call_id, __entry->seq,
740 __entry->abort_code, __entry->error, __entry->why)
743 TRACE_EVENT(rxrpc_call_complete,
744 TP_PROTO(struct rxrpc_call *call),
749 __field(unsigned int, call )
750 __field(enum rxrpc_call_completion, compl )
752 __field(u32, abort_code )
756 __entry->call = call->debug_id;
757 __entry->compl = call->completion;
758 __entry->error = call->error;
759 __entry->abort_code = call->abort_code;
762 TP_printk("c=%08x %s r=%d ac=%d",
764 __print_symbolic(__entry->compl, rxrpc_completions),
769 TRACE_EVENT(rxrpc_transmit,
770 TP_PROTO(struct rxrpc_call *call, enum rxrpc_transmit_trace why),
775 __field(unsigned int, call )
776 __field(enum rxrpc_transmit_trace, why )
777 __field(rxrpc_seq_t, tx_hard_ack )
778 __field(rxrpc_seq_t, tx_top )
779 __field(int, tx_winsize )
783 __entry->call = call->debug_id;
785 __entry->tx_hard_ack = call->tx_hard_ack;
786 __entry->tx_top = call->tx_top;
787 __entry->tx_winsize = call->tx_winsize;
790 TP_printk("c=%08x %s f=%08x n=%u/%u",
792 __print_symbolic(__entry->why, rxrpc_transmit_traces),
793 __entry->tx_hard_ack + 1,
794 __entry->tx_top - __entry->tx_hard_ack,
798 TRACE_EVENT(rxrpc_rx_data,
799 TP_PROTO(unsigned int call, rxrpc_seq_t seq,
800 rxrpc_serial_t serial, u8 flags, u8 anno),
802 TP_ARGS(call, seq, serial, flags, anno),
805 __field(unsigned int, call )
806 __field(rxrpc_seq_t, seq )
807 __field(rxrpc_serial_t, serial )
813 __entry->call = call;
815 __entry->serial = serial;
816 __entry->flags = flags;
817 __entry->anno = anno;
820 TP_printk("c=%08x DATA %08x q=%08x fl=%02x a=%02x",
828 TRACE_EVENT(rxrpc_rx_ack,
829 TP_PROTO(struct rxrpc_call *call,
830 rxrpc_serial_t serial, rxrpc_serial_t ack_serial,
831 rxrpc_seq_t first, rxrpc_seq_t prev, u8 reason, u8 n_acks),
833 TP_ARGS(call, serial, ack_serial, first, prev, reason, n_acks),
836 __field(unsigned int, call )
837 __field(rxrpc_serial_t, serial )
838 __field(rxrpc_serial_t, ack_serial )
839 __field(rxrpc_seq_t, first )
840 __field(rxrpc_seq_t, prev )
846 __entry->call = call->debug_id;
847 __entry->serial = serial;
848 __entry->ack_serial = ack_serial;
849 __entry->first = first;
850 __entry->prev = prev;
851 __entry->reason = reason;
852 __entry->n_acks = n_acks;
855 TP_printk("c=%08x %08x %s r=%08x f=%08x p=%08x n=%u",
858 __print_symbolic(__entry->reason, rxrpc_ack_names),
865 TRACE_EVENT(rxrpc_rx_abort,
866 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
869 TP_ARGS(call, serial, abort_code),
872 __field(unsigned int, call )
873 __field(rxrpc_serial_t, serial )
874 __field(u32, abort_code )
878 __entry->call = call->debug_id;
879 __entry->serial = serial;
880 __entry->abort_code = abort_code;
883 TP_printk("c=%08x ABORT %08x ac=%d",
889 TRACE_EVENT(rxrpc_rx_rwind_change,
890 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
891 u32 rwind, bool wake),
893 TP_ARGS(call, serial, rwind, wake),
896 __field(unsigned int, call )
897 __field(rxrpc_serial_t, serial )
903 __entry->call = call->debug_id;
904 __entry->serial = serial;
905 __entry->rwind = rwind;
906 __entry->wake = wake;
909 TP_printk("c=%08x %08x rw=%u%s",
913 __entry->wake ? " wake" : "")
916 TRACE_EVENT(rxrpc_tx_packet,
917 TP_PROTO(unsigned int call_id, struct rxrpc_wire_header *whdr,
918 enum rxrpc_tx_point where),
920 TP_ARGS(call_id, whdr, where),
923 __field(unsigned int, call )
924 __field(enum rxrpc_tx_point, where )
925 __field_struct(struct rxrpc_wire_header, whdr )
929 __entry->call = call_id;
930 memcpy(&__entry->whdr, whdr, sizeof(__entry->whdr));
931 __entry->where = where;
934 TP_printk("c=%08x %08x:%08x:%08x:%04x %08x %08x %02x %02x %s %s",
936 ntohl(__entry->whdr.epoch),
937 ntohl(__entry->whdr.cid),
938 ntohl(__entry->whdr.callNumber),
939 ntohs(__entry->whdr.serviceId),
940 ntohl(__entry->whdr.serial),
941 ntohl(__entry->whdr.seq),
942 __entry->whdr.type, __entry->whdr.flags,
943 __entry->whdr.type <= 15 ?
944 __print_symbolic(__entry->whdr.type, rxrpc_pkts) : "?UNK",
945 __print_symbolic(__entry->where, rxrpc_tx_points))
948 TRACE_EVENT(rxrpc_tx_data,
949 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq,
950 rxrpc_serial_t serial, u8 flags, bool retrans, bool lose),
952 TP_ARGS(call, seq, serial, flags, retrans, lose),
955 __field(unsigned int, call )
956 __field(rxrpc_seq_t, seq )
957 __field(rxrpc_serial_t, serial )
959 __field(u32, call_id )
961 __field(bool, retrans )
966 __entry->call = call->debug_id;
967 __entry->cid = call->cid;
968 __entry->call_id = call->call_id;
970 __entry->serial = serial;
971 __entry->flags = flags;
972 __entry->retrans = retrans;
973 __entry->lose = lose;
976 TP_printk("c=%08x DATA %08x:%08x %08x q=%08x fl=%02x%s%s",
983 __entry->retrans ? " *RETRANS*" : "",
984 __entry->lose ? " *LOSE*" : "")
987 TRACE_EVENT(rxrpc_tx_ack,
988 TP_PROTO(unsigned int call, rxrpc_serial_t serial,
989 rxrpc_seq_t ack_first, rxrpc_serial_t ack_serial,
990 u8 reason, u8 n_acks),
992 TP_ARGS(call, serial, ack_first, ack_serial, reason, n_acks),
995 __field(unsigned int, call )
996 __field(rxrpc_serial_t, serial )
997 __field(rxrpc_seq_t, ack_first )
998 __field(rxrpc_serial_t, ack_serial )
1000 __field(u8, n_acks )
1004 __entry->call = call;
1005 __entry->serial = serial;
1006 __entry->ack_first = ack_first;
1007 __entry->ack_serial = ack_serial;
1008 __entry->reason = reason;
1009 __entry->n_acks = n_acks;
1012 TP_printk(" c=%08x ACK %08x %s f=%08x r=%08x n=%u",
1015 __print_symbolic(__entry->reason, rxrpc_ack_names),
1017 __entry->ack_serial,
1021 TRACE_EVENT(rxrpc_receive,
1022 TP_PROTO(struct rxrpc_call *call, enum rxrpc_receive_trace why,
1023 rxrpc_serial_t serial, rxrpc_seq_t seq),
1025 TP_ARGS(call, why, serial, seq),
1028 __field(unsigned int, call )
1029 __field(enum rxrpc_receive_trace, why )
1030 __field(rxrpc_serial_t, serial )
1031 __field(rxrpc_seq_t, seq )
1032 __field(rxrpc_seq_t, hard_ack )
1033 __field(rxrpc_seq_t, top )
1037 __entry->call = call->debug_id;
1039 __entry->serial = serial;
1041 __entry->hard_ack = call->rx_hard_ack;
1042 __entry->top = call->rx_top;
1045 TP_printk("c=%08x %s r=%08x q=%08x w=%08x-%08x",
1047 __print_symbolic(__entry->why, rxrpc_receive_traces),
1054 TRACE_EVENT(rxrpc_recvmsg,
1055 TP_PROTO(struct rxrpc_call *call, enum rxrpc_recvmsg_trace why,
1056 rxrpc_seq_t seq, unsigned int offset, unsigned int len,
1059 TP_ARGS(call, why, seq, offset, len, ret),
1062 __field(unsigned int, call )
1063 __field(enum rxrpc_recvmsg_trace, why )
1064 __field(rxrpc_seq_t, seq )
1065 __field(unsigned int, offset )
1066 __field(unsigned int, len )
1071 __entry->call = call->debug_id;
1074 __entry->offset = offset;
1079 TP_printk("c=%08x %s q=%08x o=%u l=%u ret=%d",
1081 __print_symbolic(__entry->why, rxrpc_recvmsg_traces),
1088 TRACE_EVENT(rxrpc_rtt_tx,
1089 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_tx_trace why,
1090 rxrpc_serial_t send_serial),
1092 TP_ARGS(call, why, send_serial),
1095 __field(unsigned int, call )
1096 __field(enum rxrpc_rtt_tx_trace, why )
1097 __field(rxrpc_serial_t, send_serial )
1101 __entry->call = call->debug_id;
1103 __entry->send_serial = send_serial;
1106 TP_printk("c=%08x %s sr=%08x",
1108 __print_symbolic(__entry->why, rxrpc_rtt_tx_traces),
1109 __entry->send_serial)
1112 TRACE_EVENT(rxrpc_rtt_rx,
1113 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_rx_trace why,
1114 rxrpc_serial_t send_serial, rxrpc_serial_t resp_serial,
1115 s64 rtt, u8 nr, s64 avg),
1117 TP_ARGS(call, why, send_serial, resp_serial, rtt, nr, avg),
1120 __field(unsigned int, call )
1121 __field(enum rxrpc_rtt_rx_trace, why )
1123 __field(rxrpc_serial_t, send_serial )
1124 __field(rxrpc_serial_t, resp_serial )
1130 __entry->call = call->debug_id;
1132 __entry->send_serial = send_serial;
1133 __entry->resp_serial = resp_serial;
1139 TP_printk("c=%08x %s sr=%08x rr=%08x rtt=%lld nr=%u avg=%lld",
1141 __print_symbolic(__entry->why, rxrpc_rtt_rx_traces),
1142 __entry->send_serial,
1143 __entry->resp_serial,
1149 TRACE_EVENT(rxrpc_timer,
1150 TP_PROTO(struct rxrpc_call *call, enum rxrpc_timer_trace why,
1153 TP_ARGS(call, why, now),
1156 __field(unsigned int, call )
1157 __field(enum rxrpc_timer_trace, why )
1159 __field(long, ack_at )
1160 __field(long, ack_lost_at )
1161 __field(long, resend_at )
1162 __field(long, ping_at )
1163 __field(long, expect_rx_by )
1164 __field(long, expect_req_by )
1165 __field(long, expect_term_by )
1166 __field(long, timer )
1170 __entry->call = call->debug_id;
1173 __entry->ack_at = call->ack_at;
1174 __entry->ack_lost_at = call->ack_lost_at;
1175 __entry->resend_at = call->resend_at;
1176 __entry->expect_rx_by = call->expect_rx_by;
1177 __entry->expect_req_by = call->expect_req_by;
1178 __entry->expect_term_by = call->expect_term_by;
1179 __entry->timer = call->timer.expires;
1182 TP_printk("c=%08x %s a=%ld la=%ld r=%ld xr=%ld xq=%ld xt=%ld t=%ld",
1184 __print_symbolic(__entry->why, rxrpc_timer_traces),
1185 __entry->ack_at - __entry->now,
1186 __entry->ack_lost_at - __entry->now,
1187 __entry->resend_at - __entry->now,
1188 __entry->expect_rx_by - __entry->now,
1189 __entry->expect_req_by - __entry->now,
1190 __entry->expect_term_by - __entry->now,
1191 __entry->timer - __entry->now)
1194 TRACE_EVENT(rxrpc_rx_lose,
1195 TP_PROTO(struct rxrpc_skb_priv *sp),
1200 __field_struct(struct rxrpc_host_header, hdr )
1204 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
1207 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s *LOSE*",
1208 __entry->hdr.epoch, __entry->hdr.cid,
1209 __entry->hdr.callNumber, __entry->hdr.serviceId,
1210 __entry->hdr.serial, __entry->hdr.seq,
1211 __entry->hdr.type, __entry->hdr.flags,
1212 __entry->hdr.type <= 15 ?
1213 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
1216 TRACE_EVENT(rxrpc_propose_ack,
1217 TP_PROTO(struct rxrpc_call *call, enum rxrpc_propose_ack_trace why,
1218 u8 ack_reason, rxrpc_serial_t serial, bool immediate,
1219 bool background, enum rxrpc_propose_ack_outcome outcome),
1221 TP_ARGS(call, why, ack_reason, serial, immediate, background,
1225 __field(unsigned int, call )
1226 __field(enum rxrpc_propose_ack_trace, why )
1227 __field(rxrpc_serial_t, serial )
1228 __field(u8, ack_reason )
1229 __field(bool, immediate )
1230 __field(bool, background )
1231 __field(enum rxrpc_propose_ack_outcome, outcome )
1235 __entry->call = call->debug_id;
1237 __entry->serial = serial;
1238 __entry->ack_reason = ack_reason;
1239 __entry->immediate = immediate;
1240 __entry->background = background;
1241 __entry->outcome = outcome;
1244 TP_printk("c=%08x %s %s r=%08x i=%u b=%u%s",
1246 __print_symbolic(__entry->why, rxrpc_propose_ack_traces),
1247 __print_symbolic(__entry->ack_reason, rxrpc_ack_names),
1250 __entry->background,
1251 __print_symbolic(__entry->outcome, rxrpc_propose_ack_outcomes))
1254 TRACE_EVENT(rxrpc_retransmit,
1255 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq, u8 annotation,
1258 TP_ARGS(call, seq, annotation, expiry),
1261 __field(unsigned int, call )
1262 __field(rxrpc_seq_t, seq )
1263 __field(u8, annotation )
1264 __field(s64, expiry )
1268 __entry->call = call->debug_id;
1270 __entry->annotation = annotation;
1271 __entry->expiry = expiry;
1274 TP_printk("c=%08x q=%x a=%02x xp=%lld",
1277 __entry->annotation,
1281 TRACE_EVENT(rxrpc_congest,
1282 TP_PROTO(struct rxrpc_call *call, struct rxrpc_ack_summary *summary,
1283 rxrpc_serial_t ack_serial, enum rxrpc_congest_change change),
1285 TP_ARGS(call, summary, ack_serial, change),
1288 __field(unsigned int, call )
1289 __field(enum rxrpc_congest_change, change )
1290 __field(rxrpc_seq_t, hard_ack )
1291 __field(rxrpc_seq_t, top )
1292 __field(rxrpc_seq_t, lowest_nak )
1293 __field(rxrpc_serial_t, ack_serial )
1294 __field_struct(struct rxrpc_ack_summary, sum )
1298 __entry->call = call->debug_id;
1299 __entry->change = change;
1300 __entry->hard_ack = call->tx_hard_ack;
1301 __entry->top = call->tx_top;
1302 __entry->lowest_nak = call->acks_lowest_nak;
1303 __entry->ack_serial = ack_serial;
1304 memcpy(&__entry->sum, summary, sizeof(__entry->sum));
1307 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",
1309 __entry->ack_serial,
1310 __print_symbolic(__entry->sum.ack_reason, rxrpc_ack_names),
1312 __print_symbolic(__entry->sum.mode, rxrpc_congest_modes),
1314 __entry->sum.ssthresh,
1315 __entry->sum.nr_acks, __entry->sum.nr_nacks,
1316 __entry->sum.nr_new_acks, __entry->sum.nr_new_nacks,
1317 __entry->sum.nr_rot_new_acks,
1318 __entry->top - __entry->hard_ack,
1319 __entry->sum.cumulative_acks,
1320 __entry->sum.dup_acks,
1321 __entry->lowest_nak, __entry->sum.new_low_nack ? "!" : "",
1322 __print_symbolic(__entry->change, rxrpc_congest_changes),
1323 __entry->sum.retrans_timeo ? " rTxTo" : "")
1326 TRACE_EVENT(rxrpc_disconnect_call,
1327 TP_PROTO(struct rxrpc_call *call),
1332 __field(unsigned int, call )
1333 __field(u32, abort_code )
1337 __entry->call = call->debug_id;
1338 __entry->abort_code = call->abort_code;
1341 TP_printk("c=%08x ab=%08x",
1343 __entry->abort_code)
1346 TRACE_EVENT(rxrpc_improper_term,
1347 TP_PROTO(struct rxrpc_call *call),
1352 __field(unsigned int, call )
1353 __field(u32, abort_code )
1357 __entry->call = call->debug_id;
1358 __entry->abort_code = call->abort_code;
1361 TP_printk("c=%08x ab=%08x",
1363 __entry->abort_code)
1366 TRACE_EVENT(rxrpc_rx_eproto,
1367 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
1370 TP_ARGS(call, serial, why),
1373 __field(unsigned int, call )
1374 __field(rxrpc_serial_t, serial )
1375 __field(const char *, why )
1379 __entry->call = call ? call->debug_id : 0;
1380 __entry->serial = serial;
1384 TP_printk("c=%08x EPROTO %08x %s",
1390 TRACE_EVENT(rxrpc_connect_call,
1391 TP_PROTO(struct rxrpc_call *call),
1396 __field(unsigned int, call )
1397 __field(unsigned long, user_call_ID )
1399 __field(u32, call_id )
1403 __entry->call = call->debug_id;
1404 __entry->user_call_ID = call->user_call_ID;
1405 __entry->cid = call->cid;
1406 __entry->call_id = call->call_id;
1409 TP_printk("c=%08x u=%p %08x:%08x",
1411 (void *)__entry->user_call_ID,
1416 TRACE_EVENT(rxrpc_resend,
1417 TP_PROTO(struct rxrpc_call *call, int ix),
1422 __field(unsigned int, call )
1424 __array(u8, anno, 64 )
1428 __entry->call = call->debug_id;
1430 memcpy(__entry->anno, call->rxtx_annotations, 64);
1433 TP_printk("c=%08x ix=%u a=%64phN",
1439 TRACE_EVENT(rxrpc_rx_icmp,
1440 TP_PROTO(struct rxrpc_peer *peer, struct sock_extended_err *ee,
1441 struct sockaddr_rxrpc *srx),
1443 TP_ARGS(peer, ee, srx),
1446 __field(unsigned int, peer )
1447 __field_struct(struct sock_extended_err, ee )
1448 __field_struct(struct sockaddr_rxrpc, srx )
1452 __entry->peer = peer->debug_id;
1453 memcpy(&__entry->ee, ee, sizeof(__entry->ee));
1454 memcpy(&__entry->srx, srx, sizeof(__entry->srx));
1457 TP_printk("P=%08x o=%u t=%u c=%u i=%u d=%u e=%d %pISp",
1459 __entry->ee.ee_origin,
1460 __entry->ee.ee_type,
1461 __entry->ee.ee_code,
1462 __entry->ee.ee_info,
1463 __entry->ee.ee_data,
1464 __entry->ee.ee_errno,
1465 &__entry->srx.transport)
1468 TRACE_EVENT(rxrpc_tx_fail,
1469 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial, int ret,
1470 enum rxrpc_tx_point where),
1472 TP_ARGS(debug_id, serial, ret, where),
1475 __field(unsigned int, debug_id )
1476 __field(rxrpc_serial_t, serial )
1478 __field(enum rxrpc_tx_point, where )
1482 __entry->debug_id = debug_id;
1483 __entry->serial = serial;
1485 __entry->where = where;
1488 TP_printk("c=%08x r=%x ret=%d %s",
1492 __print_symbolic(__entry->where, rxrpc_tx_points))
1495 TRACE_EVENT(rxrpc_call_reset,
1496 TP_PROTO(struct rxrpc_call *call),
1501 __field(unsigned int, debug_id )
1503 __field(u32, call_id )
1504 __field(rxrpc_serial_t, call_serial )
1505 __field(rxrpc_serial_t, conn_serial )
1506 __field(rxrpc_seq_t, tx_seq )
1507 __field(rxrpc_seq_t, rx_seq )
1511 __entry->debug_id = call->debug_id;
1512 __entry->cid = call->cid;
1513 __entry->call_id = call->call_id;
1514 __entry->call_serial = call->rx_serial;
1515 __entry->conn_serial = call->conn->hi_serial;
1516 __entry->tx_seq = call->tx_hard_ack;
1517 __entry->rx_seq = call->ackr_seen;
1520 TP_printk("c=%08x %08x:%08x r=%08x/%08x tx=%08x rx=%08x",
1522 __entry->cid, __entry->call_id,
1523 __entry->call_serial, __entry->conn_serial,
1524 __entry->tx_seq, __entry->rx_seq)
1527 TRACE_EVENT(rxrpc_notify_socket,
1528 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial),
1530 TP_ARGS(debug_id, serial),
1533 __field(unsigned int, debug_id )
1534 __field(rxrpc_serial_t, serial )
1538 __entry->debug_id = debug_id;
1539 __entry->serial = serial;
1542 TP_printk("c=%08x r=%08x",
1547 #endif /* _TRACE_RXRPC_H */
1549 /* This part must be outside protection */
1550 #include <trace/define_trace.h>