[linux-2.6-block.git] / fs / gfs2 / trace_gfs2.h

/* SPDX-License-Identifier: GPL-2.0 */
#undef TRACE_SYSTEM
#define TRACE_SYSTEM gfs2

#if !defined(_TRACE_GFS2_H) || defined(TRACE_HEADER_MULTI_READ)
#define _TRACE_GFS2_H

#include <linux/tracepoint.h>

#include <linux/fs.h>
#include <linux/buffer_head.h>
#include <linux/dlmconstants.h>
#include <linux/gfs2_ondisk.h>
#include <linux/writeback.h>
#include <linux/ktime.h>
#include <linux/iomap.h>
#include "incore.h"
#include "glock.h"
#include "rgrp.h"

#define dlm_state_name(nn) { DLM_LOCK_##nn, #nn }
#define glock_trace_name(x) __print_symbolic(x,		\
			    dlm_state_name(IV),		\
			    dlm_state_name(NL),		\
			    dlm_state_name(CR),		\
			    dlm_state_name(CW),		\
			    dlm_state_name(PR),		\
			    dlm_state_name(PW),		\
			    dlm_state_name(EX))

#define block_state_name(x) __print_symbolic(x,			\
			    { GFS2_BLKST_FREE, "free" },	\
			    { GFS2_BLKST_USED, "used" },	\
			    { GFS2_BLKST_DINODE, "dinode" },	\
			    { GFS2_BLKST_UNLINKED, "unlinked" })

#define TRACE_RS_DELETE  0
#define TRACE_RS_TREEDEL 1
#define TRACE_RS_INSERT  2
#define TRACE_RS_CLAIM   3

#define rs_func_name(x) __print_symbolic(x,	\
					 { 0, "del " },	\
					 { 1, "tdel" },	\
					 { 2, "ins " },	\
					 { 3, "clm " })

#define show_glock_flags(flags) __print_flags(flags, "",	\
	{(1UL << GLF_LOCK),			"l" },		\
	{(1UL << GLF_DEMOTE),			"D" },		\
	{(1UL << GLF_PENDING_DEMOTE),		"d" },		\
	{(1UL << GLF_DEMOTE_IN_PROGRESS),	"p" },		\
	{(1UL << GLF_DIRTY),			"y" },		\
	{(1UL << GLF_LFLUSH),			"f" },		\
	{(1UL << GLF_INVALIDATE_IN_PROGRESS),	"i" },		\
	{(1UL << GLF_REPLY_PENDING),		"r" },		\
	{(1UL << GLF_INITIAL),			"I" },		\
	{(1UL << GLF_FROZEN),			"F" },		\
	{(1UL << GLF_QUEUED),			"q" },		\
	{(1UL << GLF_LRU),			"L" },		\
	{(1UL << GLF_OBJECT),			"o" },		\
	{(1UL << GLF_BLOCKING),			"b" })

#ifndef NUMPTY
#define NUMPTY
static inline u8 glock_trace_state(unsigned int state)
{
	switch(state) {
	case LM_ST_SHARED:
		return DLM_LOCK_PR;
	case LM_ST_DEFERRED:
		return DLM_LOCK_CW;
	case LM_ST_EXCLUSIVE:
		return DLM_LOCK_EX;
	}
	return DLM_LOCK_NL;
}
#endif

/* Section 1 - Locking
 *
 * Objectives:
 * Latency: Remote demote request to state change
 * Latency: Local lock request to state change
 * Latency: State change to lock grant
 * Correctness: Ordering of local lock state vs. I/O requests
 * Correctness: Responses to remote demote requests
 */

/* General glock state change (DLM lock request completes) */
TRACE_EVENT(gfs2_glock_state_change,

	TP_PROTO(const struct gfs2_glock *gl, unsigned int new_state),

	TP_ARGS(gl, new_state),

	TP_STRUCT__entry(
		__field(	dev_t,	dev			)
		__field(	u64,	glnum			)
		__field(	u32,	gltype			)
		__field(	u8,	cur_state		)
		__field(	u8,	new_state		)
		__field(	u8,	dmt_state		)
		__field(	u8,	tgt_state		)
		__field(	unsigned long,	flags		)
	),

	TP_fast_assign(
		__entry->dev		= gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->glnum		= gl->gl_name.ln_number;
		__entry->gltype		= gl->gl_name.ln_type;
		__entry->cur_state	= glock_trace_state(gl->gl_state);
		__entry->new_state	= glock_trace_state(new_state);
		__entry->tgt_state	= glock_trace_state(gl->gl_target);
		__entry->dmt_state	= glock_trace_state(gl->gl_demote_state);
		__entry->flags		= gl->gl_flags | (gl->gl_object ? (1UL<<GLF_OBJECT) : 0);
	),

	TP_printk("%u,%u glock %d:%lld state %s to %s tgt:%s dmt:%s flags:%s",
		  MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
		 (unsigned long long)__entry->glnum,
		  glock_trace_name(__entry->cur_state),
		  glock_trace_name(__entry->new_state),
		  glock_trace_name(__entry->tgt_state),
		  glock_trace_name(__entry->dmt_state),
		  show_glock_flags(__entry->flags))
);

/* State change -> unlocked, glock is being deallocated */
TRACE_EVENT(gfs2_glock_put,

	TP_PROTO(const struct gfs2_glock *gl),

	TP_ARGS(gl),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	glnum			)
		__field(	u32,	gltype			)
		__field(	u8,	cur_state		)
		__field(	unsigned long,	flags		)
	),

	TP_fast_assign(
		__entry->dev		= gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->gltype		= gl->gl_name.ln_type;
		__entry->glnum		= gl->gl_name.ln_number;
		__entry->cur_state	= glock_trace_state(gl->gl_state);
		__entry->flags		= gl->gl_flags  | (gl->gl_object ? (1UL<<GLF_OBJECT) : 0);
	),

	TP_printk("%u,%u glock %d:%lld state %s => %s flags:%s",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
                  __entry->gltype, (unsigned long long)__entry->glnum,
                  glock_trace_name(__entry->cur_state),
		  glock_trace_name(DLM_LOCK_IV),
		  show_glock_flags(__entry->flags))

);

