Linux Audio

Check our new training course

Loading...
v3.15
   1/*
   2 * trace_output.c
   3 *
   4 * Copyright (C) 2008 Red Hat Inc, Steven Rostedt <srostedt@redhat.com>
   5 *
   6 */
   7
   8#include <linux/module.h>
   9#include <linux/mutex.h>
  10#include <linux/ftrace.h>
 
 
  11
  12#include "trace_output.h"
  13
  14/* must be a power of 2 */
  15#define EVENT_HASHSIZE	128
  16
  17DECLARE_RWSEM(trace_event_sem);
  18
  19static struct hlist_head event_hash[EVENT_HASHSIZE] __read_mostly;
  20
  21static int next_event_type = __TRACE_LAST_TYPE + 1;
  22
  23int trace_print_seq(struct seq_file *m, struct trace_seq *s)
  24{
  25	int len = s->len >= PAGE_SIZE ? PAGE_SIZE - 1 : s->len;
  26	int ret;
  27
  28	ret = seq_write(m, s->buffer, len);
  29
  30	/*
  31	 * Only reset this buffer if we successfully wrote to the
  32	 * seq_file buffer.
  33	 */
  34	if (!ret)
  35		trace_seq_init(s);
  36
  37	return ret;
  38}
  39
  40enum print_line_t trace_print_bputs_msg_only(struct trace_iterator *iter)
  41{
  42	struct trace_seq *s = &iter->seq;
  43	struct trace_entry *entry = iter->ent;
  44	struct bputs_entry *field;
  45	int ret;
  46
  47	trace_assign_type(field, entry);
  48
  49	ret = trace_seq_puts(s, field->str);
  50	if (!ret)
  51		return TRACE_TYPE_PARTIAL_LINE;
  52
  53	return TRACE_TYPE_HANDLED;
  54}
  55
  56enum print_line_t trace_print_bprintk_msg_only(struct trace_iterator *iter)
  57{
  58	struct trace_seq *s = &iter->seq;
  59	struct trace_entry *entry = iter->ent;
  60	struct bprint_entry *field;
  61	int ret;
  62
  63	trace_assign_type(field, entry);
  64
  65	ret = trace_seq_bprintf(s, field->fmt, field->buf);
  66	if (!ret)
  67		return TRACE_TYPE_PARTIAL_LINE;
  68
  69	return TRACE_TYPE_HANDLED;
  70}
  71
  72enum print_line_t trace_print_printk_msg_only(struct trace_iterator *iter)
  73{
  74	struct trace_seq *s = &iter->seq;
  75	struct trace_entry *entry = iter->ent;
  76	struct print_entry *field;
  77	int ret;
  78
  79	trace_assign_type(field, entry);
  80
  81	ret = trace_seq_puts(s, field->buf);
  82	if (!ret)
  83		return TRACE_TYPE_PARTIAL_LINE;
  84
  85	return TRACE_TYPE_HANDLED;
  86}
  87
  88/**
  89 * trace_seq_printf - sequence printing of trace information
  90 * @s: trace sequence descriptor
  91 * @fmt: printf format string
  92 *
  93 * It returns 0 if the trace oversizes the buffer's free
  94 * space, 1 otherwise.
  95 *
  96 * The tracer may use either sequence operations or its own
  97 * copy to user routines. To simplify formating of a trace
  98 * trace_seq_printf is used to store strings into a special
  99 * buffer (@s). Then the output may be either used by
 100 * the sequencer or pulled into another buffer.
 101 */
 102int
 103trace_seq_printf(struct trace_seq *s, const char *fmt, ...)
 104{
 105	int len = (PAGE_SIZE - 1) - s->len;
 106	va_list ap;
 107	int ret;
 108
 109	if (s->full || !len)
 110		return 0;
 111
 112	va_start(ap, fmt);
 113	ret = vsnprintf(s->buffer + s->len, len, fmt, ap);
 114	va_end(ap);
 115
 116	/* If we can't write it all, don't bother writing anything */
 117	if (ret >= len) {
 118		s->full = 1;
 119		return 0;
 120	}
 121
 122	s->len += ret;
 123
 124	return 1;
 125}
 126EXPORT_SYMBOL_GPL(trace_seq_printf);
 127
 128/**
 129 * trace_seq_vprintf - sequence printing of trace information
 130 * @s: trace sequence descriptor
 131 * @fmt: printf format string
 132 *
 133 * The tracer may use either sequence operations or its own
 134 * copy to user routines. To simplify formating of a trace
 135 * trace_seq_printf is used to store strings into a special
 136 * buffer (@s). Then the output may be either used by
 137 * the sequencer or pulled into another buffer.
 138 */
 139int
 140trace_seq_vprintf(struct trace_seq *s, const char *fmt, va_list args)
 141{
 142	int len = (PAGE_SIZE - 1) - s->len;
 143	int ret;
 144
 145	if (s->full || !len)
 146		return 0;
 147
 148	ret = vsnprintf(s->buffer + s->len, len, fmt, args);
 149
 150	/* If we can't write it all, don't bother writing anything */
 151	if (ret >= len) {
 152		s->full = 1;
 153		return 0;
 154	}
 155
 156	s->len += ret;
 157
 158	return len;
 159}
 160EXPORT_SYMBOL_GPL(trace_seq_vprintf);
 161
 162int trace_seq_bprintf(struct trace_seq *s, const char *fmt, const u32 *binary)
 163{
 164	int len = (PAGE_SIZE - 1) - s->len;
 165	int ret;
 166
 167	if (s->full || !len)
 168		return 0;
 169
 170	ret = bstr_printf(s->buffer + s->len, len, fmt, binary);
 171
 172	/* If we can't write it all, don't bother writing anything */
 173	if (ret >= len) {
 174		s->full = 1;
 175		return 0;
 176	}
 177
 178	s->len += ret;
 179
 180	return len;
 181}
 182
 183/**
 184 * trace_seq_puts - trace sequence printing of simple string
 185 * @s: trace sequence descriptor
 186 * @str: simple string to record
 187 *
 188 * The tracer may use either the sequence operations or its own
 189 * copy to user routines. This function records a simple string
 190 * into a special buffer (@s) for later retrieval by a sequencer
 191 * or other mechanism.
 192 */
 193int trace_seq_puts(struct trace_seq *s, const char *str)
 194{
 195	int len = strlen(str);
 196
 197	if (s->full)
 198		return 0;
 
 199
 200	if (len > ((PAGE_SIZE - 1) - s->len)) {
 201		s->full = 1;
 202		return 0;
 
 
 
 
 203	}
 204
 205	memcpy(s->buffer + s->len, str, len);
 206	s->len += len;
 207
 208	return len;
 209}
 210
 211int trace_seq_putc(struct trace_seq *s, unsigned char c)
 212{
 213	if (s->full)
 214		return 0;
 215
 216	if (s->len >= (PAGE_SIZE - 1)) {
 217		s->full = 1;
 218		return 0;
 219	}
 220
 221	s->buffer[s->len++] = c;
 222
 223	return 1;
 224}
 225EXPORT_SYMBOL(trace_seq_putc);
 226
 227int trace_seq_putmem(struct trace_seq *s, const void *mem, size_t len)
 
 
 228{
 229	if (s->full)
 230		return 0;
 231
 232	if (len > ((PAGE_SIZE - 1) - s->len)) {
 233		s->full = 1;
 234		return 0;
 235	}
 236
 237	memcpy(s->buffer + s->len, mem, len);
 238	s->len += len;
 239
 240	return len;
 241}
 242
 243int trace_seq_putmem_hex(struct trace_seq *s, const void *mem, size_t len)
 244{
 245	unsigned char hex[HEX_CHARS];
 246	const unsigned char *data = mem;
 247	int i, j;
 248
 249	if (s->full)
 250		return 0;
 251
 252#ifdef __BIG_ENDIAN
 253	for (i = 0, j = 0; i < len; i++) {
 254#else
 255	for (i = len-1, j = 0; i >= 0; i--) {
 256#endif
 257		hex[j++] = hex_asc_hi(data[i]);
 258		hex[j++] = hex_asc_lo(data[i]);
 259	}
 260	hex[j++] = ' ';
 261
 262	return trace_seq_putmem(s, hex, j);
 263}
 264
 265void *trace_seq_reserve(struct trace_seq *s, size_t len)
 266{
 267	void *ret;
 268
 269	if (s->full)
 270		return NULL;
 271
 272	if (len > ((PAGE_SIZE - 1) - s->len)) {
 273		s->full = 1;
 274		return NULL;
 275	}
 276
 277	ret = s->buffer + s->len;
 278	s->len += len;
 279
 280	return ret;
 281}
 
 282
 283int trace_seq_path(struct trace_seq *s, const struct path *path)
 284{
 285	unsigned char *p;
 286
 287	if (s->full)
 288		return 0;
 289
 290	if (s->len >= (PAGE_SIZE - 1)) {
 291		s->full = 1;
 292		return 0;
 293	}
 294
 295	p = d_path(path, s->buffer + s->len, PAGE_SIZE - s->len);
 296	if (!IS_ERR(p)) {
 297		p = mangle_path(s->buffer + s->len, p, "\n");
 298		if (p) {
 299			s->len = p - s->buffer;
 300			return 1;
 301		}
 302	} else {
 303		s->buffer[s->len++] = '?';
 304		return 1;
 305	}
 306
 307	s->full = 1;
 308	return 0;
 309}
 310
 311const char *
 312ftrace_print_flags_seq(struct trace_seq *p, const char *delim,
 313		       unsigned long flags,
 314		       const struct trace_print_flags *flag_array)
 315{
 316	unsigned long mask;
 317	const char *str;
 318	const char *ret = p->buffer + p->len;
 319	int i, first = 1;
 320
 321	for (i = 0;  flag_array[i].name && flags; i++) {
 322
 323		mask = flag_array[i].mask;
 324		if ((flags & mask) != mask)
 325			continue;
 326
 327		str = flag_array[i].name;
 328		flags &= ~mask;
 329		if (!first && delim)
 330			trace_seq_puts(p, delim);
 331		else
 332			first = 0;
 333		trace_seq_puts(p, str);
 334	}
 335
 336	/* check for left over flags */
 337	if (flags) {
 338		if (!first && delim)
 339			trace_seq_puts(p, delim);
 340		trace_seq_printf(p, "0x%lx", flags);
 341	}
 342
 343	trace_seq_putc(p, 0);
 344
 345	return ret;
 346}
 347EXPORT_SYMBOL(ftrace_print_flags_seq);
 348
 349const char *
 350ftrace_print_symbols_seq(struct trace_seq *p, unsigned long val,
 351			 const struct trace_print_flags *symbol_array)
 352{
 353	int i;
 354	const char *ret = p->buffer + p->len;
 355
 356	for (i = 0;  symbol_array[i].name; i++) {
 357
 358		if (val != symbol_array[i].mask)
 359			continue;
 360
 361		trace_seq_puts(p, symbol_array[i].name);
 362		break;
 363	}
 364
 365	if (ret == (const char *)(p->buffer + p->len))
 366		trace_seq_printf(p, "0x%lx", val);
 367		
 368	trace_seq_putc(p, 0);
 369
 370	return ret;
 371}
 372EXPORT_SYMBOL(ftrace_print_symbols_seq);
 
 373
 374#if BITS_PER_LONG == 32
 375const char *
 376ftrace_print_symbols_seq_u64(struct trace_seq *p, unsigned long long val,
 377			 const struct trace_print_flags_u64 *symbol_array)
 378{
 379	int i;
 380	const char *ret = p->buffer + p->len;
 381
 382	for (i = 0;  symbol_array[i].name; i++) {
 383
 384		if (val != symbol_array[i].mask)
 385			continue;
 386
 387		trace_seq_puts(p, symbol_array[i].name);
 388		break;
 389	}
 390
 391	if (ret == (const char *)(p->buffer + p->len))
 392		trace_seq_printf(p, "0x%llx", val);
 393
 
 394	trace_seq_putc(p, 0);
 395
 396	return ret;
 397}
 398EXPORT_SYMBOL(ftrace_print_symbols_seq_u64);
 399#endif
 400
 
 
 
 
 
 
 
 
 
 
 
 401const char *
 402ftrace_print_hex_seq(struct trace_seq *p, const unsigned char *buf, int buf_len)
 
 403{
 404	int i;
 405	const char *ret = p->buffer + p->len;
 406
 407	for (i = 0; i < buf_len; i++)
 408		trace_seq_printf(p, "%s%2.2x", i == 0 ? "" : " ", buf[i]);
 
 
 
 
 
 
 409
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 410	trace_seq_putc(p, 0);
 411
 412	return ret;
 413}
 414EXPORT_SYMBOL(ftrace_print_hex_seq);
 415
 416int ftrace_raw_output_prep(struct trace_iterator *iter,
 417			   struct trace_event *trace_event)
 418{
 419	struct ftrace_event_call *event;
 420	struct trace_seq *s = &iter->seq;
 421	struct trace_seq *p = &iter->tmp_seq;
 422	struct trace_entry *entry;
 423	int ret;
 424
 425	event = container_of(trace_event, struct ftrace_event_call, event);
 426	entry = iter->ent;
 427
 428	if (entry->type != event->event.type) {
 429		WARN_ON_ONCE(1);
 430		return TRACE_TYPE_UNHANDLED;
 431	}
 432
 433	trace_seq_init(p);
 434	ret = trace_seq_printf(s, "%s: ", ftrace_event_name(event));
 435	if (!ret)
 436		return TRACE_TYPE_PARTIAL_LINE;
 437
 438	return 0;
 439}
 440EXPORT_SYMBOL(ftrace_raw_output_prep);
 441
 442static int ftrace_output_raw(struct trace_iterator *iter, char *name,
 443			     char *fmt, va_list ap)
 444{
 445	struct trace_seq *s = &iter->seq;
 446	int ret;
 447
 448	ret = trace_seq_printf(s, "%s: ", name);
 449	if (!ret)
 450		return TRACE_TYPE_PARTIAL_LINE;
 451
 452	ret = trace_seq_vprintf(s, fmt, ap);
 
 453
 454	if (!ret)
 455		return TRACE_TYPE_PARTIAL_LINE;
 456
 457	return TRACE_TYPE_HANDLED;
 458}
 459
 460int ftrace_output_call(struct trace_iterator *iter, char *name, char *fmt, ...)
 461{
 462	va_list ap;
 463	int ret;
 464
 465	va_start(ap, fmt);
 466	ret = ftrace_output_raw(iter, name, fmt, ap);
 467	va_end(ap);
 468
 469	return ret;
 470}
 471EXPORT_SYMBOL_GPL(ftrace_output_call);
 472
 473#ifdef CONFIG_KRETPROBES
 474static inline const char *kretprobed(const char *name)
 475{
 476	static const char tramp_name[] = "kretprobe_trampoline";
 477	int size = sizeof(tramp_name);
 478
 479	if (strncmp(tramp_name, name, size) == 0)
 480		return "[unknown/kretprobe'd]";
 481	return name;
 482}
 483#else
 484static inline const char *kretprobed(const char *name)
 485{
 486	return name;
 487}
 488#endif /* CONFIG_KRETPROBES */
 489
 490static int
 491seq_print_sym_short(struct trace_seq *s, const char *fmt, unsigned long address)
 492{
 493#ifdef CONFIG_KALLSYMS
 494	char str[KSYM_SYMBOL_LEN];
 
 495	const char *name;
 496
 497	kallsyms_lookup(address, NULL, NULL, NULL, str);
 498
 499	name = kretprobed(str);
 500
 501	return trace_seq_printf(s, fmt, name);
 
 
 
 502#endif
 503	return 1;
 
 504}
 505
 506static int
 507seq_print_sym_offset(struct trace_seq *s, const char *fmt,
 508		     unsigned long address)
 509{
 510#ifdef CONFIG_KALLSYMS
 511	char str[KSYM_SYMBOL_LEN];
 
 512	const char *name;
 513
 514	sprint_symbol(str, address);
 515	name = kretprobed(str);
 516
 517	return trace_seq_printf(s, fmt, name);
 
 
 
 518#endif
 519	return 1;
 
 520}
 521
 522#ifndef CONFIG_64BIT
 523# define IP_FMT "%08lx"
 524#else
 525# define IP_FMT "%016lx"
 526#endif
 527
 528int seq_print_user_ip(struct trace_seq *s, struct mm_struct *mm,
 529		      unsigned long ip, unsigned long sym_flags)
 530{
 531	struct file *file = NULL;
 532	unsigned long vmstart = 0;
 533	int ret = 1;
 534
 535	if (s->full)
 536		return 0;
 537
 538	if (mm) {
 539		const struct vm_area_struct *vma;
 540
 541		down_read(&mm->mmap_sem);
 542		vma = find_vma(mm, ip);
 543		if (vma) {
 544			file = vma->vm_file;
 545			vmstart = vma->vm_start;
 546		}
 547		if (file) {
 548			ret = trace_seq_path(s, &file->f_path);
 549			if (ret)
 550				ret = trace_seq_printf(s, "[+0x%lx]",
 551						       ip - vmstart);
 552		}
 553		up_read(&mm->mmap_sem);
 554	}
 555	if (ret && ((sym_flags & TRACE_ITER_SYM_ADDR) || !file))
 556		ret = trace_seq_printf(s, " <" IP_FMT ">", ip);
 557	return ret;
 558}
 559
 560int
 561seq_print_userip_objs(const struct userstack_entry *entry, struct trace_seq *s,
 562		      unsigned long sym_flags)
 563{
 564	struct mm_struct *mm = NULL;
 565	int ret = 1;
 566	unsigned int i;
 567
 568	if (trace_flags & TRACE_ITER_SYM_USEROBJ) {
 569		struct task_struct *task;
 570		/*
 571		 * we do the lookup on the thread group leader,
 572		 * since individual threads might have already quit!
 573		 */
 574		rcu_read_lock();
 575		task = find_task_by_vpid(entry->tgid);
 576		if (task)
 577			mm = get_task_mm(task);
 578		rcu_read_unlock();
 579	}
 580
 581	for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
 582		unsigned long ip = entry->caller[i];
 583
 584		if (ip == ULONG_MAX || !ret)
 585			break;
 586		if (ret)
 587			ret = trace_seq_puts(s, " => ");
 588		if (!ip) {
 589			if (ret)
 590				ret = trace_seq_puts(s, "??");
 591			if (ret)
 592				ret = trace_seq_putc(s, '\n');
 593			continue;
 594		}
 595		if (!ret)
 596			break;
 597		if (ret)
 598			ret = seq_print_user_ip(s, mm, ip, sym_flags);
 599		ret = trace_seq_putc(s, '\n');
 600	}
 601
 602	if (mm)
 603		mmput(mm);
 604	return ret;
 605}
 606
 607int
 608seq_print_ip_sym(struct trace_seq *s, unsigned long ip, unsigned long sym_flags)
 609{
 610	int ret;
 611
 612	if (!ip)
 613		return trace_seq_putc(s, '0');
 614
 615	if (sym_flags & TRACE_ITER_SYM_OFFSET)
 616		ret = seq_print_sym_offset(s, "%s", ip);
 617	else
 618		ret = seq_print_sym_short(s, "%s", ip);
 619
 620	if (!ret)
 621		return 0;
 622
 623	if (sym_flags & TRACE_ITER_SYM_ADDR)
 624		ret = trace_seq_printf(s, " <" IP_FMT ">", ip);
 625	return ret;
 
 
 626}
 627
 628/**
 629 * trace_print_lat_fmt - print the irq, preempt and lockdep fields
 630 * @s: trace seq struct to write to
 631 * @entry: The trace entry field from the ring buffer
 632 *
 633 * Prints the generic fields of irqs off, in hard or softirq, preempt
 634 * count.
 635 */
 636int trace_print_lat_fmt(struct trace_seq *s, struct trace_entry *entry)
 637{
 638	char hardsoft_irq;
 639	char need_resched;
 640	char irqs_off;
 641	int hardirq;
 642	int softirq;
 643	int ret;
 644
 
 645	hardirq = entry->flags & TRACE_FLAG_HARDIRQ;
 646	softirq = entry->flags & TRACE_FLAG_SOFTIRQ;
 647
 648	irqs_off =
 649		(entry->flags & TRACE_FLAG_IRQS_OFF) ? 'd' :
 650		(entry->flags & TRACE_FLAG_IRQS_NOSUPPORT) ? 'X' :
 651		'.';
 652
 653	switch (entry->flags & (TRACE_FLAG_NEED_RESCHED |
 654				TRACE_FLAG_PREEMPT_RESCHED)) {
 655	case TRACE_FLAG_NEED_RESCHED | TRACE_FLAG_PREEMPT_RESCHED:
 656		need_resched = 'N';
 657		break;
 658	case TRACE_FLAG_NEED_RESCHED:
 659		need_resched = 'n';
 660		break;
 661	case TRACE_FLAG_PREEMPT_RESCHED:
 662		need_resched = 'p';
 663		break;
 664	default:
 665		need_resched = '.';
 666		break;
 667	}
 668
 669	hardsoft_irq =
 
 
 670		(hardirq && softirq) ? 'H' :
 671		hardirq ? 'h' :
 672		softirq ? 's' :
 673		'.';
 674
 675	if (!trace_seq_printf(s, "%c%c%c",
 676			      irqs_off, need_resched, hardsoft_irq))
 677		return 0;
 678
 679	if (entry->preempt_count)
 680		ret = trace_seq_printf(s, "%x", entry->preempt_count);
 681	else
 682		ret = trace_seq_putc(s, '.');
 683
 684	return ret;
 685}
 686
 687static int
 688lat_print_generic(struct trace_seq *s, struct trace_entry *entry, int cpu)
 689{
 690	char comm[TASK_COMM_LEN];
 691
 692	trace_find_cmdline(entry->pid, comm);
 693
 694	if (!trace_seq_printf(s, "%8.8s-%-5d %3d",
 695			      comm, entry->pid, cpu))
 696		return 0;
 697
 698	return trace_print_lat_fmt(s, entry);
 699}
 700
 701static unsigned long preempt_mark_thresh_us = 100;
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 702
 703static int
 704lat_print_timestamp(struct trace_iterator *iter, u64 next_ts)
 705{
 706	unsigned long verbose = trace_flags & TRACE_ITER_VERBOSE;
 
 707	unsigned long in_ns = iter->iter_flags & TRACE_FILE_TIME_IN_NS;
 708	unsigned long long abs_ts = iter->ts - iter->trace_buffer->time_start;
 709	unsigned long long rel_ts = next_ts - iter->ts;
 710	struct trace_seq *s = &iter->seq;
 711
 712	if (in_ns) {
 713		abs_ts = ns2usecs(abs_ts);
 714		rel_ts = ns2usecs(rel_ts);
 715	}
 716
 717	if (verbose && in_ns) {
 718		unsigned long abs_usec = do_div(abs_ts, USEC_PER_MSEC);
 719		unsigned long abs_msec = (unsigned long)abs_ts;
 720		unsigned long rel_usec = do_div(rel_ts, USEC_PER_MSEC);
 721		unsigned long rel_msec = (unsigned long)rel_ts;
 722
 723		return trace_seq_printf(
 724				s, "[%08llx] %ld.%03ldms (+%ld.%03ldms): ",
 725				ns2usecs(iter->ts),
 726				abs_msec, abs_usec,
 727				rel_msec, rel_usec);
 
 728	} else if (verbose && !in_ns) {
 729		return trace_seq_printf(
 730				s, "[%016llx] %lld (+%lld): ",
 731				iter->ts, abs_ts, rel_ts);
 
 732	} else if (!verbose && in_ns) {
 733		return trace_seq_printf(
 734				s, " %4lldus%c: ",
 735				abs_ts,
 736				rel_ts > preempt_mark_thresh_us ? '!' :
 737				  rel_ts > 1 ? '+' : ' ');
 738	} else { /* !verbose && !in_ns */
 739		return trace_seq_printf(s, " %4lld: ", abs_ts);
 740	}
 
 
 741}
 742
 743int trace_print_context(struct trace_iterator *iter)
 744{
 
 745	struct trace_seq *s = &iter->seq;
 746	struct trace_entry *entry = iter->ent;
 747	unsigned long long t;
 748	unsigned long secs, usec_rem;
 749	char comm[TASK_COMM_LEN];
 750	int ret;
 751
 752	trace_find_cmdline(entry->pid, comm);
 753
 754	ret = trace_seq_printf(s, "%16s-%-5d [%03d] ",
 755			       comm, entry->pid, iter->cpu);
 756	if (!ret)
 757		return 0;
 758
 759	if (trace_flags & TRACE_ITER_IRQ_INFO) {
 760		ret = trace_print_lat_fmt(s, entry);
 761		if (!ret)
 762			return 0;
 
 
 
 763	}
 764
 
 
 
 765	if (iter->iter_flags & TRACE_FILE_TIME_IN_NS) {
 766		t = ns2usecs(iter->ts);
 767		usec_rem = do_div(t, USEC_PER_SEC);
 768		secs = (unsigned long)t;
 769		return trace_seq_printf(s, " %5lu.%06lu: ", secs, usec_rem);
 770	} else
 771		return trace_seq_printf(s, " %12llu: ", iter->ts);
 
 
 772}
 773
 774int trace_print_lat_context(struct trace_iterator *iter)
 775{
 776	u64 next_ts;
 777	int ret;
 778	/* trace_find_next_entry will reset ent_size */
 779	int ent_size = iter->ent_size;
 780	struct trace_seq *s = &iter->seq;
 
 781	struct trace_entry *entry = iter->ent,
 782			   *next_entry = trace_find_next_entry(iter, NULL,
 783							       &next_ts);
 784	unsigned long verbose = (trace_flags & TRACE_ITER_VERBOSE);
 785
 786	/* Restore the original ent_size */
 787	iter->ent_size = ent_size;
 788
 789	if (!next_entry)
 790		next_ts = iter->ts;
 791
 792	if (verbose) {
 793		char comm[TASK_COMM_LEN];
 794
 795		trace_find_cmdline(entry->pid, comm);
 796
 797		ret = trace_seq_printf(
 798				s, "%16s %5d %3d %d %08x %08lx ",
 799				comm, entry->pid, iter->cpu, entry->flags,
 800				entry->preempt_count, iter->idx);
 801	} else {
 802		ret = lat_print_generic(s, entry, iter->cpu);
 803	}
 804
 805	if (ret)
 806		ret = lat_print_timestamp(iter, next_ts);
 807
 808	return ret;
 809}
 810
 811static const char state_to_char[] = TASK_STATE_TO_CHAR_STR;
 812
 813static int task_state_char(unsigned long state)
 814{
 815	int bit = state ? __ffs(state) + 1 : 0;
 816
 817	return bit < sizeof(state_to_char) - 1 ? state_to_char[bit] : '?';
 818}
 819
 820/**
 821 * ftrace_find_event - find a registered event
 822 * @type: the type of event to look for
 823 *
 824 * Returns an event of type @type otherwise NULL
 825 * Called with trace_event_read_lock() held.
 826 */
 827struct trace_event *ftrace_find_event(int type)
 828{
 829	struct trace_event *event;
 830	unsigned key;
 831
 832	key = type & (EVENT_HASHSIZE - 1);
 833
 834	hlist_for_each_entry(event, &event_hash[key], node) {
 835		if (event->type == type)
 836			return event;
 837	}
 838
 839	return NULL;
 840}
 841
 842static LIST_HEAD(ftrace_event_list);
 843
 844static int trace_search_list(struct list_head **list)
 845{
 846	struct trace_event *e;
 847	int last = __TRACE_LAST_TYPE;
 848
 849	if (list_empty(&ftrace_event_list)) {
 850		*list = &ftrace_event_list;
 851		return last + 1;
 852	}
 853
 854	/*
 855	 * We used up all possible max events,
 856	 * lets see if somebody freed one.
 857	 */
 858	list_for_each_entry(e, &ftrace_event_list, list) {
 859		if (e->type != last + 1)
 860			break;
 861		last++;
 862	}
 863
 864	/* Did we used up all 65 thousand events??? */
 865	if ((last + 1) > FTRACE_MAX_EVENT)
 866		return 0;
 867
 868	*list = &e->list;
 869	return last + 1;
 870}
 871
 872void trace_event_read_lock(void)
 873{
 874	down_read(&trace_event_sem);
 875}
 876
 877void trace_event_read_unlock(void)
 878{
 879	up_read(&trace_event_sem);
 880}
 881
 882/**
 883 * register_ftrace_event - register output for an event type
 884 * @event: the event type to register
 885 *
 886 * Event types are stored in a hash and this hash is used to
 887 * find a way to print an event. If the @event->type is set
 888 * then it will use that type, otherwise it will assign a
 889 * type to use.
 890 *
 891 * If you assign your own type, please make sure it is added
 892 * to the trace_type enum in trace.h, to avoid collisions
 893 * with the dynamic types.
 894 *
 895 * Returns the event type number or zero on error.
 896 */
 897int register_ftrace_event(struct trace_event *event)
 898{
 899	unsigned key;
 900	int ret = 0;
 901
 902	down_write(&trace_event_sem);
 903
 904	if (WARN_ON(!event))
 905		goto out;
 906
 907	if (WARN_ON(!event->funcs))
 908		goto out;
 909
 910	INIT_LIST_HEAD(&event->list);
 911
 912	if (!event->type) {
 913		struct list_head *list = NULL;
 914
 915		if (next_event_type > FTRACE_MAX_EVENT) {
 916
 917			event->type = trace_search_list(&list);
 918			if (!event->type)
 919				goto out;
 920
 921		} else {
 922			
 923			event->type = next_event_type++;
 924			list = &ftrace_event_list;
 925		}
 926
 927		if (WARN_ON(ftrace_find_event(event->type)))
 928			goto out;
 929
 930		list_add_tail(&event->list, list);
 931
 932	} else if (event->type > __TRACE_LAST_TYPE) {
 933		printk(KERN_WARNING "Need to add type to trace.h\n");
 934		WARN_ON(1);
 935		goto out;
 936	} else {
 937		/* Is this event already used */
 938		if (ftrace_find_event(event->type))
 939			goto out;
 940	}
 941
 942	if (event->funcs->trace == NULL)
 943		event->funcs->trace = trace_nop_print;
 944	if (event->funcs->raw == NULL)
 945		event->funcs->raw = trace_nop_print;
 946	if (event->funcs->hex == NULL)
 947		event->funcs->hex = trace_nop_print;
 948	if (event->funcs->binary == NULL)
 949		event->funcs->binary = trace_nop_print;
 950
 951	key = event->type & (EVENT_HASHSIZE - 1);
 952
 953	hlist_add_head(&event->node, &event_hash[key]);
 954
 955	ret = event->type;
 956 out:
 957	up_write(&trace_event_sem);
 958
 959	return ret;
 960}
 961EXPORT_SYMBOL_GPL(register_ftrace_event);
 962
 963/*
 964 * Used by module code with the trace_event_sem held for write.
 965 */
 966int __unregister_ftrace_event(struct trace_event *event)
 967{
 968	hlist_del(&event->node);
 969	list_del(&event->list);
 970	return 0;
 971}
 972
 973/**
 974 * unregister_ftrace_event - remove a no longer used event
 975 * @event: the event to remove
 976 */
 977int unregister_ftrace_event(struct trace_event *event)
 978{
 979	down_write(&trace_event_sem);
 980	__unregister_ftrace_event(event);
 981	up_write(&trace_event_sem);
 982
 983	return 0;
 984}
 985EXPORT_SYMBOL_GPL(unregister_ftrace_event);
 986
 987/*
 988 * Standard events
 989 */
 990
 991enum print_line_t trace_nop_print(struct trace_iterator *iter, int flags,
 992				  struct trace_event *event)
 993{
 994	if (!trace_seq_printf(&iter->seq, "type: %d\n", iter->ent->type))
 995		return TRACE_TYPE_PARTIAL_LINE;
 996
 997	return TRACE_TYPE_HANDLED;
 998}
 999
