Loading...
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/kprobes.h>
12#include <linux/sched/clock.h>
13#include <linux/sched/mm.h>
14#include <linux/idr.h>
15
16#include "trace_output.h"
17
18/* must be a power of 2 */
19#define EVENT_HASHSIZE 128
20
21DECLARE_RWSEM(trace_event_sem);
22
23static struct hlist_head event_hash[EVENT_HASHSIZE] __read_mostly;
24
25enum 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
38enum 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
51enum 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
64const char *
65trace_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}
100EXPORT_SYMBOL(trace_print_flags_seq);
101
102const char *
103trace_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}
125EXPORT_SYMBOL(trace_print_symbols_seq);
126
127#if BITS_PER_LONG == 32
128const char *
129trace_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}
164EXPORT_SYMBOL(trace_print_flags_seq_u64);
165
166const char *
167trace_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}
189EXPORT_SYMBOL(trace_print_symbols_seq_u64);
190#endif
191
192const char *
193trace_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}
203EXPORT_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 */
216const char *
217trace_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}
230EXPORT_SYMBOL(trace_print_hex_seq);
231
232const char *
233trace_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}
275EXPORT_SYMBOL(trace_print_array_seq);
276
277const char *
278trace_print_hex_dump_seq(struct trace_seq *p, const char *prefix_str,
279 int prefix_type, int rowsize, int groupsize,
280 const void *buf, size_t len, bool ascii)
281{
282 const char *ret = trace_seq_buffer_ptr(p);
283
284 trace_seq_putc(p, '\n');
285 trace_seq_hex_dump(p, prefix_str, prefix_type,
286 rowsize, groupsize, buf, len, ascii);
287 trace_seq_putc(p, 0);
288 return ret;
289}
290EXPORT_SYMBOL(trace_print_hex_dump_seq);
291
292int trace_raw_output_prep(struct trace_iterator *iter,
293 struct trace_event *trace_event)
294{
295 struct trace_event_call *event;
296 struct trace_seq *s = &iter->seq;
297 struct trace_seq *p = &iter->tmp_seq;
298 struct trace_entry *entry;
299
300 event = container_of(trace_event, struct trace_event_call, event);
301 entry = iter->ent;
302
303 if (entry->type != event->event.type) {
304 WARN_ON_ONCE(1);
305 return TRACE_TYPE_UNHANDLED;
306 }
307
308 trace_seq_init(p);
309 trace_seq_printf(s, "%s: ", trace_event_name(event));
310
311 return trace_handle_return(s);
312}
313EXPORT_SYMBOL(trace_raw_output_prep);
314
315void trace_event_printf(struct trace_iterator *iter, const char *fmt, ...)
316{
317 va_list ap;
318
319 va_start(ap, fmt);
320 trace_check_vprintf(iter, trace_event_format(iter, fmt), ap);
321 va_end(ap);
322}
323EXPORT_SYMBOL(trace_event_printf);
324
325static __printf(3, 0)
326int trace_output_raw(struct trace_iterator *iter, char *name,
327 char *fmt, va_list ap)
328{
329 struct trace_seq *s = &iter->seq;
330
331 trace_seq_printf(s, "%s: ", name);
332 trace_seq_vprintf(s, trace_event_format(iter, fmt), ap);
333
334 return trace_handle_return(s);
335}
336
337int trace_output_call(struct trace_iterator *iter, char *name, char *fmt, ...)
338{
339 va_list ap;
340 int ret;
341
342 va_start(ap, fmt);
343 ret = trace_output_raw(iter, name, fmt, ap);
344 va_end(ap);
345
346 return ret;
347}
348EXPORT_SYMBOL_GPL(trace_output_call);
349
350static inline const char *kretprobed(const char *name, unsigned long addr)
351{
352 if (is_kretprobe_trampoline(addr))
353 return "[unknown/kretprobe'd]";
354 return name;
355}
356
357void
358trace_seq_print_sym(struct trace_seq *s, unsigned long address, bool offset)
359{
360#ifdef CONFIG_KALLSYMS
361 char str[KSYM_SYMBOL_LEN];
362 const char *name;
363
364 if (offset)
365 sprint_symbol(str, address);
366 else
367 kallsyms_lookup(address, NULL, NULL, NULL, str);
368 name = kretprobed(str, address);
369
370 if (name && strlen(name)) {
371 trace_seq_puts(s, name);
372 return;
373 }
374#endif
375 trace_seq_printf(s, "0x%08lx", address);
376}
377
378#ifndef CONFIG_64BIT
379# define IP_FMT "%08lx"
380#else
381# define IP_FMT "%016lx"
382#endif
383
384static int seq_print_user_ip(struct trace_seq *s, struct mm_struct *mm,
385 unsigned long ip, unsigned long sym_flags)
386{
387 struct file *file = NULL;
388 unsigned long vmstart = 0;
389 int ret = 1;
390
391 if (s->full)
392 return 0;
393
394 if (mm) {
395 const struct vm_area_struct *vma;
396
397 mmap_read_lock(mm);
398 vma = find_vma(mm, ip);
399 if (vma) {
400 file = vma->vm_file;
401 vmstart = vma->vm_start;
402 }
403 if (file) {
404 ret = trace_seq_path(s, &file->f_path);
405 if (ret)
406 trace_seq_printf(s, "[+0x%lx]",
407 ip - vmstart);
408 }
409 mmap_read_unlock(mm);
410 }
411 if (ret && ((sym_flags & TRACE_ITER_SYM_ADDR) || !file))
412 trace_seq_printf(s, " <" IP_FMT ">", ip);
413 return !trace_seq_has_overflowed(s);
414}
415
416int
417seq_print_ip_sym(struct trace_seq *s, unsigned long ip, unsigned long sym_flags)
418{
419 if (!ip) {
420 trace_seq_putc(s, '0');
421 goto out;
422 }
423
424 trace_seq_print_sym(s, ip, sym_flags & TRACE_ITER_SYM_OFFSET);
425
426 if (sym_flags & TRACE_ITER_SYM_ADDR)
427 trace_seq_printf(s, " <" IP_FMT ">", ip);
428
429 out:
430 return !trace_seq_has_overflowed(s);
431}
432
433/**
434 * trace_print_lat_fmt - print the irq, preempt and lockdep fields
435 * @s: trace seq struct to write to
436 * @entry: The trace entry field from the ring buffer
437 *
438 * Prints the generic fields of irqs off, in hard or softirq, preempt
439 * count.
440 */
441int trace_print_lat_fmt(struct trace_seq *s, struct trace_entry *entry)
442{
443 char hardsoft_irq;
444 char need_resched;
445 char irqs_off;
446 int hardirq;
447 int softirq;
448 int bh_off;
449 int nmi;
450
451 nmi = entry->flags & TRACE_FLAG_NMI;
452 hardirq = entry->flags & TRACE_FLAG_HARDIRQ;
453 softirq = entry->flags & TRACE_FLAG_SOFTIRQ;
454 bh_off = entry->flags & TRACE_FLAG_BH_OFF;
455
456 irqs_off =
457 (entry->flags & TRACE_FLAG_IRQS_OFF && bh_off) ? 'D' :
458 (entry->flags & TRACE_FLAG_IRQS_OFF) ? 'd' :
459 bh_off ? 'b' :
460 (entry->flags & TRACE_FLAG_IRQS_NOSUPPORT) ? 'X' :
461 '.';
462
463 switch (entry->flags & (TRACE_FLAG_NEED_RESCHED |
464 TRACE_FLAG_PREEMPT_RESCHED)) {
465 case TRACE_FLAG_NEED_RESCHED | TRACE_FLAG_PREEMPT_RESCHED:
466 need_resched = 'N';
467 break;
468 case TRACE_FLAG_NEED_RESCHED:
469 need_resched = 'n';
470 break;
471 case TRACE_FLAG_PREEMPT_RESCHED:
472 need_resched = 'p';
473 break;
474 default:
475 need_resched = '.';
476 break;
477 }
478
479 hardsoft_irq =
480 (nmi && hardirq) ? 'Z' :
481 nmi ? 'z' :
482 (hardirq && softirq) ? 'H' :
483 hardirq ? 'h' :
484 softirq ? 's' :
485 '.' ;
486
487 trace_seq_printf(s, "%c%c%c",
488 irqs_off, need_resched, hardsoft_irq);
489
490 if (entry->preempt_count & 0xf)
491 trace_seq_printf(s, "%x", entry->preempt_count & 0xf);
492 else
493 trace_seq_putc(s, '.');
494
495 if (entry->preempt_count & 0xf0)
496 trace_seq_printf(s, "%x", entry->preempt_count >> 4);
497 else
498 trace_seq_putc(s, '.');
499
500 return !trace_seq_has_overflowed(s);
501}
502
503static int
504lat_print_generic(struct trace_seq *s, struct trace_entry *entry, int cpu)
505{
506 char comm[TASK_COMM_LEN];
507
508 trace_find_cmdline(entry->pid, comm);
509
510 trace_seq_printf(s, "%8.8s-%-7d %3d",
511 comm, entry->pid, cpu);
512
513 return trace_print_lat_fmt(s, entry);
514}
515
516#undef MARK
517#define MARK(v, s) {.val = v, .sym = s}
518/* trace overhead mark */
519static const struct trace_mark {
520 unsigned long long val; /* unit: nsec */
521 char sym;
522} mark[] = {
523 MARK(1000000000ULL , '$'), /* 1 sec */
524 MARK(100000000ULL , '@'), /* 100 msec */
525 MARK(10000000ULL , '*'), /* 10 msec */
526 MARK(1000000ULL , '#'), /* 1000 usecs */
527 MARK(100000ULL , '!'), /* 100 usecs */
528 MARK(10000ULL , '+'), /* 10 usecs */
529};
530#undef MARK
531
532char trace_find_mark(unsigned long long d)
533{
534 int i;
535 int size = ARRAY_SIZE(mark);
536
537 for (i = 0; i < size; i++) {
538 if (d > mark[i].val)
539 break;
540 }
541
542 return (i == size) ? ' ' : mark[i].sym;
543}
544
545static int
546lat_print_timestamp(struct trace_iterator *iter, u64 next_ts)
547{
548 struct trace_array *tr = iter->tr;
549 unsigned long verbose = tr->trace_flags & TRACE_ITER_VERBOSE;
550 unsigned long in_ns = iter->iter_flags & TRACE_FILE_TIME_IN_NS;
551 unsigned long long abs_ts = iter->ts - iter->array_buffer->time_start;
552 unsigned long long rel_ts = next_ts - iter->ts;
553 struct trace_seq *s = &iter->seq;
554
555 if (in_ns) {
556 abs_ts = ns2usecs(abs_ts);
557 rel_ts = ns2usecs(rel_ts);
558 }
559
560 if (verbose && in_ns) {
561 unsigned long abs_usec = do_div(abs_ts, USEC_PER_MSEC);
562 unsigned long abs_msec = (unsigned long)abs_ts;
563 unsigned long rel_usec = do_div(rel_ts, USEC_PER_MSEC);
564 unsigned long rel_msec = (unsigned long)rel_ts;
565
566 trace_seq_printf(
567 s, "[%08llx] %ld.%03ldms (+%ld.%03ldms): ",
568 ns2usecs(iter->ts),
569 abs_msec, abs_usec,
570 rel_msec, rel_usec);
571
572 } else if (verbose && !in_ns) {
573 trace_seq_printf(
574 s, "[%016llx] %lld (+%lld): ",
575 iter->ts, abs_ts, rel_ts);
576
577 } else if (!verbose && in_ns) {
578 trace_seq_printf(
579 s, " %4lldus%c: ",
580 abs_ts,
581 trace_find_mark(rel_ts * NSEC_PER_USEC));
582
583 } else { /* !verbose && !in_ns */
584 trace_seq_printf(s, " %4lld: ", abs_ts);
585 }
586
587 return !trace_seq_has_overflowed(s);
588}
589
590static void trace_print_time(struct trace_seq *s, struct trace_iterator *iter,
591 unsigned long long ts)
592{
593 unsigned long secs, usec_rem;
594 unsigned long long t;
595
596 if (iter->iter_flags & TRACE_FILE_TIME_IN_NS) {
597 t = ns2usecs(ts);
598 usec_rem = do_div(t, USEC_PER_SEC);
599 secs = (unsigned long)t;
600 trace_seq_printf(s, " %5lu.%06lu", secs, usec_rem);
601 } else
602 trace_seq_printf(s, " %12llu", ts);
603}
604
605int trace_print_context(struct trace_iterator *iter)
606{
607 struct trace_array *tr = iter->tr;
608 struct trace_seq *s = &iter->seq;
609 struct trace_entry *entry = iter->ent;
610 char comm[TASK_COMM_LEN];
611
612 trace_find_cmdline(entry->pid, comm);
613
614 trace_seq_printf(s, "%16s-%-7d ", comm, entry->pid);
615
616 if (tr->trace_flags & TRACE_ITER_RECORD_TGID) {
617 unsigned int tgid = trace_find_tgid(entry->pid);
618
619 if (!tgid)
620 trace_seq_printf(s, "(-------) ");
621 else
622 trace_seq_printf(s, "(%7d) ", tgid);
623 }
624
625 trace_seq_printf(s, "[%03d] ", iter->cpu);
626
627 if (tr->trace_flags & TRACE_ITER_IRQ_INFO)
628 trace_print_lat_fmt(s, entry);
629
630 trace_print_time(s, iter, iter->ts);
631 trace_seq_puts(s, ": ");
632
633 return !trace_seq_has_overflowed(s);
634}
635
636int trace_print_lat_context(struct trace_iterator *iter)
637{
638 struct trace_entry *entry, *next_entry;
639 struct trace_array *tr = iter->tr;
640 struct trace_seq *s = &iter->seq;
641 unsigned long verbose = (tr->trace_flags & TRACE_ITER_VERBOSE);
642 u64 next_ts;
643
644 next_entry = trace_find_next_entry(iter, NULL, &next_ts);
645 if (!next_entry)
646 next_ts = iter->ts;
647
648 /* trace_find_next_entry() may change iter->ent */
649 entry = iter->ent;
650
651 if (verbose) {
652 char comm[TASK_COMM_LEN];
653
654 trace_find_cmdline(entry->pid, comm);
655
656 trace_seq_printf(
657 s, "%16s %7d %3d %d %08x %08lx ",
658 comm, entry->pid, iter->cpu, entry->flags,
659 entry->preempt_count & 0xf, iter->idx);
660 } else {
661 lat_print_generic(s, entry, iter->cpu);
662 }
663
664 lat_print_timestamp(iter, next_ts);
665
666 return !trace_seq_has_overflowed(s);
667}
668
669/**
670 * ftrace_find_event - find a registered event
671 * @type: the type of event to look for
672 *
673 * Returns an event of type @type otherwise NULL
674 * Called with trace_event_read_lock() held.
675 */
676struct trace_event *ftrace_find_event(int type)
677{
678 struct trace_event *event;
679 unsigned key;
680
681 key = type & (EVENT_HASHSIZE - 1);
682
683 hlist_for_each_entry(event, &event_hash[key], node) {
684 if (event->type == type)
685 return event;
686 }
687
688 return NULL;
689}
690
691static DEFINE_IDA(trace_event_ida);
692
693static void free_trace_event_type(int type)
694{
695 if (type >= __TRACE_LAST_TYPE)
696 ida_free(&trace_event_ida, type);
697}
698
699static int alloc_trace_event_type(void)
700{
701 int next;
702
703 /* Skip static defined type numbers */
704 next = ida_alloc_range(&trace_event_ida, __TRACE_LAST_TYPE,
705 TRACE_EVENT_TYPE_MAX, GFP_KERNEL);
706 if (next < 0)
707 return 0;
708 return next;
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 if (!event->type) {
750 event->type = alloc_trace_event_type();
751 if (!event->type)
752 goto out;
753 } else if (WARN(event->type > __TRACE_LAST_TYPE,
754 "Need to add type to trace.h")) {
755 goto out;
756 } else {
757 /* Is this event already used */
758 if (ftrace_find_event(event->type))
759 goto out;
760 }
761
762 if (event->funcs->trace == NULL)
763 event->funcs->trace = trace_nop_print;
764 if (event->funcs->raw == NULL)
765 event->funcs->raw = trace_nop_print;
766 if (event->funcs->hex == NULL)
767 event->funcs->hex = trace_nop_print;
768 if (event->funcs->binary == NULL)
769 event->funcs->binary = trace_nop_print;
770
771 key = event->type & (EVENT_HASHSIZE - 1);
772
773 hlist_add_head(&event->node, &event_hash[key]);
774
775 ret = event->type;
776 out:
777 up_write(&trace_event_sem);
778
779 return ret;
780}
781EXPORT_SYMBOL_GPL(register_trace_event);
782
783/*
784 * Used by module code with the trace_event_sem held for write.
785 */
786int __unregister_trace_event(struct trace_event *event)
787{
788 hlist_del(&event->node);
789 free_trace_event_type(event->type);
790 return 0;
791}
792
793/**
794 * unregister_trace_event - remove a no longer used event
795 * @event: the event to remove
796 */
797int unregister_trace_event(struct trace_event *event)
798{
799 down_write(&trace_event_sem);
800 __unregister_trace_event(event);
801 up_write(&trace_event_sem);
802
803 return 0;
804}
805EXPORT_SYMBOL_GPL(unregister_trace_event);
806
807/*
808 * Standard events
809 */
810
811enum print_line_t trace_nop_print(struct trace_iterator *iter, int flags,
812 struct trace_event *event)
813{
814 trace_seq_printf(&iter->seq, "type: %d\n", iter->ent->type);
815
816 return trace_handle_return(&iter->seq);
817}
818
819static void print_fn_trace(struct trace_seq *s, unsigned long ip,
820 unsigned long parent_ip, int flags)
821{
822 seq_print_ip_sym(s, ip, flags);
823
824 if ((flags & TRACE_ITER_PRINT_PARENT) && parent_ip) {
825 trace_seq_puts(s, " <-");
826 seq_print_ip_sym(s, parent_ip, flags);
827 }
828}
829
830/* TRACE_FN */
831static enum print_line_t trace_fn_trace(struct trace_iterator *iter, int flags,
832 struct trace_event *event)
833{
834 struct ftrace_entry *field;
835 struct trace_seq *s = &iter->seq;
836
837 trace_assign_type(field, iter->ent);
838
839 print_fn_trace(s, field->ip, field->parent_ip, flags);
840 trace_seq_putc(s, '\n');
841
842 return trace_handle_return(s);
843}
844
845static enum print_line_t trace_fn_raw(struct trace_iterator *iter, int flags,
846 struct trace_event *event)
847{
848 struct ftrace_entry *field;
849
850 trace_assign_type(field, iter->ent);
851
852 trace_seq_printf(&iter->seq, "%lx %lx\n",
853 field->ip,
854 field->parent_ip);
855
856 return trace_handle_return(&iter->seq);
857}
858
859static enum print_line_t trace_fn_hex(struct trace_iterator *iter, int flags,
860 struct trace_event *event)
861{
862 struct ftrace_entry *field;
863 struct trace_seq *s = &iter->seq;
864
865 trace_assign_type(field, iter->ent);
866
867 SEQ_PUT_HEX_FIELD(s, field->ip);
868 SEQ_PUT_HEX_FIELD(s, field->parent_ip);
869
870 return trace_handle_return(s);
871}
872
873static enum print_line_t trace_fn_bin(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_FIELD(s, field->ip);
882 SEQ_PUT_FIELD(s, field->parent_ip);
883
884 return trace_handle_return(s);
885}
886
887static struct trace_event_functions trace_fn_funcs = {
888 .trace = trace_fn_trace,
889 .raw = trace_fn_raw,
890 .hex = trace_fn_hex,
891 .binary = trace_fn_bin,
892};
893
894static struct trace_event trace_fn_event = {
895 .type = TRACE_FN,
896 .funcs = &trace_fn_funcs,
897};
898
899/* TRACE_CTX an TRACE_WAKE */
900static enum print_line_t trace_ctxwake_print(struct trace_iterator *iter,
901 char *delim)
902{
903 struct ctx_switch_entry *field;
904 char comm[TASK_COMM_LEN];
905 int S, T;
906
907
908 trace_assign_type(field, iter->ent);
909
910 T = task_index_to_char(field->next_state);
911 S = task_index_to_char(field->prev_state);
912 trace_find_cmdline(field->next_pid, comm);
913 trace_seq_printf(&iter->seq,
914 " %7d:%3d:%c %s [%03d] %7d:%3d:%c %s\n",
915 field->prev_pid,
916 field->prev_prio,
917 S, delim,
918 field->next_cpu,
919 field->next_pid,
920 field->next_prio,
921 T, comm);
922
923 return trace_handle_return(&iter->seq);
924}
925
926static enum print_line_t trace_ctx_print(struct trace_iterator *iter, int flags,
927 struct trace_event *event)
928{
929 return trace_ctxwake_print(iter, "==>");
930}
931
932static enum print_line_t trace_wake_print(struct trace_iterator *iter,
933 int flags, struct trace_event *event)
934{
935 return trace_ctxwake_print(iter, " +");
936}
937
938static int trace_ctxwake_raw(struct trace_iterator *iter, char S)
939{
940 struct ctx_switch_entry *field;
941 int T;
942
943 trace_assign_type(field, iter->ent);
944
945 if (!S)
946 S = task_index_to_char(field->prev_state);
947 T = task_index_to_char(field->next_state);
948 trace_seq_printf(&iter->seq, "%d %d %c %d %d %d %c\n",
949 field->prev_pid,
950 field->prev_prio,
951 S,
952 field->next_cpu,
953 field->next_pid,
954 field->next_prio,
955 T);
956
957 return trace_handle_return(&iter->seq);
958}
959
960static enum print_line_t trace_ctx_raw(struct trace_iterator *iter, int flags,
961 struct trace_event *event)
962{
963 return trace_ctxwake_raw(iter, 0);
964}
965
966static enum print_line_t trace_wake_raw(struct trace_iterator *iter, int flags,
967 struct trace_event *event)
968{
969 return trace_ctxwake_raw(iter, '+');
970}
971
972
973static int trace_ctxwake_hex(struct trace_iterator *iter, char S)
974{
975 struct ctx_switch_entry *field;
976 struct trace_seq *s = &iter->seq;
977 int T;
978
979 trace_assign_type(field, iter->ent);
980
981 if (!S)
982 S = task_index_to_char(field->prev_state);
983 T = task_index_to_char(field->next_state);
984
985 SEQ_PUT_HEX_FIELD(s, field->prev_pid);
986 SEQ_PUT_HEX_FIELD(s, field->prev_prio);
987 SEQ_PUT_HEX_FIELD(s, S);
988 SEQ_PUT_HEX_FIELD(s, field->next_cpu);
989 SEQ_PUT_HEX_FIELD(s, field->next_pid);
990 SEQ_PUT_HEX_FIELD(s, field->next_prio);
991 SEQ_PUT_HEX_FIELD(s, T);
992
993 return trace_handle_return(s);
994}
995
996static enum print_line_t trace_ctx_hex(struct trace_iterator *iter, int flags,
997 struct trace_event *event)
998{
999 return trace_ctxwake_hex(iter, 0);
1000}
1001
1002static enum print_line_t trace_wake_hex(struct trace_iterator *iter, int flags,
1003 struct trace_event *event)
1004{
1005 return trace_ctxwake_hex(iter, '+');
1006}
1007
1008static enum print_line_t trace_ctxwake_bin(struct trace_iterator *iter,
1009 int flags, struct trace_event *event)
1010{
1011 struct ctx_switch_entry *field;
1012 struct trace_seq *s = &iter->seq;
1013
1014 trace_assign_type(field, iter->ent);
1015
1016 SEQ_PUT_FIELD(s, field->prev_pid);
1017 SEQ_PUT_FIELD(s, field->prev_prio);
1018 SEQ_PUT_FIELD(s, field->prev_state);
1019 SEQ_PUT_FIELD(s, field->next_cpu);
1020 SEQ_PUT_FIELD(s, field->next_pid);
1021 SEQ_PUT_FIELD(s, field->next_prio);
1022 SEQ_PUT_FIELD(s, field->next_state);
1023
1024 return trace_handle_return(s);
1025}
1026
1027static struct trace_event_functions trace_ctx_funcs = {
1028 .trace = trace_ctx_print,
1029 .raw = trace_ctx_raw,
1030 .hex = trace_ctx_hex,
1031 .binary = trace_ctxwake_bin,
1032};
1033
1034static struct trace_event trace_ctx_event = {
1035 .type = TRACE_CTX,
1036 .funcs = &trace_ctx_funcs,
1037};
1038
1039static struct trace_event_functions trace_wake_funcs = {
1040 .trace = trace_wake_print,
1041 .raw = trace_wake_raw,
1042 .hex = trace_wake_hex,
1043 .binary = trace_ctxwake_bin,
1044};
1045
1046static struct trace_event trace_wake_event = {
1047 .type = TRACE_WAKE,
1048 .funcs = &trace_wake_funcs,
1049};
1050
1051/* TRACE_STACK */
1052
1053static enum print_line_t trace_stack_print(struct trace_iterator *iter,
1054 int flags, struct trace_event *event)
1055{
1056 struct stack_entry *field;
1057 struct trace_seq *s = &iter->seq;
1058 unsigned long *p;
1059 unsigned long *end;
1060
1061 trace_assign_type(field, iter->ent);
1062 end = (unsigned long *)((long)iter->ent + iter->ent_size);
1063
1064 trace_seq_puts(s, "<stack trace>\n");
1065
1066 for (p = field->caller; p && p < end && *p != ULONG_MAX; p++) {
1067
1068 if (trace_seq_has_overflowed(s))
1069 break;
1070
1071 trace_seq_puts(s, " => ");
1072 seq_print_ip_sym(s, *p, flags);
1073 trace_seq_putc(s, '\n');
1074 }
1075
1076 return trace_handle_return(s);
1077}
1078
1079static struct trace_event_functions trace_stack_funcs = {
1080 .trace = trace_stack_print,
1081};
1082
1083static struct trace_event trace_stack_event = {
1084 .type = TRACE_STACK,
1085 .funcs = &trace_stack_funcs,
1086};
1087
1088/* TRACE_USER_STACK */
1089static enum print_line_t trace_user_stack_print(struct trace_iterator *iter,
1090 int flags, struct trace_event *event)
1091{
1092 struct trace_array *tr = iter->tr;
1093 struct userstack_entry *field;
1094 struct trace_seq *s = &iter->seq;
1095 struct mm_struct *mm = NULL;
1096 unsigned int i;
1097
1098 trace_assign_type(field, iter->ent);
1099
1100 trace_seq_puts(s, "<user stack trace>\n");
1101
1102 if (tr->trace_flags & TRACE_ITER_SYM_USEROBJ) {
1103 struct task_struct *task;
1104 /*
1105 * we do the lookup on the thread group leader,
1106 * since individual threads might have already quit!
1107 */
1108 rcu_read_lock();
1109 task = find_task_by_vpid(field->tgid);
1110 if (task)
1111 mm = get_task_mm(task);
1112 rcu_read_unlock();
1113 }
1114
1115 for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
1116 unsigned long ip = field->caller[i];
1117
1118 if (!ip || trace_seq_has_overflowed(s))
1119 break;
1120
1121 trace_seq_puts(s, " => ");
1122 seq_print_user_ip(s, mm, ip, flags);
1123 trace_seq_putc(s, '\n');
1124 }
1125
1126 if (mm)
1127 mmput(mm);
1128
1129 return trace_handle_return(s);
1130}
1131
1132static struct trace_event_functions trace_user_stack_funcs = {
1133 .trace = trace_user_stack_print,
1134};
1135
1136static struct trace_event trace_user_stack_event = {
1137 .type = TRACE_USER_STACK,
1138 .funcs = &trace_user_stack_funcs,
1139};
1140
1141/* TRACE_HWLAT */
1142static enum print_line_t
1143trace_hwlat_print(struct trace_iterator *iter, int flags,
1144 struct trace_event *event)
1145{
1146 struct trace_entry *entry = iter->ent;
1147 struct trace_seq *s = &iter->seq;
1148 struct hwlat_entry *field;
1149
1150 trace_assign_type(field, entry);
1151
1152 trace_seq_printf(s, "#%-5u inner/outer(us): %4llu/%-5llu ts:%lld.%09ld count:%d",
1153 field->seqnum,
1154 field->duration,
1155 field->outer_duration,
1156 (long long)field->timestamp.tv_sec,
1157 field->timestamp.tv_nsec, field->count);
1158
1159 if (field->nmi_count) {
1160 /*
1161 * The generic sched_clock() is not NMI safe, thus
1162 * we only record the count and not the time.
1163 */
1164 if (!IS_ENABLED(CONFIG_GENERIC_SCHED_CLOCK))
1165 trace_seq_printf(s, " nmi-total:%llu",
1166 field->nmi_total_ts);
1167 trace_seq_printf(s, " nmi-count:%u",
1168 field->nmi_count);
1169 }
1170
1171 trace_seq_putc(s, '\n');
1172
1173 return trace_handle_return(s);
1174}
1175
1176static enum print_line_t
1177trace_hwlat_raw(struct trace_iterator *iter, int flags,
1178 struct trace_event *event)
1179{
1180 struct hwlat_entry *field;
1181 struct trace_seq *s = &iter->seq;
1182
1183 trace_assign_type(field, iter->ent);
1184
1185 trace_seq_printf(s, "%llu %lld %lld %09ld %u\n",
1186 field->duration,
1187 field->outer_duration,
1188 (long long)field->timestamp.tv_sec,
1189 field->timestamp.tv_nsec,
1190 field->seqnum);
1191
1192 return trace_handle_return(s);
1193}
1194
1195static struct trace_event_functions trace_hwlat_funcs = {
1196 .trace = trace_hwlat_print,
1197 .raw = trace_hwlat_raw,
1198};
1199
1200static struct trace_event trace_hwlat_event = {
1201 .type = TRACE_HWLAT,
1202 .funcs = &trace_hwlat_funcs,
1203};
1204
1205/* TRACE_OSNOISE */
1206static enum print_line_t
1207trace_osnoise_print(struct trace_iterator *iter, int flags,
1208 struct trace_event *event)
1209{
1210 struct trace_entry *entry = iter->ent;
1211 struct trace_seq *s = &iter->seq;
1212 struct osnoise_entry *field;
1213 u64 ratio, ratio_dec;
1214 u64 net_runtime;
1215
1216 trace_assign_type(field, entry);
1217
1218 /*
1219 * compute the available % of cpu time.
1220 */
1221 net_runtime = field->runtime - field->noise;
1222 ratio = net_runtime * 10000000;
1223 do_div(ratio, field->runtime);
1224 ratio_dec = do_div(ratio, 100000);
1225
1226 trace_seq_printf(s, "%llu %10llu %3llu.%05llu %7llu",
1227 field->runtime,
1228 field->noise,
1229 ratio, ratio_dec,
1230 field->max_sample);
1231
1232 trace_seq_printf(s, " %6u", field->hw_count);
1233 trace_seq_printf(s, " %6u", field->nmi_count);
1234 trace_seq_printf(s, " %6u", field->irq_count);
1235 trace_seq_printf(s, " %6u", field->softirq_count);
1236 trace_seq_printf(s, " %6u", field->thread_count);
1237
1238 trace_seq_putc(s, '\n');
1239
1240 return trace_handle_return(s);
1241}
1242
1243static enum print_line_t
1244trace_osnoise_raw(struct trace_iterator *iter, int flags,
1245 struct trace_event *event)
1246{
1247 struct osnoise_entry *field;
1248 struct trace_seq *s = &iter->seq;
1249
1250 trace_assign_type(field, iter->ent);
1251
1252 trace_seq_printf(s, "%lld %llu %llu %u %u %u %u %u\n",
1253 field->runtime,
1254 field->noise,
1255 field->max_sample,
1256 field->hw_count,
1257 field->nmi_count,
1258 field->irq_count,
1259 field->softirq_count,
1260 field->thread_count);
1261
1262 return trace_handle_return(s);
1263}
1264
1265static struct trace_event_functions trace_osnoise_funcs = {
1266 .trace = trace_osnoise_print,
1267 .raw = trace_osnoise_raw,
1268};
1269
1270static struct trace_event trace_osnoise_event = {
1271 .type = TRACE_OSNOISE,
1272 .funcs = &trace_osnoise_funcs,
1273};
1274
1275/* TRACE_TIMERLAT */
1276static enum print_line_t
1277trace_timerlat_print(struct trace_iterator *iter, int flags,
1278 struct trace_event *event)
1279{
1280 struct trace_entry *entry = iter->ent;
1281 struct trace_seq *s = &iter->seq;
1282 struct timerlat_entry *field;
1283
1284 trace_assign_type(field, entry);
1285
1286 trace_seq_printf(s, "#%-5u context %6s timer_latency %9llu ns\n",
1287 field->seqnum,
1288 field->context ? "thread" : "irq",
1289 field->timer_latency);
1290
1291 return trace_handle_return(s);
1292}
1293
1294static enum print_line_t
1295trace_timerlat_raw(struct trace_iterator *iter, int flags,
1296 struct trace_event *event)
1297{
1298 struct timerlat_entry *field;
1299 struct trace_seq *s = &iter->seq;
1300
1301 trace_assign_type(field, iter->ent);
1302
1303 trace_seq_printf(s, "%u %d %llu\n",
1304 field->seqnum,
1305 field->context,
1306 field->timer_latency);
1307
1308 return trace_handle_return(s);
1309}
1310
1311static struct trace_event_functions trace_timerlat_funcs = {
1312 .trace = trace_timerlat_print,
1313 .raw = trace_timerlat_raw,
1314};
1315
1316static struct trace_event trace_timerlat_event = {
1317 .type = TRACE_TIMERLAT,
1318 .funcs = &trace_timerlat_funcs,
1319};
1320
1321/* TRACE_BPUTS */
1322static enum print_line_t
1323trace_bputs_print(struct trace_iterator *iter, int flags,
1324 struct trace_event *event)
1325{
1326 struct trace_entry *entry = iter->ent;
1327 struct trace_seq *s = &iter->seq;
1328 struct bputs_entry *field;
1329
1330 trace_assign_type(field, entry);
1331
1332 seq_print_ip_sym(s, field->ip, flags);
1333 trace_seq_puts(s, ": ");
1334 trace_seq_puts(s, field->str);
1335
1336 return trace_handle_return(s);
1337}
1338
1339
1340static enum print_line_t
1341trace_bputs_raw(struct trace_iterator *iter, int flags,
1342 struct trace_event *event)
1343{
1344 struct bputs_entry *field;
1345 struct trace_seq *s = &iter->seq;
1346
1347 trace_assign_type(field, iter->ent);
1348
1349 trace_seq_printf(s, ": %lx : ", field->ip);
1350 trace_seq_puts(s, field->str);
1351
1352 return trace_handle_return(s);
1353}
1354
1355static struct trace_event_functions trace_bputs_funcs = {
1356 .trace = trace_bputs_print,
1357 .raw = trace_bputs_raw,
1358};
1359
1360static struct trace_event trace_bputs_event = {
1361 .type = TRACE_BPUTS,
1362 .funcs = &trace_bputs_funcs,
1363};
1364
1365/* TRACE_BPRINT */
1366static enum print_line_t
1367trace_bprint_print(struct trace_iterator *iter, int flags,
1368 struct trace_event *event)
1369{
1370 struct trace_entry *entry = iter->ent;
1371 struct trace_seq *s = &iter->seq;
1372 struct bprint_entry *field;
1373
1374 trace_assign_type(field, entry);
1375
1376 seq_print_ip_sym(s, field->ip, flags);
1377 trace_seq_puts(s, ": ");
1378 trace_seq_bprintf(s, field->fmt, field->buf);
1379
1380 return trace_handle_return(s);
1381}
1382
1383
1384static enum print_line_t
1385trace_bprint_raw(struct trace_iterator *iter, int flags,
1386 struct trace_event *event)
1387{
1388 struct bprint_entry *field;
1389 struct trace_seq *s = &iter->seq;
1390
1391 trace_assign_type(field, iter->ent);
1392
1393 trace_seq_printf(s, ": %lx : ", field->ip);
1394 trace_seq_bprintf(s, field->fmt, field->buf);
1395
1396 return trace_handle_return(s);
1397}
1398
1399static struct trace_event_functions trace_bprint_funcs = {
1400 .trace = trace_bprint_print,
1401 .raw = trace_bprint_raw,
1402};
1403
1404static struct trace_event trace_bprint_event = {
1405 .type = TRACE_BPRINT,
1406 .funcs = &trace_bprint_funcs,
1407};
1408
1409/* TRACE_PRINT */
1410static enum print_line_t trace_print_print(struct trace_iterator *iter,
1411 int flags, struct trace_event *event)
1412{
1413 struct print_entry *field;
1414 struct trace_seq *s = &iter->seq;
1415
1416 trace_assign_type(field, iter->ent);
1417
1418 seq_print_ip_sym(s, field->ip, flags);
1419 trace_seq_printf(s, ": %s", field->buf);
1420
1421 return trace_handle_return(s);
1422}
1423
1424static enum print_line_t trace_print_raw(struct trace_iterator *iter, int flags,
1425 struct trace_event *event)
1426{
1427 struct print_entry *field;
1428
1429 trace_assign_type(field, iter->ent);
1430
1431 trace_seq_printf(&iter->seq, "# %lx %s", field->ip, field->buf);
1432
1433 return trace_handle_return(&iter->seq);
1434}
1435
1436static struct trace_event_functions trace_print_funcs = {
1437 .trace = trace_print_print,
1438 .raw = trace_print_raw,
1439};
1440
1441static struct trace_event trace_print_event = {
1442 .type = TRACE_PRINT,
1443 .funcs = &trace_print_funcs,
1444};
1445
1446static enum print_line_t trace_raw_data(struct trace_iterator *iter, int flags,
1447 struct trace_event *event)
1448{
1449 struct raw_data_entry *field;
1450 int i;
1451
1452 trace_assign_type(field, iter->ent);
1453
1454 trace_seq_printf(&iter->seq, "# %x buf:", field->id);
1455
1456 for (i = 0; i < iter->ent_size - offsetof(struct raw_data_entry, buf); i++)
1457 trace_seq_printf(&iter->seq, " %02x",
1458 (unsigned char)field->buf[i]);
1459
1460 trace_seq_putc(&iter->seq, '\n');
1461
1462 return trace_handle_return(&iter->seq);
1463}
1464
1465static struct trace_event_functions trace_raw_data_funcs = {
1466 .trace = trace_raw_data,
1467 .raw = trace_raw_data,
1468};
1469
1470static struct trace_event trace_raw_data_event = {
1471 .type = TRACE_RAW_DATA,
1472 .funcs = &trace_raw_data_funcs,
1473};
1474
1475static enum print_line_t
1476trace_func_repeats_raw(struct trace_iterator *iter, int flags,
1477 struct trace_event *event)
1478{
1479 struct func_repeats_entry *field;
1480 struct trace_seq *s = &iter->seq;
1481
1482 trace_assign_type(field, iter->ent);
1483
1484 trace_seq_printf(s, "%lu %lu %u %llu\n",
1485 field->ip,
1486 field->parent_ip,
1487 field->count,
1488 FUNC_REPEATS_GET_DELTA_TS(field));
1489
1490 return trace_handle_return(s);
1491}
1492
1493static enum print_line_t
1494trace_func_repeats_print(struct trace_iterator *iter, int flags,
1495 struct trace_event *event)
1496{
1497 struct func_repeats_entry *field;
1498 struct trace_seq *s = &iter->seq;
1499
1500 trace_assign_type(field, iter->ent);
1501
1502 print_fn_trace(s, field->ip, field->parent_ip, flags);
1503 trace_seq_printf(s, " (repeats: %u, last_ts:", field->count);
1504 trace_print_time(s, iter,
1505 iter->ts - FUNC_REPEATS_GET_DELTA_TS(field));
1506 trace_seq_puts(s, ")\n");
1507
1508 return trace_handle_return(s);
1509}
1510
1511static struct trace_event_functions trace_func_repeats_funcs = {
1512 .trace = trace_func_repeats_print,
1513 .raw = trace_func_repeats_raw,
1514};
1515
1516static struct trace_event trace_func_repeats_event = {
1517 .type = TRACE_FUNC_REPEATS,
1518 .funcs = &trace_func_repeats_funcs,
1519};
1520
1521static struct trace_event *events[] __initdata = {
1522 &trace_fn_event,
1523 &trace_ctx_event,
1524 &trace_wake_event,
1525 &trace_stack_event,
1526 &trace_user_stack_event,
1527 &trace_bputs_event,
1528 &trace_bprint_event,
1529 &trace_print_event,
1530 &trace_hwlat_event,
1531 &trace_osnoise_event,
1532 &trace_timerlat_event,
1533 &trace_raw_data_event,
1534 &trace_func_repeats_event,
1535 NULL
1536};
1537
1538__init int init_events(void)
1539{
1540 struct trace_event *event;
1541 int i, ret;
1542
1543 for (i = 0; events[i]; i++) {
1544 event = events[i];
1545 ret = register_trace_event(event);
1546 WARN_ONCE(!ret, "event %d failed to register", event->type);
1547 }
1548
1549 return 0;
1550}
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
19DECLARE_RWSEM(trace_event_sem);
20
21static struct hlist_head event_hash[EVENT_HASHSIZE] __read_mostly;
22
23static int next_event_type = __TRACE_LAST_TYPE;
24
25enum 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
38enum 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
51enum 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
64const char *
65trace_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}
100EXPORT_SYMBOL(trace_print_flags_seq);
101
102const char *
103trace_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}
125EXPORT_SYMBOL(trace_print_symbols_seq);
126
127#if BITS_PER_LONG == 32
128const char *
129trace_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}
164EXPORT_SYMBOL(trace_print_flags_seq_u64);
165
166const char *
167trace_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}
189EXPORT_SYMBOL(trace_print_symbols_seq_u64);
190#endif
191
192const char *
193trace_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}
203EXPORT_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 */
216const char *
217trace_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}
230EXPORT_SYMBOL(trace_print_hex_seq);
231
232const char *
233trace_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}
275EXPORT_SYMBOL(trace_print_array_seq);
276
277const char *
278trace_print_hex_dump_seq(struct trace_seq *p, const char *prefix_str,
279 int prefix_type, int rowsize, int groupsize,
280 const void *buf, size_t len, bool ascii)
281{
282 const char *ret = trace_seq_buffer_ptr(p);
283
284 trace_seq_putc(p, '\n');
285 trace_seq_hex_dump(p, prefix_str, prefix_type,
286 rowsize, groupsize, buf, len, ascii);
287 trace_seq_putc(p, 0);
288 return ret;
289}
290EXPORT_SYMBOL(trace_print_hex_dump_seq);
291
292int trace_raw_output_prep(struct trace_iterator *iter,
293 struct trace_event *trace_event)
294{
295 struct trace_event_call *event;
296 struct trace_seq *s = &iter->seq;
297 struct trace_seq *p = &iter->tmp_seq;
298 struct trace_entry *entry;
299
300 event = container_of(trace_event, struct trace_event_call, event);
301 entry = iter->ent;
302
303 if (entry->type != event->event.type) {
304 WARN_ON_ONCE(1);
305 return TRACE_TYPE_UNHANDLED;
306 }
307
308 trace_seq_init(p);
309 trace_seq_printf(s, "%s: ", trace_event_name(event));
310
311 return trace_handle_return(s);
312}
313EXPORT_SYMBOL(trace_raw_output_prep);
314
315static int trace_output_raw(struct trace_iterator *iter, char *name,
316 char *fmt, va_list ap)
317{
318 struct trace_seq *s = &iter->seq;
319
320 trace_seq_printf(s, "%s: ", name);
321 trace_seq_vprintf(s, fmt, ap);
322
323 return trace_handle_return(s);
324}
325
326int trace_output_call(struct trace_iterator *iter, char *name, char *fmt, ...)
327{
328 va_list ap;
329 int ret;
330
331 va_start(ap, fmt);
332 ret = trace_output_raw(iter, name, fmt, ap);
333 va_end(ap);
334
335 return ret;
336}
337EXPORT_SYMBOL_GPL(trace_output_call);
338
339#ifdef CONFIG_KRETPROBES
340static inline const char *kretprobed(const char *name)
341{
342 static const char tramp_name[] = "kretprobe_trampoline";
343 int size = sizeof(tramp_name);
344
345 if (strncmp(tramp_name, name, size) == 0)
346 return "[unknown/kretprobe'd]";
347 return name;
348}
349#else
350static inline const char *kretprobed(const char *name)
351{
352 return name;
353}
354#endif /* CONFIG_KRETPROBES */
355
356static void
357seq_print_sym(struct trace_seq *s, unsigned long address, bool offset)
358{
359#ifdef CONFIG_KALLSYMS
360 char str[KSYM_SYMBOL_LEN];
361 const char *name;
362
363 if (offset)
364 sprint_symbol(str, address);
365 else
366 kallsyms_lookup(address, NULL, NULL, NULL, str);
367 name = kretprobed(str);
368
369 if (name && strlen(name)) {
370 trace_seq_puts(s, name);
371 return;
372 }
373#endif
374 trace_seq_printf(s, "0x%08lx", address);
375}
376
377#ifndef CONFIG_64BIT
378# define IP_FMT "%08lx"
379#else
380# define IP_FMT "%016lx"
381#endif
382
383static int seq_print_user_ip(struct trace_seq *s, struct mm_struct *mm,
384 unsigned long ip, unsigned long sym_flags)
385{
386 struct file *file = NULL;
387 unsigned long vmstart = 0;
388 int ret = 1;
389
390 if (s->full)
391 return 0;
392
393 if (mm) {
394 const struct vm_area_struct *vma;
395
396 mmap_read_lock(mm);
397 vma = find_vma(mm, ip);
398 if (vma) {
399 file = vma->vm_file;
400 vmstart = vma->vm_start;
401 }
402 if (file) {
403 ret = trace_seq_path(s, &file->f_path);
404 if (ret)
405 trace_seq_printf(s, "[+0x%lx]",
406 ip - vmstart);
407 }
408 mmap_read_unlock(mm);
409 }
410 if (ret && ((sym_flags & TRACE_ITER_SYM_ADDR) || !file))
411 trace_seq_printf(s, " <" IP_FMT ">", ip);
412 return !trace_seq_has_overflowed(s);
413}
414
415int
416seq_print_ip_sym(struct trace_seq *s, unsigned long ip, unsigned long sym_flags)
417{
418 if (!ip) {
419 trace_seq_putc(s, '0');
420 goto out;
421 }
422
423 seq_print_sym(s, ip, sym_flags & TRACE_ITER_SYM_OFFSET);
424
425 if (sym_flags & TRACE_ITER_SYM_ADDR)
426 trace_seq_printf(s, " <" IP_FMT ">", ip);
427
428 out:
429 return !trace_seq_has_overflowed(s);
430}
431
432/**
433 * trace_print_lat_fmt - print the irq, preempt and lockdep fields
434 * @s: trace seq struct to write to
435 * @entry: The trace entry field from the ring buffer
436 *
437 * Prints the generic fields of irqs off, in hard or softirq, preempt
438 * count.
439 */
440int trace_print_lat_fmt(struct trace_seq *s, struct trace_entry *entry)
441{
442 char hardsoft_irq;
443 char need_resched;
444 char irqs_off;
445 int hardirq;
446 int softirq;
447 int nmi;
448
449 nmi = entry->flags & TRACE_FLAG_NMI;
450 hardirq = entry->flags & TRACE_FLAG_HARDIRQ;
451 softirq = entry->flags & TRACE_FLAG_SOFTIRQ;
452
453 irqs_off =
454 (entry->flags & TRACE_FLAG_IRQS_OFF) ? 'd' :
455 (entry->flags & TRACE_FLAG_IRQS_NOSUPPORT) ? 'X' :
456 '.';
457
458 switch (entry->flags & (TRACE_FLAG_NEED_RESCHED |
459 TRACE_FLAG_PREEMPT_RESCHED)) {
460 case TRACE_FLAG_NEED_RESCHED | TRACE_FLAG_PREEMPT_RESCHED:
461 need_resched = 'N';
462 break;
463 case TRACE_FLAG_NEED_RESCHED:
464 need_resched = 'n';
465 break;
466 case TRACE_FLAG_PREEMPT_RESCHED:
467 need_resched = 'p';
468 break;
469 default:
470 need_resched = '.';
471 break;
472 }
473
474 hardsoft_irq =
475 (nmi && hardirq) ? 'Z' :
476 nmi ? 'z' :
477 (hardirq && softirq) ? 'H' :
478 hardirq ? 'h' :
479 softirq ? 's' :
480 '.' ;
481
482 trace_seq_printf(s, "%c%c%c",
483 irqs_off, need_resched, hardsoft_irq);
484
485 if (entry->preempt_count)
486 trace_seq_printf(s, "%x", entry->preempt_count);
487 else
488 trace_seq_putc(s, '.');
489
490 return !trace_seq_has_overflowed(s);
491}
492
493static int
494lat_print_generic(struct trace_seq *s, struct trace_entry *entry, int cpu)
495{
496 char comm[TASK_COMM_LEN];
497
498 trace_find_cmdline(entry->pid, comm);
499
500 trace_seq_printf(s, "%8.8s-%-7d %3d",
501 comm, entry->pid, cpu);
502
503 return trace_print_lat_fmt(s, entry);
504}
505
506#undef MARK
507#define MARK(v, s) {.val = v, .sym = s}
508/* trace overhead mark */
509static const struct trace_mark {
510 unsigned long long val; /* unit: nsec */
511 char sym;
512} mark[] = {
513 MARK(1000000000ULL , '$'), /* 1 sec */
514 MARK(100000000ULL , '@'), /* 100 msec */
515 MARK(10000000ULL , '*'), /* 10 msec */
516 MARK(1000000ULL , '#'), /* 1000 usecs */
517 MARK(100000ULL , '!'), /* 100 usecs */
518 MARK(10000ULL , '+'), /* 10 usecs */
519};
520#undef MARK
521
522char trace_find_mark(unsigned long long d)
523{
524 int i;
525 int size = ARRAY_SIZE(mark);
526
527 for (i = 0; i < size; i++) {
528 if (d > mark[i].val)
529 break;
530 }
531
532 return (i == size) ? ' ' : mark[i].sym;
533}
534
535static int
536lat_print_timestamp(struct trace_iterator *iter, u64 next_ts)
537{
538 struct trace_array *tr = iter->tr;
539 unsigned long verbose = tr->trace_flags & TRACE_ITER_VERBOSE;
540 unsigned long in_ns = iter->iter_flags & TRACE_FILE_TIME_IN_NS;
541 unsigned long long abs_ts = iter->ts - iter->array_buffer->time_start;
542 unsigned long long rel_ts = next_ts - iter->ts;
543 struct trace_seq *s = &iter->seq;
544
545 if (in_ns) {
546 abs_ts = ns2usecs(abs_ts);
547 rel_ts = ns2usecs(rel_ts);
548 }
549
550 if (verbose && in_ns) {
551 unsigned long abs_usec = do_div(abs_ts, USEC_PER_MSEC);
552 unsigned long abs_msec = (unsigned long)abs_ts;
553 unsigned long rel_usec = do_div(rel_ts, USEC_PER_MSEC);
554 unsigned long rel_msec = (unsigned long)rel_ts;
555
556 trace_seq_printf(
557 s, "[%08llx] %ld.%03ldms (+%ld.%03ldms): ",
558 ns2usecs(iter->ts),
559 abs_msec, abs_usec,
560 rel_msec, rel_usec);
561
562 } else if (verbose && !in_ns) {
563 trace_seq_printf(
564 s, "[%016llx] %lld (+%lld): ",
565 iter->ts, abs_ts, rel_ts);
566
567 } else if (!verbose && in_ns) {
568 trace_seq_printf(
569 s, " %4lldus%c: ",
570 abs_ts,
571 trace_find_mark(rel_ts * NSEC_PER_USEC));
572
573 } else { /* !verbose && !in_ns */
574 trace_seq_printf(s, " %4lld: ", abs_ts);
575 }
576
577 return !trace_seq_has_overflowed(s);
578}
579
580int trace_print_context(struct trace_iterator *iter)
581{
582 struct trace_array *tr = iter->tr;
583 struct trace_seq *s = &iter->seq;
584 struct trace_entry *entry = iter->ent;
585 unsigned long long t;
586 unsigned long secs, usec_rem;
587 char comm[TASK_COMM_LEN];
588
589 trace_find_cmdline(entry->pid, comm);
590
591 trace_seq_printf(s, "%16s-%-7d ", comm, entry->pid);
592
593 if (tr->trace_flags & TRACE_ITER_RECORD_TGID) {
594 unsigned int tgid = trace_find_tgid(entry->pid);
595
596 if (!tgid)
597 trace_seq_printf(s, "(-------) ");
598 else
599 trace_seq_printf(s, "(%7d) ", tgid);
600 }
601
602 trace_seq_printf(s, "[%03d] ", iter->cpu);
603
604 if (tr->trace_flags & TRACE_ITER_IRQ_INFO)
605 trace_print_lat_fmt(s, entry);
606
607 if (iter->iter_flags & TRACE_FILE_TIME_IN_NS) {
608 t = ns2usecs(iter->ts);
609 usec_rem = do_div(t, USEC_PER_SEC);
610 secs = (unsigned long)t;
611 trace_seq_printf(s, " %5lu.%06lu: ", secs, usec_rem);
612 } else
613 trace_seq_printf(s, " %12llu: ", iter->ts);
614
615 return !trace_seq_has_overflowed(s);
616}
617
618int trace_print_lat_context(struct trace_iterator *iter)
619{
620 struct trace_entry *entry, *next_entry;
621 struct trace_array *tr = iter->tr;
622 struct trace_seq *s = &iter->seq;
623 unsigned long verbose = (tr->trace_flags & TRACE_ITER_VERBOSE);
624 u64 next_ts;
625
626 next_entry = trace_find_next_entry(iter, NULL, &next_ts);
627 if (!next_entry)
628 next_ts = iter->ts;
629
630 /* trace_find_next_entry() may change iter->ent */
631 entry = iter->ent;
632
633 if (verbose) {
634 char comm[TASK_COMM_LEN];
635
636 trace_find_cmdline(entry->pid, comm);
637
638 trace_seq_printf(
639 s, "%16s %7d %3d %d %08x %08lx ",
640 comm, entry->pid, iter->cpu, entry->flags,
641 entry->preempt_count, iter->idx);
642 } else {
643 lat_print_generic(s, entry, iter->cpu);
644 }
645
646 lat_print_timestamp(iter, next_ts);
647
648 return !trace_seq_has_overflowed(s);
649}
650
651/**
652 * ftrace_find_event - find a registered event
653 * @type: the type of event to look for
654 *
655 * Returns an event of type @type otherwise NULL
656 * Called with trace_event_read_lock() held.
657 */
658struct trace_event *ftrace_find_event(int type)
659{
660 struct trace_event *event;
661 unsigned key;
662
663 key = type & (EVENT_HASHSIZE - 1);
664
665 hlist_for_each_entry(event, &event_hash[key], node) {
666 if (event->type == type)
667 return event;
668 }
669
670 return NULL;
671}
672
673static LIST_HEAD(ftrace_event_list);
674
675static int trace_search_list(struct list_head **list)
676{
677 struct trace_event *e;
678 int next = __TRACE_LAST_TYPE;
679
680 if (list_empty(&ftrace_event_list)) {
681 *list = &ftrace_event_list;
682 return next;
683 }
684
685 /*
686 * We used up all possible max events,
687 * lets see if somebody freed one.
688 */
689 list_for_each_entry(e, &ftrace_event_list, list) {
690 if (e->type != next)
691 break;
692 next++;
693 }
694
695 /* Did we used up all 65 thousand events??? */
696 if (next > TRACE_EVENT_TYPE_MAX)
697 return 0;
698
699 *list = &e->list;
700 return next;
701}
702
703void trace_event_read_lock(void)
704{
705 down_read(&trace_event_sem);
706}
707
708void trace_event_read_unlock(void)
709{
710 up_read(&trace_event_sem);
711}
712
713/**
714 * register_trace_event - register output for an event type
715 * @event: the event type to register
716 *
717 * Event types are stored in a hash and this hash is used to
718 * find a way to print an event. If the @event->type is set
719 * then it will use that type, otherwise it will assign a
720 * type to use.
721 *
722 * If you assign your own type, please make sure it is added
723 * to the trace_type enum in trace.h, to avoid collisions
724 * with the dynamic types.
725 *
726 * Returns the event type number or zero on error.
727 */
728int register_trace_event(struct trace_event *event)
729{
730 unsigned key;
731 int ret = 0;
732
733 down_write(&trace_event_sem);
734
735 if (WARN_ON(!event))
736 goto out;
737
738 if (WARN_ON(!event->funcs))
739 goto out;
740
741 INIT_LIST_HEAD(&event->list);
742
743 if (!event->type) {
744 struct list_head *list = NULL;
745
746 if (next_event_type > TRACE_EVENT_TYPE_MAX) {
747
748 event->type = trace_search_list(&list);
749 if (!event->type)
750 goto out;
751
752 } else {
753
754 event->type = next_event_type++;
755 list = &ftrace_event_list;
756 }
757
758 if (WARN_ON(ftrace_find_event(event->type)))
759 goto out;
760
761 list_add_tail(&event->list, list);
762
763 } else if (event->type > __TRACE_LAST_TYPE) {
764 printk(KERN_WARNING "Need to add type to trace.h\n");
765 WARN_ON(1);
766 goto out;
767 } else {
768 /* Is this event already used */
769 if (ftrace_find_event(event->type))
770 goto out;
771 }
772
773 if (event->funcs->trace == NULL)
774 event->funcs->trace = trace_nop_print;
775 if (event->funcs->raw == NULL)
776 event->funcs->raw = trace_nop_print;
777 if (event->funcs->hex == NULL)
778 event->funcs->hex = trace_nop_print;
779 if (event->funcs->binary == NULL)
780 event->funcs->binary = trace_nop_print;
781
782 key = event->type & (EVENT_HASHSIZE - 1);
783
784 hlist_add_head(&event->node, &event_hash[key]);
785
786 ret = event->type;
787 out:
788 up_write(&trace_event_sem);
789
790 return ret;
791}
792EXPORT_SYMBOL_GPL(register_trace_event);
793
794/*
795 * Used by module code with the trace_event_sem held for write.
796 */
797int __unregister_trace_event(struct trace_event *event)
798{
799 hlist_del(&event->node);
800 list_del(&event->list);
801 return 0;
802}
803
804/**
805 * unregister_trace_event - remove a no longer used event
806 * @event: the event to remove
807 */
808int unregister_trace_event(struct trace_event *event)
809{
810 down_write(&trace_event_sem);
811 __unregister_trace_event(event);
812 up_write(&trace_event_sem);
813
814 return 0;
815}
816EXPORT_SYMBOL_GPL(unregister_trace_event);
817
818/*
819 * Standard events
820 */
821
822enum print_line_t trace_nop_print(struct trace_iterator *iter, int flags,
823 struct trace_event *event)
824{
825 trace_seq_printf(&iter->seq, "type: %d\n", iter->ent->type);
826
827 return trace_handle_return(&iter->seq);
828}
829
830/* TRACE_FN */
831static enum print_line_t trace_fn_trace(struct trace_iterator *iter, int flags,
832 struct trace_event *event)
833{
834 struct ftrace_entry *field;
835 struct trace_seq *s = &iter->seq;
836
837 trace_assign_type(field, iter->ent);
838
839 seq_print_ip_sym(s, field->ip, flags);
840
841 if ((flags & TRACE_ITER_PRINT_PARENT) && field->parent_ip) {
842 trace_seq_puts(s, " <-");
843 seq_print_ip_sym(s, field->parent_ip, flags);
844 }
845
846 trace_seq_putc(s, '\n');
847
848 return trace_handle_return(s);
849}
850
851static enum print_line_t trace_fn_raw(struct trace_iterator *iter, int flags,
852 struct trace_event *event)
853{
854 struct ftrace_entry *field;
855
856 trace_assign_type(field, iter->ent);
857
858 trace_seq_printf(&iter->seq, "%lx %lx\n",
859 field->ip,
860 field->parent_ip);
861
862 return trace_handle_return(&iter->seq);
863}
864
865static enum print_line_t trace_fn_hex(struct trace_iterator *iter, int flags,
866 struct trace_event *event)
867{
868 struct ftrace_entry *field;
869 struct trace_seq *s = &iter->seq;
870
871 trace_assign_type(field, iter->ent);
872
873 SEQ_PUT_HEX_FIELD(s, field->ip);
874 SEQ_PUT_HEX_FIELD(s, field->parent_ip);
875
876 return trace_handle_return(s);
877}
878
879static enum print_line_t trace_fn_bin(struct trace_iterator *iter, int flags,
880 struct trace_event *event)
881{
882 struct ftrace_entry *field;
883 struct trace_seq *s = &iter->seq;
884
885 trace_assign_type(field, iter->ent);
886
887 SEQ_PUT_FIELD(s, field->ip);
888 SEQ_PUT_FIELD(s, field->parent_ip);
889
890 return trace_handle_return(s);
891}
892
893static struct trace_event_functions trace_fn_funcs = {
894 .trace = trace_fn_trace,
895 .raw = trace_fn_raw,
896 .hex = trace_fn_hex,
897 .binary = trace_fn_bin,
898};
899
900static struct trace_event trace_fn_event = {
901 .type = TRACE_FN,
902 .funcs = &trace_fn_funcs,
903};
904
905/* TRACE_CTX an TRACE_WAKE */
906static enum print_line_t trace_ctxwake_print(struct trace_iterator *iter,
907 char *delim)
908{
909 struct ctx_switch_entry *field;
910 char comm[TASK_COMM_LEN];
911 int S, T;
912
913
914 trace_assign_type(field, iter->ent);
915
916 T = task_index_to_char(field->next_state);
917 S = task_index_to_char(field->prev_state);
918 trace_find_cmdline(field->next_pid, comm);
919 trace_seq_printf(&iter->seq,
920 " %7d:%3d:%c %s [%03d] %7d:%3d:%c %s\n",
921 field->prev_pid,
922 field->prev_prio,
923 S, delim,
924 field->next_cpu,
925 field->next_pid,
926 field->next_prio,
927 T, comm);
928
929 return trace_handle_return(&iter->seq);
930}
931
932static enum print_line_t trace_ctx_print(struct trace_iterator *iter, int flags,
933 struct trace_event *event)
934{
935 return trace_ctxwake_print(iter, "==>");
936}
937
938static enum print_line_t trace_wake_print(struct trace_iterator *iter,
939 int flags, struct trace_event *event)
940{
941 return trace_ctxwake_print(iter, " +");
942}
943
944static int trace_ctxwake_raw(struct trace_iterator *iter, char S)
945{
946 struct ctx_switch_entry *field;
947 int T;
948
949 trace_assign_type(field, iter->ent);
950
951 if (!S)
952 S = task_index_to_char(field->prev_state);
953 T = task_index_to_char(field->next_state);
954 trace_seq_printf(&iter->seq, "%d %d %c %d %d %d %c\n",
955 field->prev_pid,
956 field->prev_prio,
957 S,
958 field->next_cpu,
959 field->next_pid,
960 field->next_prio,
961 T);
962
963 return trace_handle_return(&iter->seq);
964}
965
966static enum print_line_t trace_ctx_raw(struct trace_iterator *iter, int flags,
967 struct trace_event *event)
968{
969 return trace_ctxwake_raw(iter, 0);
970}
971
972static enum print_line_t trace_wake_raw(struct trace_iterator *iter, int flags,
973 struct trace_event *event)
974{
975 return trace_ctxwake_raw(iter, '+');
976}
977
978
979static int trace_ctxwake_hex(struct trace_iterator *iter, char S)
980{
981 struct ctx_switch_entry *field;
982 struct trace_seq *s = &iter->seq;
983 int T;
984
985 trace_assign_type(field, iter->ent);
986
987 if (!S)
988 S = task_index_to_char(field->prev_state);
989 T = task_index_to_char(field->next_state);
990
991 SEQ_PUT_HEX_FIELD(s, field->prev_pid);
992 SEQ_PUT_HEX_FIELD(s, field->prev_prio);
993 SEQ_PUT_HEX_FIELD(s, S);
994 SEQ_PUT_HEX_FIELD(s, field->next_cpu);
995 SEQ_PUT_HEX_FIELD(s, field->next_pid);
996 SEQ_PUT_HEX_FIELD(s, field->next_prio);
997 SEQ_PUT_HEX_FIELD(s, T);
998
999 return trace_handle_return(s);
1000}
1001
1002static enum print_line_t trace_ctx_hex(struct trace_iterator *iter, int flags,
1003 struct trace_event *event)
1004{
1005 return trace_ctxwake_hex(iter, 0);
1006}
1007
1008static enum print_line_t trace_wake_hex(struct trace_iterator *iter, int flags,
1009 struct trace_event *event)
1010{
1011 return trace_ctxwake_hex(iter, '+');
1012}
1013
1014static enum print_line_t trace_ctxwake_bin(struct trace_iterator *iter,
1015 int flags, struct trace_event *event)
1016{
1017 struct ctx_switch_entry *field;
1018 struct trace_seq *s = &iter->seq;
1019
1020 trace_assign_type(field, iter->ent);
1021
1022 SEQ_PUT_FIELD(s, field->prev_pid);
1023 SEQ_PUT_FIELD(s, field->prev_prio);
1024 SEQ_PUT_FIELD(s, field->prev_state);
1025 SEQ_PUT_FIELD(s, field->next_cpu);
1026 SEQ_PUT_FIELD(s, field->next_pid);
1027 SEQ_PUT_FIELD(s, field->next_prio);
1028 SEQ_PUT_FIELD(s, field->next_state);
1029
1030 return trace_handle_return(s);
1031}
1032
1033static struct trace_event_functions trace_ctx_funcs = {
1034 .trace = trace_ctx_print,
1035 .raw = trace_ctx_raw,
1036 .hex = trace_ctx_hex,
1037 .binary = trace_ctxwake_bin,
1038};
1039
1040static struct trace_event trace_ctx_event = {
1041 .type = TRACE_CTX,
1042 .funcs = &trace_ctx_funcs,
1043};
1044
1045static struct trace_event_functions trace_wake_funcs = {
1046 .trace = trace_wake_print,
1047 .raw = trace_wake_raw,
1048 .hex = trace_wake_hex,
1049 .binary = trace_ctxwake_bin,
1050};
1051
1052static struct trace_event trace_wake_event = {
1053 .type = TRACE_WAKE,
1054 .funcs = &trace_wake_funcs,
1055};
1056
1057/* TRACE_STACK */
1058
1059static enum print_line_t trace_stack_print(struct trace_iterator *iter,
1060 int flags, struct trace_event *event)
1061{
1062 struct stack_entry *field;
1063 struct trace_seq *s = &iter->seq;
1064 unsigned long *p;
1065 unsigned long *end;
1066
1067 trace_assign_type(field, iter->ent);
1068 end = (unsigned long *)((long)iter->ent + iter->ent_size);
1069
1070 trace_seq_puts(s, "<stack trace>\n");
1071
1072 for (p = field->caller; p && p < end && *p != ULONG_MAX; p++) {
1073
1074 if (trace_seq_has_overflowed(s))
1075 break;
1076
1077 trace_seq_puts(s, " => ");
1078 seq_print_ip_sym(s, *p, flags);
1079 trace_seq_putc(s, '\n');
1080 }
1081
1082 return trace_handle_return(s);
1083}
1084
1085static struct trace_event_functions trace_stack_funcs = {
1086 .trace = trace_stack_print,
1087};
1088
1089static struct trace_event trace_stack_event = {
1090 .type = TRACE_STACK,
1091 .funcs = &trace_stack_funcs,
1092};
1093
1094/* TRACE_USER_STACK */
1095static enum print_line_t trace_user_stack_print(struct trace_iterator *iter,
1096 int flags, struct trace_event *event)
1097{
1098 struct trace_array *tr = iter->tr;
1099 struct userstack_entry *field;
1100 struct trace_seq *s = &iter->seq;
1101 struct mm_struct *mm = NULL;
1102 unsigned int i;
1103
1104 trace_assign_type(field, iter->ent);
1105
1106 trace_seq_puts(s, "<user stack trace>\n");
1107
1108 if (tr->trace_flags & TRACE_ITER_SYM_USEROBJ) {
1109 struct task_struct *task;
1110 /*
1111 * we do the lookup on the thread group leader,
1112 * since individual threads might have already quit!
1113 */
1114 rcu_read_lock();
1115 task = find_task_by_vpid(field->tgid);
1116 if (task)
1117 mm = get_task_mm(task);
1118 rcu_read_unlock();
1119 }
1120
1121 for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
1122 unsigned long ip = field->caller[i];
1123
1124 if (!ip || trace_seq_has_overflowed(s))
1125 break;
1126
1127 trace_seq_puts(s, " => ");
1128 seq_print_user_ip(s, mm, ip, flags);
1129 trace_seq_putc(s, '\n');
1130 }
1131
1132 if (mm)
1133 mmput(mm);
1134
1135 return trace_handle_return(s);
1136}
1137
1138static struct trace_event_functions trace_user_stack_funcs = {
1139 .trace = trace_user_stack_print,
1140};
1141
1142static struct trace_event trace_user_stack_event = {
1143 .type = TRACE_USER_STACK,
1144 .funcs = &trace_user_stack_funcs,
1145};
1146
1147/* TRACE_HWLAT */
1148static enum print_line_t
1149trace_hwlat_print(struct trace_iterator *iter, int flags,
1150 struct trace_event *event)
1151{
1152 struct trace_entry *entry = iter->ent;
1153 struct trace_seq *s = &iter->seq;
1154 struct hwlat_entry *field;
1155
1156 trace_assign_type(field, entry);
1157
1158 trace_seq_printf(s, "#%-5u inner/outer(us): %4llu/%-5llu ts:%lld.%09ld count:%d",
1159 field->seqnum,
1160 field->duration,
1161 field->outer_duration,
1162 (long long)field->timestamp.tv_sec,
1163 field->timestamp.tv_nsec, field->count);
1164
1165 if (field->nmi_count) {
1166 /*
1167 * The generic sched_clock() is not NMI safe, thus
1168 * we only record the count and not the time.
1169 */
1170 if (!IS_ENABLED(CONFIG_GENERIC_SCHED_CLOCK))
1171 trace_seq_printf(s, " nmi-total:%llu",
1172 field->nmi_total_ts);
1173 trace_seq_printf(s, " nmi-count:%u",
1174 field->nmi_count);
1175 }
1176
1177 trace_seq_putc(s, '\n');
1178
1179 return trace_handle_return(s);
1180}
1181
1182
1183static enum print_line_t
1184trace_hwlat_raw(struct trace_iterator *iter, int flags,
1185 struct trace_event *event)
1186{
1187 struct hwlat_entry *field;
1188 struct trace_seq *s = &iter->seq;
1189
1190 trace_assign_type(field, iter->ent);
1191
1192 trace_seq_printf(s, "%llu %lld %lld %09ld %u\n",
1193 field->duration,
1194 field->outer_duration,
1195 (long long)field->timestamp.tv_sec,
1196 field->timestamp.tv_nsec,
1197 field->seqnum);
1198
1199 return trace_handle_return(s);
1200}
1201
1202static struct trace_event_functions trace_hwlat_funcs = {
1203 .trace = trace_hwlat_print,
1204 .raw = trace_hwlat_raw,
1205};
1206
1207static struct trace_event trace_hwlat_event = {
1208 .type = TRACE_HWLAT,
1209 .funcs = &trace_hwlat_funcs,
1210};
1211
1212/* TRACE_BPUTS */
1213static enum print_line_t
1214trace_bputs_print(struct trace_iterator *iter, int flags,
1215 struct trace_event *event)
1216{
1217 struct trace_entry *entry = iter->ent;
1218 struct trace_seq *s = &iter->seq;
1219 struct bputs_entry *field;
1220
1221 trace_assign_type(field, entry);
1222
1223 seq_print_ip_sym(s, field->ip, flags);
1224 trace_seq_puts(s, ": ");
1225 trace_seq_puts(s, field->str);
1226
1227 return trace_handle_return(s);
1228}
1229
1230
1231static enum print_line_t
1232trace_bputs_raw(struct trace_iterator *iter, int flags,
1233 struct trace_event *event)
1234{
1235 struct bputs_entry *field;
1236 struct trace_seq *s = &iter->seq;
1237
1238 trace_assign_type(field, iter->ent);
1239
1240 trace_seq_printf(s, ": %lx : ", field->ip);
1241 trace_seq_puts(s, field->str);
1242
1243 return trace_handle_return(s);
1244}
1245
1246static struct trace_event_functions trace_bputs_funcs = {
1247 .trace = trace_bputs_print,
1248 .raw = trace_bputs_raw,
1249};
1250
1251static struct trace_event trace_bputs_event = {
1252 .type = TRACE_BPUTS,
1253 .funcs = &trace_bputs_funcs,
1254};
1255
1256/* TRACE_BPRINT */
1257static enum print_line_t
1258trace_bprint_print(struct trace_iterator *iter, int flags,
1259 struct trace_event *event)
1260{
1261 struct trace_entry *entry = iter->ent;
1262 struct trace_seq *s = &iter->seq;
1263 struct bprint_entry *field;
1264
1265 trace_assign_type(field, entry);
1266
1267 seq_print_ip_sym(s, field->ip, flags);
1268 trace_seq_puts(s, ": ");
1269 trace_seq_bprintf(s, field->fmt, field->buf);
1270
1271 return trace_handle_return(s);
1272}
1273
1274
1275static enum print_line_t
1276trace_bprint_raw(struct trace_iterator *iter, int flags,
1277 struct trace_event *event)
1278{
1279 struct bprint_entry *field;
1280 struct trace_seq *s = &iter->seq;
1281
1282 trace_assign_type(field, iter->ent);
1283
1284 trace_seq_printf(s, ": %lx : ", field->ip);
1285 trace_seq_bprintf(s, field->fmt, field->buf);
1286
1287 return trace_handle_return(s);
1288}
1289
1290static struct trace_event_functions trace_bprint_funcs = {
1291 .trace = trace_bprint_print,
1292 .raw = trace_bprint_raw,
1293};
1294
1295static struct trace_event trace_bprint_event = {
1296 .type = TRACE_BPRINT,
1297 .funcs = &trace_bprint_funcs,
1298};
1299
1300/* TRACE_PRINT */
1301static enum print_line_t trace_print_print(struct trace_iterator *iter,
1302 int flags, struct trace_event *event)
1303{
1304 struct print_entry *field;
1305 struct trace_seq *s = &iter->seq;
1306
1307 trace_assign_type(field, iter->ent);
1308
1309 seq_print_ip_sym(s, field->ip, flags);
1310 trace_seq_printf(s, ": %s", field->buf);
1311
1312 return trace_handle_return(s);
1313}
1314
1315static enum print_line_t trace_print_raw(struct trace_iterator *iter, int flags,
1316 struct trace_event *event)
1317{
1318 struct print_entry *field;
1319
1320 trace_assign_type(field, iter->ent);
1321
1322 trace_seq_printf(&iter->seq, "# %lx %s", field->ip, field->buf);
1323
1324 return trace_handle_return(&iter->seq);
1325}
1326
1327static struct trace_event_functions trace_print_funcs = {
1328 .trace = trace_print_print,
1329 .raw = trace_print_raw,
1330};
1331
1332static struct trace_event trace_print_event = {
1333 .type = TRACE_PRINT,
1334 .funcs = &trace_print_funcs,
1335};
1336
1337static enum print_line_t trace_raw_data(struct trace_iterator *iter, int flags,
1338 struct trace_event *event)
1339{
1340 struct raw_data_entry *field;
1341 int i;
1342
1343 trace_assign_type(field, iter->ent);
1344
1345 trace_seq_printf(&iter->seq, "# %x buf:", field->id);
1346
1347 for (i = 0; i < iter->ent_size - offsetof(struct raw_data_entry, buf); i++)
1348 trace_seq_printf(&iter->seq, " %02x",
1349 (unsigned char)field->buf[i]);
1350
1351 trace_seq_putc(&iter->seq, '\n');
1352
1353 return trace_handle_return(&iter->seq);
1354}
1355
1356static struct trace_event_functions trace_raw_data_funcs = {
1357 .trace = trace_raw_data,
1358 .raw = trace_raw_data,
1359};
1360
1361static struct trace_event trace_raw_data_event = {
1362 .type = TRACE_RAW_DATA,
1363 .funcs = &trace_raw_data_funcs,
1364};
1365
1366
1367static struct trace_event *events[] __initdata = {
1368 &trace_fn_event,
1369 &trace_ctx_event,
1370 &trace_wake_event,
1371 &trace_stack_event,
1372 &trace_user_stack_event,
1373 &trace_bputs_event,
1374 &trace_bprint_event,
1375 &trace_print_event,
1376 &trace_hwlat_event,
1377 &trace_raw_data_event,
1378 NULL
1379};
1380
1381__init static int init_events(void)
1382{
1383 struct trace_event *event;
1384 int i, ret;
1385
1386 for (i = 0; events[i]; i++) {
1387 event = events[i];
1388
1389 ret = register_trace_event(event);
1390 if (!ret) {
1391 printk(KERN_WARNING "event %d failed to register\n",
1392 event->type);
1393 WARN_ON_ONCE(1);
1394 }
1395 }
1396
1397 return 0;
1398}
1399early_initcall(init_events);