1 // SPDX-License-Identifier: GPL-2.0
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>
16 #include "trace_output.h"
18 /* must be a power of 2 */
19 #define EVENT_HASHSIZE 128
21 DECLARE_RWSEM(trace_event_sem);
23 static struct hlist_head event_hash[EVENT_HASHSIZE] __read_mostly;
25 enum print_line_t trace_print_bputs_msg_only(struct trace_iterator *iter)
27 struct trace_seq *s = &iter->seq;
28 struct trace_entry *entry = iter->ent;
29 struct bputs_entry *field;
31 trace_assign_type(field, entry);
33 trace_seq_puts(s, field->str);
35 return trace_handle_return(s);
38 enum print_line_t trace_print_bprintk_msg_only(struct trace_iterator *iter)
40 struct trace_seq *s = &iter->seq;
41 struct trace_entry *entry = iter->ent;
42 struct bprint_entry *field;
44 trace_assign_type(field, entry);
46 trace_seq_bprintf(s, field->fmt, field->buf);
48 return trace_handle_return(s);
51 enum print_line_t trace_print_printk_msg_only(struct trace_iterator *iter)
53 struct trace_seq *s = &iter->seq;
54 struct trace_entry *entry = iter->ent;
55 struct print_entry *field;
57 trace_assign_type(field, entry);
59 trace_seq_puts(s, field->buf);
61 return trace_handle_return(s);
65 trace_print_flags_seq(struct trace_seq *p, const char *delim,
67 const struct trace_print_flags *flag_array)
71 const char *ret = trace_seq_buffer_ptr(p);
74 for (i = 0; flag_array[i].name && flags; i++) {
76 mask = flag_array[i].mask;
77 if ((flags & mask) != mask)
80 str = flag_array[i].name;
83 trace_seq_puts(p, delim);
86 trace_seq_puts(p, str);
89 /* check for left over flags */
92 trace_seq_puts(p, delim);
93 trace_seq_printf(p, "0x%lx", flags);
100 EXPORT_SYMBOL(trace_print_flags_seq);
103 trace_print_symbols_seq(struct trace_seq *p, unsigned long val,
104 const struct trace_print_flags *symbol_array)
107 const char *ret = trace_seq_buffer_ptr(p);
109 for (i = 0; symbol_array[i].name; i++) {
111 if (val != symbol_array[i].mask)
114 trace_seq_puts(p, symbol_array[i].name);
118 if (ret == (const char *)(trace_seq_buffer_ptr(p)))
119 trace_seq_printf(p, "0x%lx", val);
121 trace_seq_putc(p, 0);
125 EXPORT_SYMBOL(trace_print_symbols_seq);
127 #if BITS_PER_LONG == 32
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)
133 unsigned long long mask;
135 const char *ret = trace_seq_buffer_ptr(p);
138 for (i = 0; flag_array[i].name && flags; i++) {
140 mask = flag_array[i].mask;
141 if ((flags & mask) != mask)
144 str = flag_array[i].name;
147 trace_seq_puts(p, delim);
150 trace_seq_puts(p, str);
153 /* check for left over flags */
156 trace_seq_puts(p, delim);
157 trace_seq_printf(p, "0x%llx", flags);
160 trace_seq_putc(p, 0);
164 EXPORT_SYMBOL(trace_print_flags_seq_u64);
167 trace_print_symbols_seq_u64(struct trace_seq *p, unsigned long long val,
168 const struct trace_print_flags_u64 *symbol_array)
171 const char *ret = trace_seq_buffer_ptr(p);
173 for (i = 0; symbol_array[i].name; i++) {
175 if (val != symbol_array[i].mask)
178 trace_seq_puts(p, symbol_array[i].name);
182 if (ret == (const char *)(trace_seq_buffer_ptr(p)))
183 trace_seq_printf(p, "0x%llx", val);
185 trace_seq_putc(p, 0);
189 EXPORT_SYMBOL(trace_print_symbols_seq_u64);
193 trace_print_bitmask_seq(struct trace_seq *p, void *bitmask_ptr,
194 unsigned int bitmask_size)
196 const char *ret = trace_seq_buffer_ptr(p);
198 trace_seq_bitmask(p, bitmask_ptr, bitmask_size * 8);
199 trace_seq_putc(p, 0);
203 EXPORT_SYMBOL_GPL(trace_print_bitmask_seq);
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
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.
217 trace_print_hex_seq(struct trace_seq *p, const unsigned char *buf, int buf_len,
221 const char *ret = trace_seq_buffer_ptr(p);
222 const char *fmt = concatenate ? "%*phN" : "%*ph";
224 for (i = 0; i < buf_len; i += 16) {
225 if (!concatenate && i != 0)
226 trace_seq_putc(p, ' ');
227 trace_seq_printf(p, fmt, min(buf_len - i, 16), &buf[i]);
229 trace_seq_putc(p, 0);
233 EXPORT_SYMBOL(trace_print_hex_seq);
236 trace_print_array_seq(struct trace_seq *p, const void *buf, int count,
239 const char *ret = trace_seq_buffer_ptr(p);
240 const char *prefix = "";
241 void *ptr = (void *)buf;
242 size_t buf_len = count * el_size;
244 trace_seq_putc(p, '{');
246 while (ptr < buf + buf_len) {
249 trace_seq_printf(p, "%s0x%x", prefix,
253 trace_seq_printf(p, "%s0x%x", prefix,
257 trace_seq_printf(p, "%s0x%x", prefix,
261 trace_seq_printf(p, "%s0x%llx", prefix,
265 trace_seq_printf(p, "BAD SIZE:%zu 0x%x", el_size,
273 trace_seq_putc(p, '}');
274 trace_seq_putc(p, 0);
278 EXPORT_SYMBOL(trace_print_array_seq);
281 trace_print_hex_dump_seq(struct trace_seq *p, const char *prefix_str,
282 int prefix_type, int rowsize, int groupsize,
283 const void *buf, size_t len, bool ascii)
285 const char *ret = trace_seq_buffer_ptr(p);
287 trace_seq_putc(p, '\n');
288 trace_seq_hex_dump(p, prefix_str, prefix_type,
289 rowsize, groupsize, buf, len, ascii);
290 trace_seq_putc(p, 0);
293 EXPORT_SYMBOL(trace_print_hex_dump_seq);
295 int trace_raw_output_prep(struct trace_iterator *iter,
296 struct trace_event *trace_event)
298 struct trace_event_call *event;
299 struct trace_seq *s = &iter->seq;
300 struct trace_seq *p = &iter->tmp_seq;
301 struct trace_entry *entry;
303 event = container_of(trace_event, struct trace_event_call, event);
306 if (entry->type != event->event.type) {
308 return TRACE_TYPE_UNHANDLED;
312 trace_seq_printf(s, "%s: ", trace_event_name(event));
314 return trace_handle_return(s);
316 EXPORT_SYMBOL(trace_raw_output_prep);
318 void trace_event_printf(struct trace_iterator *iter, const char *fmt, ...)
323 trace_check_vprintf(iter, trace_event_format(iter, fmt), ap);
326 EXPORT_SYMBOL(trace_event_printf);
328 static __printf(3, 0)
329 int trace_output_raw(struct trace_iterator *iter, char *name,
330 char *fmt, va_list ap)
332 struct trace_seq *s = &iter->seq;
334 trace_seq_printf(s, "%s: ", name);
335 trace_seq_vprintf(s, trace_event_format(iter, fmt), ap);
337 return trace_handle_return(s);
340 int trace_output_call(struct trace_iterator *iter, char *name, char *fmt, ...)
346 ret = trace_output_raw(iter, name, fmt, ap);
351 EXPORT_SYMBOL_GPL(trace_output_call);
353 static inline const char *kretprobed(const char *name, unsigned long addr)
355 if (is_kretprobe_trampoline(addr))
356 return "[unknown/kretprobe'd]";
361 trace_seq_print_sym(struct trace_seq *s, unsigned long address, bool offset)
363 #ifdef CONFIG_KALLSYMS
364 char str[KSYM_SYMBOL_LEN];
368 sprint_symbol(str, address);
370 kallsyms_lookup(address, NULL, NULL, NULL, str);
371 name = kretprobed(str, address);
373 if (name && strlen(name)) {
374 trace_seq_puts(s, name);
378 trace_seq_printf(s, "0x%08lx", address);
382 # define IP_FMT "%08lx"
384 # define IP_FMT "%016lx"
387 static int seq_print_user_ip(struct trace_seq *s, struct mm_struct *mm,
388 unsigned long ip, unsigned long sym_flags)
390 struct file *file = NULL;
391 unsigned long vmstart = 0;
398 const struct vm_area_struct *vma;
401 vma = find_vma(mm, ip);
404 vmstart = vma->vm_start;
407 ret = trace_seq_path(s, file_user_path(file));
409 trace_seq_printf(s, "[+0x%lx]",
412 mmap_read_unlock(mm);
414 if (ret && ((sym_flags & TRACE_ITER_SYM_ADDR) || !file))
415 trace_seq_printf(s, " <" IP_FMT ">", ip);
416 return !trace_seq_has_overflowed(s);
420 seq_print_ip_sym(struct trace_seq *s, unsigned long ip, unsigned long sym_flags)
423 trace_seq_putc(s, '0');
427 trace_seq_print_sym(s, ip, sym_flags & TRACE_ITER_SYM_OFFSET);
429 if (sym_flags & TRACE_ITER_SYM_ADDR)
430 trace_seq_printf(s, " <" IP_FMT ">", ip);
433 return !trace_seq_has_overflowed(s);
437 * trace_print_lat_fmt - print the irq, preempt and lockdep fields
438 * @s: trace seq struct to write to
439 * @entry: The trace entry field from the ring buffer
441 * Prints the generic fields of irqs off, in hard or softirq, preempt
444 int trace_print_lat_fmt(struct trace_seq *s, struct trace_entry *entry)
454 nmi = entry->flags & TRACE_FLAG_NMI;
455 hardirq = entry->flags & TRACE_FLAG_HARDIRQ;
456 softirq = entry->flags & TRACE_FLAG_SOFTIRQ;
457 bh_off = entry->flags & TRACE_FLAG_BH_OFF;
460 (entry->flags & TRACE_FLAG_IRQS_OFF && bh_off) ? 'D' :
461 (entry->flags & TRACE_FLAG_IRQS_OFF) ? 'd' :
463 (entry->flags & TRACE_FLAG_IRQS_NOSUPPORT) ? 'X' :
466 switch (entry->flags & (TRACE_FLAG_NEED_RESCHED |
467 TRACE_FLAG_PREEMPT_RESCHED)) {
468 case TRACE_FLAG_NEED_RESCHED | TRACE_FLAG_PREEMPT_RESCHED:
471 case TRACE_FLAG_NEED_RESCHED:
474 case TRACE_FLAG_PREEMPT_RESCHED:
483 (nmi && hardirq) ? 'Z' :
485 (hardirq && softirq) ? 'H' :
490 trace_seq_printf(s, "%c%c%c",
491 irqs_off, need_resched, hardsoft_irq);
493 if (entry->preempt_count & 0xf)
494 trace_seq_printf(s, "%x", entry->preempt_count & 0xf);
496 trace_seq_putc(s, '.');
498 if (entry->preempt_count & 0xf0)
499 trace_seq_printf(s, "%x", entry->preempt_count >> 4);
501 trace_seq_putc(s, '.');
503 return !trace_seq_has_overflowed(s);
507 lat_print_generic(struct trace_seq *s, struct trace_entry *entry, int cpu)
509 char comm[TASK_COMM_LEN];
511 trace_find_cmdline(entry->pid, comm);
513 trace_seq_printf(s, "%8.8s-%-7d %3d",
514 comm, entry->pid, cpu);
516 return trace_print_lat_fmt(s, entry);
520 #define MARK(v, s) {.val = v, .sym = s}
521 /* trace overhead mark */
522 static const struct trace_mark {
523 unsigned long long val; /* unit: nsec */
526 MARK(1000000000ULL , '$'), /* 1 sec */
527 MARK(100000000ULL , '@'), /* 100 msec */
528 MARK(10000000ULL , '*'), /* 10 msec */
529 MARK(1000000ULL , '#'), /* 1000 usecs */
530 MARK(100000ULL , '!'), /* 100 usecs */
531 MARK(10000ULL , '+'), /* 10 usecs */
535 char trace_find_mark(unsigned long long d)
538 int size = ARRAY_SIZE(mark);
540 for (i = 0; i < size; i++) {
545 return (i == size) ? ' ' : mark[i].sym;
549 lat_print_timestamp(struct trace_iterator *iter, u64 next_ts)
551 struct trace_array *tr = iter->tr;
552 unsigned long verbose = tr->trace_flags & TRACE_ITER_VERBOSE;
553 unsigned long in_ns = iter->iter_flags & TRACE_FILE_TIME_IN_NS;
554 unsigned long long abs_ts = iter->ts - iter->array_buffer->time_start;
555 unsigned long long rel_ts = next_ts - iter->ts;
556 struct trace_seq *s = &iter->seq;
559 abs_ts = ns2usecs(abs_ts);
560 rel_ts = ns2usecs(rel_ts);
563 if (verbose && in_ns) {
564 unsigned long abs_usec = do_div(abs_ts, USEC_PER_MSEC);
565 unsigned long abs_msec = (unsigned long)abs_ts;
566 unsigned long rel_usec = do_div(rel_ts, USEC_PER_MSEC);
567 unsigned long rel_msec = (unsigned long)rel_ts;
570 s, "[%08llx] %ld.%03ldms (+%ld.%03ldms): ",
575 } else if (verbose && !in_ns) {
577 s, "[%016llx] %lld (+%lld): ",
578 iter->ts, abs_ts, rel_ts);
580 } else if (!verbose && in_ns) {
584 trace_find_mark(rel_ts * NSEC_PER_USEC));
586 } else { /* !verbose && !in_ns */
587 trace_seq_printf(s, " %4lld: ", abs_ts);
590 return !trace_seq_has_overflowed(s);
593 static void trace_print_time(struct trace_seq *s, struct trace_iterator *iter,
594 unsigned long long ts)
596 unsigned long secs, usec_rem;
597 unsigned long long t;
599 if (iter->iter_flags & TRACE_FILE_TIME_IN_NS) {
601 usec_rem = do_div(t, USEC_PER_SEC);
602 secs = (unsigned long)t;
603 trace_seq_printf(s, " %5lu.%06lu", secs, usec_rem);
605 trace_seq_printf(s, " %12llu", ts);
608 int trace_print_context(struct trace_iterator *iter)
610 struct trace_array *tr = iter->tr;
611 struct trace_seq *s = &iter->seq;
612 struct trace_entry *entry = iter->ent;
613 char comm[TASK_COMM_LEN];
615 trace_find_cmdline(entry->pid, comm);
617 trace_seq_printf(s, "%16s-%-7d ", comm, entry->pid);
619 if (tr->trace_flags & TRACE_ITER_RECORD_TGID) {
620 unsigned int tgid = trace_find_tgid(entry->pid);
623 trace_seq_printf(s, "(-------) ");
625 trace_seq_printf(s, "(%7d) ", tgid);
628 trace_seq_printf(s, "[%03d] ", iter->cpu);
630 if (tr->trace_flags & TRACE_ITER_IRQ_INFO)
631 trace_print_lat_fmt(s, entry);
633 trace_print_time(s, iter, iter->ts);
634 trace_seq_puts(s, ": ");
636 return !trace_seq_has_overflowed(s);
639 int trace_print_lat_context(struct trace_iterator *iter)
641 struct trace_entry *entry, *next_entry;
642 struct trace_array *tr = iter->tr;
643 struct trace_seq *s = &iter->seq;
644 unsigned long verbose = (tr->trace_flags & TRACE_ITER_VERBOSE);
647 next_entry = trace_find_next_entry(iter, NULL, &next_ts);
651 /* trace_find_next_entry() may change iter->ent */
655 char comm[TASK_COMM_LEN];
657 trace_find_cmdline(entry->pid, comm);
660 s, "%16s %7d %3d %d %08x %08lx ",
661 comm, entry->pid, iter->cpu, entry->flags,
662 entry->preempt_count & 0xf, iter->idx);
664 lat_print_generic(s, entry, iter->cpu);
667 lat_print_timestamp(iter, next_ts);
669 return !trace_seq_has_overflowed(s);
673 * ftrace_find_event - find a registered event
674 * @type: the type of event to look for
676 * Returns an event of type @type otherwise NULL
677 * Called with trace_event_read_lock() held.
679 struct trace_event *ftrace_find_event(int type)
681 struct trace_event *event;
684 key = type & (EVENT_HASHSIZE - 1);
686 hlist_for_each_entry(event, &event_hash[key], node) {
687 if (event->type == type)
694 static DEFINE_IDA(trace_event_ida);
696 static void free_trace_event_type(int type)
698 if (type >= __TRACE_LAST_TYPE)
699 ida_free(&trace_event_ida, type);
702 static int alloc_trace_event_type(void)
706 /* Skip static defined type numbers */
707 next = ida_alloc_range(&trace_event_ida, __TRACE_LAST_TYPE,
708 TRACE_EVENT_TYPE_MAX, GFP_KERNEL);
714 void trace_event_read_lock(void)
716 down_read(&trace_event_sem);
719 void trace_event_read_unlock(void)
721 up_read(&trace_event_sem);
725 * register_trace_event - register output for an event type
726 * @event: the event type to register
728 * Event types are stored in a hash and this hash is used to
729 * find a way to print an event. If the @event->type is set
730 * then it will use that type, otherwise it will assign a
733 * If you assign your own type, please make sure it is added
734 * to the trace_type enum in trace.h, to avoid collisions
735 * with the dynamic types.
737 * Returns the event type number or zero on error.
739 int register_trace_event(struct trace_event *event)
744 down_write(&trace_event_sem);
749 if (WARN_ON(!event->funcs))
753 event->type = alloc_trace_event_type();
756 } else if (WARN(event->type > __TRACE_LAST_TYPE,
757 "Need to add type to trace.h")) {
760 /* Is this event already used */
761 if (ftrace_find_event(event->type))
765 if (event->funcs->trace == NULL)
766 event->funcs->trace = trace_nop_print;
767 if (event->funcs->raw == NULL)
768 event->funcs->raw = trace_nop_print;
769 if (event->funcs->hex == NULL)
770 event->funcs->hex = trace_nop_print;
771 if (event->funcs->binary == NULL)
772 event->funcs->binary = trace_nop_print;
774 key = event->type & (EVENT_HASHSIZE - 1);
776 hlist_add_head(&event->node, &event_hash[key]);
780 up_write(&trace_event_sem);
784 EXPORT_SYMBOL_GPL(register_trace_event);
787 * Used by module code with the trace_event_sem held for write.
789 int __unregister_trace_event(struct trace_event *event)
791 hlist_del(&event->node);
792 free_trace_event_type(event->type);
797 * unregister_trace_event - remove a no longer used event
798 * @event: the event to remove
800 int unregister_trace_event(struct trace_event *event)
802 down_write(&trace_event_sem);
803 __unregister_trace_event(event);
804 up_write(&trace_event_sem);
808 EXPORT_SYMBOL_GPL(unregister_trace_event);
814 static void print_array(struct trace_iterator *iter, void *pos,
815 struct ftrace_event_field *field)
821 offset = *(int *)pos & 0xffff;
822 len = *(int *)pos >> 16;
825 offset += field->offset + sizeof(int);
827 if (offset + len > iter->ent_size) {
828 trace_seq_puts(&iter->seq, "<OVERFLOW>");
832 pos = (void *)iter->ent + offset;
834 for (i = 0; i < len; i++, pos++) {
836 trace_seq_putc(&iter->seq, ',');
837 trace_seq_printf(&iter->seq, "%02x", *(unsigned char *)pos);
841 static void print_fields(struct trace_iterator *iter, struct trace_event_call *call,
842 struct list_head *head)
844 struct ftrace_event_field *field;
850 list_for_each_entry_reverse(field, head, link) {
851 trace_seq_printf(&iter->seq, " %s=", field->name);
852 if (field->offset + field->size > iter->ent_size) {
853 trace_seq_puts(&iter->seq, "<OVERFLOW>");
856 pos = (void *)iter->ent + field->offset;
858 switch (field->filter_type) {
860 case FILTER_STATIC_STRING:
861 trace_seq_printf(&iter->seq, "%.*s", field->size, (char *)pos);
863 case FILTER_RDYN_STRING:
864 case FILTER_DYN_STRING:
865 offset = *(int *)pos & 0xffff;
866 len = *(int *)pos >> 16;
868 if (field->filter_type == FILTER_RDYN_STRING)
869 offset += field->offset + sizeof(int);
871 if (offset + len > iter->ent_size) {
872 trace_seq_puts(&iter->seq, "<OVERFLOW>");
875 pos = (void *)iter->ent + offset;
876 trace_seq_printf(&iter->seq, "%.*s", len, (char *)pos);
878 case FILTER_PTR_STRING:
880 trace_iter_expand_format(iter);
882 ret = strncpy_from_kernel_nofault(iter->fmt, pos,
885 trace_seq_printf(&iter->seq, "(0x%px)", pos);
887 trace_seq_printf(&iter->seq, "(0x%px:%s)",
890 case FILTER_TRACE_FN:
892 trace_seq_printf(&iter->seq, "%pS", pos);
896 switch (field->size) {
898 if (isprint(*(char *)pos)) {
899 trace_seq_printf(&iter->seq, "'%c'",
900 *(unsigned char *)pos);
902 trace_seq_printf(&iter->seq, "(%d)",
903 *(unsigned char *)pos);
906 trace_seq_printf(&iter->seq, "0x%x (%d)",
907 *(unsigned short *)pos,
908 *(unsigned short *)pos);
911 /* dynamic array info is 4 bytes */
912 if (strstr(field->type, "__data_loc")) {
913 print_array(iter, pos, NULL);
917 if (strstr(field->type, "__rel_loc")) {
918 print_array(iter, pos, field);
922 trace_seq_printf(&iter->seq, "0x%x (%d)",
923 *(unsigned int *)pos,
924 *(unsigned int *)pos);
927 trace_seq_printf(&iter->seq, "0x%llx (%lld)",
928 *(unsigned long long *)pos,
929 *(unsigned long long *)pos);
932 trace_seq_puts(&iter->seq, "<INVALID-SIZE>");
937 trace_seq_puts(&iter->seq, "<INVALID-TYPE>");
940 trace_seq_putc(&iter->seq, '\n');
943 enum print_line_t print_event_fields(struct trace_iterator *iter,
944 struct trace_event *event)
946 struct trace_event_call *call;
947 struct list_head *head;
949 /* ftrace defined events have separate call structures */
950 if (event->type <= __TRACE_LAST_TYPE) {
953 down_read(&trace_event_sem);
954 list_for_each_entry(call, &ftrace_events, list) {
955 if (call->event.type == event->type) {
959 /* No need to search all events */
960 if (call->event.type > __TRACE_LAST_TYPE)
963 up_read(&trace_event_sem);
965 trace_seq_printf(&iter->seq, "UNKNOWN TYPE %d\n", event->type);
969 call = container_of(event, struct trace_event_call, event);
971 head = trace_get_fields(call);
973 trace_seq_printf(&iter->seq, "%s:", trace_event_name(call));
975 if (head && !list_empty(head))
976 print_fields(iter, call, head);
978 trace_seq_puts(&iter->seq, "No fields found\n");
981 return trace_handle_return(&iter->seq);
984 enum print_line_t trace_nop_print(struct trace_iterator *iter, int flags,
985 struct trace_event *event)
987 trace_seq_printf(&iter->seq, "type: %d\n", iter->ent->type);
989 return trace_handle_return(&iter->seq);
992 static void print_fn_trace(struct trace_seq *s, unsigned long ip,
993 unsigned long parent_ip, long delta, int flags)
998 seq_print_ip_sym(s, ip, flags);
1000 if ((flags & TRACE_ITER_PRINT_PARENT) && parent_ip) {
1001 trace_seq_puts(s, " <-");
1002 seq_print_ip_sym(s, parent_ip, flags);
1007 static enum print_line_t trace_fn_trace(struct trace_iterator *iter, int flags,
1008 struct trace_event *event)
1010 struct ftrace_entry *field;
1011 struct trace_seq *s = &iter->seq;
1013 trace_assign_type(field, iter->ent);
1015 print_fn_trace(s, field->ip, field->parent_ip, iter->tr->text_delta, flags);
1016 trace_seq_putc(s, '\n');
1018 return trace_handle_return(s);
1021 static enum print_line_t trace_fn_raw(struct trace_iterator *iter, int flags,
1022 struct trace_event *event)
1024 struct ftrace_entry *field;
1026 trace_assign_type(field, iter->ent);
1028 trace_seq_printf(&iter->seq, "%lx %lx\n",
1032 return trace_handle_return(&iter->seq);
1035 static enum print_line_t trace_fn_hex(struct trace_iterator *iter, int flags,
1036 struct trace_event *event)
1038 struct ftrace_entry *field;
1039 struct trace_seq *s = &iter->seq;
1041 trace_assign_type(field, iter->ent);
1043 SEQ_PUT_HEX_FIELD(s, field->ip);
1044 SEQ_PUT_HEX_FIELD(s, field->parent_ip);
1046 return trace_handle_return(s);
1049 static enum print_line_t trace_fn_bin(struct trace_iterator *iter, int flags,
1050 struct trace_event *event)
1052 struct ftrace_entry *field;
1053 struct trace_seq *s = &iter->seq;
1055 trace_assign_type(field, iter->ent);
1057 SEQ_PUT_FIELD(s, field->ip);
1058 SEQ_PUT_FIELD(s, field->parent_ip);
1060 return trace_handle_return(s);
1063 static struct trace_event_functions trace_fn_funcs = {
1064 .trace = trace_fn_trace,
1065 .raw = trace_fn_raw,
1066 .hex = trace_fn_hex,
1067 .binary = trace_fn_bin,
1070 static struct trace_event trace_fn_event = {
1072 .funcs = &trace_fn_funcs,
1075 /* TRACE_CTX an TRACE_WAKE */
1076 static enum print_line_t trace_ctxwake_print(struct trace_iterator *iter,
1079 struct ctx_switch_entry *field;
1080 char comm[TASK_COMM_LEN];
1084 trace_assign_type(field, iter->ent);
1086 T = task_index_to_char(field->next_state);
1087 S = task_index_to_char(field->prev_state);
1088 trace_find_cmdline(field->next_pid, comm);
1089 trace_seq_printf(&iter->seq,
1090 " %7d:%3d:%c %s [%03d] %7d:%3d:%c %s\n",
1099 return trace_handle_return(&iter->seq);
1102 static enum print_line_t trace_ctx_print(struct trace_iterator *iter, int flags,
1103 struct trace_event *event)
1105 return trace_ctxwake_print(iter, "==>");
1108 static enum print_line_t trace_wake_print(struct trace_iterator *iter,
1109 int flags, struct trace_event *event)
1111 return trace_ctxwake_print(iter, " +");
1114 static int trace_ctxwake_raw(struct trace_iterator *iter, char S)
1116 struct ctx_switch_entry *field;
1119 trace_assign_type(field, iter->ent);
1122 S = task_index_to_char(field->prev_state);
1123 T = task_index_to_char(field->next_state);
1124 trace_seq_printf(&iter->seq, "%d %d %c %d %d %d %c\n",
1133 return trace_handle_return(&iter->seq);
1136 static enum print_line_t trace_ctx_raw(struct trace_iterator *iter, int flags,
1137 struct trace_event *event)
1139 return trace_ctxwake_raw(iter, 0);
1142 static enum print_line_t trace_wake_raw(struct trace_iterator *iter, int flags,
1143 struct trace_event *event)
1145 return trace_ctxwake_raw(iter, '+');
1149 static int trace_ctxwake_hex(struct trace_iterator *iter, char S)
1151 struct ctx_switch_entry *field;
1152 struct trace_seq *s = &iter->seq;
1155 trace_assign_type(field, iter->ent);
1158 S = task_index_to_char(field->prev_state);
1159 T = task_index_to_char(field->next_state);
1161 SEQ_PUT_HEX_FIELD(s, field->prev_pid);
1162 SEQ_PUT_HEX_FIELD(s, field->prev_prio);
1163 SEQ_PUT_HEX_FIELD(s, S);
1164 SEQ_PUT_HEX_FIELD(s, field->next_cpu);
1165 SEQ_PUT_HEX_FIELD(s, field->next_pid);
1166 SEQ_PUT_HEX_FIELD(s, field->next_prio);
1167 SEQ_PUT_HEX_FIELD(s, T);
1169 return trace_handle_return(s);
1172 static enum print_line_t trace_ctx_hex(struct trace_iterator *iter, int flags,
1173 struct trace_event *event)
1175 return trace_ctxwake_hex(iter, 0);
1178 static enum print_line_t trace_wake_hex(struct trace_iterator *iter, int flags,
1179 struct trace_event *event)
1181 return trace_ctxwake_hex(iter, '+');
1184 static enum print_line_t trace_ctxwake_bin(struct trace_iterator *iter,
1185 int flags, struct trace_event *event)
1187 struct ctx_switch_entry *field;
1188 struct trace_seq *s = &iter->seq;
1190 trace_assign_type(field, iter->ent);
1192 SEQ_PUT_FIELD(s, field->prev_pid);
1193 SEQ_PUT_FIELD(s, field->prev_prio);
1194 SEQ_PUT_FIELD(s, field->prev_state);
1195 SEQ_PUT_FIELD(s, field->next_cpu);
1196 SEQ_PUT_FIELD(s, field->next_pid);
1197 SEQ_PUT_FIELD(s, field->next_prio);
1198 SEQ_PUT_FIELD(s, field->next_state);
1200 return trace_handle_return(s);
1203 static struct trace_event_functions trace_ctx_funcs = {
1204 .trace = trace_ctx_print,
1205 .raw = trace_ctx_raw,
1206 .hex = trace_ctx_hex,
1207 .binary = trace_ctxwake_bin,
1210 static struct trace_event trace_ctx_event = {
1212 .funcs = &trace_ctx_funcs,
1215 static struct trace_event_functions trace_wake_funcs = {
1216 .trace = trace_wake_print,
1217 .raw = trace_wake_raw,
1218 .hex = trace_wake_hex,
1219 .binary = trace_ctxwake_bin,
1222 static struct trace_event trace_wake_event = {
1224 .funcs = &trace_wake_funcs,
1229 static enum print_line_t trace_stack_print(struct trace_iterator *iter,
1230 int flags, struct trace_event *event)
1232 struct stack_entry *field;
1233 struct trace_seq *s = &iter->seq;
1237 trace_assign_type(field, iter->ent);
1238 end = (unsigned long *)((long)iter->ent + iter->ent_size);
1240 trace_seq_puts(s, "<stack trace>\n");
1242 for (p = field->caller; p && p < end && *p != ULONG_MAX; p++) {
1244 if (trace_seq_has_overflowed(s))
1247 trace_seq_puts(s, " => ");
1248 seq_print_ip_sym(s, *p, flags);
1249 trace_seq_putc(s, '\n');
1252 return trace_handle_return(s);
1255 static struct trace_event_functions trace_stack_funcs = {
1256 .trace = trace_stack_print,
1259 static struct trace_event trace_stack_event = {
1260 .type = TRACE_STACK,
1261 .funcs = &trace_stack_funcs,
1264 /* TRACE_USER_STACK */
1265 static enum print_line_t trace_user_stack_print(struct trace_iterator *iter,
1266 int flags, struct trace_event *event)
1268 struct trace_array *tr = iter->tr;
1269 struct userstack_entry *field;
1270 struct trace_seq *s = &iter->seq;
1271 struct mm_struct *mm = NULL;
1274 trace_assign_type(field, iter->ent);
1276 trace_seq_puts(s, "<user stack trace>\n");
1278 if (tr->trace_flags & TRACE_ITER_SYM_USEROBJ) {
1279 struct task_struct *task;
1281 * we do the lookup on the thread group leader,
1282 * since individual threads might have already quit!
1285 task = find_task_by_vpid(field->tgid);
1287 mm = get_task_mm(task);
1291 for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
1292 unsigned long ip = field->caller[i];
1294 if (!ip || trace_seq_has_overflowed(s))
1297 trace_seq_puts(s, " => ");
1298 seq_print_user_ip(s, mm, ip, flags);
1299 trace_seq_putc(s, '\n');
1305 return trace_handle_return(s);
1308 static struct trace_event_functions trace_user_stack_funcs = {
1309 .trace = trace_user_stack_print,
1312 static struct trace_event trace_user_stack_event = {
1313 .type = TRACE_USER_STACK,
1314 .funcs = &trace_user_stack_funcs,
1318 static enum print_line_t
1319 trace_hwlat_print(struct trace_iterator *iter, int flags,
1320 struct trace_event *event)
1322 struct trace_entry *entry = iter->ent;
1323 struct trace_seq *s = &iter->seq;
1324 struct hwlat_entry *field;
1326 trace_assign_type(field, entry);
1328 trace_seq_printf(s, "#%-5u inner/outer(us): %4llu/%-5llu ts:%lld.%09ld count:%d",
1331 field->outer_duration,
1332 (long long)field->timestamp.tv_sec,
1333 field->timestamp.tv_nsec, field->count);
1335 if (field->nmi_count) {
1337 * The generic sched_clock() is not NMI safe, thus
1338 * we only record the count and not the time.
1340 if (!IS_ENABLED(CONFIG_GENERIC_SCHED_CLOCK))
1341 trace_seq_printf(s, " nmi-total:%llu",
1342 field->nmi_total_ts);
1343 trace_seq_printf(s, " nmi-count:%u",
1347 trace_seq_putc(s, '\n');
1349 return trace_handle_return(s);
1352 static enum print_line_t
1353 trace_hwlat_raw(struct trace_iterator *iter, int flags,
1354 struct trace_event *event)
1356 struct hwlat_entry *field;
1357 struct trace_seq *s = &iter->seq;
1359 trace_assign_type(field, iter->ent);
1361 trace_seq_printf(s, "%llu %lld %lld %09ld %u\n",
1363 field->outer_duration,
1364 (long long)field->timestamp.tv_sec,
1365 field->timestamp.tv_nsec,
1368 return trace_handle_return(s);
1371 static struct trace_event_functions trace_hwlat_funcs = {
1372 .trace = trace_hwlat_print,
1373 .raw = trace_hwlat_raw,
1376 static struct trace_event trace_hwlat_event = {
1377 .type = TRACE_HWLAT,
1378 .funcs = &trace_hwlat_funcs,
1382 static enum print_line_t
1383 trace_osnoise_print(struct trace_iterator *iter, int flags,
1384 struct trace_event *event)
1386 struct trace_entry *entry = iter->ent;
1387 struct trace_seq *s = &iter->seq;
1388 struct osnoise_entry *field;
1389 u64 ratio, ratio_dec;
1392 trace_assign_type(field, entry);
1395 * compute the available % of cpu time.
1397 net_runtime = field->runtime - field->noise;
1398 ratio = net_runtime * 10000000;
1399 do_div(ratio, field->runtime);
1400 ratio_dec = do_div(ratio, 100000);
1402 trace_seq_printf(s, "%llu %10llu %3llu.%05llu %7llu",
1408 trace_seq_printf(s, " %6u", field->hw_count);
1409 trace_seq_printf(s, " %6u", field->nmi_count);
1410 trace_seq_printf(s, " %6u", field->irq_count);
1411 trace_seq_printf(s, " %6u", field->softirq_count);
1412 trace_seq_printf(s, " %6u", field->thread_count);
1414 trace_seq_putc(s, '\n');
1416 return trace_handle_return(s);
1419 static enum print_line_t
1420 trace_osnoise_raw(struct trace_iterator *iter, int flags,
1421 struct trace_event *event)
1423 struct osnoise_entry *field;
1424 struct trace_seq *s = &iter->seq;
1426 trace_assign_type(field, iter->ent);
1428 trace_seq_printf(s, "%lld %llu %llu %u %u %u %u %u\n",
1435 field->softirq_count,
1436 field->thread_count);
1438 return trace_handle_return(s);
1441 static struct trace_event_functions trace_osnoise_funcs = {
1442 .trace = trace_osnoise_print,
1443 .raw = trace_osnoise_raw,
1446 static struct trace_event trace_osnoise_event = {
1447 .type = TRACE_OSNOISE,
1448 .funcs = &trace_osnoise_funcs,
1451 /* TRACE_TIMERLAT */
1453 static char *timerlat_lat_context[] = {"irq", "thread", "user-ret"};
1454 static enum print_line_t
1455 trace_timerlat_print(struct trace_iterator *iter, int flags,
1456 struct trace_event *event)
1458 struct trace_entry *entry = iter->ent;
1459 struct trace_seq *s = &iter->seq;
1460 struct timerlat_entry *field;
1462 trace_assign_type(field, entry);
1464 trace_seq_printf(s, "#%-5u context %6s timer_latency %9llu ns\n",
1466 timerlat_lat_context[field->context],
1467 field->timer_latency);
1469 return trace_handle_return(s);
1472 static enum print_line_t
1473 trace_timerlat_raw(struct trace_iterator *iter, int flags,
1474 struct trace_event *event)
1476 struct timerlat_entry *field;
1477 struct trace_seq *s = &iter->seq;
1479 trace_assign_type(field, iter->ent);
1481 trace_seq_printf(s, "%u %d %llu\n",
1484 field->timer_latency);
1486 return trace_handle_return(s);
1489 static struct trace_event_functions trace_timerlat_funcs = {
1490 .trace = trace_timerlat_print,
1491 .raw = trace_timerlat_raw,
1494 static struct trace_event trace_timerlat_event = {
1495 .type = TRACE_TIMERLAT,
1496 .funcs = &trace_timerlat_funcs,
1500 static enum print_line_t
1501 trace_bputs_print(struct trace_iterator *iter, int flags,
1502 struct trace_event *event)
1504 struct trace_entry *entry = iter->ent;
1505 struct trace_seq *s = &iter->seq;
1506 struct bputs_entry *field;
1508 trace_assign_type(field, entry);
1510 seq_print_ip_sym(s, field->ip, flags);
1511 trace_seq_puts(s, ": ");
1512 trace_seq_puts(s, field->str);
1514 return trace_handle_return(s);
1518 static enum print_line_t
1519 trace_bputs_raw(struct trace_iterator *iter, int flags,
1520 struct trace_event *event)
1522 struct bputs_entry *field;
1523 struct trace_seq *s = &iter->seq;
1525 trace_assign_type(field, iter->ent);
1527 trace_seq_printf(s, ": %lx : ", field->ip);
1528 trace_seq_puts(s, field->str);
1530 return trace_handle_return(s);
1533 static struct trace_event_functions trace_bputs_funcs = {
1534 .trace = trace_bputs_print,
1535 .raw = trace_bputs_raw,
1538 static struct trace_event trace_bputs_event = {
1539 .type = TRACE_BPUTS,
1540 .funcs = &trace_bputs_funcs,
1544 static enum print_line_t
1545 trace_bprint_print(struct trace_iterator *iter, int flags,
1546 struct trace_event *event)
1548 struct trace_entry *entry = iter->ent;
1549 struct trace_seq *s = &iter->seq;
1550 struct bprint_entry *field;
1552 trace_assign_type(field, entry);
1554 seq_print_ip_sym(s, field->ip, flags);
1555 trace_seq_puts(s, ": ");
1556 trace_seq_bprintf(s, field->fmt, field->buf);
1558 return trace_handle_return(s);
1562 static enum print_line_t
1563 trace_bprint_raw(struct trace_iterator *iter, int flags,
1564 struct trace_event *event)
1566 struct bprint_entry *field;
1567 struct trace_seq *s = &iter->seq;
1569 trace_assign_type(field, iter->ent);
1571 trace_seq_printf(s, ": %lx : ", field->ip);
1572 trace_seq_bprintf(s, field->fmt, field->buf);
1574 return trace_handle_return(s);
1577 static struct trace_event_functions trace_bprint_funcs = {
1578 .trace = trace_bprint_print,
1579 .raw = trace_bprint_raw,
1582 static struct trace_event trace_bprint_event = {
1583 .type = TRACE_BPRINT,
1584 .funcs = &trace_bprint_funcs,
1588 static enum print_line_t trace_print_print(struct trace_iterator *iter,
1589 int flags, struct trace_event *event)
1591 struct print_entry *field;
1592 struct trace_seq *s = &iter->seq;
1594 trace_assign_type(field, iter->ent);
1596 seq_print_ip_sym(s, field->ip, flags);
1597 trace_seq_printf(s, ": %s", field->buf);
1599 return trace_handle_return(s);
1602 static enum print_line_t trace_print_raw(struct trace_iterator *iter, int flags,
1603 struct trace_event *event)
1605 struct print_entry *field;
1607 trace_assign_type(field, iter->ent);
1609 trace_seq_printf(&iter->seq, "# %lx %s", field->ip, field->buf);
1611 return trace_handle_return(&iter->seq);
1614 static struct trace_event_functions trace_print_funcs = {
1615 .trace = trace_print_print,
1616 .raw = trace_print_raw,
1619 static struct trace_event trace_print_event = {
1620 .type = TRACE_PRINT,
1621 .funcs = &trace_print_funcs,
1624 static enum print_line_t trace_raw_data(struct trace_iterator *iter, int flags,
1625 struct trace_event *event)
1627 struct raw_data_entry *field;
1630 trace_assign_type(field, iter->ent);
1632 trace_seq_printf(&iter->seq, "# %x buf:", field->id);
1634 for (i = 0; i < iter->ent_size - offsetof(struct raw_data_entry, buf); i++)
1635 trace_seq_printf(&iter->seq, " %02x",
1636 (unsigned char)field->buf[i]);
1638 trace_seq_putc(&iter->seq, '\n');
1640 return trace_handle_return(&iter->seq);
1643 static struct trace_event_functions trace_raw_data_funcs = {
1644 .trace = trace_raw_data,
1645 .raw = trace_raw_data,
1648 static struct trace_event trace_raw_data_event = {
1649 .type = TRACE_RAW_DATA,
1650 .funcs = &trace_raw_data_funcs,
1653 static enum print_line_t
1654 trace_func_repeats_raw(struct trace_iterator *iter, int flags,
1655 struct trace_event *event)
1657 struct func_repeats_entry *field;
1658 struct trace_seq *s = &iter->seq;
1660 trace_assign_type(field, iter->ent);
1662 trace_seq_printf(s, "%lu %lu %u %llu\n",
1666 FUNC_REPEATS_GET_DELTA_TS(field));
1668 return trace_handle_return(s);
1671 static enum print_line_t
1672 trace_func_repeats_print(struct trace_iterator *iter, int flags,
1673 struct trace_event *event)
1675 struct func_repeats_entry *field;
1676 struct trace_seq *s = &iter->seq;
1678 trace_assign_type(field, iter->ent);
1680 print_fn_trace(s, field->ip, field->parent_ip, iter->tr->text_delta, flags);
1681 trace_seq_printf(s, " (repeats: %u, last_ts:", field->count);
1682 trace_print_time(s, iter,
1683 iter->ts - FUNC_REPEATS_GET_DELTA_TS(field));
1684 trace_seq_puts(s, ")\n");
1686 return trace_handle_return(s);
1689 static struct trace_event_functions trace_func_repeats_funcs = {
1690 .trace = trace_func_repeats_print,
1691 .raw = trace_func_repeats_raw,
1694 static struct trace_event trace_func_repeats_event = {
1695 .type = TRACE_FUNC_REPEATS,
1696 .funcs = &trace_func_repeats_funcs,
1699 static struct trace_event *events[] __initdata = {
1704 &trace_user_stack_event,
1706 &trace_bprint_event,
1709 &trace_osnoise_event,
1710 &trace_timerlat_event,
1711 &trace_raw_data_event,
1712 &trace_func_repeats_event,
1716 __init int init_events(void)
1718 struct trace_event *event;
1721 for (i = 0; events[i]; i++) {
1723 ret = register_trace_event(event);
1724 WARN_ONCE(!ret, "event %d failed to register", event->type);