/* Callback (local or remote) requesting lock demotion */
TRACE_EVENT(gfs2_demote_rq,

	TP_PROTO(const struct gfs2_glock *gl, bool remote),

	TP_ARGS(gl, remote),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	glnum			)
		__field(	u32,	gltype			)
		__field(	u8,	cur_state		)
		__field(	u8,	dmt_state		)
		__field(	unsigned long,	flags		)
		__field(	bool,	remote			)
	),

	TP_fast_assign(
		__entry->dev		= gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->gltype		= gl->gl_name.ln_type;
		__entry->glnum		= gl->gl_name.ln_number;
		__entry->cur_state	= glock_trace_state(gl->gl_state);
		__entry->dmt_state	= glock_trace_state(gl->gl_demote_state);
		__entry->flags		= gl->gl_flags  | (gl->gl_object ? (1UL<<GLF_OBJECT) : 0);
		__entry->remote		= remote;
	),

	TP_printk("%u,%u glock %d:%lld demote %s to %s flags:%s %s",
		  MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
		  (unsigned long long)__entry->glnum,
                  glock_trace_name(__entry->cur_state),
                  glock_trace_name(__entry->dmt_state),
		  show_glock_flags(__entry->flags),
		  __entry->remote ? "remote" : "local")

);

/* Promotion/grant of a glock */
TRACE_EVENT(gfs2_promote,

	TP_PROTO(const struct gfs2_holder *gh, int first),

	TP_ARGS(gh, first),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	glnum			)
		__field(	u32,	gltype			)
		__field(	int,	first			)
		__field(	u8,	state			)
	),

	TP_fast_assign(
		__entry->dev	= gh->gh_gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->glnum	= gh->gh_gl->gl_name.ln_number;
		__entry->gltype	= gh->gh_gl->gl_name.ln_type;
		__entry->first	= first;
		__entry->state	= glock_trace_state(gh->gh_state);
	),

	TP_printk("%u,%u glock %u:%llu promote %s %s",
		  MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
		  (unsigned long long)__entry->glnum,
		  __entry->first ? "first": "other",
		  glock_trace_name(__entry->state))
);

/* Queue/dequeue a lock request */
TRACE_EVENT(gfs2_glock_queue,

	TP_PROTO(const struct gfs2_holder *gh, int queue),

	TP_ARGS(gh, queue),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	glnum			)
		__field(	u32,	gltype			)
		__field(	int,	queue			)
		__field(	u8,	state			)
	),

	TP_fast_assign(
		__entry->dev	= gh->gh_gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->glnum	= gh->gh_gl->gl_name.ln_number;
		__entry->gltype	= gh->gh_gl->gl_name.ln_type;
		__entry->queue	= queue;
		__entry->state	= glock_trace_state(gh->gh_state);
	),

	TP_printk("%u,%u glock %u:%llu %squeue %s",
		  MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
		  (unsigned long long)__entry->glnum,
		  __entry->queue ? "" : "de",
		  glock_trace_name(__entry->state))
);

/* DLM sends a reply to GFS2 */
TRACE_EVENT(gfs2_glock_lock_time,

	TP_PROTO(const struct gfs2_glock *gl, s64 tdiff),

	TP_ARGS(gl, tdiff),

	TP_STRUCT__entry(
		__field(	dev_t,	dev		)
		__field(	u64,	glnum		)
		__field(	u32,	gltype		)
		__field(	int,	status		)
		__field(	char,	flags		)
		__field(	s64,	tdiff		)
		__field(	u64,	srtt		)
		__field(	u64,	srttvar		)
		__field(	u64,	srttb		)
		__field(	u64,	srttvarb	)
		__field(	u64,	sirt		)
		__field(	u64,	sirtvar		)
		__field(	u64,	dcount		)
		__field(	u64,	qcount		)
	),

	TP_fast_assign(
		__entry->dev            = gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->glnum          = gl->gl_name.ln_number;
		__entry->gltype         = gl->gl_name.ln_type;
		__entry->status		= gl->gl_lksb.sb_status;
		__entry->flags		= gl->gl_lksb.sb_flags;
		__entry->tdiff		= tdiff;
		__entry->srtt		= gl->gl_stats.stats[GFS2_LKS_SRTT];
		__entry->srttvar	= gl->gl_stats.stats[GFS2_LKS_SRTTVAR];
		__entry->srttb		= gl->gl_stats.stats[GFS2_LKS_SRTTB];
		__entry->srttvarb	= gl->gl_stats.stats[GFS2_LKS_SRTTVARB];
		__entry->sirt		= gl->gl_stats.stats[GFS2_LKS_SIRT];
		__entry->sirtvar	= gl->gl_stats.stats[GFS2_LKS_SIRTVAR];
		__entry->dcount		= gl->gl_stats.stats[GFS2_LKS_DCOUNT];
		__entry->qcount		= gl->gl_stats.stats[GFS2_LKS_QCOUNT];
	),

	TP_printk("%u,%u glock %d:%lld status:%d flags:%02x tdiff:%lld srtt:%lld/%lld srttb:%lld/%lld sirt:%lld/%lld dcnt:%lld qcnt:%lld",
		  MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
		  (unsigned long long)__entry->glnum,
		  __entry->status, __entry->flags,
		  (long long)__entry->tdiff,
		  (long long)__entry->srtt,
		  (long long)__entry->srttvar,
		  (long long)__entry->srttb,
		  (long long)__entry->srttvarb,
		  (long long)__entry->sirt,
		  (long long)__entry->sirtvar,
		  (long long)__entry->dcount,
		  (long long)__entry->qcount)
);

/* Section 2 - Log/journal
 *
 * Objectives:
 * Latency: Log flush time
 * Correctness: pin/unpin vs. disk I/O ordering
 * Performance: Log usage stats
 */

/* Pin/unpin a block in the log */
TRACE_EVENT(gfs2_pin,

	TP_PROTO(const struct gfs2_bufdata *bd, int pin),

	TP_ARGS(bd, pin),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	int,	pin			)
		__field(	u32,	len			)
		__field(	sector_t,	block		)
		__field(	u64,	ino			)
	),

	TP_fast_assign(
		__entry->dev		= bd->bd_gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->pin		= pin;
		__entry->len		= bd->bd_bh->b_size;
		__entry->block		= bd->bd_bh->b_blocknr;
		__entry->ino		= bd->bd_gl->gl_name.ln_number;
	),

	TP_printk("%u,%u log %s %llu/%lu inode %llu",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
		  __entry->pin ? "pin" : "unpin",
		  (unsigned long long)__entry->block,
		  (unsigned long)__entry->len,
		  (unsigned long long)__entry->ino)
);

