1/* SPDX-License-Identifier: GPL-2.0 */
   2/*
   3 * Copyright (c) 2017, 2018 Oracle.  All rights reserved.
   4 *
   5 * Trace point definitions for the "rpcrdma" subsystem.
   6 */
   7#undef TRACE_SYSTEM
   8#define TRACE_SYSTEM rpcrdma
   9
  10#if !defined(_TRACE_RPCRDMA_H) || defined(TRACE_HEADER_MULTI_READ)
  11#define _TRACE_RPCRDMA_H
  12
  13#include <linux/scatterlist.h>
  14#include <linux/sunrpc/rpc_rdma_cid.h>
  15#include <linux/tracepoint.h>
  16#include <trace/events/rdma.h>
 
 
 
  17
  18/**
  19 ** Event classes
  20 **/
  21
  22DECLARE_EVENT_CLASS(rpcrdma_completion_class,
  23	TP_PROTO(
  24		const struct ib_wc *wc,
  25		const struct rpc_rdma_cid *cid
  26	),
  27
  28	TP_ARGS(wc, cid),
  29
  30	TP_STRUCT__entry(
  31		__field(u32, cq_id)
  32		__field(int, completion_id)
  33		__field(unsigned long, status)
  34		__field(unsigned int, vendor_err)
  35	),
  36
  37	TP_fast_assign(
  38		__entry->cq_id = cid->ci_queue_id;
  39		__entry->completion_id = cid->ci_completion_id;
  40		__entry->status = wc->status;
  41		if (wc->status)
  42			__entry->vendor_err = wc->vendor_err;
  43		else
  44			__entry->vendor_err = 0;
  45	),
  46
  47	TP_printk("cq.id=%u cid=%d status=%s (%lu/0x%x)",
  48		__entry->cq_id, __entry->completion_id,
  49		rdma_show_wc_status(__entry->status),
  50		__entry->status, __entry->vendor_err
  51	)
  52);
  53
  54#define DEFINE_COMPLETION_EVENT(name)					\
  55		DEFINE_EVENT(rpcrdma_completion_class, name,		\
  56				TP_PROTO(				\
  57					const struct ib_wc *wc,		\
  58					const struct rpc_rdma_cid *cid	\
  59				),					\
  60				TP_ARGS(wc, cid))
  61
  62DECLARE_EVENT_CLASS(xprtrdma_reply_event,
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
  63	TP_PROTO(
  64		const struct rpcrdma_rep *rep
  65	),
  66
  67	TP_ARGS(rep),
  68
  69	TP_STRUCT__entry(
  70		__field(const void *, rep)
  71		__field(const void *, r_xprt)
  72		__field(u32, xid)
  73		__field(u32, version)
  74		__field(u32, proc)
 
 
  75	),
  76
  77	TP_fast_assign(
  78		__entry->rep = rep;
  79		__entry->r_xprt = rep->rr_rxprt;
  80		__entry->xid = be32_to_cpu(rep->rr_xid);
  81		__entry->version = be32_to_cpu(rep->rr_vers);
  82		__entry->proc = be32_to_cpu(rep->rr_proc);
 
 
  83	),
  84
  85	TP_printk("rxprt %p xid=0x%08x rep=%p: version %u proc %u",
  86		__entry->r_xprt, __entry->xid, __entry->rep,
  87		__entry->version, __entry->proc
  88	)
  89);
  90
  91#define DEFINE_REPLY_EVENT(name)					\
  92		DEFINE_EVENT(xprtrdma_reply_event, name,		\
 
  93				TP_PROTO(				\
  94					const struct rpcrdma_rep *rep	\
  95				),					\
  96				TP_ARGS(rep))
  97
  98DECLARE_EVENT_CLASS(xprtrdma_rxprt,
  99	TP_PROTO(
 100		const struct rpcrdma_xprt *r_xprt
 101	),
 102
 103	TP_ARGS(r_xprt),
 104
 105	TP_STRUCT__entry(
 106		__field(const void *, r_xprt)
 107		__string(addr, rpcrdma_addrstr(r_xprt))
 108		__string(port, rpcrdma_portstr(r_xprt))
 109	),
 110
 111	TP_fast_assign(
 112		__entry->r_xprt = r_xprt;
 113		__assign_str(addr, rpcrdma_addrstr(r_xprt));
 114		__assign_str(port, rpcrdma_portstr(r_xprt));
 115	),
 116
 117	TP_printk("peer=[%s]:%s r_xprt=%p",
 118		__get_str(addr), __get_str(port), __entry->r_xprt
 119	)
 120);
 121
 122#define DEFINE_RXPRT_EVENT(name)					\
 123		DEFINE_EVENT(xprtrdma_rxprt, name,			\
 124				TP_PROTO(				\
 125					const struct rpcrdma_xprt *r_xprt \
 126				),					\
 127				TP_ARGS(r_xprt))
 128
 129DECLARE_EVENT_CLASS(xprtrdma_connect_class,
 130	TP_PROTO(
 131		const struct rpcrdma_xprt *r_xprt,
 132		int rc
 133	),
 134
 135	TP_ARGS(r_xprt, rc),
 136
 137	TP_STRUCT__entry(
 138		__field(const void *, r_xprt)
 139		__field(int, rc)
 140		__field(int, connect_status)
 141		__string(addr, rpcrdma_addrstr(r_xprt))
 142		__string(port, rpcrdma_portstr(r_xprt))
 143	),
 144
 145	TP_fast_assign(
 146		__entry->r_xprt = r_xprt;
 147		__entry->rc = rc;
 148		__entry->connect_status = r_xprt->rx_ep->re_connect_status;
 149		__assign_str(addr, rpcrdma_addrstr(r_xprt));
 150		__assign_str(port, rpcrdma_portstr(r_xprt));
 151	),
 152
 153	TP_printk("peer=[%s]:%s r_xprt=%p: rc=%d connection status=%d",
 154		__get_str(addr), __get_str(port), __entry->r_xprt,
 155		__entry->rc, __entry->connect_status
 156	)
 157);
 158
 159#define DEFINE_CONN_EVENT(name)						\
 160		DEFINE_EVENT(xprtrdma_connect_class, xprtrdma_##name,	\
 161				TP_PROTO(				\
 162					const struct rpcrdma_xprt *r_xprt, \
 163					int rc				\
 164				),					\
 165				TP_ARGS(r_xprt, rc))
 166
 167DECLARE_EVENT_CLASS(xprtrdma_rdch_event,
 168	TP_PROTO(
 169		const struct rpc_task *task,
 170		unsigned int pos,
 171		struct rpcrdma_mr *mr,
 172		int nsegs
 173	),
 174
 175	TP_ARGS(task, pos, mr, nsegs),
 176
 177	TP_STRUCT__entry(
 178		__field(unsigned int, task_id)
 179		__field(unsigned int, client_id)
 180		__field(unsigned int, pos)
 181		__field(int, nents)
 182		__field(u32, handle)
 183		__field(u32, length)
 184		__field(u64, offset)
 185		__field(int, nsegs)
 186	),
 187
 188	TP_fast_assign(
 189		__entry->task_id = task->tk_pid;
 190		__entry->client_id = task->tk_client->cl_clid;
 191		__entry->pos = pos;
 192		__entry->nents = mr->mr_nents;
 193		__entry->handle = mr->mr_handle;
 194		__entry->length = mr->mr_length;
 195		__entry->offset = mr->mr_offset;
 196		__entry->nsegs = nsegs;
 197	),
 198
 199	TP_printk("task:%u@%u pos=%u %u@0x%016llx:0x%08x (%s)",
 
 200		__entry->task_id, __entry->client_id,
 201		__entry->pos, __entry->length,
 202		(unsigned long long)__entry->offset, __entry->handle,
 203		__entry->nents < __entry->nsegs ? "more" : "last"
 204	)
 205);
 206
 207#define DEFINE_RDCH_EVENT(name)						\
 208		DEFINE_EVENT(xprtrdma_rdch_event, xprtrdma_chunk_##name,\
 209				TP_PROTO(				\
 210					const struct rpc_task *task,	\
 211					unsigned int pos,		\
 212					struct rpcrdma_mr *mr,		\
 213					int nsegs			\
 214				),					\
 215				TP_ARGS(task, pos, mr, nsegs))
 216
 217DECLARE_EVENT_CLASS(xprtrdma_wrch_event,
 218	TP_PROTO(
 219		const struct rpc_task *task,
 220		struct rpcrdma_mr *mr,
 221		int nsegs
 222	),
 223
 224	TP_ARGS(task, mr, nsegs),
 225
 226	TP_STRUCT__entry(
 227		__field(unsigned int, task_id)
 228		__field(unsigned int, client_id)
 229		__field(int, nents)
 230		__field(u32, handle)
 231		__field(u32, length)
 232		__field(u64, offset)
 233		__field(int, nsegs)
 234	),
 235
 236	TP_fast_assign(
 237		__entry->task_id = task->tk_pid;
 238		__entry->client_id = task->tk_client->cl_clid;
 239		__entry->nents = mr->mr_nents;
 240		__entry->handle = mr->mr_handle;
 241		__entry->length = mr->mr_length;
 242		__entry->offset = mr->mr_offset;
 243		__entry->nsegs = nsegs;
 244	),
 245
 246	TP_printk("task:%u@%u %u@0x%016llx:0x%08x (%s)",
 
 247		__entry->task_id, __entry->client_id,
 248		__entry->length, (unsigned long long)__entry->offset,
 249		__entry->handle,
 250		__entry->nents < __entry->nsegs ? "more" : "last"
 251	)
 252);
 253
 254#define DEFINE_WRCH_EVENT(name)						\
 255		DEFINE_EVENT(xprtrdma_wrch_event, xprtrdma_chunk_##name,\
 256				TP_PROTO(				\
 257					const struct rpc_task *task,	\
 258					struct rpcrdma_mr *mr,		\
 259					int nsegs			\
 260				),					\
 261				TP_ARGS(task, mr, nsegs))
 262
 263DECLARE_EVENT_CLASS(xprtrdma_frwr_done,
 
 
 
 
 
 
 
 
 
 
 
 
 264	TP_PROTO(
 265		const struct ib_wc *wc,
 266		const struct rpcrdma_frwr *frwr
 267	),
 268
 269	TP_ARGS(wc, frwr),
 270
 271	TP_STRUCT__entry(
 
 
 272		__field(u32, mr_id)
 273		__field(unsigned int, status)
 274		__field(unsigned int, vendor_err)
 
 
 
 275	),
 276
 277	TP_fast_assign(
 278		__entry->mr_id = frwr->fr_mr->res.id;
 279		__entry->status = wc->status;
 280		__entry->vendor_err = __entry->status ? wc->vendor_err : 0;
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 281	),
 282
 283	TP_printk(
 284		"mr.id=%u: %s (%u/0x%x)",
 285		__entry->mr_id, rdma_show_wc_status(__entry->status),
 286		__entry->status, __entry->vendor_err
 
 
 287	)
 288);
 289
 290#define DEFINE_FRWR_DONE_EVENT(name)					\
 291		DEFINE_EVENT(xprtrdma_frwr_done, name,			\
 
 292				TP_PROTO(				\
 293					const struct ib_wc *wc,		\
 294					const struct rpcrdma_frwr *frwr	\
 295				),					\
 296				TP_ARGS(wc, frwr))
 297
 298TRACE_DEFINE_ENUM(DMA_BIDIRECTIONAL);
 299TRACE_DEFINE_ENUM(DMA_TO_DEVICE);
 300TRACE_DEFINE_ENUM(DMA_FROM_DEVICE);
 301TRACE_DEFINE_ENUM(DMA_NONE);
 302
 303#define xprtrdma_show_direction(x)					\
 304		__print_symbolic(x,					\
 305				{ DMA_BIDIRECTIONAL, "BIDIR" },		\
 306				{ DMA_TO_DEVICE, "TO_DEVICE" },		\
 307				{ DMA_FROM_DEVICE, "FROM_DEVICE" },	\
 308				{ DMA_NONE, "NONE" })
 309
 310DECLARE_EVENT_CLASS(xprtrdma_mr,
 311	TP_PROTO(
 312		const struct rpcrdma_mr *mr
 313	),
 314
 315	TP_ARGS(mr),
 316
 317	TP_STRUCT__entry(
 318		__field(u32, mr_id)
 319		__field(int, nents)
 320		__field(u32, handle)
 321		__field(u32, length)
 322		__field(u64, offset)
 323		__field(u32, dir)
 324	),
 325
 326	TP_fast_assign(
 327		__entry->mr_id  = mr->frwr.fr_mr->res.id;
 328		__entry->nents  = mr->mr_nents;
 329		__entry->handle = mr->mr_handle;
 330		__entry->length = mr->mr_length;
 331		__entry->offset = mr->mr_offset;
 332		__entry->dir    = mr->mr_dir;
 333	),
 334
 335	TP_printk("mr.id=%u nents=%d %u@0x%016llx:0x%08x (%s)",
 336		__entry->mr_id, __entry->nents, __entry->length,
 337		(unsigned long long)__entry->offset, __entry->handle,
 338		xprtrdma_show_direction(__entry->dir)
 339	)
 340);
 341
 342#define DEFINE_MR_EVENT(name) \
 343		DEFINE_EVENT(xprtrdma_mr, xprtrdma_mr_##name, \
 344				TP_PROTO( \
 345					const struct rpcrdma_mr *mr \
 346				), \
 
 347				TP_ARGS(mr))
 348
 349DECLARE_EVENT_CLASS(xprtrdma_cb_event,
 350	TP_PROTO(
 
 351		const struct rpc_rqst *rqst
 352	),
 353
 354	TP_ARGS(rqst),
 355
 356	TP_STRUCT__entry(
 357		__field(const void *, rqst)
 358		__field(const void *, rep)
 359		__field(const void *, req)
 360		__field(u32, xid)
 
 
 361	),
 362
 363	TP_fast_assign(
 364		__entry->rqst = rqst;
 365		__entry->req = rpcr_to_rdmar(rqst);
 366		__entry->rep = rpcr_to_rdmar(rqst)->rl_reply;
 367		__entry->xid = be32_to_cpu(rqst->rq_xid);
 
 
 368	),
 369
 370	TP_printk("xid=0x%08x, rqst=%p req=%p rep=%p",
 371		__entry->xid, __entry->rqst, __entry->req, __entry->rep
 372	)
 373);
 374
 375#define DEFINE_CB_EVENT(name)						\
 376		DEFINE_EVENT(xprtrdma_cb_event, name,			\
 
 377				TP_PROTO(				\
 
 378					const struct rpc_rqst *rqst	\
 379				),					\
 380				TP_ARGS(rqst))
 381
 382/**
 383 ** Connection events
 384 **/
 385
 386TRACE_EVENT(xprtrdma_inline_thresh,
 387	TP_PROTO(
 388		const struct rpcrdma_ep *ep
 389	),
 390
 391	TP_ARGS(ep),
 392
 393	TP_STRUCT__entry(
 394		__field(unsigned int, inline_send)
 395		__field(unsigned int, inline_recv)
 396		__field(unsigned int, max_send)
 397		__field(unsigned int, max_recv)
 398		__array(unsigned char, srcaddr, sizeof(struct sockaddr_in6))
 399		__array(unsigned char, dstaddr, sizeof(struct sockaddr_in6))
 400	),
 401
 402	TP_fast_assign(
 403		const struct rdma_cm_id *id = ep->re_id;
 404
 405		__entry->inline_send = ep->re_inline_send;
 406		__entry->inline_recv = ep->re_inline_recv;
 407		__entry->max_send = ep->re_max_inline_send;
 408		__entry->max_recv = ep->re_max_inline_recv;
 409		memcpy(__entry->srcaddr, &id->route.addr.src_addr,
 410		       sizeof(struct sockaddr_in6));
 411		memcpy(__entry->dstaddr, &id->route.addr.dst_addr,
 412		       sizeof(struct sockaddr_in6));
 413	),
 414
 415	TP_printk("%pISpc -> %pISpc neg send/recv=%u/%u, calc send/recv=%u/%u",
 416		__entry->srcaddr, __entry->dstaddr,
 417		__entry->inline_send, __entry->inline_recv,
 418		__entry->max_send, __entry->max_recv
 419	)
 420);
 421
 422DEFINE_CONN_EVENT(connect);
 423DEFINE_CONN_EVENT(disconnect);
 424
 425DEFINE_RXPRT_EVENT(xprtrdma_op_inject_dsc);
 426DEFINE_RXPRT_EVENT(xprtrdma_op_setport);
 427
 428TRACE_EVENT(xprtrdma_op_connect,
 429	TP_PROTO(
 430		const struct rpcrdma_xprt *r_xprt,
 431		unsigned long delay
 432	),
 433
 434	TP_ARGS(r_xprt, delay),
 435
 436	TP_STRUCT__entry(
 437		__field(const void *, r_xprt)
 438		__field(unsigned long, delay)
 439		__string(addr, rpcrdma_addrstr(r_xprt))
 440		__string(port, rpcrdma_portstr(r_xprt))
 441	),
 442
 443	TP_fast_assign(
 444		__entry->r_xprt = r_xprt;
 445		__entry->delay = delay;
 446		__assign_str(addr, rpcrdma_addrstr(r_xprt));
 447		__assign_str(port, rpcrdma_portstr(r_xprt));
 448	),
 449
 450	TP_printk("peer=[%s]:%s r_xprt=%p delay=%lu",
 451		__get_str(addr), __get_str(port), __entry->r_xprt,
 452		__entry->delay
 453	)
 454);
 455
 456
 457TRACE_EVENT(xprtrdma_op_set_cto,
 458	TP_PROTO(
 459		const struct rpcrdma_xprt *r_xprt,
 460		unsigned long connect,
 461		unsigned long reconnect
 462	),
 463
 464	TP_ARGS(r_xprt, connect, reconnect),
 465
 466	TP_STRUCT__entry(
 467		__field(const void *, r_xprt)
 468		__field(unsigned long, connect)
 469		__field(unsigned long, reconnect)
 470		__string(addr, rpcrdma_addrstr(r_xprt))
 471		__string(port, rpcrdma_portstr(r_xprt))
 472	),
 473
 474	TP_fast_assign(
 475		__entry->r_xprt = r_xprt;
 476		__entry->connect = connect;
 477		__entry->reconnect = reconnect;
 478		__assign_str(addr, rpcrdma_addrstr(r_xprt));
 479		__assign_str(port, rpcrdma_portstr(r_xprt));
 480	),
 481
 482	TP_printk("peer=[%s]:%s r_xprt=%p: connect=%lu reconnect=%lu",
 483		__get_str(addr), __get_str(port), __entry->r_xprt,
 484		__entry->connect / HZ, __entry->reconnect / HZ
 485	)
 486);
 487
 488TRACE_EVENT(xprtrdma_qp_event,
 489	TP_PROTO(
 490		const struct rpcrdma_ep *ep,
 491		const struct ib_event *event
 492	),
 493
 494	TP_ARGS(ep, event),
 495
 496	TP_STRUCT__entry(
 497		__field(unsigned long, event)
 498		__string(name, event->device->name)
 499		__array(unsigned char, srcaddr, sizeof(struct sockaddr_in6))
 500		__array(unsigned char, dstaddr, sizeof(struct sockaddr_in6))
 501	),
 502
 503	TP_fast_assign(
 504		const struct rdma_cm_id *id = ep->re_id;
 505
 506		__entry->event = event->event;
 507		__assign_str(name, event->device->name);
 508		memcpy(__entry->srcaddr, &id->route.addr.src_addr,
 509		       sizeof(struct sockaddr_in6));
 510		memcpy(__entry->dstaddr, &id->route.addr.dst_addr,
 511		       sizeof(struct sockaddr_in6));
 512	),
 513
 514	TP_printk("%pISpc -> %pISpc device=%s %s (%lu)",
 515		__entry->srcaddr, __entry->dstaddr, __get_str(name),
 516		rdma_show_ib_event(__entry->event), __entry->event
 517	)
 518);
 519
 520/**
 521 ** Call events
 522 **/
 523
 524TRACE_EVENT(xprtrdma_createmrs,
 525	TP_PROTO(
 526		const struct rpcrdma_xprt *r_xprt,
 527		unsigned int count
 528	),
 529
 530	TP_ARGS(r_xprt, count),
 531
 532	TP_STRUCT__entry(
 533		__field(const void *, r_xprt)
 534		__string(addr, rpcrdma_addrstr(r_xprt))
 535		__string(port, rpcrdma_portstr(r_xprt))
 536		__field(unsigned int, count)
 537	),
 538
 539	TP_fast_assign(
 540		__entry->r_xprt = r_xprt;
 541		__entry->count = count;
 542		__assign_str(addr, rpcrdma_addrstr(r_xprt));
 543		__assign_str(port, rpcrdma_portstr(r_xprt));
 544	),
 545
 546	TP_printk("peer=[%s]:%s r_xprt=%p: created %u MRs",
 547		__get_str(addr), __get_str(port), __entry->r_xprt,
 548		__entry->count
 549	)
 550);
 551
 552TRACE_EVENT(xprtrdma_mr_get,
 553	TP_PROTO(
 554		const struct rpcrdma_req *req
 555	),
 556
 557	TP_ARGS(req),
 558
 559	TP_STRUCT__entry(
 560		__field(const void *, req)
 561		__field(unsigned int, task_id)
 562		__field(unsigned int, client_id)
 563		__field(u32, xid)
 564	),
 565
 566	TP_fast_assign(
 567		const struct rpc_rqst *rqst = &req->rl_slot;
 568
 569		__entry->req = req;
 570		__entry->task_id = rqst->rq_task->tk_pid;
 571		__entry->client_id = rqst->rq_task->tk_client->cl_clid;
 572		__entry->xid = be32_to_cpu(rqst->rq_xid);
 573	),
 574
 575	TP_printk("task:%u@%u xid=0x%08x req=%p",
 576		__entry->task_id, __entry->client_id, __entry->xid,
 577		__entry->req
 578	)
 579);
 580
 581TRACE_EVENT(xprtrdma_nomrs,
 582	TP_PROTO(
 
 583		const struct rpcrdma_req *req
 584	),
 585
 586	TP_ARGS(req),
 587
 588	TP_STRUCT__entry(
 589		__field(const void *, req)
 590		__field(unsigned int, task_id)
 591		__field(unsigned int, client_id)
 592		__field(u32, xid)
 
 593	),
 594
 595	TP_fast_assign(
 596		const struct rpc_rqst *rqst = &req->rl_slot;
 597
 598		__entry->req = req;
 599		__entry->task_id = rqst->rq_task->tk_pid;
 600		__entry->client_id = rqst->rq_task->tk_client->cl_clid;
 601		__entry->xid = be32_to_cpu(rqst->rq_xid);
 
 602	),
 603
 604	TP_printk("task:%u@%u xid=0x%08x req=%p",
 605		__entry->task_id, __entry->client_id, __entry->xid,
 606		__entry->req
 607	)
 608);
 609
 610DEFINE_RDCH_EVENT(read);
 611DEFINE_WRCH_EVENT(write);
 612DEFINE_WRCH_EVENT(reply);
 
 613
 614TRACE_DEFINE_ENUM(rpcrdma_noch);
 615TRACE_DEFINE_ENUM(rpcrdma_noch_pullup);
 616TRACE_DEFINE_ENUM(rpcrdma_noch_mapped);
 617TRACE_DEFINE_ENUM(rpcrdma_readch);
 618TRACE_DEFINE_ENUM(rpcrdma_areadch);
 619TRACE_DEFINE_ENUM(rpcrdma_writech);
 620TRACE_DEFINE_ENUM(rpcrdma_replych);
 621
 622#define xprtrdma_show_chunktype(x)					\
 623		__print_symbolic(x,					\
 624				{ rpcrdma_noch, "inline" },		\
 625				{ rpcrdma_noch_pullup, "pullup" },	\
 626				{ rpcrdma_noch_mapped, "mapped" },	\
 627				{ rpcrdma_readch, "read list" },	\
 628				{ rpcrdma_areadch, "*read list" },	\
 629				{ rpcrdma_writech, "write list" },	\
 630				{ rpcrdma_replych, "reply chunk" })
 631
 632TRACE_EVENT(xprtrdma_marshal,
 633	TP_PROTO(
 634		const struct rpcrdma_req *req,
 635		unsigned int rtype,
 636		unsigned int wtype
 637	),
 638
 639	TP_ARGS(req, rtype, wtype),
 640
 641	TP_STRUCT__entry(
 642		__field(unsigned int, task_id)
 643		__field(unsigned int, client_id)
 644		__field(u32, xid)
 645		__field(unsigned int, hdrlen)
 646		__field(unsigned int, headlen)
 647		__field(unsigned int, pagelen)
 648		__field(unsigned int, taillen)
 649		__field(unsigned int, rtype)
 650		__field(unsigned int, wtype)
 651	),
 652
 653	TP_fast_assign(
 654		const struct rpc_rqst *rqst = &req->rl_slot;
 655
 656		__entry->task_id = rqst->rq_task->tk_pid;
 657		__entry->client_id = rqst->rq_task->tk_client->cl_clid;
 658		__entry->xid = be32_to_cpu(rqst->rq_xid);
 659		__entry->hdrlen = req->rl_hdrbuf.len;
 660		__entry->headlen = rqst->rq_snd_buf.head[0].iov_len;
 661		__entry->pagelen = rqst->rq_snd_buf.page_len;
 662		__entry->taillen = rqst->rq_snd_buf.tail[0].iov_len;
 663		__entry->rtype = rtype;
 664		__entry->wtype = wtype;
 665	),
 666
 667	TP_printk("task:%u@%u xid=0x%08x: hdr=%u xdr=%u/%u/%u %s/%s",
 
 668		__entry->task_id, __entry->client_id, __entry->xid,
 669		__entry->hdrlen,
 670		__entry->headlen, __entry->pagelen, __entry->taillen,
 671		xprtrdma_show_chunktype(__entry->rtype),
 672		xprtrdma_show_chunktype(__entry->wtype)
 673	)
 674);
 675
 676TRACE_EVENT(xprtrdma_marshal_failed,
 677	TP_PROTO(const struct rpc_rqst *rqst,
 678		 int ret
 679	),
 680
 681	TP_ARGS(rqst, ret),
 682
 683	TP_STRUCT__entry(
 684		__field(unsigned int, task_id)
 685		__field(unsigned int, client_id)
 686		__field(u32, xid)
 687		__field(int, ret)
 688	),
 689
 690	TP_fast_assign(
 691		__entry->task_id = rqst->rq_task->tk_pid;
 692		__entry->client_id = rqst->rq_task->tk_client->cl_clid;
 693		__entry->xid = be32_to_cpu(rqst->rq_xid);
 694		__entry->ret = ret;
 695	),
 696
 697	TP_printk("task:%u@%u xid=0x%08x: ret=%d",
 698		__entry->task_id, __entry->client_id, __entry->xid,
 699		__entry->ret
 700	)
 701);
 702
 703TRACE_EVENT(xprtrdma_prepsend_failed,
 704	TP_PROTO(const struct rpc_rqst *rqst,
 705		 int ret
 706	),
 707
 708	TP_ARGS(rqst, ret),
 709
 710	TP_STRUCT__entry(
 711		__field(unsigned int, task_id)
 712		__field(unsigned int, client_id)
 713		__field(u32, xid)
 714		__field(int, ret)
 715	),
 716
 717	TP_fast_assign(
 718		__entry->task_id = rqst->rq_task->tk_pid;
 719		__entry->client_id = rqst->rq_task->tk_client->cl_clid;
 720		__entry->xid = be32_to_cpu(rqst->rq_xid);
 721		__entry->ret = ret;
 722	),
 723
 724	TP_printk("task:%u@%u xid=0x%08x: ret=%d",
 725		__entry->task_id, __entry->client_id, __entry->xid,
 726		__entry->ret
 727	)
 728);
 729
 730TRACE_EVENT(xprtrdma_post_send,
 731	TP_PROTO(
 732		const struct rpcrdma_req *req
 733	),
 734
 735	TP_ARGS(req),
 736
 737	TP_STRUCT__entry(
 738		__field(const void *, req)
 739		__field(const void *, sc)
 740		__field(unsigned int, task_id)
 741		__field(unsigned int, client_id)
 742		__field(int, num_sge)
 743		__field(int, signaled)
 744	),
 745
 746	TP_fast_assign(
 747		const struct rpc_rqst *rqst = &req->rl_slot;
 
 748
 
 
 749		__entry->task_id = rqst->rq_task->tk_pid;
 750		__entry->client_id = rqst->rq_task->tk_client ?
 751				     rqst->rq_task->tk_client->cl_clid : -1;
 752		__entry->req = req;
 753		__entry->sc = req->rl_sendctx;
 754		__entry->num_sge = req->rl_wr.num_sge;
 755		__entry->signaled = req->rl_wr.send_flags & IB_SEND_SIGNALED;
 756	),
 757
 758	TP_printk("task:%u@%u req=%p sc=%p (%d SGE%s) %s",
 759		__entry->task_id, __entry->client_id,
 760		__entry->req, __entry->sc, __entry->num_sge,
 761		(__entry->num_sge == 1 ? "" : "s"),
 762		(__entry->signaled ? "signaled" : "")
 763	)
 764);
 765
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 766TRACE_EVENT(xprtrdma_post_recv,
 767	TP_PROTO(
 768		const struct rpcrdma_rep *rep
 769	),
 770
 771	TP_ARGS(rep),
 772
 773	TP_STRUCT__entry(
 774		__field(const void *, rep)
 
 775	),
 776
 777	TP_fast_assign(
 778		__entry->rep = rep;
 
 779	),
 780
 781	TP_printk("rep=%p",
 782		__entry->rep
 783	)
 784);
 785
 786TRACE_EVENT(xprtrdma_post_recvs,
 787	TP_PROTO(
 788		const struct rpcrdma_xprt *r_xprt,
 789		unsigned int count,
 790		int status
 791	),
 792
 793	TP_ARGS(r_xprt, count, status),
 794
 795	TP_STRUCT__entry(
 796		__field(const void *, r_xprt)
 797		__field(unsigned int, count)
 798		__field(int, status)
 799		__field(int, posted)
 800		__string(addr, rpcrdma_addrstr(r_xprt))
 801		__string(port, rpcrdma_portstr(r_xprt))
 802	),
 803
 804	TP_fast_assign(
 805		__entry->r_xprt = r_xprt;
 
 
 806		__entry->count = count;
 807		__entry->status = status;
 808		__entry->posted = r_xprt->rx_ep->re_receive_count;
 809		__assign_str(addr, rpcrdma_addrstr(r_xprt));
 810		__assign_str(port, rpcrdma_portstr(r_xprt));
 811	),
 812
 813	TP_printk("peer=[%s]:%s r_xprt=%p: %u new recvs, %d active (rc %d)",
 814		__get_str(addr), __get_str(port), __entry->r_xprt,
 815		__entry->count, __entry->posted, __entry->status
 816	)
 817);
 818
 819TRACE_EVENT(xprtrdma_post_linv,
 820	TP_PROTO(
 821		const struct rpcrdma_req *req,
 822		int status
 823	),
 824
 825	TP_ARGS(req, status),
 826
 827	TP_STRUCT__entry(
 828		__field(const void *, req)
 829		__field(int, status)
 830		__field(u32, xid)
 
 831	),
 832
 833	TP_fast_assign(
 834		__entry->req = req;
 
 
 835		__entry->status = status;
 836		__entry->xid = be32_to_cpu(req->rl_slot.rq_xid);
 
 837	),
 838
 839	TP_printk("req=%p xid=0x%08x status=%d",
 840		__entry->req, __entry->xid, __entry->status
 
 841	)
 842);
 843
 844/**
 845 ** Completion events
 846 **/
 847
 848TRACE_EVENT(xprtrdma_wc_send,
 849	TP_PROTO(
 850		const struct rpcrdma_sendctx *sc,
 851		const struct ib_wc *wc
 852	),
 853
 854	TP_ARGS(sc, wc),
 855
 856	TP_STRUCT__entry(
 857		__field(const void *, req)
 858		__field(const void *, sc)
 859		__field(unsigned int, unmap_count)
 860		__field(unsigned int, status)
 861		__field(unsigned int, vendor_err)
 862	),
 863
 864	TP_fast_assign(
 865		__entry->req = sc->sc_req;
 866		__entry->sc = sc;
 867		__entry->unmap_count = sc->sc_unmap_count;
 868		__entry->status = wc->status;
 869		__entry->vendor_err = __entry->status ? wc->vendor_err : 0;
 870	),
 871
 872	TP_printk("req=%p sc=%p unmapped=%u: %s (%u/0x%x)",
 873		__entry->req, __entry->sc, __entry->unmap_count,
 874		rdma_show_wc_status(__entry->status),
 875		__entry->status, __entry->vendor_err
 876	)
 877);
 878
 879TRACE_EVENT(xprtrdma_wc_receive,
 880	TP_PROTO(
 881		const struct ib_wc *wc
 882	),
 883
 884	TP_ARGS(wc),
 885
 886	TP_STRUCT__entry(
 887		__field(const void *, rep)
 888		__field(u32, byte_len)
 889		__field(unsigned int, status)
 890		__field(u32, vendor_err)
 891	),
 892
 893	TP_fast_assign(
 894		__entry->rep = container_of(wc->wr_cqe, struct rpcrdma_rep,
 895					    rr_cqe);
 896		__entry->status = wc->status;
 897		if (wc->status) {
 898			__entry->byte_len = 0;
 899			__entry->vendor_err = wc->vendor_err;
 900		} else {
 901			__entry->byte_len = wc->byte_len;
 902			__entry->vendor_err = 0;
 903		}
 904	),
 905
 906	TP_printk("rep=%p %u bytes: %s (%u/0x%x)",
 907		__entry->rep, __entry->byte_len,
 908		rdma_show_wc_status(__entry->status),
 909		__entry->status, __entry->vendor_err
 910	)
 911);
 912
 913DEFINE_FRWR_DONE_EVENT(xprtrdma_wc_fastreg);
 914DEFINE_FRWR_DONE_EVENT(xprtrdma_wc_li);
 915DEFINE_FRWR_DONE_EVENT(xprtrdma_wc_li_wake);
 916DEFINE_FRWR_DONE_EVENT(xprtrdma_wc_li_done);
 
 917
 918TRACE_EVENT(xprtrdma_frwr_alloc,
 919	TP_PROTO(
 920		const struct rpcrdma_mr *mr,
 921		int rc
 922	),
 923
 924	TP_ARGS(mr, rc),
 925
 926	TP_STRUCT__entry(
 927		__field(u32, mr_id)
 928		__field(int, rc)
 929	),
 930
 931	TP_fast_assign(
 932		__entry->mr_id = mr->frwr.fr_mr->res.id;
 933		__entry->rc = rc;
 934	),
 935
 936	TP_printk("mr.id=%u: rc=%d",
 937		__entry->mr_id, __entry->rc
 938	)
 939);
 940
 941TRACE_EVENT(xprtrdma_frwr_dereg,
 942	TP_PROTO(
 943		const struct rpcrdma_mr *mr,
 944		int rc
 945	),
 946
 947	TP_ARGS(mr, rc),
 948
 949	TP_STRUCT__entry(
 950		__field(u32, mr_id)
 951		__field(int, nents)
 952		__field(u32, handle)
 953		__field(u32, length)
 954		__field(u64, offset)
 955		__field(u32, dir)
 956		__field(int, rc)
 957	),
 958
 959	TP_fast_assign(
 960		__entry->mr_id  = mr->frwr.fr_mr->res.id;
 961		__entry->nents  = mr->mr_nents;
 962		__entry->handle = mr->mr_handle;
 963		__entry->length = mr->mr_length;
 964		__entry->offset = mr->mr_offset;
 965		__entry->dir    = mr->mr_dir;
 966		__entry->rc	= rc;
 967	),
 968
 969	TP_printk("mr.id=%u nents=%d %u@0x%016llx:0x%08x (%s): rc=%d",
 970		__entry->mr_id, __entry->nents, __entry->length,
 971		(unsigned long long)__entry->offset, __entry->handle,
 972		xprtrdma_show_direction(__entry->dir),
 973		__entry->rc
 974	)
 975);
 976
 977TRACE_EVENT(xprtrdma_frwr_sgerr,
 978	TP_PROTO(
 979		const struct rpcrdma_mr *mr,
 980		int sg_nents
 981	),
 982
 983	TP_ARGS(mr, sg_nents),
 984
 985	TP_STRUCT__entry(
 986		__field(u32, mr_id)
 987		__field(u64, addr)
 988		__field(u32, dir)
 989		__field(int, nents)
 990	),
 991
 992	TP_fast_assign(
 993		__entry->mr_id = mr->frwr.fr_mr->res.id;
 994		__entry->addr = mr->mr_sg->dma_address;
 995		__entry->dir = mr->mr_dir;
 996		__entry->nents = sg_nents;
 997	),
 998
 999	TP_printk("mr.id=%u DMA addr=0x%llx (%s) sg_nents=%d",
1000		__entry->mr_id, __entry->addr,
1001		xprtrdma_show_direction(__entry->dir),
1002		__entry->nents
1003	)
1004);
1005
1006TRACE_EVENT(xprtrdma_frwr_maperr,
1007	TP_PROTO(
1008		const struct rpcrdma_mr *mr,
1009		int num_mapped
1010	),
1011
1012	TP_ARGS(mr, num_mapped),
1013
1014	TP_STRUCT__entry(
1015		__field(u32, mr_id)
1016		__field(u64, addr)
1017		__field(u32, dir)
1018		__field(int, num_mapped)
1019		__field(int, nents)
1020	),
1021
1022	TP_fast_assign(
1023		__entry->mr_id = mr->frwr.fr_mr->res.id;
1024		__entry->addr = mr->mr_sg->dma_address;
1025		__entry->dir = mr->mr_dir;
1026		__entry->num_mapped = num_mapped;
1027		__entry->nents = mr->mr_nents;
1028	),
1029
1030	TP_printk("mr.id=%u DMA addr=0x%llx (%s) nents=%d of %d",
1031		__entry->mr_id, __entry->addr,
1032		xprtrdma_show_direction(__entry->dir),
1033		__entry->num_mapped, __entry->nents
1034	)
1035);
1036
 