1000/* TRACE_FN */
1001static enum print_line_t trace_fn_trace(struct trace_iterator *iter, int flags,
1002					struct trace_event *event)
1003{
1004	struct ftrace_entry *field;
1005	struct trace_seq *s = &iter->seq;
1006
1007	trace_assign_type(field, iter->ent);
1008
1009	if (!seq_print_ip_sym(s, field->ip, flags))
1010		goto partial;
1011
1012	if ((flags & TRACE_ITER_PRINT_PARENT) && field->parent_ip) {
1013		if (!trace_seq_puts(s, " <-"))
1014			goto partial;
1015		if (!seq_print_ip_sym(s,
1016				      field->parent_ip,
1017				      flags))
1018			goto partial;
1019	}
1020	if (!trace_seq_putc(s, '\n'))
1021		goto partial;
1022
1023	return TRACE_TYPE_HANDLED;
1024
1025 partial:
1026	return TRACE_TYPE_PARTIAL_LINE;
1027}
1028
1029static enum print_line_t trace_fn_raw(struct trace_iterator *iter, int flags,
1030				      struct trace_event *event)
1031{
1032	struct ftrace_entry *field;
1033
1034	trace_assign_type(field, iter->ent);
1035
1036	if (!trace_seq_printf(&iter->seq, "%lx %lx\n",
1037			      field->ip,
1038			      field->parent_ip))
1039		return TRACE_TYPE_PARTIAL_LINE;
1040
1041	return TRACE_TYPE_HANDLED;
1042}
1043
1044static enum print_line_t trace_fn_hex(struct trace_iterator *iter, int flags,
1045				      struct trace_event *event)
1046{
1047	struct ftrace_entry *field;
1048	struct trace_seq *s = &iter->seq;
1049
1050	trace_assign_type(field, iter->ent);
1051
1052	SEQ_PUT_HEX_FIELD_RET(s, field->ip);
1053	SEQ_PUT_HEX_FIELD_RET(s, field->parent_ip);
1054
1055	return TRACE_TYPE_HANDLED;
1056}
1057
1058static enum print_line_t trace_fn_bin(struct trace_iterator *iter, int flags,
1059				      struct trace_event *event)
1060{
1061	struct ftrace_entry *field;
1062	struct trace_seq *s = &iter->seq;
1063
1064	trace_assign_type(field, iter->ent);
1065
1066	SEQ_PUT_FIELD_RET(s, field->ip);
1067	SEQ_PUT_FIELD_RET(s, field->parent_ip);
1068
1069	return TRACE_TYPE_HANDLED;
1070}
1071
1072static struct trace_event_functions trace_fn_funcs = {
1073	.trace		= trace_fn_trace,
1074	.raw		= trace_fn_raw,
1075	.hex		= trace_fn_hex,
1076	.binary		= trace_fn_bin,
1077};
1078
1079static struct trace_event trace_fn_event = {
1080	.type		= TRACE_FN,
1081	.funcs		= &trace_fn_funcs,
1082};
1083
1084/* TRACE_CTX an TRACE_WAKE */
1085static enum print_line_t trace_ctxwake_print(struct trace_iterator *iter,
1086					     char *delim)
1087{
1088	struct ctx_switch_entry *field;
1089	char comm[TASK_COMM_LEN];
1090	int S, T;
1091
1092
1093	trace_assign_type(field, iter->ent);
1094
1095	T = task_state_char(field->next_state);
1096	S = task_state_char(field->prev_state);
1097	trace_find_cmdline(field->next_pid, comm);
1098	if (!trace_seq_printf(&iter->seq,
1099			      " %5d:%3d:%c %s [%03d] %5d:%3d:%c %s\n",
1100			      field->prev_pid,
1101			      field->prev_prio,
1102			      S, delim,
1103			      field->next_cpu,
1104			      field->next_pid,
1105			      field->next_prio,
1106			      T, comm))
1107		return TRACE_TYPE_PARTIAL_LINE;
1108
1109	return TRACE_TYPE_HANDLED;
1110}
1111
1112static enum print_line_t trace_ctx_print(struct trace_iterator *iter, int flags,
1113					 struct trace_event *event)
1114{
1115	return trace_ctxwake_print(iter, "==>");
1116}
1117
1118static enum print_line_t trace_wake_print(struct trace_iterator *iter,
1119					  int flags, struct trace_event *event)
1120{
1121	return trace_ctxwake_print(iter, "  +");
1122}
1123
1124static int trace_ctxwake_raw(struct trace_iterator *iter, char S)
1125{
1126	struct ctx_switch_entry *field;
1127	int T;
1128
1129	trace_assign_type(field, iter->ent);
1130
1131	if (!S)
1132		S = task_state_char(field->prev_state);
1133	T = task_state_char(field->next_state);
1134	if (!trace_seq_printf(&iter->seq, "%d %d %c %d %d %d %c\n",
1135			      field->prev_pid,
1136			      field->prev_prio,
1137			      S,
1138			      field->next_cpu,
1139			      field->next_pid,
1140			      field->next_prio,
1141			      T))
1142		return TRACE_TYPE_PARTIAL_LINE;
1143
1144	return TRACE_TYPE_HANDLED;
1145}
1146
1147static enum print_line_t trace_ctx_raw(struct trace_iterator *iter, int flags,
1148				       struct trace_event *event)
1149{
1150	return trace_ctxwake_raw(iter, 0);
1151}
1152
1153static enum print_line_t trace_wake_raw(struct trace_iterator *iter, int flags,
1154					struct trace_event *event)
1155{
1156	return trace_ctxwake_raw(iter, '+');
1157}
1158
1159
1160static int trace_ctxwake_hex(struct trace_iterator *iter, char S)
1161{
1162	struct ctx_switch_entry *field;
1163	struct trace_seq *s = &iter->seq;
1164	int T;
1165
1166	trace_assign_type(field, iter->ent);
1167
1168	if (!S)
1169		S = task_state_char(field->prev_state);
1170	T = task_state_char(field->next_state);
1171
1172	SEQ_PUT_HEX_FIELD_RET(s, field->prev_pid);
1173	SEQ_PUT_HEX_FIELD_RET(s, field->prev_prio);
1174	SEQ_PUT_HEX_FIELD_RET(s, S);
1175	SEQ_PUT_HEX_FIELD_RET(s, field->next_cpu);
1176	SEQ_PUT_HEX_FIELD_RET(s, field->next_pid);
1177	SEQ_PUT_HEX_FIELD_RET(s, field->next_prio);
1178	SEQ_PUT_HEX_FIELD_RET(s, T);
1179
1180	return TRACE_TYPE_HANDLED;
1181}
1182
1183static enum print_line_t trace_ctx_hex(struct trace_iterator *iter, int flags,
1184				       struct trace_event *event)
1185{
1186	return trace_ctxwake_hex(iter, 0);
1187}
1188
1189static enum print_line_t trace_wake_hex(struct trace_iterator *iter, int flags,
1190					struct trace_event *event)
1191{
1192	return trace_ctxwake_hex(iter, '+');
1193}
1194
1195static enum print_line_t trace_ctxwake_bin(struct trace_iterator *iter,
1196					   int flags, struct trace_event *event)
1197{
1198	struct ctx_switch_entry *field;
1199	struct trace_seq *s = &iter->seq;
1200
1201	trace_assign_type(field, iter->ent);
1202
1203	SEQ_PUT_FIELD_RET(s, field->prev_pid);
1204	SEQ_PUT_FIELD_RET(s, field->prev_prio);
1205	SEQ_PUT_FIELD_RET(s, field->prev_state);
1206	SEQ_PUT_FIELD_RET(s, field->next_pid);
1207	SEQ_PUT_FIELD_RET(s, field->next_prio);
1208	SEQ_PUT_FIELD_RET(s, field->next_state);
 
1209
1210	return TRACE_TYPE_HANDLED;
1211}
1212
1213static struct trace_event_functions trace_ctx_funcs = {
1214	.trace		= trace_ctx_print,
1215	.raw		= trace_ctx_raw,
1216	.hex		= trace_ctx_hex,
1217	.binary		= trace_ctxwake_bin,
1218};
1219
1220static struct trace_event trace_ctx_event = {
1221	.type		= TRACE_CTX,
1222	.funcs		= &trace_ctx_funcs,
1223};
1224
1225static struct trace_event_functions trace_wake_funcs = {
1226	.trace		= trace_wake_print,
1227	.raw		= trace_wake_raw,
1228	.hex		= trace_wake_hex,
1229	.binary		= trace_ctxwake_bin,
1230};
1231
1232static struct trace_event trace_wake_event = {
1233	.type		= TRACE_WAKE,
1234	.funcs		= &trace_wake_funcs,
1235};
1236
1237/* TRACE_STACK */
1238
1239static enum print_line_t trace_stack_print(struct trace_iterator *iter,
1240					   int flags, struct trace_event *event)
1241{
1242	struct stack_entry *field;
1243	struct trace_seq *s = &iter->seq;
1244	unsigned long *p;
1245	unsigned long *end;
1246
1247	trace_assign_type(field, iter->ent);
1248	end = (unsigned long *)((long)iter->ent + iter->ent_size);
1249
1250	if (!trace_seq_puts(s, "<stack trace>\n"))
1251		goto partial;
1252
1253	for (p = field->caller; p && *p != ULONG_MAX && p < end; p++) {
1254		if (!trace_seq_puts(s, " => "))
1255			goto partial;
1256
1257		if (!seq_print_ip_sym(s, *p, flags))
1258			goto partial;
1259		if (!trace_seq_putc(s, '\n'))
1260			goto partial;
1261	}
1262
1263	return TRACE_TYPE_HANDLED;
 
 
 
1264
1265 partial:
1266	return TRACE_TYPE_PARTIAL_LINE;
1267}
1268
1269static struct trace_event_functions trace_stack_funcs = {
1270	.trace		= trace_stack_print,
1271};
1272
1273static struct trace_event trace_stack_event = {
1274	.type		= TRACE_STACK,
1275	.funcs		= &trace_stack_funcs,
1276};
1277
1278/* TRACE_USER_STACK */
1279static enum print_line_t trace_user_stack_print(struct trace_iterator *iter,
1280						int flags, struct trace_event *event)
1281{
 
1282	struct userstack_entry *field;
1283	struct trace_seq *s = &iter->seq;
 
 
1284
1285	trace_assign_type(field, iter->ent);
1286
1287	if (!trace_seq_puts(s, "<user stack trace>\n"))
1288		goto partial;
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
1289
1290	if (!seq_print_userip_objs(field, s, flags))
1291		goto partial;
 
 
 
1292
1293	return TRACE_TYPE_HANDLED;
 
 
1294
1295 partial:
1296	return TRACE_TYPE_PARTIAL_LINE;
 
 
1297}
1298
1299static struct trace_event_functions trace_user_stack_funcs = {
1300	.trace		= trace_user_stack_print,
1301};
1302
1303static struct trace_event trace_user_stack_event = {
1304	.type		= TRACE_USER_STACK,
1305	.funcs		= &trace_user_stack_funcs,
1306};
1307
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
1308/* TRACE_BPUTS */
1309static enum print_line_t
1310trace_bputs_print(struct trace_iterator *iter, int flags,
1311		   struct trace_event *event)
1312{
1313	struct trace_entry *entry = iter->ent;
1314	struct trace_seq *s = &iter->seq;
1315	struct bputs_entry *field;
1316
1317	trace_assign_type(field, entry);
1318
1319	if (!seq_print_ip_sym(s, field->ip, flags))
1320		goto partial;
1321
1322	if (!trace_seq_puts(s, ": "))
1323		goto partial;
1324
1325	if (!trace_seq_puts(s, field->str))
1326		goto partial;
1327
1328	return TRACE_TYPE_HANDLED;
1329
1330 partial:
1331	return TRACE_TYPE_PARTIAL_LINE;
1332}
1333
1334
1335static enum print_line_t
1336trace_bputs_raw(struct trace_iterator *iter, int flags,
1337		struct trace_event *event)
1338{
1339	struct bputs_entry *field;
1340	struct trace_seq *s = &iter->seq;
1341
1342	trace_assign_type(field, iter->ent);
1343
1344	if (!trace_seq_printf(s, ": %lx : ", field->ip))
1345		goto partial;
1346
1347	if (!trace_seq_puts(s, field->str))
1348		goto partial;
1349
1350	return TRACE_TYPE_HANDLED;
1351
1352 partial:
1353	return TRACE_TYPE_PARTIAL_LINE;
1354}
1355
1356static struct trace_event_functions trace_bputs_funcs = {
1357	.trace		= trace_bputs_print,
1358	.raw		= trace_bputs_raw,
1359};
1360
1361static struct trace_event trace_bputs_event = {
1362	.type		= TRACE_BPUTS,
1363	.funcs		= &trace_bputs_funcs,
1364};
1365
1366/* TRACE_BPRINT */
1367static enum print_line_t
1368trace_bprint_print(struct trace_iterator *iter, int flags,
1369		   struct trace_event *event)
1370{
1371	struct trace_entry *entry = iter->ent;
1372	struct trace_seq *s = &iter->seq;
1373	struct bprint_entry *field;
1374
1375	trace_assign_type(field, entry);
1376
1377	if (!seq_print_ip_sym(s, field->ip, flags))
1378		goto partial;
1379
1380	if (!trace_seq_puts(s, ": "))
1381		goto partial;
1382
1383	if (!trace_seq_bprintf(s, field->fmt, field->buf))
1384		goto partial;
1385
1386	return TRACE_TYPE_HANDLED;
1387
1388 partial:
1389	return TRACE_TYPE_PARTIAL_LINE;
1390}
1391
1392
1393static enum print_line_t
1394trace_bprint_raw(struct trace_iterator *iter, int flags,
1395		 struct trace_event *event)
1396{
1397	struct bprint_entry *field;
1398	struct trace_seq *s = &iter->seq;
1399
1400	trace_assign_type(field, iter->ent);
1401
1402	if (!trace_seq_printf(s, ": %lx : ", field->ip))
1403		goto partial;
1404
1405	if (!trace_seq_bprintf(s, field->fmt, field->buf))
1406		goto partial;
1407
1408	return TRACE_TYPE_HANDLED;
1409
1410 partial:
1411	return TRACE_TYPE_PARTIAL_LINE;
1412}
1413
1414static struct trace_event_functions trace_bprint_funcs = {
1415	.trace		= trace_bprint_print,
1416	.raw		= trace_bprint_raw,
1417};
1418
1419static struct trace_event trace_bprint_event = {
1420	.type		= TRACE_BPRINT,
1421	.funcs		= &trace_bprint_funcs,
1422};
1423
1424/* TRACE_PRINT */
1425static enum print_line_t trace_print_print(struct trace_iterator *iter,
1426					   int flags, struct trace_event *event)
1427{
1428	struct print_entry *field;
1429	struct trace_seq *s = &iter->seq;
1430
1431	trace_assign_type(field, iter->ent);
1432
1433	if (!seq_print_ip_sym(s, field->ip, flags))
1434		goto partial;
1435
1436	if (!trace_seq_printf(s, ": %s", field->buf))
1437		goto partial;
1438
1439	return TRACE_TYPE_HANDLED;
1440
1441 partial:
1442	return TRACE_TYPE_PARTIAL_LINE;
1443}
1444
1445static enum print_line_t trace_print_raw(struct trace_iterator *iter, int flags,
1446					 struct trace_event *event)
1447{
1448	struct print_entry *field;
1449
1450	trace_assign_type(field, iter->ent);
1451
1452	if (!trace_seq_printf(&iter->seq, "# %lx %s", field->ip, field->buf))
1453		goto partial;
1454
1455	return TRACE_TYPE_HANDLED;
1456
1457 partial:
1458	return TRACE_TYPE_PARTIAL_LINE;
1459}
1460
1461static struct trace_event_functions trace_print_funcs = {
1462	.trace		= trace_print_print,
1463	.raw		= trace_print_raw,
1464};
1465
1466static struct trace_event trace_print_event = {
1467	.type	 	= TRACE_PRINT,
1468	.funcs		= &trace_print_funcs,
1469};
1470
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
1471
1472static struct trace_event *events[] __initdata = {
1473	&trace_fn_event,
1474	&trace_ctx_event,
1475	&trace_wake_event,
1476	&trace_stack_event,
1477	&trace_user_stack_event,
1478	&trace_bputs_event,
1479	&trace_bprint_event,
1480	&trace_print_event,
 
 
1481	NULL
1482};
1483
1484__init static int init_events(void)
1485{
1486	struct trace_event *event;
1487	int i, ret;
1488
1489	for (i = 0; events[i]; i++) {
1490		event = events[i];
1491
1492		ret = register_ftrace_event(event);
1493		if (!ret) {
1494			printk(KERN_WARNING "event %d failed to register\n",
1495			       event->type);
1496			WARN_ON_ONCE(1);
1497		}
1498	}
1499
1500	return 0;
1501}
1502early_initcall(init_events);
v4.17
   1/*
   2 * trace_output.c
   3 *
   4 * Copyright (C) 2008 Red Hat Inc, Steven Rostedt <srostedt@redhat.com>
   5 *
   6 */
 
   7#include <linux/module.h>
   8#include <linux/mutex.h>
   9#include <linux/ftrace.h>
  10#include <linux/sched/clock.h>
  11#include <linux/sched/mm.h>
  12
  13#include "trace_output.h"
  14
  15/* must be a power of 2 */
  16#define EVENT_HASHSIZE	128
  17
  18DECLARE_RWSEM(trace_event_sem);
  19
  20static struct hlist_head event_hash[EVENT_HASHSIZE] __read_mostly;
  21
  22static int next_event_type = __TRACE_LAST_TYPE + 1;
  23
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
  24enum print_line_t trace_print_bputs_msg_only(struct trace_iterator *iter)
  25{
  26	struct trace_seq *s = &iter->seq;
  27	struct trace_entry *entry = iter->ent;
  28	struct bputs_entry *field;
 
  29
  30	trace_assign_type(field, entry);
  31
  32	trace_seq_puts(s, field->str);
 
 
  33
  34	return trace_handle_return(s);
  35}
  36
  37enum print_line_t trace_print_bprintk_msg_only(struct trace_iterator *iter)
  38{
  39	struct trace_seq *s = &iter->seq;
  40	struct trace_entry *entry = iter->ent;
  41	struct bprint_entry *field;
 
  42
  43	trace_assign_type(field, entry);
  44
  45	trace_seq_bprintf(s, field->fmt, field->buf);
 
 
  46
  47	return trace_handle_return(s);
  48}
  49
  50enum print_line_t trace_print_printk_msg_only(struct trace_iterator *iter)
  51{
  52	struct trace_seq *s = &iter->seq;
  53	struct trace_entry *entry = iter->ent;
  54	struct print_entry *field;
 
  55
  56	trace_assign_type(field, entry);
  57
  58	trace_seq_puts(s, field->buf);
 
 
  59
  60	return trace_handle_return(s);
  61}
  62
  63const char *
  64trace_print_flags_seq(struct trace_seq *p, const char *delim,
  65		      unsigned long flags,
  66		      const struct trace_print_flags *flag_array)
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
  67{
  68	unsigned long mask;
  69	const char *str;
  70	const char *ret = trace_seq_buffer_ptr(p);
  71	int i, first = 1;
 
 
 
 
 
 
 
 
 
 
 
 
 
 
  72
  73	for (i = 0;  flag_array[i].name && flags; i++) {
 
 
 
 
 
 
 
 
 
 
 
 
  74
  75		mask = flag_array[i].mask;
  76		if ((flags & mask) != mask)
  77			continue;
  78
  79		str = flag_array[i].name;
  80		flags &= ~mask;
  81		if (!first && delim)
  82			trace_seq_puts(p, delim);
  83		else
  84			first = 0;
  85		trace_seq_puts(p, str);
  86	}
  87
  88	/* check for left over flags */
  89	if (flags) {
  90		if (!first && delim)
  91			trace_seq_puts(p, delim);
  92		trace_seq_printf(p, "0x%lx", flags);
 
 
 
 
 
 
 
 
 
  93	}
  94
  95	trace_seq_putc(p, 0);
  96
  97	return ret;
  98}
  99EXPORT_SYMBOL(trace_print_flags_seq);
 100
 101const char *
 102trace_print_symbols_seq(struct trace_seq *p, unsigned long val,
 103			const struct trace_print_flags *symbol_array)
 104{
 105	int i;
 106	const char *ret = trace_seq_buffer_ptr(p);
 
 
 
 
 
 
 
 
 
 
 
 107
 108	for (i = 0;  symbol_array[i].name; i++) {
 
 
 
 
 109
 110		if (val != symbol_array[i].mask)
 111			continue;
 112
 113		trace_seq_puts(p, symbol_array[i].name);
 114		break;
 
 
 
 
 
 115	}
 
 
 
 
 
 
 
 
 
 
 
 116
 117	if (ret == (const char *)(trace_seq_buffer_ptr(p)))
 118		trace_seq_printf(p, "0x%lx", val);
 
 
 119
 120	trace_seq_putc(p, 0);
 
 121
 122	return ret;
 123}
 124EXPORT_SYMBOL(trace_print_symbols_seq);
 125
 126#if BITS_PER_LONG == 32
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 127const char *
 128trace_print_flags_seq_u64(struct trace_seq *p, const char *delim,
 129		      unsigned long long flags,
 130		      const struct trace_print_flags_u64 *flag_array)
 131{
 132	unsigned long long mask;
 133	const char *str;
 134	const char *ret = trace_seq_buffer_ptr(p);
 135	int i, first = 1;
 136
 137	for (i = 0;  flag_array[i].name && flags; i++) {
 138
 139		mask = flag_array[i].mask;
 140		if ((flags & mask) != mask)
 141			continue;
 142
 143		str = flag_array[i].name;
 144		flags &= ~mask;
 145		if (!first && delim)
 146			trace_seq_puts(p, delim);
 147		else
 148			first = 0;
 149		trace_seq_puts(p, str);
 150	}
 151
 152	/* check for left over flags */
 153	if (flags) {
 154		if (!first && delim)
 155			trace_seq_puts(p, delim);
 156		trace_seq_printf(p, "0x%llx", flags);
 157	}
 158
 159	trace_seq_putc(p, 0);
 160
 161	return ret;
 162}
 163EXPORT_SYMBOL(trace_print_flags_seq_u64);
 164
 165const char *
 166trace_print_symbols_seq_u64(struct trace_seq *p, unsigned long long val,
 167			 const struct trace_print_flags_u64 *symbol_array)
 168{
 169	int i;
 170	const char *ret = trace_seq_buffer_ptr(p);
 171
 172	for (i = 0;  symbol_array[i].name; i++) {
 173
 174		if (val != symbol_array[i].mask)
 175			continue;
 176
 177		trace_seq_puts(p, symbol_array[i].name);
 178		break;
 179	}
 180
 181	if (ret == (const char *)(trace_seq_buffer_ptr(p)))
 182		trace_seq_printf(p, "0x%llx", val);
 183
 184	trace_seq_putc(p, 0);
 185
 186	return ret;
 187}
 188EXPORT_SYMBOL(trace_print_symbols_seq_u64);
 189#endif
 190
 
 191const char *
 192trace_print_bitmask_seq(struct trace_seq *p, void *bitmask_ptr,
 193			unsigned int bitmask_size)
 194{
 195	const char *ret = trace_seq_buffer_ptr(p);
 
 
 
 
 
 
 
 
 
 
 
 
 
 196
 197	trace_seq_bitmask(p, bitmask_ptr, bitmask_size * 8);
 198	trace_seq_putc(p, 0);
 199
 200	return ret;
 201}
 202EXPORT_SYMBOL_GPL(trace_print_bitmask_seq);
 
 203
 204/**
 205 * trace_print_hex_seq - print buffer as hex sequence
 206 * @p: trace seq struct to write to
 207 * @buf: The buffer to print
 208 * @buf_len: Length of @buf in bytes
 209 * @concatenate: Print @buf as single hex string or with spacing
 210 *
 211 * Prints the passed buffer as a hex sequence either as a whole,
 212 * single hex string if @concatenate is true or with spacing after
 213 * each byte in case @concatenate is false.
 214 */
 215const char *
 216trace_print_hex_seq(struct trace_seq *p, const unsigned char *buf, int buf_len,
 217		    bool concatenate)
 218{
 219	int i;
 220	const char *ret = trace_seq_buffer_ptr(p);
 221
 222	for (i = 0; i < buf_len; i++)
 223		trace_seq_printf(p, "%s%2.2x", concatenate || i == 0 ? "" : " ",
 224				 buf[i]);
 225	trace_seq_putc(p, 0);
 226
 227	return ret;
 228}
 229EXPORT_SYMBOL(trace_print_hex_seq);
 230
 231const char *
 232trace_print_array_seq(struct trace_seq *p, const void *buf, int count,
 233		      size_t el_size)
 234{
 235	const char *ret = trace_seq_buffer_ptr(p);
 236	const char *prefix = "";
 237	void *ptr = (void *)buf;
 238	size_t buf_len = count * el_size;
 239
 240	trace_seq_putc(p, '{');
 241
 242	while (ptr < buf + buf_len) {
 243		switch (el_size) {
 244		case 1:
 245			trace_seq_printf(p, "%s0x%x", prefix,
 246					 *(u8 *)ptr);
 247			break;
 248		case 2:
 249			trace_seq_printf(p, "%s0x%x", prefix,
 250					 *(u16 *)ptr);
 251			break;
 252		case 4:
 253			trace_seq_printf(p, "%s0x%x", prefix,
 254					 *(u32 *)ptr);
 255			break;
 256		case 8:
 257			trace_seq_printf(p, "%s0x%llx", prefix,
 258					 *(u64 *)ptr);
 259			break;
 260		default:
 261			trace_seq_printf(p, "BAD SIZE:%zu 0x%x", el_size,
 262					 *(u8 *)ptr);
 263			el_size = 1;
 264		}
 265		prefix = ",";
 266		ptr += el_size;
 267	}
 268
 269	trace_seq_putc(p, '}');
 270	trace_seq_putc(p, 0);
 271
 272	return ret;
 273}
 274EXPORT_SYMBOL(trace_print_array_seq);
 275
 276int trace_raw_output_prep(struct trace_iterator *iter,
 277			  struct trace_event *trace_event)
 278{
 279	struct trace_event_call *event;
 280	struct trace_seq *s = &iter->seq;
 281	struct trace_seq *p = &iter->tmp_seq;
 282	struct trace_entry *entry;
 
 283
 284	event = container_of(trace_event, struct trace_event_call, event);
 285	entry = iter->ent;
 286
 287	if (entry->type != event->event.type) {
 288		WARN_ON_ONCE(1);
 289		return TRACE_TYPE_UNHANDLED;
 290	}
 291
 292	trace_seq_init(p);
 293	trace_seq_printf(s, "%s: ", trace_event_name(event));
 
 
 294
 295	return trace_handle_return(s);
 296}
 297EXPORT_SYMBOL(trace_raw_output_prep);
 298
 299static int trace_output_raw(struct trace_iterator *iter, char *name,
 300			    char *fmt, va_list ap)
 301{
 302	struct trace_seq *s = &iter->seq;
 
 
 
 
 
 303
 304	trace_seq_printf(s, "%s: ", name);
 305	trace_seq_vprintf(s, fmt, ap);
 306
 307	return trace_handle_return(s);
 
 
 
 308}
 309
 310int trace_output_call(struct trace_iterator *iter, char *name, char *fmt, ...)
 311{
 312	va_list ap;
 313	int ret;
 314
 315	va_start(ap, fmt);
 316	ret = trace_output_raw(iter, name, fmt, ap);
 317	va_end(ap);
 318
 319	return ret;
 320}
 321EXPORT_SYMBOL_GPL(trace_output_call);
 322
 323#ifdef CONFIG_KRETPROBES
 324static inline const char *kretprobed(const char *name)
 325{
 326	static const char tramp_name[] = "kretprobe_trampoline";
 327	int size = sizeof(tramp_name);
 328
 329	if (strncmp(tramp_name, name, size) == 0)
 330		return "[unknown/kretprobe'd]";
 331	return name;
 332}
 333#else
 334static inline const char *kretprobed(const char *name)
 335{
 336	return name;
 337}
 338#endif /* CONFIG_KRETPROBES */
 339
 340static void
 341seq_print_sym_short(struct trace_seq *s, const char *fmt, unsigned long address)
 342{
 
 343	char str[KSYM_SYMBOL_LEN];
 344#ifdef CONFIG_KALLSYMS
 345	const char *name;
 346
 347	kallsyms_lookup(address, NULL, NULL, NULL, str);
 348
 349	name = kretprobed(str);
 350
 351	if (name && strlen(name)) {
 352		trace_seq_printf(s, fmt, name);
 353		return;
 354	}
 355#endif
 356	snprintf(str, KSYM_SYMBOL_LEN, "0x%08lx", address);
 357	trace_seq_printf(s, fmt, str);
 358}
 359
 360static void
 361seq_print_sym_offset(struct trace_seq *s, const char *fmt,
 362		     unsigned long address)
 363{
 
 364	char str[KSYM_SYMBOL_LEN];
 365#ifdef CONFIG_KALLSYMS
 366	const char *name;
 367
 368	sprint_symbol(str, address);
 369	name = kretprobed(str);
 370
 371	if (name && strlen(name)) {
 372		trace_seq_printf(s, fmt, name);
 373		return;
 374	}
 375#endif
 376	snprintf(str, KSYM_SYMBOL_LEN, "0x%08lx", address);
 377	trace_seq_printf(s, fmt, str);
 378}
 379
 380#ifndef CONFIG_64BIT
 381# define IP_FMT "%08lx"
 382#else
 383# define IP_FMT "%016lx"
 384#endif
 385
 386static int seq_print_user_ip(struct trace_seq *s, struct mm_struct *mm,
 387			     unsigned long ip, unsigned long sym_flags)
 388{
 389	struct file *file = NULL;
 390	unsigned long vmstart = 0;
 391	int ret = 1;
 392
 393	if (s->full)
 394		return 0;
 395
 396	if (mm) {
 397		const struct vm_area_struct *vma;
 398
 399		down_read(&mm->mmap_sem);
 400		vma = find_vma(mm, ip);
 401		if (vma) {
 402			file = vma->vm_file;
 403			vmstart = vma->vm_start;
 404		}
 405		if (file) {
 406			ret = trace_seq_path(s, &file->f_path);
 407			if (ret)
 408				trace_seq_printf(s, "[+0x%lx]",
 409						 ip - vmstart);
 410		}
 411		up_read(&mm->mmap_sem);
 412	}
 413	if (ret && ((sym_flags & TRACE_ITER_SYM_ADDR) || !file))
 414		trace_seq_printf(s, " <" IP_FMT ">", ip);
 415	return !trace_seq_has_overflowed(s);
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 
 416}
 417
 418int
 419seq_print_ip_sym(struct trace_seq *s, unsigned long ip, unsigned long sym_flags)
 420{
 421	if (!ip) {
 422		trace_seq_putc(s, '0');
 423		goto out;
 424	}
 425
 426	if (sym_flags & TRACE_ITER_SYM_OFFSET)
 427		seq_print_sym_offset(s, "%s", ip);
 428	else
 429		seq_print_sym_short(s, "%s", ip);
 
 
 
 430
 431	if (sym_flags & TRACE_ITER_SYM_ADDR)
 432		trace_seq_printf(s, " <" IP_FMT ">", ip);
 433
 434 out:
 435	return !trace_seq_has_overflowed(s);
 436}
 437
 438/**
 439 * trace_print_lat_fmt - print the irq, preempt and lockdep fields
 440 * @s: trace seq struct to write to
 441 * @entry: The trace entry field from the ring buffer
 442 *
 443 * Prints the generic fields of irqs off, in hard or softirq, preempt
 444 * count.
 445 */
 446int trace_print_lat_fmt(struct trace_seq *s, struct trace_entry *entry)
 447{
 448	char hardsoft_irq;
 449	char need_resched;
 450	char irqs_off;
 451	int hardirq;
 452	int softirq;
 453	int nmi;
 454
 455	nmi = entry->flags & TRACE_FLAG_NMI;
 456	hardirq = entry->flags & TRACE_FLAG_HARDIRQ;
 457	softirq = entry->flags & TRACE_FLAG_SOFTIRQ;
 458
 459	irqs_off =
 460		(entry->flags & TRACE_FLAG_IRQS_OFF) ? 'd' :
 461		(entry->flags & TRACE_FLAG_IRQS_NOSUPPORT) ? 'X' :
 462		'.';
 463
 464	switch (entry->flags & (TRACE_FLAG_NEED_RESCHED |
 465				TRACE_FLAG_PREEMPT_RESCHED)) {
 466	case TRACE_FLAG_NEED_RESCHED | TRACE_FLAG_PREEMPT_RESCHED:
 467		need_resched = 'N';
 468		break;
 469	case TRACE_FLAG_NEED_RESCHED:
 470		need_resched = 'n';
 471		break;
 472	case TRACE_FLAG_PREEMPT_RESCHED:
 473		need_resched = 'p';
 474		break;
 475	default:
 476		need_resched = '.';
 477		break;
 478	}
 479
 480	hardsoft_irq =
 481		(nmi && hardirq)     ? 'Z' :
 482		nmi                  ? 'z' :
 483		(hardirq && softirq) ? 'H' :
 484		hardirq              ? 'h' :
 485		softirq              ? 's' :
 486		                       '.' ;
 487
 488	trace_seq_printf(s, "%c%c%c",
 489			 irqs_off, need_resched, hardsoft_irq);
 
 490
 491	if (entry->preempt_count)
 492		trace_seq_printf(s, "%x", entry->preempt_count);
 493	else
 494		trace_seq_putc(s, '.');
 495
 496	return !trace_seq_has_overflowed(s);
 497}
 498
 499static int
 500lat_print_generic(struct trace_seq *s, struct trace_entry *entry, int cpu)
 501{
 502	char comm[TASK_COMM_LEN];
 503
 504	trace_find_cmdline(entry->pid, comm);
 505
 506	trace_seq_printf(s, "%8.8s-%-5d %3d",
 507			 comm, entry->pid, cpu);
 
 508
 509	return trace_print_lat_fmt(s, entry);
 510}
 511
 512#undef MARK
 513#define MARK(v, s) {.val = v, .sym = s}
 514/* trace overhead mark */
 515static const struct trace_mark {
 516	unsigned long long	val; /* unit: nsec */
 517	char			sym;
 518} mark[] = {
 519	MARK(1000000000ULL	, '$'), /* 1 sec */
 520	MARK(100000000ULL	, '@'), /* 100 msec */
 521	MARK(10000000ULL	, '*'), /* 10 msec */
 522	MARK(1000000ULL		, '#'), /* 1000 usecs */
 523	MARK(100000ULL		, '!'), /* 100 usecs */
 524	MARK(10000ULL		, '+'), /* 10 usecs */
 525};
 526#undef MARK
 527
 528char trace_find_mark(unsigned long long d)
 529{
 530	int i;
 531	int size = ARRAY_SIZE(mark);
 532
 533	for (i = 0; i < size; i++) {
 534		if (d > mark[i].val)
 535			break;
 536	}
 537
 538	return (i == size) ? ' ' : mark[i].sym;
 539}
 540
 541static int
 542lat_print_timestamp(struct trace_iterator *iter, u64 next_ts)
 543{
 544	struct trace_array *tr = iter->tr;
 545	unsigned long verbose = tr->trace_flags & TRACE_ITER_VERBOSE;
 546	unsigned long in_ns = iter->iter_flags & TRACE_FILE_TIME_IN_NS;
 547	unsigned long long abs_ts = iter->ts - iter->trace_buffer->time_start;
 548	unsigned long long rel_ts = next_ts - iter->ts;
 549	struct trace_seq *s = &iter->seq;
 550
 551	if (in_ns) {
 552		abs_ts = ns2usecs(abs_ts);
 553		rel_ts = ns2usecs(rel_ts);
 554	}
 555
 556	if (verbose && in_ns) {
 557		unsigned long abs_usec = do_div(abs_ts, USEC_PER_MSEC);
 558		unsigned long abs_msec = (unsigned long)abs_ts;
 559		unsigned long rel_usec = do_div(rel_ts, USEC_PER_MSEC);
 560		unsigned long rel_msec = (unsigned long)rel_ts;
 561
 562		trace_seq_printf(
 563			s, "[%08llx] %ld.%03ldms (+%ld.%03ldms): ",
 564			ns2usecs(iter->ts),
 565			abs_msec, abs_usec,
 566			rel_msec, rel_usec);
 567
 568	} else if (verbose && !in_ns) {
 569		trace_seq_printf(
 570			s, "[%016llx] %lld (+%lld): ",
 571			iter->ts, abs_ts, rel_ts);
 572
 573	} else if (!verbose && in_ns) {
 574		trace_seq_printf(
 575			s, " %4lldus%c: ",
 576			abs_ts,
 577			trace_find_mark(rel_ts * NSEC_PER_USEC));
 578
 579	} else { /* !verbose && !in_ns */
 580		trace_seq_printf(s, " %4lld: ", abs_ts);
 581	}
 582
 583	return !trace_seq_has_overflowed(s);
 584}
 585
 586int trace_print_context(struct trace_iterator *iter)
 587{
 588	struct trace_array *tr = iter->tr;
 589	struct trace_seq *s = &iter->seq;
 590	struct trace_entry *entry = iter->ent;
 591	unsigned long long t;
 592	unsigned long secs, usec_rem;
 593	char comm[TASK_COMM_LEN];
 
 594
 595	trace_find_cmdline(entry->pid, comm);
 596
 597	trace_seq_printf(s, "%16s-%-5d [%03d] ",
 598			       comm, entry->pid, iter->cpu);
 
 
 599
 600	if (tr->trace_flags & TRACE_ITER_RECORD_TGID) {
 601		unsigned int tgid = trace_find_tgid(entry->pid);
 602
 603		if (!tgid)
 604			trace_seq_printf(s, "(-----) ");
 605		else
 606			trace_seq_printf(s, "(%5d) ", tgid);
 607	}
 608
 609	if (tr->trace_flags & TRACE_ITER_IRQ_INFO)
 610		trace_print_lat_fmt(s, entry);
 611
 612	if (iter->iter_flags & TRACE_FILE_TIME_IN_NS) {
 613		t = ns2usecs(iter->ts);
 614		usec_rem = do_div(t, USEC_PER_SEC);
 615		secs = (unsigned long)t;
 616		trace_seq_printf(s, " %5lu.%06lu: ", secs, usec_rem);
 617	} else
 618		trace_seq_printf(s, " %12llu: ", iter->ts);
 619
 620	return !trace_seq_has_overflowed(s);
 621}
 622
 623int trace_print_lat_context(struct trace_iterator *iter)
 624{
 625	struct trace_array *tr = iter->tr;
 
 626	/* trace_find_next_entry will reset ent_size */
 627	int ent_size = iter->ent_size;
 628	struct trace_seq *s = &iter->seq;
 629	u64 next_ts;
 630	struct trace_entry *entry = iter->ent,
 631			   *next_entry = trace_find_next_entry(iter, NULL,
 632							       &next_ts);
 633	unsigned long verbose = (tr->trace_flags & TRACE_ITER_VERBOSE);
 634
 635	/* Restore the original ent_size */
 636	iter->ent_size = ent_size;
 637
 638	if (!next_entry)
 639		next_ts = iter->ts;
 640
 641	if (verbose) {
 642		char comm[TASK_COMM_LEN];
 643
 644		trace_find_cmdline(entry->pid, comm);
 645
 646		trace_seq_printf(
 647			s, "%16s %5d %3d %d %08x %08lx ",
 648			comm, entry->pid, iter->cpu, entry->flags,
 649			entry->preempt_count, iter->idx);
 650	} else {
 651		lat_print_generic(s, entry, iter->cpu);
 652	}
 653
 654	lat_print_timestamp(iter, next_ts);
 
 655
 656	return !trace_seq_has_overflowed(s);
 
 
 
 
 
 
 
 
 
 657}
 658
 659/**
 660 * ftrace_find_event - find a registered event
 661 * @type: the type of event to look for
 662 *
 663 * Returns an event of type @type otherwise NULL
 664 * Called with trace_event_read_lock() held.
 665 */
 666struct trace_event *ftrace_find_event(int type)
 667{
 668	struct trace_event *event;
 669	unsigned key;
 670
 671	key = type & (EVENT_HASHSIZE - 1);
 672
 673	hlist_for_each_entry(event, &event_hash[key], node) {
 674		if (event->type == type)
 675			return event;
 676	}
 677
 678	return NULL;
 679}
 680
 681static LIST_HEAD(ftrace_event_list);
 682
 683static int trace_search_list(struct list_head **list)
 684{
 685	struct trace_event *e;
 686	int last = __TRACE_LAST_TYPE;
 687
 688	if (list_empty(&ftrace_event_list)) {
 689		*list = &ftrace_event_list;
 690		return last + 1;
 691	}
 692
 693	/*
 694	 * We used up all possible max events,
 695	 * lets see if somebody freed one.
 696	 */
 697	list_for_each_entry(e, &ftrace_event_list, list) {
 698		if (e->type != last + 1)
 699			break;
 700		last++;
 701	}
 702
 703	/* Did we used up all 65 thousand events??? */
 704	if ((last + 1) > TRACE_EVENT_TYPE_MAX)
 705		return 0;
 706
 707	*list = &e->list;
 708	return last + 1;
 709}
 710
 711void trace_event_read_lock(void)
 712{
 713	down_read(&trace_event_sem);
 714}
 715
 716void trace_event_read_unlock(void)
 717{
 718	up_read(&trace_event_sem);
 719}
 720
 721/**
 722 * register_trace_event - register output for an event type
 723 * @event: the event type to register
 724 *
 725 * Event types are stored in a hash and this hash is used to
 726 * find a way to print an event. If the @event->type is set
 727 * then it will use that type, otherwise it will assign a
 728 * type to use.
 729 *
 730 * If you assign your own type, please make sure it is added
 731 * to the trace_type enum in trace.h, to avoid collisions
 732 * with the dynamic types.
 733 *
 734 * Returns the event type number or zero on error.
 735 */
 736int register_trace_event(struct trace_event *event)
 737{
 738	unsigned key;
 739	int ret = 0;
 740
 741	down_write(&trace_event_sem);
 742
 743	if (WARN_ON(!event))
 744		goto out;
 745
 746	if (WARN_ON(!event->funcs))
 747		goto out;
 748
 749	INIT_LIST_HEAD(&event->list);
 750
 751	if (!event->type) {
 752		struct list_head *list = NULL;
 753
 754		if (next_event_type > TRACE_EVENT_TYPE_MAX) {
 755
 756			event->type = trace_search_list(&list);
 757			if (!event->type)
 758				goto out;
 759
 760		} else {
 761
 762			event->type = next_event_type++;
 763			list = &ftrace_event_list;
 764		}
 765
 766		if (WARN_ON(ftrace_find_event(event->type)))
 767			goto out;
 768
 769		list_add_tail(&event->list, list);
 770
 771	} else if (event->type > __TRACE_LAST_TYPE) {
 772		printk(KERN_WARNING "Need to add type to trace.h\n");
 773		WARN_ON(1);
 774		goto out;
 775	} else {
 776		/* Is this event already used */
 777		if (ftrace_find_event(event->type))
 778			goto out;
 779	}
 780
 781	if (event->funcs->trace == NULL)
 782		event->funcs->trace = trace_nop_print;
 783	if (event->funcs->raw == NULL)
 784		event->funcs->raw = trace_nop_print;
 785	if (event->funcs->hex == NULL)
 786		event->funcs->hex = trace_nop_print;
 787	if (event->funcs->binary == NULL)
 788		event->funcs->binary = trace_nop_print;
 789
 790	key = event->type & (EVENT_HASHSIZE - 1);
 791
 792	hlist_add_head(&event->node, &event_hash[key]);
 793
 794	ret = event->type;
 795 out:
 796	up_write(&trace_event_sem);
 797
 798	return ret;
 799}
 800EXPORT_SYMBOL_GPL(register_trace_event);
 801
 802/*
 803 * Used by module code with the trace_event_sem held for write.
 804 */
 805int __unregister_trace_event(struct trace_event *event)
 806{
 807	hlist_del(&event->node);
 808	list_del(&event->list);
 809	return 0;
 810}
 811
 812/**
 813 * unregister_trace_event - remove a no longer used event
 814 * @event: the event to remove
 815 */
 816int unregister_trace_event(struct trace_event *event)
 817{
 818	down_write(&trace_event_sem);
 819	__unregister_trace_event(event);
 820	up_write(&trace_event_sem);
 821
 822	return 0;
 823}
 824EXPORT_SYMBOL_GPL(unregister_trace_event);
 825
 826/*
 827 * Standard events
 828 */
 829
 830enum print_line_t trace_nop_print(struct trace_iterator *iter, int flags,
 831				  struct trace_event *event)
 832{
 833	trace_seq_printf(&iter->seq, "type: %d\n", iter->ent->type);
 
 834
 835	return trace_handle_return(&iter->seq);
 836}
 837
 838/* TRACE_FN */
 839static enum print_line_t trace_fn_trace(struct trace_iterator *iter, int flags,
 840					struct trace_event *event)
 841{
 842	struct ftrace_entry *field;
 843	struct trace_seq *s = &iter->seq;
 844
 845	trace_assign_type(field, iter->ent);
 846
 847	seq_print_ip_sym(s, field->ip, flags);
 
 848
 849	if ((flags & TRACE_ITER_PRINT_PARENT) && field->parent_ip) {
 850		trace_seq_puts(s, " <-");
 851		seq_print_ip_sym(s, field->parent_ip, flags);
 
 
 
 
 852	}
 
 
 853
 854	trace_seq_putc(s, '\n');
 855
 856	return trace_handle_return(s);
 
 857}
 858
 859static enum print_line_t trace_fn_raw(struct trace_iterator *iter, int flags,
 860				      struct trace_event *event)
 861{
 862	struct ftrace_entry *field;
 863
 864	trace_assign_type(field, iter->ent);
 865
 866	trace_seq_printf(&iter->seq, "%lx %lx\n",
 867			 field->ip,
 868			 field->parent_ip);
 
 869
 870	return trace_handle_return(&iter->seq);
 871}
 872
 873static enum print_line_t trace_fn_hex(struct trace_iterator *iter, int flags,
 874				      struct trace_event *event)
 875{
 876	struct ftrace_entry *field;
 877	struct trace_seq *s = &iter->seq;
 878
 879	trace_assign_type(field, iter->ent);
 880
 881	SEQ_PUT_HEX_FIELD(s, field->ip);
 882	SEQ_PUT_HEX_FIELD(s, field->parent_ip);
 883
 884	return trace_handle_return(s);
 885}
 886
 887static enum print_line_t trace_fn_bin(struct trace_iterator *iter, int flags,
 888				      struct trace_event *event)
 889{
 890	struct ftrace_entry *field;
 891	struct trace_seq *s = &iter->seq;
 892
 893	trace_assign_type(field, iter->ent);
 894
 895	SEQ_PUT_FIELD(s, field->ip);
 896	SEQ_PUT_FIELD(s, field->parent_ip);
 897
 898	return trace_handle_return(s);
 899}
 900
 901static struct trace_event_functions trace_fn_funcs = {
 902	.trace		= trace_fn_trace,
 903	.raw		= trace_fn_raw,
 904	.hex		= trace_fn_hex,
 905	.binary		= trace_fn_bin,
 906};
 907
 908static struct trace_event trace_fn_event = {
 909	.type		= TRACE_FN,
 910	.funcs		= &trace_fn_funcs,
 911};
 912
 913/* TRACE_CTX an TRACE_WAKE */
 914static enum print_line_t trace_ctxwake_print(struct trace_iterator *iter,
 915					     char *delim)
 916{
 917	struct ctx_switch_entry *field;
 918	char comm[TASK_COMM_LEN];
 919	int S, T;
 920
 921
 922	trace_assign_type(field, iter->ent);
 923
 924	T = task_index_to_char(field->next_state);
 925	S = task_index_to_char(field->prev_state);
 926	trace_find_cmdline(field->next_pid, comm);
 927	trace_seq_printf(&iter->seq,
 928			 " %5d:%3d:%c %s [%03d] %5d:%3d:%c %s\n",
 929			 field->prev_pid,
 930			 field->prev_prio,
 931			 S, delim,
 932			 field->next_cpu,
 933			 field->next_pid,
 934			 field->next_prio,
 935			 T, comm);
 
 936
 937	return trace_handle_return(&iter->seq);
 938}
 939
 940static enum print_line_t trace_ctx_print(struct trace_iterator *iter, int flags,
 941					 struct trace_event *event)
 942{
 943	return trace_ctxwake_print(iter, "==>");
 944}
 945
 946static enum print_line_t trace_wake_print(struct trace_iterator *iter,
 947					  int flags, struct trace_event *event)
 948{
 949	return trace_ctxwake_print(iter, "  +");
 950}
 951
 952static int trace_ctxwake_raw(struct trace_iterator *iter, char S)
 953{
 954	struct ctx_switch_entry *field;
 955	int T;
 956
 957	trace_assign_type(field, iter->ent);
 958
 959	if (!S)
 960		S = task_index_to_char(field->prev_state);
 961	T = task_index_to_char(field->next_state);
 962	trace_seq_printf(&iter->seq, "%d %d %c %d %d %d %c\n",
 963			 field->prev_pid,
 964			 field->prev_prio,
 965			 S,
 966			 field->next_cpu,
 967			 field->next_pid,
 968			 field->next_prio,
 969			 T);
 
 970
 971	return trace_handle_return(&iter->seq);
 972}
 973
 974static enum print_line_t trace_ctx_raw(struct trace_iterator *iter, int flags,
 975				       struct trace_event *event)
 976{
 977	return trace_ctxwake_raw(iter, 0);
 978}
 979
 980static enum print_line_t trace_wake_raw(struct trace_iterator *iter, int flags,
 981					struct trace_event *event)
 982{
 983	return trace_ctxwake_raw(iter, '+');
 984}
 985
 986
 987static int trace_ctxwake_hex(struct trace_iterator *iter, char S)
 988{
 989	struct ctx_switch_entry *field;
 990	struct trace_seq *s = &iter->seq;
 991	int T;
 992
 993	trace_assign_type(field, iter->ent);
 994
 995	if (!S)
 996		S = task_index_to_char(field->prev_state);
 997	T = task_index_to_char(field->next_state);
 998
 999	SEQ_PUT_HEX_FIELD(s, field->prev_pid);
1000	SEQ_PUT_HEX_FIELD(s, field->prev_prio);
1001	SEQ_PUT_HEX_FIELD(s, S);
1002	SEQ_PUT_HEX_FIELD(s, field->next_cpu);
1003	SEQ_PUT_HEX_FIELD(s, field->next_pid);
1004	SEQ_PUT_HEX_FIELD(s, field->next_prio);
1005	SEQ_PUT_HEX_FIELD(s, T);
1006
1007	return trace_handle_return(s);
1008}
1009
1010static enum print_line_t trace_ctx_hex(struct trace_iterator *iter, int flags,
1011				       struct trace_event *event)
1012{
1013	return trace_ctxwake_hex(iter, 0);
1014}
1015
1016static enum print_line_t trace_wake_hex(struct trace_iterator *iter, int flags,
1017					struct trace_event *event)
1018{
1019	return trace_ctxwake_hex(iter, '+');
1020}
1021
1022static enum print_line_t trace_ctxwake_bin(struct trace_iterator *iter,
1023					   int flags, struct trace_event *event)
1024{
1025	struct ctx_switch_entry *field;
1026	struct trace_seq *s = &iter->seq;
1027
1028	trace_assign_type(field, iter->ent);
1029
1030	SEQ_PUT_FIELD(s, field->prev_pid);
1031	SEQ_PUT_FIELD(s, field->prev_prio);
1032	SEQ_PUT_FIELD(s, field->prev_state);
1033	SEQ_PUT_FIELD(s, field->next_cpu);
1034	SEQ_PUT_FIELD(s, field->next_pid);
1035	SEQ_PUT_FIELD(s, field->next_prio);
1036	SEQ_PUT_FIELD(s, field->next_state);
1037
1038	return trace_handle_return(s);
1039}
1040
1041static struct trace_event_functions trace_ctx_funcs = {
1042	.trace		= trace_ctx_print,
1043	.raw		= trace_ctx_raw,
1044	.hex		= trace_ctx_hex,
1045	.binary		= trace_ctxwake_bin,
1046};
1047
1048static struct trace_event trace_ctx_event = {
1049	.type		= TRACE_CTX,
1050	.funcs		= &trace_ctx_funcs,
1051};
1052
1053static struct trace_event_functions trace_wake_funcs = {
1054	.trace		= trace_wake_print,
1055	.raw		= trace_wake_raw,
1056	.hex		= trace_wake_hex,
1057	.binary		= trace_ctxwake_bin,
1058};
1059
1060static struct trace_event trace_wake_event = {
1061	.type		= TRACE_WAKE,
1062	.funcs		= &trace_wake_funcs,
1063};
1064
1065/* TRACE_STACK */
1066
1067static enum print_line_t trace_stack_print(struct trace_iterator *iter,
1068					   int flags, struct trace_event *event)
1069{
1070	struct stack_entry *field;
1071	struct trace_seq *s = &iter->seq;
1072	unsigned long *p;
1073	unsigned long *end;
1074
1075	trace_assign_type(field, iter->ent);
1076	end = (unsigned long *)((long)iter->ent + iter->ent_size);
1077
1078	trace_seq_puts(s, "<stack trace>\n");
 
1079
1080	for (p = field->caller; p && *p != ULONG_MAX && p < end; p++) {
 
 
1081
1082		if (trace_seq_has_overflowed(s))
1083			break;
 
 
 
1084
1085		trace_seq_puts(s, " => ");
1086		seq_print_ip_sym(s, *p, flags);
1087		trace_seq_putc(s, '\n');
1088	}
1089
1090	return trace_handle_return(s);
 
1091}
1092
1093static struct trace_event_functions trace_stack_funcs = {
1094	.trace		= trace_stack_print,
1095};
1096
1097static struct trace_event trace_stack_event = {
1098	.type		= TRACE_STACK,
1099	.funcs		= &trace_stack_funcs,
1100};
1101
1102/* TRACE_USER_STACK */
1103static enum print_line_t trace_user_stack_print(struct trace_iterator *iter,
1104						int flags, struct trace_event *event)
1105{
1106	struct trace_array *tr = iter->tr;
1107	struct userstack_entry *field;
1108	struct trace_seq *s = &iter->seq;
1109	struct mm_struct *mm = NULL;
1110	unsigned int i;
1111
1112	trace_assign_type(field, iter->ent);
1113
1114	trace_seq_puts(s, "<user stack trace>\n");
1115
1116	if (tr->trace_flags & TRACE_ITER_SYM_USEROBJ) {
1117		struct task_struct *task;
1118		/*
1119		 * we do the lookup on the thread group leader,
1120		 * since individual threads might have already quit!
1121		 */
1122		rcu_read_lock();
1123		task = find_task_by_vpid(field->tgid);
1124		if (task)
1125			mm = get_task_mm(task);
1126		rcu_read_unlock();
1127	}
1128
1129	for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
1130		unsigned long ip = field->caller[i];
1131
1132		if (ip == ULONG_MAX || trace_seq_has_overflowed(s))
1133			break;
1134
1135		trace_seq_puts(s, " => ");
1136
1137		if (!ip) {
1138			trace_seq_puts(s, "??");
1139			trace_seq_putc(s, '\n');
1140			continue;
1141		}
1142
1143		seq_print_user_ip(s, mm, ip, flags);
1144		trace_seq_putc(s, '\n');
1145	}
1146
1147	if (mm)
1148		mmput(mm);
1149
1150	return trace_handle_return(s);
1151}
1152
1153static struct trace_event_functions trace_user_stack_funcs = {
1154	.trace		= trace_user_stack_print,
1155};
1156
1157static struct trace_event trace_user_stack_event = {
1158	.type		= TRACE_USER_STACK,
1159	.funcs		= &trace_user_stack_funcs,
1160};
1161
1162/* TRACE_HWLAT */
1163static enum print_line_t
1164trace_hwlat_print(struct trace_iterator *iter, int flags,
1165		  struct trace_event *event)
1166{
1167	struct trace_entry *entry = iter->ent;
1168	struct trace_seq *s = &iter->seq;
1169	struct hwlat_entry *field;
1170
1171	trace_assign_type(field, entry);
1172
1173	trace_seq_printf(s, "#%-5u inner/outer(us): %4llu/%-5llu ts:%lld.%09ld",
1174			 field->seqnum,
1175			 field->duration,
1176			 field->outer_duration,
1177			 (long long)field->timestamp.tv_sec,
1178			 field->timestamp.tv_nsec);
1179
1180	if (field->nmi_count) {
1181		/*
1182		 * The generic sched_clock() is not NMI safe, thus
1183		 * we only record the count and not the time.
1184		 */
1185		if (!IS_ENABLED(CONFIG_GENERIC_SCHED_CLOCK))
1186			trace_seq_printf(s, " nmi-total:%llu",
1187					 field->nmi_total_ts);
1188		trace_seq_printf(s, " nmi-count:%u",
1189				 field->nmi_count);
1190	}
1191
1192	trace_seq_putc(s, '\n');
1193
1194	return trace_handle_return(s);
1195}
1196
1197
1198static enum print_line_t
1199trace_hwlat_raw(struct trace_iterator *iter, int flags,
1200		struct trace_event *event)
1201{
1202	struct hwlat_entry *field;
1203	struct trace_seq *s = &iter->seq;
1204
1205	trace_assign_type(field, iter->ent);
1206
1207	trace_seq_printf(s, "%llu %lld %lld %09ld %u\n",
1208			 field->duration,
1209			 field->outer_duration,
1210			 (long long)field->timestamp.tv_sec,
1211			 field->timestamp.tv_nsec,
1212			 field->seqnum);
1213
1214	return trace_handle_return(s);
1215}
1216
1217static struct trace_event_functions trace_hwlat_funcs = {
1218	.trace		= trace_hwlat_print,
1219	.raw		= trace_hwlat_raw,
1220};
1221
1222static struct trace_event trace_hwlat_event = {
1223	.type		= TRACE_HWLAT,
1224	.funcs		= &trace_hwlat_funcs,
1225};
1226
1227/* TRACE_BPUTS */
1228static enum print_line_t
1229trace_bputs_print(struct trace_iterator *iter, int flags,
1230		   struct trace_event *event)
1231{
1232	struct trace_entry *entry = iter->ent;
1233	struct trace_seq *s = &iter->seq;
1234	struct bputs_entry *field;
1235
1236	trace_assign_type(field, entry);
1237
1238	seq_print_ip_sym(s, field->ip, flags);
1239	trace_seq_puts(s, ": ");
1240	trace_seq_puts(s, field->str);
 
 
1241
1242	return trace_handle_return(s);
 
 
 
 
 
 
1243}
1244
1245
1246static enum print_line_t
1247trace_bputs_raw(struct trace_iterator *iter, int flags,
1248		struct trace_event *event)
1249{
1250	struct bputs_entry *field;
1251	struct trace_seq *s = &iter->seq;
1252
1253	trace_assign_type(field, iter->ent);
1254
1255	trace_seq_printf(s, ": %lx : ", field->ip);
1256	trace_seq_puts(s, field->str);
 
 
 
1257
1258	return trace_handle_return(s);
 
 
 
1259}
1260
1261static struct trace_event_functions trace_bputs_funcs = {
1262	.trace		= trace_bputs_print,
1263	.raw		= trace_bputs_raw,
1264};
1265
1266static struct trace_event trace_bputs_event = {
1267	.type		= TRACE_BPUTS,
1268	.funcs		= &trace_bputs_funcs,
1269};
1270
1271/* TRACE_BPRINT */
1272static enum print_line_t
1273trace_bprint_print(struct trace_iterator *iter, int flags,
1274		   struct trace_event *event)
1275{
1276	struct trace_entry *entry = iter->ent;
1277	struct trace_seq *s = &iter->seq;
1278	struct bprint_entry *field;
1279
1280	trace_assign_type(field, entry);
1281
1282	seq_print_ip_sym(s, field->ip, flags);
1283	trace_seq_puts(s, ": ");
1284	trace_seq_bprintf(s, field->fmt, field->buf);
 
 
1285
1286	return trace_handle_return(s);
 
 
 
 
 
 
1287}
1288
1289
1290static enum print_line_t
1291trace_bprint_raw(struct trace_iterator *iter, int flags,
1292		 struct trace_event *event)
1293{
1294	struct bprint_entry *field;
1295	struct trace_seq *s = &iter->seq;
1296
1297	trace_assign_type(field, iter->ent);
1298
1299	trace_seq_printf(s, ": %lx : ", field->ip);
1300	trace_seq_bprintf(s, field->fmt, field->buf);
 
 
 
1301
1302	return trace_handle_return(s);
 
 
 
1303}
1304
1305static struct trace_event_functions trace_bprint_funcs = {
1306	.trace		= trace_bprint_print,
1307	.raw		= trace_bprint_raw,
1308};
1309
1310static struct trace_event trace_bprint_event = {
1311	.type		= TRACE_BPRINT,
1312	.funcs		= &trace_bprint_funcs,
1313};
1314
1315/* TRACE_PRINT */
1316static enum print_line_t trace_print_print(struct trace_iterator *iter,
1317					   int flags, struct trace_event *event)
1318{
1319	struct print_entry *field;
1320	struct trace_seq *s = &iter->seq;
1321
1322	trace_assign_type(field, iter->ent);
1323
1324	seq_print_ip_sym(s, field->ip, flags);
1325	trace_seq_printf(s, ": %s", field->buf);
 
 
 
 
 
1326
1327	return trace_handle_return(s);
 
1328}
1329
1330static enum print_line_t trace_print_raw(struct trace_iterator *iter, int flags,
1331					 struct trace_event *event)
1332{
1333	struct print_entry *field;
1334
1335	trace_assign_type(field, iter->ent);
1336
1337	trace_seq_printf(&iter->seq, "# %lx %s", field->ip, field->buf);
 
1338
1339	return trace_handle_return(&iter->seq);
 
 
 
1340}
1341
1342static struct trace_event_functions trace_print_funcs = {
1343	.trace		= trace_print_print,
1344	.raw		= trace_print_raw,
1345};
1346
1347static struct trace_event trace_print_event = {
1348	.type	 	= TRACE_PRINT,
1349	.funcs		= &trace_print_funcs,
1350};
1351
1352static enum print_line_t trace_raw_data(struct trace_iterator *iter, int flags,
1353					 struct trace_event *event)
1354{
1355	struct raw_data_entry *field;
1356	int i;
1357
1358	trace_assign_type(field, iter->ent);
1359
1360	trace_seq_printf(&iter->seq, "# %x buf:", field->id);
1361
1362	for (i = 0; i < iter->ent_size - offsetof(struct raw_data_entry, buf); i++)
1363		trace_seq_printf(&iter->seq, " %02x",
1364				 (unsigned char)field->buf[i]);
1365
1366	trace_seq_putc(&iter->seq, '\n');
1367
1368	return trace_handle_return(&iter->seq);
1369}
1370
1371static struct trace_event_functions trace_raw_data_funcs = {
1372	.trace		= trace_raw_data,
1373	.raw		= trace_raw_data,
1374};
1375
1376static struct trace_event trace_raw_data_event = {
1377	.type	 	= TRACE_RAW_DATA,
1378	.funcs		= &trace_raw_data_funcs,
1379};
1380
1381
1382static struct trace_event *events[] __initdata = {
1383	&trace_fn_event,
1384	&trace_ctx_event,
1385	&trace_wake_event,
1386	&trace_stack_event,
1387	&trace_user_stack_event,
1388	&trace_bputs_event,
1389	&trace_bprint_event,
1390	&trace_print_event,
1391	&trace_hwlat_event,
1392	&trace_raw_data_event,
1393	NULL
1394};
1395
1396__init static int init_events(void)
1397{
1398	struct trace_event *event;
1399	int i, ret;
1400
1401	for (i = 0; events[i]; i++) {
1402		event = events[i];
1403
1404		ret = register_trace_event(event);
1405		if (!ret) {
1406			printk(KERN_WARNING "event %d failed to register\n",
1407			       event->type);
1408			WARN_ON_ONCE(1);
1409		}
1410	}
1411
1412	return 0;
1413}
1414early_initcall(init_events);