/* Flushing the log */
TRACE_EVENT(gfs2_log_flush,

	TP_PROTO(const struct gfs2_sbd *sdp, int start, u32 flags),

	TP_ARGS(sdp, start, flags),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	int,	start			)
		__field(	u64,	log_seq			)
		__field(	u32,	flags			)
	),

	TP_fast_assign(
		__entry->dev            = sdp->sd_vfs->s_dev;
		__entry->start		= start;
		__entry->log_seq	= sdp->sd_log_sequence;
		__entry->flags		= flags;
	),

	TP_printk("%u,%u log flush %s %llu %llx",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
		  __entry->start ? "start" : "end",
		  (unsigned long long)__entry->log_seq,
		  (unsigned long long)__entry->flags)
);

/* Reserving/releasing blocks in the log */
TRACE_EVENT(gfs2_log_blocks,

	TP_PROTO(const struct gfs2_sbd *sdp, int blocks),

	TP_ARGS(sdp, blocks),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	int,	blocks			)
	),

	TP_fast_assign(
		__entry->dev		= sdp->sd_vfs->s_dev;
		__entry->blocks		= blocks;
	),

	TP_printk("%u,%u log reserve %d", MAJOR(__entry->dev),
		  MINOR(__entry->dev), __entry->blocks)
);

/* Writing back the AIL */
TRACE_EVENT(gfs2_ail_flush,

	TP_PROTO(const struct gfs2_sbd *sdp, const struct writeback_control *wbc, int start),

	TP_ARGS(sdp, wbc, start),

	TP_STRUCT__entry(
		__field(	dev_t,	dev			)
		__field(	int, start			)
		__field(	int, sync_mode			)
		__field(	long, nr_to_write		)
	),

	TP_fast_assign(
		__entry->dev		= sdp->sd_vfs->s_dev;
		__entry->start		= start;
		__entry->sync_mode	= wbc->sync_mode;
		__entry->nr_to_write	= wbc->nr_to_write;
	),

	TP_printk("%u,%u ail flush %s %s %ld", MAJOR(__entry->dev),
		  MINOR(__entry->dev), __entry->start ? "start" : "end",
		  __entry->sync_mode == WB_SYNC_ALL ? "all" : "none",
		  __entry->nr_to_write)
);

/* Section 3 - bmap
 *
 * Objectives:
 * Latency: Bmap request time
 * Performance: Block allocator tracing
 * Correctness: Test of disard generation vs. blocks allocated
 */

/* Map an extent of blocks, possibly a new allocation */
TRACE_EVENT(gfs2_bmap,

	TP_PROTO(const struct gfs2_inode *ip, const struct buffer_head *bh,
		sector_t lblock, int create, int errno),

	TP_ARGS(ip, bh, lblock, create, errno),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	sector_t, lblock		)
		__field(	sector_t, pblock		)
		__field(	u64,	inum			)
		__field(	unsigned long, state		)
		__field(	u32,	len			)
		__field(	int,	create			)
		__field(	int,	errno			)
	),

	TP_fast_assign(
		__entry->dev            = ip->i_gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->lblock		= lblock;
		__entry->pblock		= buffer_mapped(bh) ?  bh->b_blocknr : 0;
		__entry->inum		= ip->i_no_addr;
		__entry->state		= bh->b_state;
		__entry->len		= bh->b_size;
		__entry->create		= create;
		__entry->errno		= errno;
	),

	TP_printk("%u,%u bmap %llu map %llu/%lu to %llu flags:%08lx %s %d",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
		  (unsigned long long)__entry->inum,
		  (unsigned long long)__entry->lblock,
		  (unsigned long)__entry->len,
		  (unsigned long long)__entry->pblock,
		  __entry->state, __entry->create ? "create " : "nocreate",
		  __entry->errno)
);

TRACE_EVENT(gfs2_iomap_start,

	TP_PROTO(const struct gfs2_inode *ip, loff_t pos, ssize_t length,
		 u16 flags),

	TP_ARGS(ip, pos, length, flags),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	inum			)
		__field(	loff_t, pos			)
		__field(	ssize_t, length			)
		__field(	u16,	flags			)
	),

	TP_fast_assign(
		__entry->dev            = ip->i_gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->inum		= ip->i_no_addr;
		__entry->pos		= pos;
		__entry->length		= length;
		__entry->flags		= flags;
	),

	TP_printk("%u,%u bmap %llu iomap start %llu/%lu flags:%08x",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
		  (unsigned long long)__entry->inum,
		  (unsigned long long)__entry->pos,
		  (unsigned long)__entry->length, (u16)__entry->flags)
);

TRACE_EVENT(gfs2_iomap_end,

	TP_PROTO(const struct gfs2_inode *ip, struct iomap *iomap, int ret),

	TP_ARGS(ip, iomap, ret),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	inum			)
		__field(	loff_t, offset			)
		__field(	ssize_t, length			)
		__field(	sector_t, pblock		)
		__field(	u16,	flags			)
		__field(	u16,	type			)
		__field(	int,	ret			)
	),

	TP_fast_assign(
		__entry->dev            = ip->i_gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->inum		= ip->i_no_addr;
		__entry->offset		= iomap->offset;
		__entry->length		= iomap->length;
		__entry->pblock		= iomap->addr == IOMAP_NULL_ADDR ? 0 :
					 (iomap->addr >> ip->i_inode.i_blkbits);
		__entry->flags		= iomap->flags;
		__entry->type		= iomap->type;
		__entry->ret		= ret;
	),

	TP_printk("%u,%u bmap %llu iomap end %llu/%lu to %llu ty:%d flags:%08x rc:%d",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
		  (unsigned long long)__entry->inum,
		  (unsigned long long)__entry->offset,
		  (unsigned long)__entry->length,
		  (long long)__entry->pblock,
		  (u16)__entry->type,
		  (u16)__entry->flags, __entry->ret)
);