1037DEFINE_MR_EVENT(localinv);
1038DEFINE_MR_EVENT(map);
1039DEFINE_MR_EVENT(unmap);
1040DEFINE_MR_EVENT(reminv);
1041DEFINE_MR_EVENT(recycle);
 
 
1042
1043TRACE_EVENT(xprtrdma_dma_maperr,
1044	TP_PROTO(
1045		u64 addr
1046	),
1047
1048	TP_ARGS(addr),
1049
1050	TP_STRUCT__entry(
1051		__field(u64, addr)
1052	),
1053
1054	TP_fast_assign(
1055		__entry->addr = addr;
1056	),
1057
1058	TP_printk("dma addr=0x%llx\n", __entry->addr)
1059);
1060
1061/**
1062 ** Reply events
1063 **/
1064
1065TRACE_EVENT(xprtrdma_reply,
1066	TP_PROTO(
1067		const struct rpc_task *task,
1068		const struct rpcrdma_rep *rep,
1069		const struct rpcrdma_req *req,
1070		unsigned int credits
1071	),
1072
1073	TP_ARGS(task, rep, req, credits),
1074
1075	TP_STRUCT__entry(
1076		__field(unsigned int, task_id)
1077		__field(unsigned int, client_id)
1078		__field(const void *, rep)
1079		__field(const void *, req)
1080		__field(u32, xid)
1081		__field(unsigned int, credits)
1082	),
1083
1084	TP_fast_assign(
1085		__entry->task_id = task->tk_pid;
1086		__entry->client_id = task->tk_client->cl_clid;
1087		__entry->rep = rep;
1088		__entry->req = req;
1089		__entry->xid = be32_to_cpu(rep->rr_xid);
1090		__entry->credits = credits;
1091	),
1092
1093	TP_printk("task:%u@%u xid=0x%08x, %u credits, rep=%p -> req=%p",
1094		__entry->task_id, __entry->client_id, __entry->xid,
1095		__entry->credits, __entry->rep, __entry->req
1096	)
1097);
1098
1099TRACE_EVENT(xprtrdma_defer_cmp,
 
 
 
 
 
1100	TP_PROTO(
1101		const struct rpcrdma_rep *rep
 
 
1102	),
1103
1104	TP_ARGS(rep),
1105
1106	TP_STRUCT__entry(
1107		__field(unsigned int, task_id)
1108		__field(unsigned int, client_id)
1109		__field(const void *, rep)
1110		__field(u32, xid)
 
 
1111	),
1112
1113	TP_fast_assign(
1114		__entry->task_id = rep->rr_rqst->rq_task->tk_pid;
1115		__entry->client_id = rep->rr_rqst->rq_task->tk_client->cl_clid;
1116		__entry->rep = rep;
1117		__entry->xid = be32_to_cpu(rep->rr_xid);
 
1118	),
1119
1120	TP_printk("task:%u@%u xid=0x%08x rep=%p",
1121		__entry->task_id, __entry->client_id, __entry->xid,
1122		__entry->rep
1123	)
1124);
1125
1126DEFINE_REPLY_EVENT(xprtrdma_reply_vers);
1127DEFINE_REPLY_EVENT(xprtrdma_reply_rqst);
1128DEFINE_REPLY_EVENT(xprtrdma_reply_short);
1129DEFINE_REPLY_EVENT(xprtrdma_reply_hdr);
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
1130
1131TRACE_EVENT(xprtrdma_fixup,
1132	TP_PROTO(
1133		const struct rpc_rqst *rqst,
1134		unsigned long fixup
1135	),
1136
1137	TP_ARGS(rqst, fixup),
1138
1139	TP_STRUCT__entry(
1140		__field(unsigned int, task_id)
1141		__field(unsigned int, client_id)
1142		__field(unsigned long, fixup)
1143		__field(size_t, headlen)
1144		__field(unsigned int, pagelen)
1145		__field(size_t, taillen)
1146	),
1147
1148	TP_fast_assign(
1149		__entry->task_id = rqst->rq_task->tk_pid;
1150		__entry->client_id = rqst->rq_task->tk_client->cl_clid;
1151		__entry->fixup = fixup;
1152		__entry->headlen = rqst->rq_rcv_buf.head[0].iov_len;
1153		__entry->pagelen = rqst->rq_rcv_buf.page_len;
1154		__entry->taillen = rqst->rq_rcv_buf.tail[0].iov_len;
1155	),
1156
1157	TP_printk("task:%u@%u fixup=%lu xdr=%zu/%u/%zu",
1158		__entry->task_id, __entry->client_id, __entry->fixup,
1159		__entry->headlen, __entry->pagelen, __entry->taillen
1160	)
1161);
1162
1163TRACE_EVENT(xprtrdma_decode_seg,
1164	TP_PROTO(
1165		u32 handle,
1166		u32 length,
1167		u64 offset
1168	),
1169
1170	TP_ARGS(handle, length, offset),
1171
1172	TP_STRUCT__entry(
1173		__field(u32, handle)
1174		__field(u32, length)
1175		__field(u64, offset)
1176	),
1177
1178	TP_fast_assign(
1179		__entry->handle = handle;
1180		__entry->length = length;
1181		__entry->offset = offset;
1182	),
1183
1184	TP_printk("%u@0x%016llx:0x%08x",
1185		__entry->length, (unsigned long long)__entry->offset,
1186		__entry->handle
1187	)
1188);
1189
1190/**
1191 ** Allocation/release of rpcrdma_reqs and rpcrdma_reps
1192 **/
1193
1194TRACE_EVENT(xprtrdma_op_allocate,
1195	TP_PROTO(
1196		const struct rpc_task *task,
1197		const struct rpcrdma_req *req
1198	),
1199
1200	TP_ARGS(task, req),
1201
1202	TP_STRUCT__entry(
1203		__field(unsigned int, task_id)
1204		__field(unsigned int, client_id)
1205		__field(const void *, req)
1206		__field(size_t, callsize)
1207		__field(size_t, rcvsize)
1208	),
1209
1210	TP_fast_assign(
1211		__entry->task_id = task->tk_pid;
1212		__entry->client_id = task->tk_client->cl_clid;
1213		__entry->req = req;
1214		__entry->callsize = task->tk_rqstp->rq_callsize;
1215		__entry->rcvsize = task->tk_rqstp->rq_rcvsize;
1216	),
1217
1218	TP_printk("task:%u@%u req=%p (%zu, %zu)",
1219		__entry->task_id, __entry->client_id,
1220		__entry->req, __entry->callsize, __entry->rcvsize
1221	)
1222);
1223
1224TRACE_EVENT(xprtrdma_op_free,
1225	TP_PROTO(
1226		const struct rpc_task *task,
1227		const struct rpcrdma_req *req
1228	),
1229
1230	TP_ARGS(task, req),
1231
1232	TP_STRUCT__entry(
1233		__field(unsigned int, task_id)
1234		__field(unsigned int, client_id)
1235		__field(const void *, req)
1236		__field(const void *, rep)
1237	),
1238
1239	TP_fast_assign(
1240		__entry->task_id = task->tk_pid;
1241		__entry->client_id = task->tk_client->cl_clid;
1242		__entry->req = req;
1243		__entry->rep = req->rl_reply;
1244	),
1245
1246	TP_printk("task:%u@%u req=%p rep=%p",
1247		__entry->task_id, __entry->client_id,
1248		__entry->req, __entry->rep
1249	)
1250);
1251
1252/**
1253 ** Callback events
1254 **/
1255
1256TRACE_EVENT(xprtrdma_cb_setup,
1257	TP_PROTO(
1258		const struct rpcrdma_xprt *r_xprt,
1259		unsigned int reqs
1260	),
1261
1262	TP_ARGS(r_xprt, reqs),
1263
1264	TP_STRUCT__entry(
1265		__field(const void *, r_xprt)
1266		__field(unsigned int, reqs)
1267		__string(addr, rpcrdma_addrstr(r_xprt))
1268		__string(port, rpcrdma_portstr(r_xprt))
1269	),
1270
1271	TP_fast_assign(
1272		__entry->r_xprt = r_xprt;
1273		__entry->reqs = reqs;
1274		__assign_str(addr, rpcrdma_addrstr(r_xprt));
1275		__assign_str(port, rpcrdma_portstr(r_xprt));
1276	),
1277
1278	TP_printk("peer=[%s]:%s r_xprt=%p: %u reqs",
1279		__get_str(addr), __get_str(port),
1280		__entry->r_xprt, __entry->reqs
1281	)
1282);
1283
1284DEFINE_CB_EVENT(xprtrdma_cb_call);
1285DEFINE_CB_EVENT(xprtrdma_cb_reply);
1286
1287TRACE_EVENT(xprtrdma_leaked_rep,
1288	TP_PROTO(
1289		const struct rpc_rqst *rqst,
1290		const struct rpcrdma_rep *rep
1291	),
1292
1293	TP_ARGS(rqst, rep),
1294
1295	TP_STRUCT__entry(
1296		__field(unsigned int, task_id)
1297		__field(unsigned int, client_id)
1298		__field(u32, xid)
1299		__field(const void *, rep)
1300	),
1301
1302	TP_fast_assign(
1303		__entry->task_id = rqst->rq_task->tk_pid;
1304		__entry->client_id = rqst->rq_task->tk_client->cl_clid;
1305		__entry->xid = be32_to_cpu(rqst->rq_xid);
1306		__entry->rep = rep;
1307	),
1308
1309	TP_printk("task:%u@%u xid=0x%08x rep=%p",
1310		__entry->task_id, __entry->client_id, __entry->xid,
1311		__entry->rep
1312	)
1313);
1314
1315/**
1316 ** Server-side RPC/RDMA events
1317 **/
1318
1319DECLARE_EVENT_CLASS(svcrdma_accept_class,
1320	TP_PROTO(
1321		const struct svcxprt_rdma *rdma,
1322		long status
1323	),
1324
1325	TP_ARGS(rdma, status),
1326
1327	TP_STRUCT__entry(
1328		__field(long, status)
1329		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1330	),
1331
1332	TP_fast_assign(
1333		__entry->status = status;
1334		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1335	),
1336
1337	TP_printk("addr=%s status=%ld",
1338		__get_str(addr), __entry->status
1339	)
1340);
1341
1342#define DEFINE_ACCEPT_EVENT(name) \
1343		DEFINE_EVENT(svcrdma_accept_class, svcrdma_##name##_err, \
1344				TP_PROTO( \
1345					const struct svcxprt_rdma *rdma, \
1346					long status \
1347				), \
1348				TP_ARGS(rdma, status))
1349
1350DEFINE_ACCEPT_EVENT(pd);
1351DEFINE_ACCEPT_EVENT(qp);
1352DEFINE_ACCEPT_EVENT(fabric);
1353DEFINE_ACCEPT_EVENT(initdepth);
1354DEFINE_ACCEPT_EVENT(accept);
1355
1356TRACE_DEFINE_ENUM(RDMA_MSG);
1357TRACE_DEFINE_ENUM(RDMA_NOMSG);
1358TRACE_DEFINE_ENUM(RDMA_MSGP);
1359TRACE_DEFINE_ENUM(RDMA_DONE);
1360TRACE_DEFINE_ENUM(RDMA_ERROR);
1361
1362#define show_rpcrdma_proc(x)						\
1363		__print_symbolic(x,					\
1364				{ RDMA_MSG, "RDMA_MSG" },		\
1365				{ RDMA_NOMSG, "RDMA_NOMSG" },		\
1366				{ RDMA_MSGP, "RDMA_MSGP" },		\
1367				{ RDMA_DONE, "RDMA_DONE" },		\
1368				{ RDMA_ERROR, "RDMA_ERROR" })
1369
1370TRACE_EVENT(svcrdma_decode_rqst,
1371	TP_PROTO(
1372		const struct svc_rdma_recv_ctxt *ctxt,
1373		__be32 *p,
1374		unsigned int hdrlen
1375	),
1376
1377	TP_ARGS(ctxt, p, hdrlen),
1378
1379	TP_STRUCT__entry(
1380		__field(u32, cq_id)
1381		__field(int, completion_id)
1382		__field(u32, xid)
1383		__field(u32, vers)
1384		__field(u32, proc)
1385		__field(u32, credits)
1386		__field(unsigned int, hdrlen)
1387	),
1388
1389	TP_fast_assign(
1390		__entry->cq_id = ctxt->rc_cid.ci_queue_id;
1391		__entry->completion_id = ctxt->rc_cid.ci_completion_id;
1392		__entry->xid = be32_to_cpup(p++);
1393		__entry->vers = be32_to_cpup(p++);
1394		__entry->credits = be32_to_cpup(p++);
1395		__entry->proc = be32_to_cpup(p);
1396		__entry->hdrlen = hdrlen;
1397	),
1398
1399	TP_printk("cq.id=%u cid=%d xid=0x%08x vers=%u credits=%u proc=%s hdrlen=%u",
1400		__entry->cq_id, __entry->completion_id,
1401		__entry->xid, __entry->vers, __entry->credits,
1402		show_rpcrdma_proc(__entry->proc), __entry->hdrlen)
1403);
1404
1405TRACE_EVENT(svcrdma_decode_short_err,
1406	TP_PROTO(
1407		const struct svc_rdma_recv_ctxt *ctxt,
1408		unsigned int hdrlen
1409	),
1410
1411	TP_ARGS(ctxt, hdrlen),
1412
1413	TP_STRUCT__entry(
1414		__field(u32, cq_id)
1415		__field(int, completion_id)
1416		__field(unsigned int, hdrlen)
1417	),
1418
1419	TP_fast_assign(
1420		__entry->cq_id = ctxt->rc_cid.ci_queue_id;
1421		__entry->completion_id = ctxt->rc_cid.ci_completion_id;
1422		__entry->hdrlen = hdrlen;
1423	),
1424
1425	TP_printk("cq.id=%u cid=%d hdrlen=%u",
1426		__entry->cq_id, __entry->completion_id,
1427		__entry->hdrlen)
1428);
1429
1430DECLARE_EVENT_CLASS(svcrdma_badreq_event,
1431	TP_PROTO(
1432		const struct svc_rdma_recv_ctxt *ctxt,
1433		__be32 *p
1434	),
1435
1436	TP_ARGS(ctxt, p),
1437
1438	TP_STRUCT__entry(
1439		__field(u32, cq_id)
1440		__field(int, completion_id)
1441		__field(u32, xid)
1442		__field(u32, vers)
1443		__field(u32, proc)
1444		__field(u32, credits)
1445	),
1446
1447	TP_fast_assign(
1448		__entry->cq_id = ctxt->rc_cid.ci_queue_id;
1449		__entry->completion_id = ctxt->rc_cid.ci_completion_id;
1450		__entry->xid = be32_to_cpup(p++);
1451		__entry->vers = be32_to_cpup(p++);
1452		__entry->credits = be32_to_cpup(p++);
1453		__entry->proc = be32_to_cpup(p);
1454	),
1455
1456	TP_printk("cq.id=%u cid=%d xid=0x%08x vers=%u credits=%u proc=%u",
1457		__entry->cq_id, __entry->completion_id,
1458		__entry->xid, __entry->vers, __entry->credits, __entry->proc)
1459);
1460
1461#define DEFINE_BADREQ_EVENT(name)					\
1462		DEFINE_EVENT(svcrdma_badreq_event,			\
1463			     svcrdma_decode_##name##_err,		\
1464				TP_PROTO(				\
1465					const struct svc_rdma_recv_ctxt *ctxt,	\
1466					__be32 *p			\
1467				),					\
1468				TP_ARGS(ctxt, p))
1469
1470DEFINE_BADREQ_EVENT(badvers);
1471DEFINE_BADREQ_EVENT(drop);
1472DEFINE_BADREQ_EVENT(badproc);
1473DEFINE_BADREQ_EVENT(parse);
1474
1475DECLARE_EVENT_CLASS(svcrdma_segment_event,
1476	TP_PROTO(
 
 
1477		u32 handle,
1478		u32 length,
1479		u64 offset
1480	),
1481
1482	TP_ARGS(handle, length, offset),
1483
1484	TP_STRUCT__entry(
 
 
 
1485		__field(u32, handle)
1486		__field(u32, length)
1487		__field(u64, offset)
1488	),
1489
1490	TP_fast_assign(
 
 
 
1491		__entry->handle = handle;
1492		__entry->length = length;
1493		__entry->offset = offset;
1494	),
1495
1496	TP_printk("%u@0x%016llx:0x%08x",
1497		__entry->length, (unsigned long long)__entry->offset,
1498		__entry->handle
 
1499	)
1500);
1501
1502#define DEFINE_SEGMENT_EVENT(name)					\
1503		DEFINE_EVENT(svcrdma_segment_event, svcrdma_##name,\
1504				TP_PROTO(				\
1505					u32 handle,			\
1506					u32 length,			\
1507					u64 offset			\
1508				),					\
1509				TP_ARGS(handle, length, offset))
1510
1511DEFINE_SEGMENT_EVENT(decode_wseg);
1512DEFINE_SEGMENT_EVENT(encode_rseg);
1513DEFINE_SEGMENT_EVENT(send_rseg);
1514DEFINE_SEGMENT_EVENT(encode_wseg);
1515DEFINE_SEGMENT_EVENT(send_wseg);
1516
1517DECLARE_EVENT_CLASS(svcrdma_chunk_event,
1518	TP_PROTO(
1519		u32 length
 
 
1520	),
1521
1522	TP_ARGS(length),
1523
1524	TP_STRUCT__entry(
 
 
 
 
 
1525		__field(u32, length)
 
1526	),
1527
1528	TP_fast_assign(
1529		__entry->length = length;
 
 
 
 
 
 
1530	),
1531
1532	TP_printk("length=%u",
1533		__entry->length
 
 
1534	)
1535);
1536
1537#define DEFINE_CHUNK_EVENT(name)					\
1538		DEFINE_EVENT(svcrdma_chunk_event, svcrdma_##name,	\
1539				TP_PROTO(				\
1540					u32 length			\
1541				),					\
1542				TP_ARGS(length))
1543
1544DEFINE_CHUNK_EVENT(send_pzr);
1545DEFINE_CHUNK_EVENT(encode_write_chunk);
1546DEFINE_CHUNK_EVENT(send_write_chunk);
1547DEFINE_CHUNK_EVENT(encode_read_chunk);
1548DEFINE_CHUNK_EVENT(send_reply_chunk);
1549
1550TRACE_EVENT(svcrdma_send_read_chunk,
1551	TP_PROTO(
1552		u32 length,
1553		u32 position
 
1554	),
1555
1556	TP_ARGS(length, position),
1557
1558	TP_STRUCT__entry(
 
 
 
 
1559		__field(u32, length)
1560		__field(u32, position)
1561	),
1562
1563	TP_fast_assign(
1564		__entry->length = length;
1565		__entry->position = position;
 
 
 
 
 
 
 
1566	),
1567
1568	TP_printk("length=%u position=%u",
1569		__entry->length, __entry->position
 
 
1570	)
1571);
1572
1573DECLARE_EVENT_CLASS(svcrdma_error_event,
1574	TP_PROTO(
1575		__be32 xid
1576	),
1577
1578	TP_ARGS(xid),
1579
1580	TP_STRUCT__entry(
1581		__field(u32, xid)
1582	),
1583
1584	TP_fast_assign(
1585		__entry->xid = be32_to_cpu(xid);
1586	),
1587
1588	TP_printk("xid=0x%08x",
1589		__entry->xid
1590	)
1591);
1592
1593#define DEFINE_ERROR_EVENT(name)					\
1594		DEFINE_EVENT(svcrdma_error_event, svcrdma_err_##name,	\
1595				TP_PROTO(				\
1596					__be32 xid			\
1597				),					\
1598				TP_ARGS(xid))
1599
1600DEFINE_ERROR_EVENT(vers);
1601DEFINE_ERROR_EVENT(chunk);
1602
1603/**
1604 ** Server-side RDMA API events
1605 **/
1606
1607DECLARE_EVENT_CLASS(svcrdma_dma_map_class,
1608	TP_PROTO(
1609		const struct svcxprt_rdma *rdma,
1610		u64 dma_addr,
1611		u32 length
1612	),
1613
1614	TP_ARGS(rdma, dma_addr, length),
1615
1616	TP_STRUCT__entry(
1617		__field(u64, dma_addr)
1618		__field(u32, length)
1619		__string(device, rdma->sc_cm_id->device->name)
1620		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1621	),
1622
1623	TP_fast_assign(
1624		__entry->dma_addr = dma_addr;
1625		__entry->length = length;
1626		__assign_str(device, rdma->sc_cm_id->device->name);
1627		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1628	),
1629
1630	TP_printk("addr=%s device=%s dma_addr=%llu length=%u",
1631		__get_str(addr), __get_str(device),
1632		__entry->dma_addr, __entry->length
1633	)
1634);
1635
1636#define DEFINE_SVC_DMA_EVENT(name)					\
1637		DEFINE_EVENT(svcrdma_dma_map_class, svcrdma_##name,	\
1638				TP_PROTO(				\
1639					const struct svcxprt_rdma *rdma,\
1640					u64 dma_addr,			\
1641					u32 length			\
1642				),					\
1643				TP_ARGS(rdma, dma_addr, length))
1644
1645DEFINE_SVC_DMA_EVENT(dma_map_page);
 
