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,
86 rxrpc_call_got_userid,
87 rxrpc_call_new_client,
88 rxrpc_call_new_service,
90 rxrpc_call_put_kernel,
91 rxrpc_call_put_noqueue,
92 rxrpc_call_put_userid,
94 rxrpc_call_queued_ref,
99 enum rxrpc_transmit_trace {
100 rxrpc_transmit_await_reply,
102 rxrpc_transmit_queue,
103 rxrpc_transmit_queue_last,
104 rxrpc_transmit_rotate,
105 rxrpc_transmit_rotate_last,
109 enum rxrpc_receive_trace {
112 rxrpc_receive_incoming,
114 rxrpc_receive_queue_last,
115 rxrpc_receive_rotate,
118 enum rxrpc_recvmsg_trace {
120 rxrpc_recvmsg_data_return,
121 rxrpc_recvmsg_dequeue,
126 rxrpc_recvmsg_requeue,
127 rxrpc_recvmsg_return,
128 rxrpc_recvmsg_terminal,
129 rxrpc_recvmsg_to_be_accepted,
133 enum rxrpc_rtt_tx_trace {
136 rxrpc_rtt_tx_no_slot,
140 enum rxrpc_rtt_rx_trace {
143 rxrpc_rtt_rx_obsolete,
144 rxrpc_rtt_rx_ping_response,
145 rxrpc_rtt_rx_requested_ack,
148 enum rxrpc_timer_trace {
151 rxrpc_timer_exp_hard,
152 rxrpc_timer_exp_idle,
153 rxrpc_timer_exp_keepalive,
154 rxrpc_timer_exp_lost_ack,
155 rxrpc_timer_exp_normal,
156 rxrpc_timer_exp_ping,
157 rxrpc_timer_exp_resend,
159 rxrpc_timer_init_for_reply,
160 rxrpc_timer_init_for_send_reply,
162 rxrpc_timer_set_for_ack,
163 rxrpc_timer_set_for_hard,
164 rxrpc_timer_set_for_idle,
165 rxrpc_timer_set_for_keepalive,
166 rxrpc_timer_set_for_lost_ack,
167 rxrpc_timer_set_for_normal,
168 rxrpc_timer_set_for_ping,
169 rxrpc_timer_set_for_resend,
170 rxrpc_timer_set_for_send,
173 enum rxrpc_propose_ack_trace {
174 rxrpc_propose_ack_client_tx_end,
175 rxrpc_propose_ack_input_data,
176 rxrpc_propose_ack_ping_for_check_life,
177 rxrpc_propose_ack_ping_for_keepalive,
178 rxrpc_propose_ack_ping_for_lost_ack,
179 rxrpc_propose_ack_ping_for_lost_reply,
180 rxrpc_propose_ack_ping_for_params,
181 rxrpc_propose_ack_processing_op,
182 rxrpc_propose_ack_respond_to_ack,
183 rxrpc_propose_ack_respond_to_ping,
184 rxrpc_propose_ack_retry_tx,
185 rxrpc_propose_ack_rotate_rx,
186 rxrpc_propose_ack_terminal_ack,
189 enum rxrpc_propose_ack_outcome {
190 rxrpc_propose_ack_subsume,
191 rxrpc_propose_ack_update,
192 rxrpc_propose_ack_use,
195 enum rxrpc_congest_change {
196 rxrpc_cong_begin_retransmission,
197 rxrpc_cong_cleared_nacks,
198 rxrpc_cong_new_low_nack,
199 rxrpc_cong_no_change,
201 rxrpc_cong_retransmit_again,
202 rxrpc_cong_rtt_window_end,
206 enum rxrpc_tx_point {
207 rxrpc_tx_point_call_abort,
208 rxrpc_tx_point_call_ack,
209 rxrpc_tx_point_call_data_frag,
210 rxrpc_tx_point_call_data_nofrag,
211 rxrpc_tx_point_call_final_resend,
212 rxrpc_tx_point_conn_abort,
213 rxrpc_tx_point_rxkad_challenge,
214 rxrpc_tx_point_rxkad_response,
215 rxrpc_tx_point_reject,
216 rxrpc_tx_point_version_keepalive,
217 rxrpc_tx_point_version_reply,
220 #endif /* end __RXRPC_DECLARE_TRACE_ENUMS_ONCE_ONLY */
223 * Declare tracing information enums and their string mappings for display.
225 #define rxrpc_skb_traces \
226 EM(rxrpc_skb_cleaned, "CLN") \
227 EM(rxrpc_skb_freed, "FRE") \
228 EM(rxrpc_skb_got, "GOT") \
229 EM(rxrpc_skb_lost, "*L*") \
230 EM(rxrpc_skb_new, "NEW") \
231 EM(rxrpc_skb_purged, "PUR") \
232 EM(rxrpc_skb_received, "RCV") \
233 EM(rxrpc_skb_rotated, "ROT") \
234 EM(rxrpc_skb_seen, "SEE") \
235 EM(rxrpc_skb_unshared, "UNS") \
236 E_(rxrpc_skb_unshared_nomem, "US0")
238 #define rxrpc_local_traces \
239 EM(rxrpc_local_got, "GOT") \
240 EM(rxrpc_local_new, "NEW") \
241 EM(rxrpc_local_processing, "PRO") \
242 EM(rxrpc_local_put, "PUT") \
243 E_(rxrpc_local_queued, "QUE")
245 #define rxrpc_peer_traces \
246 EM(rxrpc_peer_got, "GOT") \
247 EM(rxrpc_peer_new, "NEW") \
248 EM(rxrpc_peer_processing, "PRO") \
249 E_(rxrpc_peer_put, "PUT")
251 #define rxrpc_conn_traces \
252 EM(rxrpc_conn_got, "GOT") \
253 EM(rxrpc_conn_new_client, "NWc") \
254 EM(rxrpc_conn_new_service, "NWs") \
255 EM(rxrpc_conn_put_client, "PTc") \
256 EM(rxrpc_conn_put_service, "PTs") \
257 EM(rxrpc_conn_queued, "QUE") \
258 EM(rxrpc_conn_reap_service, "RPs") \
259 E_(rxrpc_conn_seen, "SEE")
261 #define rxrpc_client_traces \
262 EM(rxrpc_client_activate_chans, "Activa") \
263 EM(rxrpc_client_alloc, "Alloc ") \
264 EM(rxrpc_client_chan_activate, "ChActv") \
265 EM(rxrpc_client_chan_disconnect, "ChDisc") \
266 EM(rxrpc_client_chan_pass, "ChPass") \
267 EM(rxrpc_client_chan_wait_failed, "ChWtFl") \
268 EM(rxrpc_client_cleanup, "Clean ") \
269 EM(rxrpc_client_discard, "Discar") \
270 EM(rxrpc_client_duplicate, "Duplic") \
271 EM(rxrpc_client_exposed, "Expose") \
272 EM(rxrpc_client_replace, "Replac") \
273 EM(rxrpc_client_to_active, "->Actv") \
274 E_(rxrpc_client_to_idle, "->Idle")
276 #define rxrpc_call_traces \
277 EM(rxrpc_call_connected, "CON") \
278 EM(rxrpc_call_error, "*E*") \
279 EM(rxrpc_call_got, "GOT") \
280 EM(rxrpc_call_got_kernel, "Gke") \
281 EM(rxrpc_call_got_userid, "Gus") \
282 EM(rxrpc_call_new_client, "NWc") \
283 EM(rxrpc_call_new_service, "NWs") \
284 EM(rxrpc_call_put, "PUT") \
285 EM(rxrpc_call_put_kernel, "Pke") \
286 EM(rxrpc_call_put_noqueue, "PNQ") \
287 EM(rxrpc_call_put_userid, "Pus") \
288 EM(rxrpc_call_queued, "QUE") \
289 EM(rxrpc_call_queued_ref, "QUR") \
290 EM(rxrpc_call_release, "RLS") \
291 E_(rxrpc_call_seen, "SEE")
293 #define rxrpc_transmit_traces \
294 EM(rxrpc_transmit_await_reply, "AWR") \
295 EM(rxrpc_transmit_end, "END") \
296 EM(rxrpc_transmit_queue, "QUE") \
297 EM(rxrpc_transmit_queue_last, "QLS") \
298 EM(rxrpc_transmit_rotate, "ROT") \
299 EM(rxrpc_transmit_rotate_last, "RLS") \
300 E_(rxrpc_transmit_wait, "WAI")
302 #define rxrpc_receive_traces \
303 EM(rxrpc_receive_end, "END") \
304 EM(rxrpc_receive_front, "FRN") \
305 EM(rxrpc_receive_incoming, "INC") \
306 EM(rxrpc_receive_queue, "QUE") \
307 EM(rxrpc_receive_queue_last, "QLS") \
308 E_(rxrpc_receive_rotate, "ROT")
310 #define rxrpc_recvmsg_traces \
311 EM(rxrpc_recvmsg_cont, "CONT") \
312 EM(rxrpc_recvmsg_data_return, "DATA") \
313 EM(rxrpc_recvmsg_dequeue, "DEQU") \
314 EM(rxrpc_recvmsg_enter, "ENTR") \
315 EM(rxrpc_recvmsg_full, "FULL") \
316 EM(rxrpc_recvmsg_hole, "HOLE") \
317 EM(rxrpc_recvmsg_next, "NEXT") \
318 EM(rxrpc_recvmsg_requeue, "REQU") \
319 EM(rxrpc_recvmsg_return, "RETN") \
320 EM(rxrpc_recvmsg_terminal, "TERM") \
321 EM(rxrpc_recvmsg_to_be_accepted, "TBAC") \
322 E_(rxrpc_recvmsg_wait, "WAIT")
324 #define rxrpc_rtt_tx_traces \
325 EM(rxrpc_rtt_tx_cancel, "CNCE") \
326 EM(rxrpc_rtt_tx_data, "DATA") \
327 EM(rxrpc_rtt_tx_no_slot, "FULL") \
328 E_(rxrpc_rtt_tx_ping, "PING")
330 #define rxrpc_rtt_rx_traces \
331 EM(rxrpc_rtt_rx_cancel, "CNCL") \
332 EM(rxrpc_rtt_rx_obsolete, "OBSL") \
333 EM(rxrpc_rtt_rx_lost, "LOST") \
334 EM(rxrpc_rtt_rx_ping_response, "PONG") \
335 E_(rxrpc_rtt_rx_requested_ack, "RACK")
337 #define rxrpc_timer_traces \
338 EM(rxrpc_timer_begin, "Begin ") \
339 EM(rxrpc_timer_expired, "*EXPR*") \
340 EM(rxrpc_timer_exp_ack, "ExpAck") \
341 EM(rxrpc_timer_exp_hard, "ExpHrd") \
342 EM(rxrpc_timer_exp_idle, "ExpIdl") \
343 EM(rxrpc_timer_exp_keepalive, "ExpKA ") \
344 EM(rxrpc_timer_exp_lost_ack, "ExpLoA") \
345 EM(rxrpc_timer_exp_normal, "ExpNml") \
346 EM(rxrpc_timer_exp_ping, "ExpPng") \
347 EM(rxrpc_timer_exp_resend, "ExpRsn") \
348 EM(rxrpc_timer_init_for_reply, "IniRpl") \
349 EM(rxrpc_timer_init_for_send_reply, "SndRpl") \
350 EM(rxrpc_timer_restart, "Restrt") \
351 EM(rxrpc_timer_set_for_ack, "SetAck") \
352 EM(rxrpc_timer_set_for_hard, "SetHrd") \
353 EM(rxrpc_timer_set_for_idle, "SetIdl") \
354 EM(rxrpc_timer_set_for_keepalive, "KeepAl") \
355 EM(rxrpc_timer_set_for_lost_ack, "SetLoA") \
356 EM(rxrpc_timer_set_for_normal, "SetNml") \
357 EM(rxrpc_timer_set_for_ping, "SetPng") \
358 EM(rxrpc_timer_set_for_resend, "SetRTx") \
359 E_(rxrpc_timer_set_for_send, "SetSnd")
361 #define rxrpc_propose_ack_traces \
362 EM(rxrpc_propose_ack_client_tx_end, "ClTxEnd") \
363 EM(rxrpc_propose_ack_input_data, "DataIn ") \
364 EM(rxrpc_propose_ack_ping_for_check_life, "ChkLife") \
365 EM(rxrpc_propose_ack_ping_for_keepalive, "KeepAlv") \
366 EM(rxrpc_propose_ack_ping_for_lost_ack, "LostAck") \
367 EM(rxrpc_propose_ack_ping_for_lost_reply, "LostRpl") \
368 EM(rxrpc_propose_ack_ping_for_params, "Params ") \
369 EM(rxrpc_propose_ack_processing_op, "ProcOp ") \
370 EM(rxrpc_propose_ack_respond_to_ack, "Rsp2Ack") \
371 EM(rxrpc_propose_ack_respond_to_ping, "Rsp2Png") \
372 EM(rxrpc_propose_ack_retry_tx, "RetryTx") \
373 EM(rxrpc_propose_ack_rotate_rx, "RxAck ") \
374 E_(rxrpc_propose_ack_terminal_ack, "ClTerm ")
376 #define rxrpc_propose_ack_outcomes \
377 EM(rxrpc_propose_ack_subsume, " Subsume") \
378 EM(rxrpc_propose_ack_update, " Update") \
379 E_(rxrpc_propose_ack_use, " New")
381 #define rxrpc_congest_modes \
382 EM(RXRPC_CALL_CONGEST_AVOIDANCE, "CongAvoid") \
383 EM(RXRPC_CALL_FAST_RETRANSMIT, "FastReTx ") \
384 EM(RXRPC_CALL_PACKET_LOSS, "PktLoss ") \
385 E_(RXRPC_CALL_SLOW_START, "SlowStart")
387 #define rxrpc_congest_changes \
388 EM(rxrpc_cong_begin_retransmission, " Retrans") \
389 EM(rxrpc_cong_cleared_nacks, " Cleared") \
390 EM(rxrpc_cong_new_low_nack, " NewLowN") \
391 EM(rxrpc_cong_no_change, " -") \
392 EM(rxrpc_cong_progress, " Progres") \
393 EM(rxrpc_cong_retransmit_again, " ReTxAgn") \
394 EM(rxrpc_cong_rtt_window_end, " RttWinE") \
395 E_(rxrpc_cong_saw_nack, " SawNack")
399 EM(RXRPC_PACKET_TYPE_DATA, "DATA") \
400 EM(RXRPC_PACKET_TYPE_ACK, "ACK") \
401 EM(RXRPC_PACKET_TYPE_BUSY, "BUSY") \
402 EM(RXRPC_PACKET_TYPE_ABORT, "ABORT") \
403 EM(RXRPC_PACKET_TYPE_ACKALL, "ACKALL") \
404 EM(RXRPC_PACKET_TYPE_CHALLENGE, "CHALL") \
405 EM(RXRPC_PACKET_TYPE_RESPONSE, "RESP") \
406 EM(RXRPC_PACKET_TYPE_DEBUG, "DEBUG") \
411 EM(RXRPC_PACKET_TYPE_VERSION, "VERSION") \
415 #define rxrpc_ack_names \
417 EM(RXRPC_ACK_REQUESTED, "REQ") \
418 EM(RXRPC_ACK_DUPLICATE, "DUP") \
419 EM(RXRPC_ACK_OUT_OF_SEQUENCE, "OOS") \
420 EM(RXRPC_ACK_EXCEEDS_WINDOW, "WIN") \
421 EM(RXRPC_ACK_NOSPACE, "MEM") \
422 EM(RXRPC_ACK_PING, "PNG") \
423 EM(RXRPC_ACK_PING_RESPONSE, "PNR") \
424 EM(RXRPC_ACK_DELAY, "DLY") \
425 EM(RXRPC_ACK_IDLE, "IDL") \
426 E_(RXRPC_ACK__INVALID, "-?-")
428 #define rxrpc_completions \
429 EM(RXRPC_CALL_SUCCEEDED, "Succeeded") \
430 EM(RXRPC_CALL_REMOTELY_ABORTED, "RemoteAbort") \
431 EM(RXRPC_CALL_LOCALLY_ABORTED, "LocalAbort") \
432 EM(RXRPC_CALL_LOCAL_ERROR, "LocalError") \
433 E_(RXRPC_CALL_NETWORK_ERROR, "NetError")
435 #define rxrpc_tx_points \
436 EM(rxrpc_tx_point_call_abort, "CallAbort") \
437 EM(rxrpc_tx_point_call_ack, "CallAck") \
438 EM(rxrpc_tx_point_call_data_frag, "CallDataFrag") \
439 EM(rxrpc_tx_point_call_data_nofrag, "CallDataNofrag") \
440 EM(rxrpc_tx_point_call_final_resend, "CallFinalResend") \
441 EM(rxrpc_tx_point_conn_abort, "ConnAbort") \
442 EM(rxrpc_tx_point_reject, "Reject") \
443 EM(rxrpc_tx_point_rxkad_challenge, "RxkadChall") \
444 EM(rxrpc_tx_point_rxkad_response, "RxkadResp") \
445 EM(rxrpc_tx_point_version_keepalive, "VerKeepalive") \
446 E_(rxrpc_tx_point_version_reply, "VerReply")
449 * Export enum symbols via userspace.
453 #define EM(a, b) TRACE_DEFINE_ENUM(a);
454 #define E_(a, b) TRACE_DEFINE_ENUM(a);
461 rxrpc_transmit_traces;
462 rxrpc_receive_traces;
463 rxrpc_recvmsg_traces;
467 rxrpc_propose_ack_traces;
468 rxrpc_propose_ack_outcomes;
470 rxrpc_congest_changes;
474 * Now redefine the EM() and E_() macros to map the enums to the strings that
475 * will be printed in the output.
479 #define EM(a, b) { a, b },
480 #define E_(a, b) { a, b }
482 TRACE_EVENT(rxrpc_local,
483 TP_PROTO(unsigned int local_debug_id, enum rxrpc_local_trace op,
484 int usage, const void *where),
486 TP_ARGS(local_debug_id, op, usage, where),
489 __field(unsigned int, local )
492 __field(const void *, where )
496 __entry->local = local_debug_id;
498 __entry->usage = usage;
499 __entry->where = where;
502 TP_printk("L=%08x %s u=%d sp=%pSR",
504 __print_symbolic(__entry->op, rxrpc_local_traces),
509 TRACE_EVENT(rxrpc_peer,
510 TP_PROTO(unsigned int peer_debug_id, enum rxrpc_peer_trace op,
511 int usage, const void *where),
513 TP_ARGS(peer_debug_id, op, usage, where),
516 __field(unsigned int, peer )
519 __field(const void *, where )
523 __entry->peer = peer_debug_id;
525 __entry->usage = usage;
526 __entry->where = where;
529 TP_printk("P=%08x %s u=%d sp=%pSR",
531 __print_symbolic(__entry->op, rxrpc_peer_traces),
536 TRACE_EVENT(rxrpc_conn,
537 TP_PROTO(unsigned int conn_debug_id, enum rxrpc_conn_trace op,
538 int usage, const void *where),
540 TP_ARGS(conn_debug_id, op, usage, where),
543 __field(unsigned int, conn )
546 __field(const void *, where )
550 __entry->conn = conn_debug_id;
552 __entry->usage = usage;
553 __entry->where = where;
556 TP_printk("C=%08x %s u=%d sp=%pSR",
558 __print_symbolic(__entry->op, rxrpc_conn_traces),
563 TRACE_EVENT(rxrpc_client,
564 TP_PROTO(struct rxrpc_connection *conn, int channel,
565 enum rxrpc_client_trace op),
567 TP_ARGS(conn, channel, op),
570 __field(unsigned int, conn )
572 __field(int, channel )
574 __field(enum rxrpc_client_trace, op )
578 __entry->conn = conn ? conn->debug_id : 0;
579 __entry->channel = channel;
580 __entry->usage = conn ? atomic_read(&conn->usage) : -2;
582 __entry->cid = conn ? conn->proto.cid : 0;
585 TP_printk("C=%08x h=%2d %s i=%08x u=%d",
588 __print_symbolic(__entry->op, rxrpc_client_traces),
593 TRACE_EVENT(rxrpc_call,
594 TP_PROTO(unsigned int call_debug_id, enum rxrpc_call_trace op,
595 int usage, const void *where, const void *aux),
597 TP_ARGS(call_debug_id, op, usage, where, aux),
600 __field(unsigned int, call )
603 __field(const void *, where )
604 __field(const void *, aux )
608 __entry->call = call_debug_id;
610 __entry->usage = usage;
611 __entry->where = where;
615 TP_printk("c=%08x %s u=%d sp=%pSR a=%p",
617 __print_symbolic(__entry->op, rxrpc_call_traces),
623 TRACE_EVENT(rxrpc_skb,
624 TP_PROTO(struct sk_buff *skb, enum rxrpc_skb_trace op,
625 int usage, int mod_count, u8 flags, const void *where),
627 TP_ARGS(skb, op, usage, mod_count, flags, where),
630 __field(struct sk_buff *, skb )
631 __field(enum rxrpc_skb_trace, op )
634 __field(int, mod_count )
635 __field(const void *, where )
640 __entry->flags = flags;
642 __entry->usage = usage;
643 __entry->mod_count = mod_count;
644 __entry->where = where;
647 TP_printk("s=%p %cx %s u=%d m=%d p=%pSR",
649 __entry->flags & RXRPC_SKB_TX_BUFFER ? 'T' : 'R',
650 __print_symbolic(__entry->op, rxrpc_skb_traces),
656 TRACE_EVENT(rxrpc_rx_packet,
657 TP_PROTO(struct rxrpc_skb_priv *sp),
662 __field_struct(struct rxrpc_host_header, hdr )
666 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
669 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s",
670 __entry->hdr.epoch, __entry->hdr.cid,
671 __entry->hdr.callNumber, __entry->hdr.serviceId,
672 __entry->hdr.serial, __entry->hdr.seq,
673 __entry->hdr.type, __entry->hdr.flags,
674 __entry->hdr.type <= 15 ?
675 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
678 TRACE_EVENT(rxrpc_rx_done,
679 TP_PROTO(int result, int abort_code),
681 TP_ARGS(result, abort_code),
684 __field(int, result )
685 __field(int, abort_code )
689 __entry->result = result;
690 __entry->abort_code = abort_code;
693 TP_printk("r=%d a=%d", __entry->result, __entry->abort_code)
696 TRACE_EVENT(rxrpc_abort,
697 TP_PROTO(unsigned int call_nr, const char *why, u32 cid, u32 call_id,
698 rxrpc_seq_t seq, int abort_code, int error),
700 TP_ARGS(call_nr, why, cid, call_id, seq, abort_code, error),
703 __field(unsigned int, call_nr )
704 __array(char, why, 4 )
706 __field(u32, call_id )
707 __field(rxrpc_seq_t, seq )
708 __field(int, abort_code )
713 memcpy(__entry->why, why, 4);
714 __entry->call_nr = call_nr;
716 __entry->call_id = call_id;
717 __entry->abort_code = abort_code;
718 __entry->error = error;
722 TP_printk("c=%08x %08x:%08x s=%u a=%d e=%d %s",
724 __entry->cid, __entry->call_id, __entry->seq,
725 __entry->abort_code, __entry->error, __entry->why)
728 TRACE_EVENT(rxrpc_call_complete,
729 TP_PROTO(struct rxrpc_call *call),
734 __field(unsigned int, call )
735 __field(enum rxrpc_call_completion, compl )
737 __field(u32, abort_code )
741 __entry->call = call->debug_id;
742 __entry->compl = call->completion;
743 __entry->error = call->error;
744 __entry->abort_code = call->abort_code;
747 TP_printk("c=%08x %s r=%d ac=%d",
749 __print_symbolic(__entry->compl, rxrpc_completions),
754 TRACE_EVENT(rxrpc_transmit,
755 TP_PROTO(struct rxrpc_call *call, enum rxrpc_transmit_trace why),
760 __field(unsigned int, call )
761 __field(enum rxrpc_transmit_trace, why )
762 __field(rxrpc_seq_t, tx_hard_ack )
763 __field(rxrpc_seq_t, tx_top )
764 __field(int, tx_winsize )
768 __entry->call = call->debug_id;
770 __entry->tx_hard_ack = call->tx_hard_ack;
771 __entry->tx_top = call->tx_top;
772 __entry->tx_winsize = call->tx_winsize;
775 TP_printk("c=%08x %s f=%08x n=%u/%u",
777 __print_symbolic(__entry->why, rxrpc_transmit_traces),
778 __entry->tx_hard_ack + 1,
779 __entry->tx_top - __entry->tx_hard_ack,
783 TRACE_EVENT(rxrpc_rx_data,
784 TP_PROTO(unsigned int call, rxrpc_seq_t seq,
785 rxrpc_serial_t serial, u8 flags, u8 anno),
787 TP_ARGS(call, seq, serial, flags, anno),
790 __field(unsigned int, call )
791 __field(rxrpc_seq_t, seq )
792 __field(rxrpc_serial_t, serial )
798 __entry->call = call;
800 __entry->serial = serial;
801 __entry->flags = flags;
802 __entry->anno = anno;
805 TP_printk("c=%08x DATA %08x q=%08x fl=%02x a=%02x",
813 TRACE_EVENT(rxrpc_rx_ack,
814 TP_PROTO(struct rxrpc_call *call,
815 rxrpc_serial_t serial, rxrpc_serial_t ack_serial,
816 rxrpc_seq_t first, rxrpc_seq_t prev, u8 reason, u8 n_acks),
818 TP_ARGS(call, serial, ack_serial, first, prev, reason, n_acks),
821 __field(unsigned int, call )
822 __field(rxrpc_serial_t, serial )
823 __field(rxrpc_serial_t, ack_serial )
824 __field(rxrpc_seq_t, first )
825 __field(rxrpc_seq_t, prev )
831 __entry->call = call->debug_id;
832 __entry->serial = serial;
833 __entry->ack_serial = ack_serial;
834 __entry->first = first;
835 __entry->prev = prev;
836 __entry->reason = reason;
837 __entry->n_acks = n_acks;
840 TP_printk("c=%08x %08x %s r=%08x f=%08x p=%08x n=%u",
843 __print_symbolic(__entry->reason, rxrpc_ack_names),
850 TRACE_EVENT(rxrpc_rx_abort,
851 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
854 TP_ARGS(call, serial, abort_code),
857 __field(unsigned int, call )
858 __field(rxrpc_serial_t, serial )
859 __field(u32, abort_code )
863 __entry->call = call->debug_id;
864 __entry->serial = serial;
865 __entry->abort_code = abort_code;
868 TP_printk("c=%08x ABORT %08x ac=%d",
874 TRACE_EVENT(rxrpc_rx_rwind_change,
875 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
876 u32 rwind, bool wake),
878 TP_ARGS(call, serial, rwind, wake),
881 __field(unsigned int, call )
882 __field(rxrpc_serial_t, serial )
888 __entry->call = call->debug_id;
889 __entry->serial = serial;
890 __entry->rwind = rwind;
891 __entry->wake = wake;
894 TP_printk("c=%08x %08x rw=%u%s",
898 __entry->wake ? " wake" : "")
901 TRACE_EVENT(rxrpc_tx_packet,
902 TP_PROTO(unsigned int call_id, struct rxrpc_wire_header *whdr,
903 enum rxrpc_tx_point where),
905 TP_ARGS(call_id, whdr, where),
908 __field(unsigned int, call )
909 __field(enum rxrpc_tx_point, where )
910 __field_struct(struct rxrpc_wire_header, whdr )
914 __entry->call = call_id;
915 memcpy(&__entry->whdr, whdr, sizeof(__entry->whdr));
916 __entry->where = where;
919 TP_printk("c=%08x %08x:%08x:%08x:%04x %08x %08x %02x %02x %s %s",
921 ntohl(__entry->whdr.epoch),
922 ntohl(__entry->whdr.cid),
923 ntohl(__entry->whdr.callNumber),
924 ntohs(__entry->whdr.serviceId),
925 ntohl(__entry->whdr.serial),
926 ntohl(__entry->whdr.seq),
927 __entry->whdr.type, __entry->whdr.flags,
928 __entry->whdr.type <= 15 ?
929 __print_symbolic(__entry->whdr.type, rxrpc_pkts) : "?UNK",
930 __print_symbolic(__entry->where, rxrpc_tx_points))
933 TRACE_EVENT(rxrpc_tx_data,
934 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq,
935 rxrpc_serial_t serial, u8 flags, bool retrans, bool lose),
937 TP_ARGS(call, seq, serial, flags, retrans, lose),
940 __field(unsigned int, call )
941 __field(rxrpc_seq_t, seq )
942 __field(rxrpc_serial_t, serial )
944 __field(u32, call_id )
946 __field(bool, retrans )
951 __entry->call = call->debug_id;
952 __entry->cid = call->cid;
953 __entry->call_id = call->call_id;
955 __entry->serial = serial;
956 __entry->flags = flags;
957 __entry->retrans = retrans;
958 __entry->lose = lose;
961 TP_printk("c=%08x DATA %08x:%08x %08x q=%08x fl=%02x%s%s",
968 __entry->retrans ? " *RETRANS*" : "",
969 __entry->lose ? " *LOSE*" : "")
972 TRACE_EVENT(rxrpc_tx_ack,
973 TP_PROTO(unsigned int call, rxrpc_serial_t serial,
974 rxrpc_seq_t ack_first, rxrpc_serial_t ack_serial,
975 u8 reason, u8 n_acks),
977 TP_ARGS(call, serial, ack_first, ack_serial, reason, n_acks),
980 __field(unsigned int, call )
981 __field(rxrpc_serial_t, serial )
982 __field(rxrpc_seq_t, ack_first )
983 __field(rxrpc_serial_t, ack_serial )
989 __entry->call = call;
990 __entry->serial = serial;
991 __entry->ack_first = ack_first;
992 __entry->ack_serial = ack_serial;
993 __entry->reason = reason;
994 __entry->n_acks = n_acks;
997 TP_printk(" c=%08x ACK %08x %s f=%08x r=%08x n=%u",
1000 __print_symbolic(__entry->reason, rxrpc_ack_names),
1002 __entry->ack_serial,
1006 TRACE_EVENT(rxrpc_receive,
1007 TP_PROTO(struct rxrpc_call *call, enum rxrpc_receive_trace why,
1008 rxrpc_serial_t serial, rxrpc_seq_t seq),
1010 TP_ARGS(call, why, serial, seq),
1013 __field(unsigned int, call )
1014 __field(enum rxrpc_receive_trace, why )
1015 __field(rxrpc_serial_t, serial )
1016 __field(rxrpc_seq_t, seq )
1017 __field(rxrpc_seq_t, hard_ack )
1018 __field(rxrpc_seq_t, top )
1022 __entry->call = call->debug_id;
1024 __entry->serial = serial;
1026 __entry->hard_ack = call->rx_hard_ack;
1027 __entry->top = call->rx_top;
1030 TP_printk("c=%08x %s r=%08x q=%08x w=%08x-%08x",
1032 __print_symbolic(__entry->why, rxrpc_receive_traces),
1039 TRACE_EVENT(rxrpc_recvmsg,
1040 TP_PROTO(struct rxrpc_call *call, enum rxrpc_recvmsg_trace why,
1041 rxrpc_seq_t seq, unsigned int offset, unsigned int len,
1044 TP_ARGS(call, why, seq, offset, len, ret),
1047 __field(unsigned int, call )
1048 __field(enum rxrpc_recvmsg_trace, why )
1049 __field(rxrpc_seq_t, seq )
1050 __field(unsigned int, offset )
1051 __field(unsigned int, len )
1056 __entry->call = call ? call->debug_id : 0;
1059 __entry->offset = offset;
1064 TP_printk("c=%08x %s q=%08x o=%u l=%u ret=%d",
1066 __print_symbolic(__entry->why, rxrpc_recvmsg_traces),
1073 TRACE_EVENT(rxrpc_rtt_tx,
1074 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_tx_trace why,
1075 int slot, rxrpc_serial_t send_serial),
1077 TP_ARGS(call, why, slot, send_serial),
1080 __field(unsigned int, call )
1081 __field(enum rxrpc_rtt_tx_trace, why )
1083 __field(rxrpc_serial_t, send_serial )
1087 __entry->call = call->debug_id;
1089 __entry->slot = slot;
1090 __entry->send_serial = send_serial;
1093 TP_printk("c=%08x [%d] %s sr=%08x",
1096 __print_symbolic(__entry->why, rxrpc_rtt_tx_traces),
1097 __entry->send_serial)
1100 TRACE_EVENT(rxrpc_rtt_rx,
1101 TP_PROTO(struct rxrpc_call *call, enum rxrpc_rtt_rx_trace why,
1103 rxrpc_serial_t send_serial, rxrpc_serial_t resp_serial,
1106 TP_ARGS(call, why, slot, send_serial, resp_serial, rtt, rto),
1109 __field(unsigned int, call )
1110 __field(enum rxrpc_rtt_rx_trace, why )
1112 __field(rxrpc_serial_t, send_serial )
1113 __field(rxrpc_serial_t, resp_serial )
1119 __entry->call = call->debug_id;
1121 __entry->slot = slot;
1122 __entry->send_serial = send_serial;
1123 __entry->resp_serial = resp_serial;
1128 TP_printk("c=%08x [%d] %s sr=%08x rr=%08x rtt=%u rto=%u",
1131 __print_symbolic(__entry->why, rxrpc_rtt_rx_traces),
1132 __entry->send_serial,
1133 __entry->resp_serial,
1138 TRACE_EVENT(rxrpc_timer,
1139 TP_PROTO(struct rxrpc_call *call, enum rxrpc_timer_trace why,
1142 TP_ARGS(call, why, now),
1145 __field(unsigned int, call )
1146 __field(enum rxrpc_timer_trace, why )
1148 __field(long, ack_at )
1149 __field(long, ack_lost_at )
1150 __field(long, resend_at )
1151 __field(long, ping_at )
1152 __field(long, expect_rx_by )
1153 __field(long, expect_req_by )
1154 __field(long, expect_term_by )
1155 __field(long, timer )
1159 __entry->call = call->debug_id;
1162 __entry->ack_at = call->ack_at;
1163 __entry->ack_lost_at = call->ack_lost_at;
1164 __entry->resend_at = call->resend_at;
1165 __entry->expect_rx_by = call->expect_rx_by;
1166 __entry->expect_req_by = call->expect_req_by;
1167 __entry->expect_term_by = call->expect_term_by;
1168 __entry->timer = call->timer.expires;
1171 TP_printk("c=%08x %s a=%ld la=%ld r=%ld xr=%ld xq=%ld xt=%ld t=%ld",
1173 __print_symbolic(__entry->why, rxrpc_timer_traces),
1174 __entry->ack_at - __entry->now,
1175 __entry->ack_lost_at - __entry->now,
1176 __entry->resend_at - __entry->now,
1177 __entry->expect_rx_by - __entry->now,
1178 __entry->expect_req_by - __entry->now,
1179 __entry->expect_term_by - __entry->now,
1180 __entry->timer - __entry->now)
1183 TRACE_EVENT(rxrpc_rx_lose,
1184 TP_PROTO(struct rxrpc_skb_priv *sp),
1189 __field_struct(struct rxrpc_host_header, hdr )
1193 memcpy(&__entry->hdr, &sp->hdr, sizeof(__entry->hdr));
1196 TP_printk("%08x:%08x:%08x:%04x %08x %08x %02x %02x %s *LOSE*",
1197 __entry->hdr.epoch, __entry->hdr.cid,
1198 __entry->hdr.callNumber, __entry->hdr.serviceId,
1199 __entry->hdr.serial, __entry->hdr.seq,
1200 __entry->hdr.type, __entry->hdr.flags,
1201 __entry->hdr.type <= 15 ?
1202 __print_symbolic(__entry->hdr.type, rxrpc_pkts) : "?UNK")
1205 TRACE_EVENT(rxrpc_propose_ack,
1206 TP_PROTO(struct rxrpc_call *call, enum rxrpc_propose_ack_trace why,
1207 u8 ack_reason, rxrpc_serial_t serial, bool immediate,
1208 bool background, enum rxrpc_propose_ack_outcome outcome),
1210 TP_ARGS(call, why, ack_reason, serial, immediate, background,
1214 __field(unsigned int, call )
1215 __field(enum rxrpc_propose_ack_trace, why )
1216 __field(rxrpc_serial_t, serial )
1217 __field(u8, ack_reason )
1218 __field(bool, immediate )
1219 __field(bool, background )
1220 __field(enum rxrpc_propose_ack_outcome, outcome )
1224 __entry->call = call->debug_id;
1226 __entry->serial = serial;
1227 __entry->ack_reason = ack_reason;
1228 __entry->immediate = immediate;
1229 __entry->background = background;
1230 __entry->outcome = outcome;
1233 TP_printk("c=%08x %s %s r=%08x i=%u b=%u%s",
1235 __print_symbolic(__entry->why, rxrpc_propose_ack_traces),
1236 __print_symbolic(__entry->ack_reason, rxrpc_ack_names),
1239 __entry->background,
1240 __print_symbolic(__entry->outcome, rxrpc_propose_ack_outcomes))
1243 TRACE_EVENT(rxrpc_retransmit,
1244 TP_PROTO(struct rxrpc_call *call, rxrpc_seq_t seq, u8 annotation,
1247 TP_ARGS(call, seq, annotation, expiry),
1250 __field(unsigned int, call )
1251 __field(rxrpc_seq_t, seq )
1252 __field(u8, annotation )
1253 __field(s64, expiry )
1257 __entry->call = call->debug_id;
1259 __entry->annotation = annotation;
1260 __entry->expiry = expiry;
1263 TP_printk("c=%08x q=%x a=%02x xp=%lld",
1266 __entry->annotation,
1270 TRACE_EVENT(rxrpc_congest,
1271 TP_PROTO(struct rxrpc_call *call, struct rxrpc_ack_summary *summary,
1272 rxrpc_serial_t ack_serial, enum rxrpc_congest_change change),
1274 TP_ARGS(call, summary, ack_serial, change),
1277 __field(unsigned int, call )
1278 __field(enum rxrpc_congest_change, change )
1279 __field(rxrpc_seq_t, hard_ack )
1280 __field(rxrpc_seq_t, top )
1281 __field(rxrpc_seq_t, lowest_nak )
1282 __field(rxrpc_serial_t, ack_serial )
1283 __field_struct(struct rxrpc_ack_summary, sum )
1287 __entry->call = call->debug_id;
1288 __entry->change = change;
1289 __entry->hard_ack = call->tx_hard_ack;
1290 __entry->top = call->tx_top;
1291 __entry->lowest_nak = call->acks_lowest_nak;
1292 __entry->ack_serial = ack_serial;
1293 memcpy(&__entry->sum, summary, sizeof(__entry->sum));
1296 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",
1298 __entry->ack_serial,
1299 __print_symbolic(__entry->sum.ack_reason, rxrpc_ack_names),
1301 __print_symbolic(__entry->sum.mode, rxrpc_congest_modes),
1303 __entry->sum.ssthresh,
1304 __entry->sum.nr_acks, __entry->sum.nr_nacks,
1305 __entry->sum.nr_new_acks, __entry->sum.nr_new_nacks,
1306 __entry->sum.nr_rot_new_acks,
1307 __entry->top - __entry->hard_ack,
1308 __entry->sum.cumulative_acks,
1309 __entry->sum.dup_acks,
1310 __entry->lowest_nak, __entry->sum.new_low_nack ? "!" : "",
1311 __print_symbolic(__entry->change, rxrpc_congest_changes),
1312 __entry->sum.retrans_timeo ? " rTxTo" : "")
1315 TRACE_EVENT(rxrpc_disconnect_call,
1316 TP_PROTO(struct rxrpc_call *call),
1321 __field(unsigned int, call )
1322 __field(u32, abort_code )
1326 __entry->call = call->debug_id;
1327 __entry->abort_code = call->abort_code;
1330 TP_printk("c=%08x ab=%08x",
1332 __entry->abort_code)
1335 TRACE_EVENT(rxrpc_improper_term,
1336 TP_PROTO(struct rxrpc_call *call),
1341 __field(unsigned int, call )
1342 __field(u32, abort_code )
1346 __entry->call = call->debug_id;
1347 __entry->abort_code = call->abort_code;
1350 TP_printk("c=%08x ab=%08x",
1352 __entry->abort_code)
1355 TRACE_EVENT(rxrpc_rx_eproto,
1356 TP_PROTO(struct rxrpc_call *call, rxrpc_serial_t serial,
1359 TP_ARGS(call, serial, why),
1362 __field(unsigned int, call )
1363 __field(rxrpc_serial_t, serial )
1364 __field(const char *, why )
1368 __entry->call = call ? call->debug_id : 0;
1369 __entry->serial = serial;
1373 TP_printk("c=%08x EPROTO %08x %s",
1379 TRACE_EVENT(rxrpc_connect_call,
1380 TP_PROTO(struct rxrpc_call *call),
1385 __field(unsigned int, call )
1386 __field(unsigned long, user_call_ID )
1388 __field(u32, call_id )
1392 __entry->call = call->debug_id;
1393 __entry->user_call_ID = call->user_call_ID;
1394 __entry->cid = call->cid;
1395 __entry->call_id = call->call_id;
1398 TP_printk("c=%08x u=%p %08x:%08x",
1400 (void *)__entry->user_call_ID,
1405 TRACE_EVENT(rxrpc_resend,
1406 TP_PROTO(struct rxrpc_call *call, int ix),
1411 __field(unsigned int, call )
1413 __array(u8, anno, 64 )
1417 __entry->call = call->debug_id;
1419 memcpy(__entry->anno, call->rxtx_annotations, 64);
1422 TP_printk("c=%08x ix=%u a=%64phN",
1428 TRACE_EVENT(rxrpc_rx_icmp,
1429 TP_PROTO(struct rxrpc_peer *peer, struct sock_extended_err *ee,
1430 struct sockaddr_rxrpc *srx),
1432 TP_ARGS(peer, ee, srx),
1435 __field(unsigned int, peer )
1436 __field_struct(struct sock_extended_err, ee )
1437 __field_struct(struct sockaddr_rxrpc, srx )
1441 __entry->peer = peer->debug_id;
1442 memcpy(&__entry->ee, ee, sizeof(__entry->ee));
1443 memcpy(&__entry->srx, srx, sizeof(__entry->srx));
1446 TP_printk("P=%08x o=%u t=%u c=%u i=%u d=%u e=%d %pISp",
1448 __entry->ee.ee_origin,
1449 __entry->ee.ee_type,
1450 __entry->ee.ee_code,
1451 __entry->ee.ee_info,
1452 __entry->ee.ee_data,
1453 __entry->ee.ee_errno,
1454 &__entry->srx.transport)
1457 TRACE_EVENT(rxrpc_tx_fail,
1458 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial, int ret,
1459 enum rxrpc_tx_point where),
1461 TP_ARGS(debug_id, serial, ret, where),
1464 __field(unsigned int, debug_id )
1465 __field(rxrpc_serial_t, serial )
1467 __field(enum rxrpc_tx_point, where )
1471 __entry->debug_id = debug_id;
1472 __entry->serial = serial;
1474 __entry->where = where;
1477 TP_printk("c=%08x r=%x ret=%d %s",
1481 __print_symbolic(__entry->where, rxrpc_tx_points))
1484 TRACE_EVENT(rxrpc_call_reset,
1485 TP_PROTO(struct rxrpc_call *call),
1490 __field(unsigned int, debug_id )
1492 __field(u32, call_id )
1493 __field(rxrpc_serial_t, call_serial )
1494 __field(rxrpc_serial_t, conn_serial )
1495 __field(rxrpc_seq_t, tx_seq )
1496 __field(rxrpc_seq_t, rx_seq )
1500 __entry->debug_id = call->debug_id;
1501 __entry->cid = call->cid;
1502 __entry->call_id = call->call_id;
1503 __entry->call_serial = call->rx_serial;
1504 __entry->conn_serial = call->conn->hi_serial;
1505 __entry->tx_seq = call->tx_hard_ack;
1506 __entry->rx_seq = call->ackr_seen;
1509 TP_printk("c=%08x %08x:%08x r=%08x/%08x tx=%08x rx=%08x",
1511 __entry->cid, __entry->call_id,
1512 __entry->call_serial, __entry->conn_serial,
1513 __entry->tx_seq, __entry->rx_seq)
1516 TRACE_EVENT(rxrpc_notify_socket,
1517 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial),
1519 TP_ARGS(debug_id, serial),
1522 __field(unsigned int, debug_id )
1523 __field(rxrpc_serial_t, serial )
1527 __entry->debug_id = debug_id;
1528 __entry->serial = serial;
1531 TP_printk("c=%08x r=%08x",
1536 TRACE_EVENT(rxrpc_rx_discard_ack,
1537 TP_PROTO(unsigned int debug_id, rxrpc_serial_t serial,
1538 rxrpc_seq_t first_soft_ack, rxrpc_seq_t call_ackr_first,
1539 rxrpc_seq_t prev_pkt, rxrpc_seq_t call_ackr_prev),
1541 TP_ARGS(debug_id, serial, first_soft_ack, call_ackr_first,
1542 prev_pkt, call_ackr_prev),
1545 __field(unsigned int, debug_id )
1546 __field(rxrpc_serial_t, serial )
1547 __field(rxrpc_seq_t, first_soft_ack)
1548 __field(rxrpc_seq_t, call_ackr_first)
1549 __field(rxrpc_seq_t, prev_pkt)
1550 __field(rxrpc_seq_t, call_ackr_prev)
1554 __entry->debug_id = debug_id;
1555 __entry->serial = serial;
1556 __entry->first_soft_ack = first_soft_ack;
1557 __entry->call_ackr_first = call_ackr_first;
1558 __entry->prev_pkt = prev_pkt;
1559 __entry->call_ackr_prev = call_ackr_prev;
1562 TP_printk("c=%08x r=%08x %08x<%08x %08x<%08x",
1565 __entry->first_soft_ack,
1566 __entry->call_ackr_first,
1568 __entry->call_ackr_prev)
1571 #endif /* _TRACE_RXRPC_H */
1573 /* This part must be outside protection */
1574 #include <trace/define_trace.h>