/* Keep track of blocks as they are allocated/freed */
TRACE_EVENT(gfs2_block_alloc,

	TP_PROTO(const struct gfs2_inode *ip, struct gfs2_rgrpd *rgd,
		 u64 block, unsigned len, u8 block_state),

	TP_ARGS(ip, rgd, block, len, block_state),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	start			)
		__field(	u64,	inum			)
		__field(	u32,	len			)
		__field(	u8,	block_state		)
		__field(        u64,	rd_addr			)
		__field(        u32,	rd_free_clone		)
		__field(	u32,	rd_reserved		)
	),

	TP_fast_assign(
		__entry->dev		= rgd->rd_gl->gl_name.ln_sbd->sd_vfs->s_dev;
		__entry->start		= block;
		__entry->inum		= ip->i_no_addr;
		__entry->len		= len;
		__entry->block_state	= block_state;
		__entry->rd_addr	= rgd->rd_addr;
		__entry->rd_free_clone	= rgd->rd_free_clone;
		__entry->rd_reserved	= rgd->rd_reserved;
	),

	TP_printk("%u,%u bmap %llu alloc %llu/%lu %s rg:%llu rf:%u rr:%lu",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
		  (unsigned long long)__entry->inum,
		  (unsigned long long)__entry->start,
		  (unsigned long)__entry->len,
		  block_state_name(__entry->block_state),
		  (unsigned long long)__entry->rd_addr,
		  __entry->rd_free_clone, (unsigned long)__entry->rd_reserved)
);

/* Keep track of multi-block reservations as they are allocated/freed */
TRACE_EVENT(gfs2_rs,

	TP_PROTO(const struct gfs2_blkreserv *rs, u8 func),

	TP_ARGS(rs, func),

	TP_STRUCT__entry(
		__field(        dev_t,  dev                     )
		__field(	u64,	rd_addr			)
		__field(	u32,	rd_free_clone		)
		__field(	u32,	rd_reserved		)
		__field(	u64,	inum			)
		__field(	u64,	start			)
		__field(	u32,	free			)
		__field(	u8,	func			)
	),

	TP_fast_assign(
		__entry->dev		= rs->rs_rbm.rgd->rd_sbd->sd_vfs->s_dev;
		__entry->rd_addr	= rs->rs_rbm.rgd->rd_addr;
		__entry->rd_free_clone	= rs->rs_rbm.rgd->rd_free_clone;
		__entry->rd_reserved	= rs->rs_rbm.rgd->rd_reserved;
		__entry->inum		= rs->rs_inum;
		__entry->start		= gfs2_rbm_to_block(&rs->rs_rbm);
		__entry->free		= rs->rs_free;
		__entry->func		= func;
	),

	TP_printk("%u,%u bmap %llu resrv %llu rg:%llu rf:%lu rr:%lu %s f:%lu",
		  MAJOR(__entry->dev), MINOR(__entry->dev),
		  (unsigned long long)__entry->inum,
		  (unsigned long long)__entry->start,
		  (unsigned long long)__entry->rd_addr,
		  (unsigned long)__entry->rd_free_clone,
		  (unsigned long)__entry->rd_reserved,
		  rs_func_name(__entry->func), (unsigned long)__entry->free)
);

#endif /* _TRACE_GFS2_H */

/* This part must be outside protection */
#undef TRACE_INCLUDE_PATH
#define TRACE_INCLUDE_PATH .
#define TRACE_INCLUDE_FILE trace_gfs2
#include <trace/define_trace.h>
Commit	Line	Data
b2441318	1	/* SPDX-License-Identifier: GPL-2.0 */
d0b6e04a LZ	2	#undef TRACE_SYSTEM
	3	#define TRACE_SYSTEM gfs2
	4
63997775 SW	5	#if !defined(_TRACE_GFS2_H) \|\| defined(TRACE_HEADER_MULTI_READ)
	6	#define _TRACE_GFS2_H
	7
	8	#include <linux/tracepoint.h>
	9
63997775 SW	10	#include <linux/fs.h>
	11	#include <linux/buffer_head.h>
	12	#include <linux/dlmconstants.h>
	13	#include <linux/gfs2_ondisk.h>
c83ae9ca	14	#include <linux/writeback.h>
a245769f	15	#include <linux/ktime.h>
3974320c	16	#include <linux/iomap.h>
63997775 SW	17	#include "incore.h"
63997775 SW	18	#include "glock.h"
8e2e0047	19	#include "rgrp.h"
63997775 SW	20
	21	#define dlm_state_name(nn) { DLM_LOCK_##nn, #nn }
	22	#define glock_trace_name(x) __print_symbolic(x, \
	23	dlm_state_name(IV), \
	24	dlm_state_name(NL), \
	25	dlm_state_name(CR), \
	26	dlm_state_name(CW), \
	27	dlm_state_name(PR), \
	28	dlm_state_name(PW), \
	29	dlm_state_name(EX))
	30
	31	#define block_state_name(x) __print_symbolic(x, \
	32	{ GFS2_BLKST_FREE, "free" }, \
	33	{ GFS2_BLKST_USED, "used" }, \
	34	{ GFS2_BLKST_DINODE, "dinode" }, \
	35	{ GFS2_BLKST_UNLINKED, "unlinked" })
	36
8e2e0047 BP	37	#define TRACE_RS_DELETE 0
	38	#define TRACE_RS_TREEDEL 1
	39	#define TRACE_RS_INSERT 2
	40	#define TRACE_RS_CLAIM 3
	41
	42	#define rs_func_name(x) __print_symbolic(x, \
	43	{ 0, "del " }, \
	44	{ 1, "tdel" }, \
	45	{ 2, "ins " }, \
	46	{ 3, "clm " })
	47
63997775 SW	48	#define show_glock_flags(flags) __print_flags(flags, "", \
	49	{(1UL << GLF_LOCK), "l" }, \
	50	{(1UL << GLF_DEMOTE), "D" }, \
	51	{(1UL << GLF_PENDING_DEMOTE), "d" }, \
	52	{(1UL << GLF_DEMOTE_IN_PROGRESS), "p" }, \
	53	{(1UL << GLF_DIRTY), "y" }, \
	54	{(1UL << GLF_LFLUSH), "f" }, \
	55	{(1UL << GLF_INVALIDATE_IN_PROGRESS), "i" }, \
	56	{(1UL << GLF_REPLY_PENDING), "r" }, \
	57	{(1UL << GLF_INITIAL), "I" }, \