1646DEFINE_SVC_DMA_EVENT(dma_unmap_page);
1647
1648TRACE_EVENT(svcrdma_dma_map_rw_err,
1649	TP_PROTO(
1650		const struct svcxprt_rdma *rdma,
1651		unsigned int nents,
1652		int status
1653	),
1654
1655	TP_ARGS(rdma, nents, status),
1656
1657	TP_STRUCT__entry(
1658		__field(int, status)
1659		__field(unsigned int, nents)
1660		__string(device, rdma->sc_cm_id->device->name)
1661		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1662	),
1663
1664	TP_fast_assign(
1665		__entry->status = status;
1666		__entry->nents = nents;
1667		__assign_str(device, rdma->sc_cm_id->device->name);
1668		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1669	),
1670
1671	TP_printk("addr=%s device=%s nents=%u status=%d",
1672		__get_str(addr), __get_str(device), __entry->nents,
1673		__entry->status
1674	)
1675);
1676
1677TRACE_EVENT(svcrdma_no_rwctx_err,
1678	TP_PROTO(
1679		const struct svcxprt_rdma *rdma,
1680		unsigned int num_sges
1681	),
1682
1683	TP_ARGS(rdma, num_sges),
1684
1685	TP_STRUCT__entry(
1686		__field(unsigned int, num_sges)
1687		__string(device, rdma->sc_cm_id->device->name)
1688		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1689	),
1690
1691	TP_fast_assign(
1692		__entry->num_sges = num_sges;
1693		__assign_str(device, rdma->sc_cm_id->device->name);
1694		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1695	),
1696
1697	TP_printk("addr=%s device=%s num_sges=%d",
1698		__get_str(addr), __get_str(device), __entry->num_sges
1699	)
1700);
1701
1702TRACE_EVENT(svcrdma_page_overrun_err,
1703	TP_PROTO(
1704		const struct svcxprt_rdma *rdma,
1705		const struct svc_rqst *rqst,
1706		unsigned int pageno
1707	),
1708
1709	TP_ARGS(rdma, rqst, pageno),
1710
1711	TP_STRUCT__entry(
1712		__field(unsigned int, pageno)
1713		__field(u32, xid)
1714		__string(device, rdma->sc_cm_id->device->name)
1715		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1716	),
1717
1718	TP_fast_assign(
1719		__entry->pageno = pageno;
1720		__entry->xid = __be32_to_cpu(rqst->rq_xid);
1721		__assign_str(device, rdma->sc_cm_id->device->name);
1722		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1723	),
1724
1725	TP_printk("addr=%s device=%s xid=0x%08x pageno=%u", __get_str(addr),
1726		__get_str(device), __entry->xid, __entry->pageno
1727	)
1728);
1729
1730TRACE_EVENT(svcrdma_small_wrch_err,
1731	TP_PROTO(
1732		const struct svcxprt_rdma *rdma,
1733		unsigned int remaining,
1734		unsigned int seg_no,
1735		unsigned int num_segs
1736	),
1737
1738	TP_ARGS(rdma, remaining, seg_no, num_segs),
1739
1740	TP_STRUCT__entry(
1741		__field(unsigned int, remaining)
1742		__field(unsigned int, seg_no)
1743		__field(unsigned int, num_segs)
1744		__string(device, rdma->sc_cm_id->device->name)
1745		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1746	),
1747
1748	TP_fast_assign(
1749		__entry->remaining = remaining;
1750		__entry->seg_no = seg_no;
1751		__entry->num_segs = num_segs;
1752		__assign_str(device, rdma->sc_cm_id->device->name);
1753		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1754	),
1755
1756	TP_printk("addr=%s device=%s remaining=%u seg_no=%u num_segs=%u",
1757		__get_str(addr), __get_str(device), __entry->remaining,
1758		__entry->seg_no, __entry->num_segs
1759	)
1760);
1761
1762TRACE_EVENT(svcrdma_send_pullup,
1763	TP_PROTO(
1764		unsigned int len
 
1765	),
1766
1767	TP_ARGS(len),
1768
1769	TP_STRUCT__entry(
1770		__field(unsigned int, len)
 
 
 
1771	),
1772
1773	TP_fast_assign(
1774		__entry->len = len;
 
 
 
1775	),
1776
1777	TP_printk("len=%u", __entry->len)
 
 
 
1778);
1779
1780TRACE_EVENT(svcrdma_send_err,
1781	TP_PROTO(
1782		const struct svc_rqst *rqst,
1783		int status
1784	),
1785
1786	TP_ARGS(rqst, status),
1787
1788	TP_STRUCT__entry(
1789		__field(int, status)
1790		__field(u32, xid)
1791		__string(addr, rqst->rq_xprt->xpt_remotebuf)
1792	),
1793
1794	TP_fast_assign(
1795		__entry->status = status;
1796		__entry->xid = __be32_to_cpu(rqst->rq_xid);
1797		__assign_str(addr, rqst->rq_xprt->xpt_remotebuf);
1798	),
1799
1800	TP_printk("addr=%s xid=0x%08x status=%d", __get_str(addr),
1801		__entry->xid, __entry->status
1802	)
1803);
1804
1805TRACE_EVENT(svcrdma_post_send,
1806	TP_PROTO(
1807		const struct svc_rdma_send_ctxt *ctxt
1808	),
1809
1810	TP_ARGS(ctxt),
1811
1812	TP_STRUCT__entry(
1813		__field(u32, cq_id)
1814		__field(int, completion_id)
1815		__field(unsigned int, num_sge)
1816		__field(u32, inv_rkey)
1817	),
1818
1819	TP_fast_assign(
1820		const struct ib_send_wr *wr = &ctxt->sc_send_wr;
1821
1822		__entry->cq_id = ctxt->sc_cid.ci_queue_id;
1823		__entry->completion_id = ctxt->sc_cid.ci_completion_id;
1824		__entry->num_sge = wr->num_sge;
1825		__entry->inv_rkey = (wr->opcode == IB_WR_SEND_WITH_INV) ?
1826					wr->ex.invalidate_rkey : 0;
1827	),
1828
1829	TP_printk("cq_id=%u cid=%d num_sge=%u inv_rkey=0x%08x",
1830		__entry->cq_id, __entry->completion_id,
1831		__entry->num_sge, __entry->inv_rkey
1832	)
1833);
1834
1835DEFINE_COMPLETION_EVENT(svcrdma_wc_send);
 
 
1836
1837TRACE_EVENT(svcrdma_post_recv,
1838	TP_PROTO(
1839		const struct svc_rdma_recv_ctxt *ctxt
1840	),
1841
1842	TP_ARGS(ctxt),
1843
1844	TP_STRUCT__entry(
1845		__field(u32, cq_id)
1846		__field(int, completion_id)
1847	),
1848
1849	TP_fast_assign(
1850		__entry->cq_id = ctxt->rc_cid.ci_queue_id;
1851		__entry->completion_id = ctxt->rc_cid.ci_completion_id;
1852	),
1853
1854	TP_printk("cq.id=%d cid=%d",
1855		__entry->cq_id, __entry->completion_id
1856	)
1857);
1858
1859DEFINE_COMPLETION_EVENT(svcrdma_wc_receive);
 
 
1860
1861TRACE_EVENT(svcrdma_rq_post_err,
1862	TP_PROTO(
1863		const struct svcxprt_rdma *rdma,
1864		int status
1865	),
1866
1867	TP_ARGS(rdma, status),
1868
1869	TP_STRUCT__entry(
1870		__field(int, status)
1871		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1872	),
1873
1874	TP_fast_assign(
1875		__entry->status = status;
1876		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1877	),
1878
1879	TP_printk("addr=%s status=%d",
1880		__get_str(addr), __entry->status
1881	)
1882);
1883
1884TRACE_EVENT(svcrdma_post_chunk,
1885	TP_PROTO(
1886		const struct rpc_rdma_cid *cid,
1887		int sqecount
1888	),
1889
1890	TP_ARGS(cid, sqecount),
1891
1892	TP_STRUCT__entry(
1893		__field(u32, cq_id)
1894		__field(int, completion_id)
1895		__field(int, sqecount)
1896	),
1897
1898	TP_fast_assign(
1899		__entry->cq_id = cid->ci_queue_id;
1900		__entry->completion_id = cid->ci_completion_id;
1901		__entry->sqecount = sqecount;
1902	),
1903
1904	TP_printk("cq.id=%u cid=%d sqecount=%d",
1905		__entry->cq_id, __entry->completion_id,
1906		__entry->sqecount
1907	)
1908);
1909
1910DEFINE_COMPLETION_EVENT(svcrdma_wc_read);
1911DEFINE_COMPLETION_EVENT(svcrdma_wc_write);
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
1912
1913TRACE_EVENT(svcrdma_qp_error,
1914	TP_PROTO(
1915		const struct ib_event *event,
1916		const struct sockaddr *sap
1917	),
1918
1919	TP_ARGS(event, sap),
1920
1921	TP_STRUCT__entry(
1922		__field(unsigned int, event)
1923		__string(device, event->device->name)
1924		__array(__u8, addr, INET6_ADDRSTRLEN + 10)
1925	),
1926
1927	TP_fast_assign(
1928		__entry->event = event->event;
1929		__assign_str(device, event->device->name);
1930		snprintf(__entry->addr, sizeof(__entry->addr) - 1,
1931			 "%pISpc", sap);
1932	),
1933
1934	TP_printk("addr=%s dev=%s event=%s (%u)",
1935		__entry->addr, __get_str(device),
1936		rdma_show_ib_event(__entry->event), __entry->event
1937	)
1938);
1939
1940DECLARE_EVENT_CLASS(svcrdma_sendqueue_event,
1941	TP_PROTO(
1942		const struct svcxprt_rdma *rdma
1943	),
1944
1945	TP_ARGS(rdma),
1946
1947	TP_STRUCT__entry(
1948		__field(int, avail)
1949		__field(int, depth)
1950		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1951	),
1952
1953	TP_fast_assign(
1954		__entry->avail = atomic_read(&rdma->sc_sq_avail);
1955		__entry->depth = rdma->sc_sq_depth;
1956		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1957	),
1958
1959	TP_printk("addr=%s sc_sq_avail=%d/%d",
1960		__get_str(addr), __entry->avail, __entry->depth
1961	)
1962);
1963
1964#define DEFINE_SQ_EVENT(name)						\
1965		DEFINE_EVENT(svcrdma_sendqueue_event, svcrdma_sq_##name,\
1966				TP_PROTO(				\
1967					const struct svcxprt_rdma *rdma \
1968				),					\
1969				TP_ARGS(rdma))
1970
1971DEFINE_SQ_EVENT(full);
1972DEFINE_SQ_EVENT(retry);
1973
1974TRACE_EVENT(svcrdma_sq_post_err,
1975	TP_PROTO(
1976		const struct svcxprt_rdma *rdma,
1977		int status
1978	),
1979
1980	TP_ARGS(rdma, status),
1981
1982	TP_STRUCT__entry(
1983		__field(int, avail)
1984		__field(int, depth)
1985		__field(int, status)
1986		__string(addr, rdma->sc_xprt.xpt_remotebuf)
1987	),
1988
1989	TP_fast_assign(
1990		__entry->avail = atomic_read(&rdma->sc_sq_avail);
1991		__entry->depth = rdma->sc_sq_depth;
1992		__entry->status = status;
1993		__assign_str(addr, rdma->sc_xprt.xpt_remotebuf);
1994	),
1995
1996	TP_printk("addr=%s sc_sq_avail=%d/%d status=%d",
1997		__get_str(addr), __entry->avail, __entry->depth,
1998		__entry->status
1999	)
2000);
2001
2002#endif /* _TRACE_RPCRDMA_H */
2003
2004#include <trace/define_trace.h>