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