7b5e3d5f	58	{(1UL << GLF_FROZEN), "F" }, \
627c10b7 SW	59	{(1UL << GLF_QUEUED), "q" }, \
627c10b7 SW	60	{(1UL << GLF_LRU), "L" }, \
a245769f SW	61	{(1UL << GLF_OBJECT), "o" }, \
a245769f SW	62	{(1UL << GLF_BLOCKING), "b" })
63997775 SW	63
	64	#ifndef NUMPTY
	65	#define NUMPTY
	66	static inline u8 glock_trace_state(unsigned int state)
	67	{
	68	switch(state) {
	69	case LM_ST_SHARED:
	70	return DLM_LOCK_PR;
	71	case LM_ST_DEFERRED:
	72	return DLM_LOCK_CW;
	73	case LM_ST_EXCLUSIVE:
	74	return DLM_LOCK_EX;
	75	}
	76	return DLM_LOCK_NL;
	77	}
	78	#endif
	79
	80	/* Section 1 - Locking
	81	*
	82	* Objectives:
	83	* Latency: Remote demote request to state change
	84	* Latency: Local lock request to state change
	85	* Latency: State change to lock grant
	86	* Correctness: Ordering of local lock state vs. I/O requests
	87	* Correctness: Responses to remote demote requests
	88	*/
	89
	90	/* General glock state change (DLM lock request completes) */
	91	TRACE_EVENT(gfs2_glock_state_change,
	92
	93	TP_PROTO(const struct gfs2_glock *gl, unsigned int new_state),
	94
	95	TP_ARGS(gl, new_state),
	96
	97	TP_STRUCT__entry(
	98	__field( dev_t, dev )
	99	__field( u64, glnum )
	100	__field( u32, gltype )
	101	__field( u8, cur_state )
	102	__field( u8, new_state )
	103	__field( u8, dmt_state )
	104	__field( u8, tgt_state )
	105	__field( unsigned long, flags )
	106	),
	107
	108	TP_fast_assign(
15562c43	109	__entry->dev = gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	110	__entry->glnum = gl->gl_name.ln_number;
	111	__entry->gltype = gl->gl_name.ln_type;
	112	__entry->cur_state = glock_trace_state(gl->gl_state);
	113	__entry->new_state = glock_trace_state(new_state);
	114	__entry->tgt_state = glock_trace_state(gl->gl_target);
	115	__entry->dmt_state = glock_trace_state(gl->gl_demote_state);
627c10b7	116	__entry->flags = gl->gl_flags \| (gl->gl_object ? (1UL<<GLF_OBJECT) : 0);
63997775 SW	117	),
	118
	119	TP_printk("%u,%u glock %d:%lld state %s to %s tgt:%s dmt:%s flags:%s",
	120	MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
	121	(unsigned long long)__entry->glnum,
	122	glock_trace_name(__entry->cur_state),
	123	glock_trace_name(__entry->new_state),
	124	glock_trace_name(__entry->tgt_state),
	125	glock_trace_name(__entry->dmt_state),
	126	show_glock_flags(__entry->flags))
	127	);
	128
	129	/* State change -> unlocked, glock is being deallocated */
	130	TRACE_EVENT(gfs2_glock_put,
	131
	132	TP_PROTO(const struct gfs2_glock *gl),
	133
	134	TP_ARGS(gl),
	135
	136	TP_STRUCT__entry(
	137	__field( dev_t, dev )
	138	__field( u64, glnum )
	139	__field( u32, gltype )
	140	__field( u8, cur_state )
	141	__field( unsigned long, flags )
	142	),
	143
	144	TP_fast_assign(
15562c43	145	__entry->dev = gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	146	__entry->gltype = gl->gl_name.ln_type;
	147	__entry->glnum = gl->gl_name.ln_number;
	148	__entry->cur_state = glock_trace_state(gl->gl_state);
627c10b7	149	__entry->flags = gl->gl_flags \| (gl->gl_object ? (1UL<<GLF_OBJECT) : 0);
63997775 SW	150	),
	151
	152	TP_printk("%u,%u glock %d:%lld state %s => %s flags:%s",
	153	MAJOR(__entry->dev), MINOR(__entry->dev),
	154	__entry->gltype, (unsigned long long)__entry->glnum,
	155	glock_trace_name(__entry->cur_state),
	156	glock_trace_name(DLM_LOCK_IV),
	157	show_glock_flags(__entry->flags))
	158
	159	);
	160
	161	/* Callback (local or remote) requesting lock demotion */
	162	TRACE_EVENT(gfs2_demote_rq,
	163
7bd8b2eb	164	TP_PROTO(const struct gfs2_glock *gl, bool remote),
63997775	165
7bd8b2eb	166	TP_ARGS(gl, remote),
63997775 SW	167
	168	TP_STRUCT__entry(
	169	__field( dev_t, dev )
	170	__field( u64, glnum )
	171	__field( u32, gltype )
	172	__field( u8, cur_state )
	173	__field( u8, dmt_state )
	174	__field( unsigned long, flags )
7bd8b2eb	175	__field( bool, remote )
63997775 SW	176	),
	177
	178	TP_fast_assign(
15562c43	179	__entry->dev = gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	180	__entry->gltype = gl->gl_name.ln_type;
	181	__entry->glnum = gl->gl_name.ln_number;
	182	__entry->cur_state = glock_trace_state(gl->gl_state);
	183	__entry->dmt_state = glock_trace_state(gl->gl_demote_state);
627c10b7	184	__entry->flags = gl->gl_flags \| (gl->gl_object ? (1UL<<GLF_OBJECT) : 0);
7bd8b2eb	185	__entry->remote = remote;
63997775 SW	186	),
63997775 SW	187
7bd8b2eb	188	TP_printk("%u,%u glock %d:%lld demote %s to %s flags:%s %s",
63997775 SW	189	MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
	190	(unsigned long long)__entry->glnum,
	191	glock_trace_name(__entry->cur_state),
	192	glock_trace_name(__entry->dmt_state),
7bd8b2eb SW	193	show_glock_flags(__entry->flags),
7bd8b2eb SW	194	__entry->remote ? "remote" : "local")
63997775 SW	195
	196	);
	197
	198	/* Promotion/grant of a glock */
	199	TRACE_EVENT(gfs2_promote,
	200
	201	TP_PROTO(const struct gfs2_holder *gh, int first),
	202
	203	TP_ARGS(gh, first),
	204
	205	TP_STRUCT__entry(
	206	__field( dev_t, dev )
	207	__field( u64, glnum )
	208	__field( u32, gltype )
	209	__field( int, first )
	210	__field( u8, state )
	211	),
	212
	213	TP_fast_assign(
15562c43	214	__entry->dev = gh->gh_gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	215	__entry->glnum = gh->gh_gl->gl_name.ln_number;
	216	__entry->gltype = gh->gh_gl->gl_name.ln_type;
	217	__entry->first = first;
	218	__entry->state = glock_trace_state(gh->gh_state);
	219	),
	220
	221	TP_printk("%u,%u glock %u:%llu promote %s %s",
	222	MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
	223	(unsigned long long)__entry->glnum,
	224	__entry->first ? "first": "other",
	225	glock_trace_name(__entry->state))
	226	);
	227
	228	/* Queue/dequeue a lock request */
	229	TRACE_EVENT(gfs2_glock_queue,
	230
	231	TP_PROTO(const struct gfs2_holder *gh, int queue),
	232
	233	TP_ARGS(gh, queue),
	234
	235	TP_STRUCT__entry(
	236	__field( dev_t, dev )
	237	__field( u64, glnum )
	238	__field( u32, gltype )
	239	__field( int, queue )
	240	__field( u8, state )
	241	),
	242
	243	TP_fast_assign(
15562c43	244	__entry->dev = gh->gh_gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	245	__entry->glnum = gh->gh_gl->gl_name.ln_number;
	246	__entry->gltype = gh->gh_gl->gl_name.ln_type;
	247	__entry->queue = queue;
	248	__entry->state = glock_trace_state(gh->gh_state);
	249	),
	250
	251	TP_printk("%u,%u glock %u:%llu %squeue %s",
	252	MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
	253	(unsigned long long)__entry->glnum,
	254	__entry->queue ? "" : "de",
	255	glock_trace_name(__entry->state))
	256	);
	257
a245769f SW	258	/* DLM sends a reply to GFS2 */
	259	TRACE_EVENT(gfs2_glock_lock_time,
	260
	261	TP_PROTO(const struct gfs2_glock *gl, s64 tdiff),
	262
	263	TP_ARGS(gl, tdiff),
	264
	265	TP_STRUCT__entry(
	266	__field( dev_t, dev )
	267	__field( u64, glnum )
	268	__field( u32, gltype )
	269	__field( int, status )
	270	__field( char, flags )
	271	__field( s64, tdiff )
4d207133 BH	272	__field( u64, srtt )
	273	__field( u64, srttvar )
	274	__field( u64, srttb )
	275	__field( u64, srttvarb )
	276	__field( u64, sirt )
	277	__field( u64, sirtvar )
	278	__field( u64, dcount )
	279	__field( u64, qcount )
a245769f SW	280	),
	281
	282	TP_fast_assign(
15562c43	283	__entry->dev = gl->gl_name.ln_sbd->sd_vfs->s_dev;
a245769f SW	284	__entry->glnum = gl->gl_name.ln_number;
	285	__entry->gltype = gl->gl_name.ln_type;
	286	__entry->status = gl->gl_lksb.sb_status;
	287	__entry->flags = gl->gl_lksb.sb_flags;
	288	__entry->tdiff = tdiff;
	289	__entry->srtt = gl->gl_stats.stats[GFS2_LKS_SRTT];
	290	__entry->srttvar = gl->gl_stats.stats[GFS2_LKS_SRTTVAR];
	291	__entry->srttb = gl->gl_stats.stats[GFS2_LKS_SRTTB];
	292	__entry->srttvarb = gl->gl_stats.stats[GFS2_LKS_SRTTVARB];
	293	__entry->sirt = gl->gl_stats.stats[GFS2_LKS_SIRT];
	294	__entry->sirtvar = gl->gl_stats.stats[GFS2_LKS_SIRTVAR];
	295	__entry->dcount = gl->gl_stats.stats[GFS2_LKS_DCOUNT];
	296	__entry->qcount = gl->gl_stats.stats[GFS2_LKS_QCOUNT];
	297	),
	298
	299	TP_printk("%u,%u glock %d:%lld status:%d flags:%02x tdiff:%lld srtt:%lld/%lld srttb:%lld/%lld sirt:%lld/%lld dcnt:%lld qcnt:%lld",
	300	MAJOR(__entry->dev), MINOR(__entry->dev), __entry->gltype,
	301	(unsigned long long)__entry->glnum,
	302	__entry->status, __entry->flags,
	303	(long long)__entry->tdiff,
	304	(long long)__entry->srtt,
	305	(long long)__entry->srttvar,
	306	(long long)__entry->srttb,
	307	(long long)__entry->srttvarb,
	308	(long long)__entry->sirt,
	309	(long long)__entry->sirtvar,
	310	(long long)__entry->dcount,
	311	(long long)__entry->qcount)
	312	);
	313
63997775 SW	314	/* Section 2 - Log/journal
	315	*
	316	* Objectives:
	317	* Latency: Log flush time
	318	* Correctness: pin/unpin vs. disk I/O ordering
	319	* Performance: Log usage stats
	320	*/
	321
	322	/* Pin/unpin a block in the log */
	323	TRACE_EVENT(gfs2_pin,
	324
	325	TP_PROTO(const struct gfs2_bufdata *bd, int pin),
	326
	327	TP_ARGS(bd, pin),
	328
	329	TP_STRUCT__entry(
	330	__field( dev_t, dev )
	331	__field( int, pin )
	332	__field( u32, len )
	333	__field( sector_t, block )
	334	__field( u64, ino )
	335	),
	336
	337	TP_fast_assign(
15562c43	338	__entry->dev = bd->bd_gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	339	__entry->pin = pin;
	340	__entry->len = bd->bd_bh->b_size;
	341	__entry->block = bd->bd_bh->b_blocknr;
	342	__entry->ino = bd->bd_gl->gl_name.ln_number;
	343	),
	344
	345	TP_printk("%u,%u log %s %llu/%lu inode %llu",
	346	MAJOR(__entry->dev), MINOR(__entry->dev),
	347	__entry->pin ? "pin" : "unpin",
	348	(unsigned long long)__entry->block,
	349	(unsigned long)__entry->len,
	350	(unsigned long long)__entry->ino)
	351	);
	352
	353	/* Flushing the log */
	354	TRACE_EVENT(gfs2_log_flush,
	355
805c0907	356	TP_PROTO(const struct gfs2_sbd *sdp, int start, u32 flags),
63997775	357
805c0907	358	TP_ARGS(sdp, start, flags),
63997775 SW	359
	360	TP_STRUCT__entry(
	361	__field( dev_t, dev )
	362	__field( int, start )
	363	__field( u64, log_seq )
805c0907	364	__field( u32, flags )
63997775 SW	365	),
	366
	367	TP_fast_assign(
	368	__entry->dev = sdp->sd_vfs->s_dev;
	369	__entry->start = start;
	370	__entry->log_seq = sdp->sd_log_sequence;
805c0907	371	__entry->flags = flags;
63997775 SW	372	),
63997775 SW	373
805c0907	374	TP_printk("%u,%u log flush %s %llu %llx",
63997775 SW	375	MAJOR(__entry->dev), MINOR(__entry->dev),
63997775 SW	376	__entry->start ? "start" : "end",
805c0907 BP	377	(unsigned long long)__entry->log_seq,
805c0907 BP	378	(unsigned long long)__entry->flags)
63997775 SW	379	);
	380
	381	/* Reserving/releasing blocks in the log */
	382	TRACE_EVENT(gfs2_log_blocks,
	383
	384	TP_PROTO(const struct gfs2_sbd *sdp, int blocks),
	385
	386	TP_ARGS(sdp, blocks),
	387
	388	TP_STRUCT__entry(
	389	__field( dev_t, dev )
	390	__field( int, blocks )
	391	),
	392
	393	TP_fast_assign(
	394	__entry->dev = sdp->sd_vfs->s_dev;
	395	__entry->blocks = blocks;
	396	),
	397
	398	TP_printk("%u,%u log reserve %d", MAJOR(__entry->dev),
	399	MINOR(__entry->dev), __entry->blocks)
	400	);
	401
c83ae9ca SW	402	/* Writing back the AIL */
	403	TRACE_EVENT(gfs2_ail_flush,
	404
	405	TP_PROTO(const struct gfs2_sbd sdp, const struct writeback_control wbc, int start),
	406
	407	TP_ARGS(sdp, wbc, start),
	408
	409	TP_STRUCT__entry(
	410	__field( dev_t, dev )
	411	__field( int, start )
	412	__field( int, sync_mode )
	413	__field( long, nr_to_write )
	414	),
	415
	416	TP_fast_assign(
	417	__entry->dev = sdp->sd_vfs->s_dev;
	418	__entry->start = start;
	419	__entry->sync_mode = wbc->sync_mode;
	420	__entry->nr_to_write = wbc->nr_to_write;
	421	),
	422
	423	TP_printk("%u,%u ail flush %s %s %ld", MAJOR(__entry->dev),
	424	MINOR(__entry->dev), __entry->start ? "start" : "end",
	425	__entry->sync_mode == WB_SYNC_ALL ? "all" : "none",
	426	__entry->nr_to_write)
	427	);
	428
63997775 SW	429	/* Section 3 - bmap
	430	*
	431	* Objectives:
	432	* Latency: Bmap request time
	433	* Performance: Block allocator tracing
	434	* Correctness: Test of disard generation vs. blocks allocated
	435	*/
	436
	437	/* Map an extent of blocks, possibly a new allocation */
	438	TRACE_EVENT(gfs2_bmap,
	439
	440	TP_PROTO(const struct gfs2_inode ip, const struct buffer_head bh,
	441	sector_t lblock, int create, int errno),
	442
	443	TP_ARGS(ip, bh, lblock, create, errno),
	444
	445	TP_STRUCT__entry(
	446	__field( dev_t, dev )
	447	__field( sector_t, lblock )
	448	__field( sector_t, pblock )
	449	__field( u64, inum )
	450	__field( unsigned long, state )
	451	__field( u32, len )
	452	__field( int, create )
	453	__field( int, errno )
	454	),
	455
	456	TP_fast_assign(
15562c43	457	__entry->dev = ip->i_gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	458	__entry->lblock = lblock;
	459	__entry->pblock = buffer_mapped(bh) ? bh->b_blocknr : 0;
	460	__entry->inum = ip->i_no_addr;
	461	__entry->state = bh->b_state;
	462	__entry->len = bh->b_size;
	463	__entry->create = create;
	464	__entry->errno = errno;
	465	),
	466
	467	TP_printk("%u,%u bmap %llu map %llu/%lu to %llu flags:%08lx %s %d",
	468	MAJOR(__entry->dev), MINOR(__entry->dev),
	469	(unsigned long long)__entry->inum,
	470	(unsigned long long)__entry->lblock,
	471	(unsigned long)__entry->len,
	472	(unsigned long long)__entry->pblock,
	473	__entry->state, __entry->create ? "create " : "nocreate",
	474	__entry->errno)
	475	);
	476
3974320c BP	477	TRACE_EVENT(gfs2_iomap_start,
	478
	479	TP_PROTO(const struct gfs2_inode *ip, loff_t pos, ssize_t length,
	480	u16 flags),
	481
	482	TP_ARGS(ip, pos, length, flags),
	483
	484	TP_STRUCT__entry(
	485	__field( dev_t, dev )
	486	__field( u64, inum )
	487	__field( loff_t, pos )
	488	__field( ssize_t, length )
	489	__field( u16, flags )
	490	),
	491
	492	TP_fast_assign(
	493	__entry->dev = ip->i_gl->gl_name.ln_sbd->sd_vfs->s_dev;
	494	__entry->inum = ip->i_no_addr;
	495	__entry->pos = pos;
	496	__entry->length = length;
	497	__entry->flags = flags;
	498	),
	499
	500	TP_printk("%u,%u bmap %llu iomap start %llu/%lu flags:%08x",
	501	MAJOR(__entry->dev), MINOR(__entry->dev),
	502	(unsigned long long)__entry->inum,
	503	(unsigned long long)__entry->pos,
	504	(unsigned long)__entry->length, (u16)__entry->flags)
	505	);
	506
	507	TRACE_EVENT(gfs2_iomap_end,
	508
	509	TP_PROTO(const struct gfs2_inode ip, struct iomap iomap, int ret),
	510
	511	TP_ARGS(ip, iomap, ret),
	512
	513	TP_STRUCT__entry(
	514	__field( dev_t, dev )
	515	__field( u64, inum )
	516	__field( loff_t, offset )
	517	__field( ssize_t, length )
ee6ed857	518	__field( sector_t, pblock )
3974320c BP	519	__field( u16, flags )
	520	__field( u16, type )
	521	__field( int, ret )
	522	),
	523
	524	TP_fast_assign(
	525	__entry->dev = ip->i_gl->gl_name.ln_sbd->sd_vfs->s_dev;
	526	__entry->inum = ip->i_no_addr;
	527	__entry->offset = iomap->offset;
	528	__entry->length = iomap->length;
ee6ed857 AG	529	__entry->pblock = iomap->addr == IOMAP_NULL_ADDR ? 0 :
ee6ed857 AG	530	(iomap->addr >> ip->i_inode.i_blkbits);
3974320c BP	531	__entry->flags = iomap->flags;
	532	__entry->type = iomap->type;
	533	__entry->ret = ret;
	534	),
	535
ee6ed857	536	TP_printk("%u,%u bmap %llu iomap end %llu/%lu to %llu ty:%d flags:%08x rc:%d",
3974320c BP	537	MAJOR(__entry->dev), MINOR(__entry->dev),
	538	(unsigned long long)__entry->inum,
	539	(unsigned long long)__entry->offset,
ee6ed857 AG	540	(unsigned long)__entry->length,
	541	(long long)__entry->pblock,
	542	(u16)__entry->type,
3974320c BP	543	(u16)__entry->flags, __entry->ret)
	544	);
	545
63997775 SW	546	/* Keep track of blocks as they are allocated/freed */
	547	TRACE_EVENT(gfs2_block_alloc,
	548
41db1ab9 BP	549	TP_PROTO(const struct gfs2_inode ip, struct gfs2_rgrpd rgd,
41db1ab9 BP	550	u64 block, unsigned len, u8 block_state),
63997775	551
41db1ab9	552	TP_ARGS(ip, rgd, block, len, block_state),
63997775 SW	553
	554	TP_STRUCT__entry(
	555	__field( dev_t, dev )
	556	__field( u64, start )
	557	__field( u64, inum )
	558	__field( u32, len )
	559	__field( u8, block_state )
41db1ab9 BP	560	__field( u64, rd_addr )
41db1ab9 BP	561	__field( u32, rd_free_clone )
8e2e0047	562	__field( u32, rd_reserved )
63997775 SW	563	),
	564
	565	TP_fast_assign(
15562c43	566	__entry->dev = rgd->rd_gl->gl_name.ln_sbd->sd_vfs->s_dev;
63997775 SW	567	__entry->start = block;
	568	__entry->inum = ip->i_no_addr;
	569	__entry->len = len;
	570	__entry->block_state = block_state;
41db1ab9 BP	571	__entry->rd_addr = rgd->rd_addr;
41db1ab9 BP	572	__entry->rd_free_clone = rgd->rd_free_clone;
8e2e0047	573	__entry->rd_reserved = rgd->rd_reserved;
63997775 SW	574	),
63997775 SW	575
8e2e0047	576	TP_printk("%u,%u bmap %llu alloc %llu/%lu %s rg:%llu rf:%u rr:%lu",
63997775 SW	577	MAJOR(__entry->dev), MINOR(__entry->dev),
	578	(unsigned long long)__entry->inum,
	579	(unsigned long long)__entry->start,
	580	(unsigned long)__entry->len,
41db1ab9 BP	581	block_state_name(__entry->block_state),
41db1ab9 BP	582	(unsigned long long)__entry->rd_addr,
8e2e0047 BP	583	__entry->rd_free_clone, (unsigned long)__entry->rd_reserved)
	584	);
	585
	586	/* Keep track of multi-block reservations as they are allocated/freed */
	587	TRACE_EVENT(gfs2_rs,
	588
9e733d39	589	TP_PROTO(const struct gfs2_blkreserv *rs, u8 func),
8e2e0047	590
9e733d39	591	TP_ARGS(rs, func),
8e2e0047 BP	592
	593	TP_STRUCT__entry(
	594	__field( dev_t, dev )
	595	__field( u64, rd_addr )
	596	__field( u32, rd_free_clone )
	597	__field( u32, rd_reserved )
	598	__field( u64, inum )
	599	__field( u64, start )
	600	__field( u32, free )
	601	__field( u8, func )
	602	),
	603
	604	TP_fast_assign(
9e733d39 SW	605	__entry->dev = rs->rs_rbm.rgd->rd_sbd->sd_vfs->s_dev;
	606	__entry->rd_addr = rs->rs_rbm.rgd->rd_addr;
	607	__entry->rd_free_clone = rs->rs_rbm.rgd->rd_free_clone;
	608	__entry->rd_reserved = rs->rs_rbm.rgd->rd_reserved;
	609	__entry->inum = rs->rs_inum;
4a993fb1	610	__entry->start = gfs2_rbm_to_block(&rs->rs_rbm);
8e2e0047 BP	611	__entry->free = rs->rs_free;
	612	__entry->func = func;
	613	),
	614
9e733d39	615	TP_printk("%u,%u bmap %llu resrv %llu rg:%llu rf:%lu rr:%lu %s f:%lu",
8e2e0047 BP	616	MAJOR(__entry->dev), MINOR(__entry->dev),
	617	(unsigned long long)__entry->inum,
	618	(unsigned long long)__entry->start,
	619	(unsigned long long)__entry->rd_addr,
	620	(unsigned long)__entry->rd_free_clone,
	621	(unsigned long)__entry->rd_reserved,
	622	rs_func_name(__entry->func), (unsigned long)__entry->free)
63997775 SW	623	);
	624
	625	#endif /* _TRACE_GFS2_H */
	626
	627	/* This part must be outside protection */
	628	#undef TRACE_INCLUDE_PATH
	629	#define TRACE_INCLUDE_PATH .
d0b6e04a	630	#define TRACE_INCLUDE_FILE trace_gfs2
63997775 SW	631	#include <trace/define_trace.h>
63997775 SW	632